May 30 09:48:38 interpol wpa_supplicant[22422]: EAPOL: External notification - portEnabled=0
May 30 09:48:38 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:48:38 interpol wpa_supplicant[22422]: EAPOL: External notification - portValid=0
May 30 09:48:38 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:48:38 interpol wpa_supplicant[22422]: EAPOL: External notification - EAP success=0
May 30 09:48:38 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:48:38 interpol wpa_supplicant[22422]: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
May 30 09:48:38 interpol wpa_supplicant[22422]: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
May 30 09:48:38 interpol wpa_supplicant[22422]: RTM_NEWLINK: operstate=0 ifi_flags=0x1043 ([UP][RUNNING])
May 30 09:48:38 interpol wpa_supplicant[22422]: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
May 30 09:48:38 interpol wpa_supplicant[22422]: nl80211: Event message available
May 30 09:48:38 interpol wpa_supplicant[22422]: nl80211: Ignore disconnect event when using userspace SME
May 30 09:48:38 interpol wpa_supplicant[22422]: nl80211: Event message available
May 30 09:48:38 interpol wpa_supplicant[22422]: nl80211: Ignored unknown event (cmd=20)
May 30 09:48:38 interpol NetworkManager[28085]: <info> (wlan0): writing resolv.conf to /sbin/resolvconf
May 30 09:48:38 interpol kernel: [43632.669214] cfg80211: Ignoring regulatory request Set by core since the driver uses its own custom regulatory domain
May 30 09:48:38 interpol kernel: [43632.669218] cfg80211: World regulatory domain updated:
May 30 09:48:38 interpol kernel: [43632.669220] cfg80211:     (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
May 30 09:48:38 interpol kernel: [43632.669224] cfg80211:     (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
May 30 09:48:38 interpol kernel: [43632.669227] cfg80211:     (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
May 30 09:48:38 interpol kernel: [43632.669229] cfg80211:     (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
May 30 09:48:38 interpol kernel: [43632.669232] cfg80211:     (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
May 30 09:48:38 interpol kernel: [43632.669236] cfg80211:     (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
May 30 09:48:38 interpol kernel: [43632.669251] cfg80211: Calling CRDA for country: BO
May 30 09:48:38 interpol dnsmasq[28487]: started, version 2.59 cache disabled
May 30 09:48:38 interpol dnsmasq[28487]: compile time options: IPv6 GNU-getopt DBus i18n DHCP TFTP conntrack IDN
May 30 09:48:38 interpol dnsmasq[28487]: warning: no upstream servers configured
May 30 09:48:38 interpol NetworkManager[28085]: <info> (wlan0): cleaning up...
May 30 09:48:38 interpol NetworkManager[28085]: <info> (wlan0): taking down device.
May 30 09:48:39 interpol kernel: [43632.682262] cfg80211: Updating information on frequency 2412 MHz for a 20 MHz width channel with regulatory rule:
May 30 09:48:39 interpol kernel: [43632.682268] cfg80211: 2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A mBi, 3000 mBm)
May 30 09:48:39 interpol kernel: [43632.682270] cfg80211: Updating information on frequency 2417 MHz for a 20 MHz width channel with regulatory rule:
May 30 09:48:39 interpol kernel: [43632.682273] cfg80211: 2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A mBi, 3000 mBm)
May 30 09:48:39 interpol kernel: [43632.682275] cfg80211: Updating information on frequency 2422 MHz for a 20 MHz width channel with regulatory rule:
May 30 09:48:39 interpol kernel: [43632.682277] cfg80211: 2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A mBi, 3000 mBm)
May 30 09:48:39 interpol kernel: [43632.682279] cfg80211: Updating information on frequency 2427 MHz for a 20 MHz width channel with regulatory rule:
May 30 09:48:39 interpol kernel: [43632.682281] cfg80211: 2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A mBi, 3000 mBm)
May 30 09:48:39 interpol kernel: [43632.682283] cfg80211: Updating information on frequency 2432 MHz for a 20 MHz width channel with regulatory rule:
May 30 09:48:39 interpol kernel: [43632.682285] cfg80211: 2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A mBi, 3000 mBm)
May 30 09:48:39 interpol kernel: [43632.682287] cfg80211: Updating information on frequency 2437 MHz for a 20 MHz width channel with regulatory rule:
May 30 09:48:39 interpol kernel: [43632.682289] cfg80211: 2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A mBi, 3000 mBm)
May 30 09:48:39 interpol kernel: [43632.682291] cfg80211: Updating information on frequency 2442 MHz for a 20 MHz width channel with regulatory rule:
May 30 09:48:39 interpol kernel: [43632.682293] cfg80211: 2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A mBi, 3000 mBm)
May 30 09:48:39 interpol kernel: [43632.682295] cfg80211: Updating information on frequency 2447 MHz for a 20 MHz width channel with regulatory rule:
May 30 09:48:39 interpol kernel: [43632.682297] cfg80211: 2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A mBi, 3000 mBm)
May 30 09:48:39 interpol kernel: [43632.682299] cfg80211: Updating information on frequency 2452 MHz for a 20 MHz width channel with regulatory rule:
May 30 09:48:39 interpol kernel: [43632.682301] cfg80211: 2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A mBi, 3000 mBm)
May 30 09:48:39 interpol kernel: [43632.682303] cfg80211: Updating information on frequency 2457 MHz for a 20 MHz width channel with regulatory rule:
May 30 09:48:39 interpol kernel: [43632.682306] cfg80211: 2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A mBi, 3000 mBm)
May 30 09:48:39 interpol kernel: [43632.682307] cfg80211: Updating information on frequency 2462 MHz for a 20 MHz width channel with regulatory rule:
May 30 09:48:39 interpol kernel: [43632.682310] cfg80211: 2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A mBi, 3000 mBm)
May 30 09:48:39 interpol kernel: [43632.682311] cfg80211: Updating information on frequency 2467 MHz for a 20 MHz width channel with regulatory rule:
May 30 09:48:39 interpol kernel: [43632.682314] cfg80211: 2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A mBi, 3000 mBm)
May 30 09:48:39 interpol kernel: [43632.682315] cfg80211: Updating information on frequency 2472 MHz for a 20 MHz width channel with regulatory rule:
May 30 09:48:39 interpol kernel: [43632.682318] cfg80211: 2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A mBi, 3000 mBm)
May 30 09:48:39 interpol kernel: [43632.682321] cfg80211: Regulatory domain changed to country: BO
May 30 09:48:39 interpol kernel: [43632.682322] cfg80211:     (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
May 30 09:48:39 interpol kernel: [43632.682324] cfg80211:     (2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 3000 mBm)
May 30 09:48:39 interpol kernel: [43632.682326] cfg80211:     (5735000 KHz - 5835000 KHz @ 40000 KHz), (N/A, 3000 mBm)
May 30 09:48:39 interpol wpa_supplicant[22422]: RTM_NEWLINK: operstate=0 ifi_flags=0x1002 ()
May 30 09:48:39 interpol wpa_supplicant[22422]: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
May 30 09:48:39 interpol wpa_supplicant[22422]: Removing interface wlan0
May 30 09:48:39 interpol wpa_supplicant[22422]: No keys have been configured - skip key clearing
May 30 09:48:39 interpol wpa_supplicant[22422]: State: DISCONNECTED -> DISCONNECTED
May 30 09:48:39 interpol wpa_supplicant[22422]: wpa_driver_nl80211_set_operstate: operstate 0->0 (DORMANT)
May 30 09:48:39 interpol wpa_supplicant[22422]: netlink: Operstate: linkmode=-1, operstate=5
May 30 09:48:39 interpol wpa_supplicant[22422]: EAPOL: External notification - portEnabled=0
May 30 09:48:39 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:48:39 interpol wpa_supplicant[22422]: EAPOL: External notification - portValid=0
May 30 09:48:39 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:48:39 interpol wpa_supplicant[22422]: EAPOL: External notification - EAP success=0
May 30 09:48:39 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:48:39 interpol wpa_supplicant[22422]: No keys have been configured - skip key clearing
May 30 09:48:39 interpol dbus[779]: [system] Activating service name='org.freedesktop.nm_dispatcher' (using servicehelper)
May 30 09:48:39 interpol dbus[779]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
May 30 09:48:39 interpol wpa_supplicant[22422]: Removed BSSID 00:00:00:00:00:00 from blacklist (clear)
May 30 09:48:39 interpol wpa_supplicant[22422]: BSS: Remove id 5 BSSID 58:93:96:0b:de:48 SSID 'linaroconnect'
May 30 09:48:39 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/15/BSSs/5'
May 30 09:48:39 interpol wpa_supplicant[22422]: BSS: Remove id 7 BSSID c8:3a:35:1c:ec:80 SSID ''
May 30 09:48:39 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/15/BSSs/7'
May 30 09:48:39 interpol wpa_supplicant[22422]: BSS: Remove id 12 BSSID 58:93:96:0b:e1:78 SSID 'linaroconnect'
May 30 09:48:39 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/15/BSSs/12'
May 30 09:48:39 interpol wpa_supplicant[22422]: BSS: Remove id 18 BSSID 58:93:96:4b:de:48 SSID ''
May 30 09:48:39 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/15/BSSs/18'
May 30 09:48:39 interpol wpa_supplicant[22422]: BSS: Remove id 0 BSSID 58:93:96:0b:e0:18 SSID 'linaroconnect'
May 30 09:48:39 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/15/BSSs/0'
May 30 09:48:39 interpol wpa_supplicant[22422]: BSS: Remove id 11 BSSID 58:93:96:0b:de:c8 SSID 'linaroconnect'
May 30 09:48:39 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/15/BSSs/11'
May 30 09:48:39 interpol wpa_supplicant[22422]: BSS: Remove id 1 BSSID 00:02:6f:4e:b3:31 SSID 'linaroconnect'
May 30 09:48:39 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/15/BSSs/1'
May 30 09:48:39 interpol wpa_supplicant[22422]: BSS: Remove id 6 BSSID 58:93:96:0b:e0:d8 SSID 'linaroconnect'
May 30 09:48:39 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/15/BSSs/6'
May 30 09:48:39 interpol wpa_supplicant[22422]: BSS: Remove id 3 BSSID 58:93:96:0b:e1:b8 SSID 'linaroconnect'
May 30 09:48:39 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/15/BSSs/3'
May 30 09:48:39 interpol wpa_supplicant[22422]: BSS: Remove id 30 BSSID 00:14:78:52:3b:ec SSID ''
May 30 09:48:39 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/15/BSSs/30'
May 30 09:48:39 interpol wpa_supplicant[22422]: BSS: Remove id 32 BSSID 00:02:6f:4e:b2:7d SSID 'linaroconnect'
May 30 09:48:39 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/15/BSSs/32'
May 30 09:48:39 interpol wpa_supplicant[22422]: BSS: Remove id 8 BSSID 50:a7:33:15:d7:48 SSID 'linaroconnect'
May 30 09:48:39 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/15/BSSs/8'
May 30 09:48:39 interpol wpa_supplicant[22422]: BSS: Remove id 9 BSSID 00:02:6f:4e:b2:7f SSID 'linaroconnect'
May 30 09:48:39 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/15/BSSs/9'
May 30 09:48:39 interpol wpa_supplicant[22422]: BSS: Remove id 10 BSSID 00:02:6f:4e:b3:30 SSID 'linaroconnect'
May 30 09:48:39 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/15/BSSs/10'
May 30 09:48:39 interpol wpa_supplicant[22422]: BSS: Remove id 31 BSSID 00:02:6f:4e:b2:7b SSID 'linaroconnect'
May 30 09:48:39 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/15/BSSs/31'
May 30 09:48:39 interpol wpa_supplicant[22422]: BSS: Remove id 14 BSSID 00:02:6f:b2:03:c0 SSID 'GOLD COAST HOTEL'
May 30 09:48:39 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/15/BSSs/14'
May 30 09:48:39 interpol wpa_supplicant[22422]: BSS: Remove id 22 BSSID 58:93:96:4b:de:c8 SSID ''
May 30 09:48:39 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/15/BSSs/22'
May 30 09:48:39 interpol wpa_supplicant[22422]: BSS: Remove id 19 BSSID 58:93:96:4b:e0:d8 SSID ''
May 30 09:48:39 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/15/BSSs/19'
May 30 09:48:39 interpol wpa_supplicant[22422]: BSS: Remove id 24 BSSID 00:02:6f:b2:07:ac SSID 'GOLD COAST HOTEL'
May 30 09:48:39 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/15/BSSs/24'
May 30 09:48:39 interpol wpa_supplicant[22422]: BSS: Remove id 25 BSSID 50:a7:33:55:d7:48 SSID ''
May 30 09:48:39 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/15/BSSs/25'
May 30 09:48:39 interpol wpa_supplicant[22422]: BSS: Remove id 21 BSSID 00:02:6f:b2:07:b0 SSID 'GOLD COAST HOTEL'
May 30 09:48:39 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/15/BSSs/21'
May 30 09:48:39 interpol wpa_supplicant[22422]: BSS: Remove id 20 BSSID 00:02:6f:b2:05:8c SSID 'GOLD COAST HOTEL'
May 30 09:48:39 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/15/BSSs/20'
May 30 09:48:39 interpol wpa_supplicant[22422]: BSS: Remove id 15 BSSID 58:93:96:4b:e1:b8 SSID ''
May 30 09:48:39 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/15/BSSs/15'
May 30 09:48:39 interpol wpa_supplicant[22422]: BSS: Remove id 33 BSSID 00:02:6f:b2:03:bc SSID 'GOLD COAST HOTEL'
May 30 09:48:39 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/15/BSSs/33'
May 30 09:48:39 interpol wpa_supplicant[22422]: Cancelling scan request
May 30 09:48:39 interpol wpa_supplicant[22422]: Cancelling authentication timeout
May 30 09:48:39 interpol wpa_supplicant[22422]: dbus: Unregister interface object '/fi/w1/wpa_supplicant1/Interfaces/15'
May 30 09:48:39 interpol wpa_supplicant[22422]: netlink: Operstate: linkmode=0, operstate=6
May 30 09:48:39 interpol kernel: [43633.283179] PM: Syncing filesystems ... done.
May 30 09:48:39 interpol kernel: [43633.286201] PM: Preparing system for mem sleep
May 30 09:49:21 interpol kernel: [43634.384205] Freezing user space processes ... (elapsed 0.01 seconds) done.
May 30 09:49:21 interpol kernel: [43634.400014] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
May 30 09:49:21 interpol kernel: [43634.415968] PM: Entering mem sleep
May 30 09:49:21 interpol kernel: [43634.416100] Suspending console(s) (use no_console_suspend to debug)
May 30 09:49:21 interpol kernel: [43634.416148] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0
May 30 09:49:21 interpol kernel: [43634.432007] ehci_hcd 0000:00:1a.0: BAR 0: set to [mem 0xf2728000-0xf27283ff] (PCI address [0xf2728000-0xf27283ff])
May 30 09:49:21 interpol kernel: [43634.432020] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0
May 30 09:49:21 interpol kernel: [43634.432049] ehci_hcd 0000:00:1a.0: restoring config space at offset 0xf (was 0x400, writing 0x40b)
May 30 09:49:21 interpol kernel: [43634.432076] ehci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102)
May 30 09:49:21 interpol kernel: [43634.432102] ehci_hcd 0000:00:1a.0: PME# disabled
May 30 09:49:21 interpol kernel: [43634.432107] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0
May 30 09:49:21 interpol kernel: [43634.432111] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0
May 30 09:49:21 interpol kernel: [43634.432120] ehci_hcd 0000:00:1a.0: PCI INT D -> GSI 23 (level, low) -> IRQ 23
May 30 09:49:21 interpol kernel: [43634.432127] ehci_hcd 0000:00:1a.0: setting latency timer to 64
May 30 09:49:21 interpol kernel: [43634.432153] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0
May 30 09:49:21 interpol kernel: [43634.447933] ehci_hcd 0000:00:1d.0: BAR 0: set to [mem 0xf2728400-0xf27287ff] (PCI address [0xf2728400-0xf27287ff])
May 30 09:49:21 interpol kernel: [43634.447942] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0
May 30 09:49:21 interpol kernel: [43634.447962] ehci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x400, writing 0x40b)
May 30 09:49:21 interpol kernel: [43634.447989] ehci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102)
May 30 09:49:21 interpol kernel: [43634.448023] ehci_hcd 0000:00:1d.0: PME# disabled
May 30 09:49:21 interpol kernel: [43634.448029] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0
May 30 09:49:21 interpol kernel: [43634.448037] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0
May 30 09:49:21 interpol kernel: [43634.448043] ehci_hcd 0000:00:1d.0: PCI INT D -> GSI 19 (level, low) -> IRQ 19
May 30 09:49:21 interpol kernel: [43634.448050] ehci_hcd 0000:00:1d.0: setting latency timer to 64
May 30 09:49:21 interpol kernel: [43634.448285] hdaps: setting ec_rate=0, filter_order=1
May 30 09:49:21 interpol kernel: [43634.624124] PM: suspend of drv:psmouse dev:serio2 complete after 176.134 msecs
May 30 09:49:21 interpol kernel: [43634.624304] sd 0:0:0:0: [sda] Synchronizing SCSI cache
May 30 09:49:21 interpol kernel: [43634.660259] sd 0:0:0:0: [sda] Stopping disk
May 30 09:49:21 interpol kernel: [43634.867191] PM: suspend of drv:tpm_tis dev:00:0b complete after 190.405 msecs
May 30 09:49:21 interpol kernel: [43634.867403] ehci_hcd 0000:00:1d.0: PCI INT D disabled
May 30 09:49:21 interpol kernel: [43634.867416] ehci_hcd 0000:00:1a.0: PCI INT D disabled
May 30 09:49:21 interpol kernel: [43634.899100] i915 0000:00:02.0: power state changed by ACPI to D3
May 30 09:49:21 interpol kernel: [43634.933017] e1000e 0000:00:19.0: PME# enabled
May 30 09:49:21 interpol kernel: [43634.933024] e1000e 0000:00:19.0: wake-up capability enabled by ACPI
May 30 09:49:21 interpol kernel: [43634.971455] snd_hda_intel 0000:00:1b.0: PCI INT B disabled
May 30 09:49:21 interpol kernel: [43634.986951] PM: suspend of drv:snd_hda_intel dev:0000:00:1b.0 complete after 119.750 msecs
May 30 09:49:21 interpol kernel: [43635.045789] PM: suspend of drv:sd dev:0:0:0:0 complete after 422.216 msecs
May 30 09:49:21 interpol kernel: [43635.045857] PM: suspend of drv:scsi dev:target0:0:0 complete after 422.235 msecs
May 30 09:49:21 interpol kernel: [43635.045929] PM: suspend of drv:scsi dev:host0 complete after 369.400 msecs
May 30 09:49:21 interpol kernel: [43635.062757] PM: suspend of drv:ahci dev:0000:00:1f.2 complete after 195.724 msecs
May 30 09:49:21 interpol kernel: [43635.062782] PM: suspend of drv: dev:pci0000:00 complete after 195.222 msecs
May 30 09:49:21 interpol kernel: [43635.062804] PM: suspend of devices complete after 615.696 msecs
May 30 09:49:21 interpol kernel: [43635.062810] PM: suspend devices took 0.648 seconds
May 30 09:49:21 interpol kernel: [43635.078974] ehci_hcd 0000:00:1d.0: PME# enabled
May 30 09:49:21 interpol kernel: [43635.078979] ehci_hcd 0000:00:1d.0: wake-up capability enabled by ACPI
May 30 09:49:21 interpol kernel: [43635.094740] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D3
May 30 09:49:21 interpol kernel: [43635.094965] ehci_hcd 0000:00:1a.0: PME# enabled
May 30 09:49:21 interpol kernel: [43635.094969] ehci_hcd 0000:00:1a.0: wake-up capability enabled by ACPI
May 30 09:49:21 interpol kernel: [43635.110711] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D3
May 30 09:49:21 interpol kernel: [43635.126804] PM: late suspend of devices complete after 64.099 msecs
May 30 09:49:21 interpol kernel: [43635.126993] ACPI: Preparing to enter system sleep state S3
May 30 09:49:21 interpol kernel: [43635.298459] PM: Saving platform NVS memory
May 30 09:49:21 interpol kernel: [43635.302803] Disabling non-boot CPUs ...
May 30 09:49:21 interpol kernel: [43635.406270] CPU 1 is now offline
May 30 09:49:21 interpol kernel: [43635.510094] CPU 2 is now offline
May 30 09:49:21 interpol kernel: [43635.613865] CPU 3 is now offline
May 30 09:49:21 interpol kernel: [43635.614278] Extended CMOS year: 2000
May 30 09:49:21 interpol kernel: [43635.614515] ACPI: Low-level resume complete
May 30 09:49:21 interpol kernel: [43635.614570] PM: Restoring platform NVS memory
May 30 09:49:21 interpol kernel: [43635.615227] Extended CMOS year: 2000
May 30 09:49:21 interpol kernel: [43635.615280] Enabling non-boot CPUs ...
May 30 09:49:21 interpol kernel: [43635.615375] Booting Node 0 Processor 1 APIC 0x1
May 30 09:49:21 interpol kernel: [43635.615377] smpboot cpu 1: start_ip = 99000
May 30 09:49:21 interpol kernel: [43635.626391] Calibrating delay loop (skipped) already calibrated this CPU
May 30 09:49:21 interpol kernel: [43635.662848] CPU1 is up
May 30 09:49:21 interpol kernel: [43635.662964] Booting Node 0 Processor 2 APIC 0x4
May 30 09:49:21 interpol kernel: [43635.662966] smpboot cpu 2: start_ip = 99000
May 30 09:49:21 interpol kernel: [43635.673978] Calibrating delay loop (skipped) already calibrated this CPU
May 30 09:49:21 interpol kernel: [43635.710774] CPU2 is up
May 30 09:49:21 interpol kernel: [43635.711012] Booting Node 0 Processor 3 APIC 0x5
May 30 09:49:21 interpol kernel: [43635.711013] smpboot cpu 3: start_ip = 99000
May 30 09:49:21 interpol kernel: [43635.722027] Calibrating delay loop (skipped) already calibrated this CPU
May 30 09:49:21 interpol kernel: [43635.758729] CPU3 is up
May 30 09:49:21 interpol kernel: [43635.761791] ACPI: Waking up from system sleep state S3
May 30 09:49:21 interpol kernel: [43636.062196] i915 0000:00:02.0: restoring config space at offset 0x1 (was 0x900007, writing 0x900407)
May 30 09:49:21 interpol kernel: [43636.062307] ehci_hcd 0000:00:1a.0: restoring config space at offset 0xf (was 0x400, writing 0x40b)
May 30 09:49:21 interpol kernel: [43636.062325] ehci_hcd 0000:00:1a.0: restoring config space at offset 0x4 (was 0x0, writing 0xf2728000)
May 30 09:49:21 interpol kernel: [43636.062333] ehci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102)
May 30 09:49:21 interpol kernel: [43636.062355] ehci_hcd 0000:00:1a.0: wake-up capability disabled by ACPI
May 30 09:49:21 interpol kernel: [43636.062360] ehci_hcd 0000:00:1a.0: PME# disabled
May 30 09:49:21 interpol kernel: [43636.062364] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0
May 30 09:49:21 interpol kernel: [43636.062368] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0
May 30 09:49:21 interpol kernel: [43636.062543] pcieport 0000:00:1c.4: restoring config space at offset 0xf (was 0x100, writing 0x4010b)
May 30 09:49:21 interpol kernel: [43636.062555] pcieport 0000:00:1c.4: restoring config space at offset 0x9 (was 0x10001, writing 0x1fff1)
May 30 09:49:21 interpol kernel: [43636.062560] pcieport 0000:00:1c.4: restoring config space at offset 0x8 (was 0x0, writing 0xf240f240)
May 30 09:49:21 interpol kernel: [43636.062565] pcieport 0000:00:1c.4: restoring config space at offset 0x7 (was 0x0, writing 0xf0)
May 30 09:49:21 interpol kernel: [43636.062573] pcieport 0000:00:1c.4: restoring config space at offset 0x3 (was 0x810000, writing 0x810010)
May 30 09:49:21 interpol kernel: [43636.062580] pcieport 0000:00:1c.4: restoring config space at offset 0x1 (was 0x100000, writing 0x100107)
May 30 09:49:21 interpol kernel: [43636.062614] ehci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x400, writing 0x40b)
May 30 09:49:21 interpol kernel: [43636.062632] ehci_hcd 0000:00:1d.0: restoring config space at offset 0x4 (was 0x0, writing 0xf2728400)
May 30 09:49:21 interpol kernel: [43636.062640] ehci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102)
May 30 09:49:21 interpol kernel: [43636.062658] ehci_hcd 0000:00:1d.0: wake-up capability disabled by ACPI
May 30 09:49:21 interpol kernel: [43636.062663] ehci_hcd 0000:00:1d.0: PME# disabled
May 30 09:49:21 interpol kernel: [43636.062665] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0
May 30 09:49:21 interpol kernel: [43636.062669] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0
May 30 09:49:21 interpol kernel: [43636.062772] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407)
May 30 09:49:21 interpol kernel: [43636.062840] intel ips 0000:00:1f.6: restoring config space at offset 0xf (was 0x400, writing 0x40b)
May 30 09:49:21 interpol kernel: [43636.062862] intel ips 0000:00:1f.6: restoring config space at offset 0x1 (was 0x100000, writing 0x100002)
May 30 09:49:21 interpol kernel: [43636.062944] iwlwifi 0000:02:00.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100506)
May 30 09:49:21 interpol kernel: [43636.063118] PM: early resume of devices complete after 1.045 msecs
May 30 09:49:21 interpol kernel: [43636.063262] e1000e 0000:00:19.0: wake-up capability disabled by ACPI
May 30 09:49:21 interpol kernel: [43636.063270] e1000e 0000:00:19.0: PME# disabled
May 30 09:49:21 interpol kernel: [43636.063308] i915 0000:00:02.0: power state changed by ACPI to D0
May 30 09:49:21 interpol kernel: [43636.063313] mei 0000:00:16.0: irq 41 for MSI/MSI-X
May 30 09:49:21 interpol kernel: [43636.063468] e1000e 0000:00:19.0: irq 42 for MSI/MSI-X
May 30 09:49:21 interpol kernel: [43636.066413] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0
May 30 09:49:21 interpol kernel: [43636.066471] pci 0000:00:1e.0: setting latency timer to 64
May 30 09:49:21 interpol kernel: [43636.066501] i915 0000:00:02.0: power state changed by ACPI to D0
May 30 09:49:21 interpol kernel: [43636.066514] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0
May 30 09:49:21 interpol kernel: [43636.066521] i915 0000:00:02.0: setting latency timer to 64
May 30 09:49:21 interpol kernel: [43636.066543] snd_hda_intel 0000:00:1b.0: PCI INT B -> GSI 17 (level, low) -> IRQ 17
May 30 09:49:21 interpol kernel: [43636.066550] snd_hda_intel 0000:00:1b.0: setting latency timer to 64
May 30 09:49:21 interpol kernel: [43636.066614] snd_hda_intel 0000:00:1b.0: irq 45 for MSI/MSI-X
May 30 09:49:21 interpol kernel: [43636.066687] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0
May 30 09:49:21 interpol kernel: [43636.066697] ehci_hcd 0000:00:1a.0: PCI INT D -> GSI 23 (level, low) -> IRQ 23
May 30 09:49:21 interpol kernel: [43636.066700] ahci 0000:00:1f.2: setting latency timer to 64
May 30 09:49:21 interpol kernel: [43636.066706] ehci_hcd 0000:00:1a.0: setting latency timer to 64
May 30 09:49:21 interpol kernel: [43636.066856] sd 0:0:0:0: [sda] Starting disk
May 30 09:49:21 interpol kernel: [43636.066859] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0
May 30 09:49:21 interpol kernel: [43636.066866] ehci_hcd 0000:00:1d.0: PCI INT D -> GSI 19 (level, low) -> IRQ 19
May 30 09:49:21 interpol kernel: [43636.066873] ehci_hcd 0000:00:1d.0: setting latency timer to 64
May 30 09:49:21 interpol kernel: [43636.219993] watchdog: only one watchdog can use /dev/watchdog.
May 30 09:49:21 interpol kernel: [43636.220000] watchdog: error registering /dev/watchdog (err=-16).
May 30 09:49:21 interpol kernel: [43636.220003] mei: unable to register watchdog device.
May 30 09:49:21 interpol kernel: [43636.393494] ata6: SATA link down (SStatus 0 SControl 300)
May 30 09:49:21 interpol kernel: [43636.401478] ata5: SATA link down (SStatus 0 SControl 300)
May 30 09:49:21 interpol kernel: [43636.409472] ata2: SATA link down (SStatus 0 SControl 300)
May 30 09:49:21 interpol kernel: [43636.445525] PM: resume of drv:i915 dev:0000:00:02.0 complete after 382.936 msecs
May 30 09:49:21 interpol kernel: [43637.112248] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
May 30 09:49:21 interpol kernel: [43637.283145] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
May 30 09:49:21 interpol kernel: [43637.283151] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
May 30 09:49:21 interpol kernel: [43637.283155] ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
May 30 09:49:21 interpol kernel: [43637.286813] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
May 30 09:49:21 interpol kernel: [43637.286822] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
May 30 09:49:21 interpol kernel: [43637.286829] ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
May 30 09:49:21 interpol kernel: [43637.288553] ata1.00: configured for UDMA/100
May 30 09:49:21 interpol kernel: [43637.329080] PM: resume of drv:sd dev:0:0:0:0 complete after 1267.394 msecs
May 30 09:49:21 interpol kernel: [43637.329131] PM: resume of drv:scsi_device dev:0:0:0:0 complete after 1267.423 msecs
May 30 09:49:21 interpol kernel: [43637.329146] PM: resume of drv:scsi_disk dev:0:0:0:0 complete after 1223.786 msecs
May 30 09:49:21 interpol kernel: [43637.330330] hdaps: initial mode latch is 0x05
May 30 09:49:21 interpol kernel: [43637.330490] hdaps: setting ec_rate=250, filter_order=2
May 30 09:49:21 interpol kernel: [43637.330729] PM: resume of devices complete after 1269.722 msecs
May 30 09:49:21 interpol kernel: [43637.330824] PM: resume devices took 1.268 seconds
May 30 09:49:21 interpol kernel: [43637.330930] PM: Finishing wakeup.
May 30 09:49:21 interpol kernel: [43637.330931] Restarting tasks ... done.
May 30 09:49:21 interpol kernel: [43637.348087] video LNXVIDEO:00: Restoring backlight state
May 30 09:49:21 interpol acpid: client 967[0:0] has disconnected
May 30 09:49:21 interpol acpid: client connected from 967[0:0]
May 30 09:49:21 interpol acpid: 1 client rule loaded
May 30 09:49:21 interpol kernel: [43637.367456] [drm:drm_mode_getfb] *ERROR* invalid framebuffer id
May 30 09:49:24 interpol anacron[28787]: Anacron 2.3 started on 2012-05-30
May 30 09:49:24 interpol anacron[28787]: Normal exit (0 jobs run)
May 30 09:49:25 interpol kernel: [43641.356923] ehci_hcd 0000:00:1d.0: PCI INT D disabled
May 30 09:49:25 interpol kernel: [43641.356931] ehci_hcd 0000:00:1a.0: PCI INT D disabled
May 30 09:49:25 interpol kernel: [43641.357150] ehci_hcd 0000:00:1a.0: PME# enabled
May 30 09:49:25 interpol kernel: [43641.357162] ehci_hcd 0000:00:1d.0: PME# enabled
May 30 09:49:25 interpol kernel: [43641.372870] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D3
May 30 09:49:25 interpol kernel: [43641.372877] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D3
May 30 09:49:25 interpol kernel: [43641.638150] e1000e 0000:00:19.0: PME# enabled
May 30 09:49:25 interpol NetworkManager[28085]: <info> wake requested (sleeping: yes  enabled: yes)
May 30 09:49:25 interpol NetworkManager[28085]: <info> waking up and re-enabling...
May 30 09:49:25 interpol NetworkManager[28085]: <info> WWAN now enabled by management service
May 30 09:49:25 interpol NetworkManager[28085]: <info> (eth0): now managed
May 30 09:49:25 interpol NetworkManager[28085]: <info> (eth0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
May 30 09:49:25 interpol NetworkManager[28085]: <info> (eth0): bringing up device.
May 30 09:49:25 interpol kernel: [43641.768234] e1000e 0000:00:19.0: BAR 0: set to [mem 0xf2500000-0xf251ffff] (PCI address [0xf2500000-0xf251ffff])
May 30 09:49:25 interpol kernel: [43641.768249] e1000e 0000:00:19.0: BAR 1: set to [mem 0xf2525000-0xf2525fff] (PCI address [0xf2525000-0xf2525fff])
May 30 09:49:25 interpol kernel: [43641.768260] e1000e 0000:00:19.0: BAR 2: set to [io  0x1820-0x183f] (PCI address [0x1820-0x183f])
May 30 09:49:25 interpol kernel: [43641.768292] e1000e 0000:00:19.0: restoring config space at offset 0xf (was 0x100, writing 0x10b)
May 30 09:49:25 interpol kernel: [43641.768329] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107)
May 30 09:49:25 interpol kernel: [43641.768404] e1000e 0000:00:19.0: PME# disabled
May 30 09:49:25 interpol kernel: [43641.872562] e1000e 0000:00:19.0: irq 42 for MSI/MSI-X
May 30 09:49:25 interpol NetworkManager[28085]: <info> (eth0): preparing device.
May 30 09:49:25 interpol NetworkManager[28085]: <info> (eth0): deactivating device (reason 'managed') [2]
May 30 09:49:25 interpol NetworkManager[28085]: <info> Unmanaged Device found; state CONNECTED forced. (see http://bugs.launchpad.net/bugs/191889)
May 30 09:49:25 interpol NetworkManager[28085]: <info> Unmanaged Device found; state CONNECTED forced. (see http://bugs.launchpad.net/bugs/191889)
May 30 09:49:25 interpol NetworkManager[28085]: <info> (wlan0): now managed
May 30 09:49:25 interpol NetworkManager[28085]: <info> (wlan0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
May 30 09:49:25 interpol NetworkManager[28085]: <info> (wlan0): bringing up device.
May 30 09:49:25 interpol kernel: [43641.928089] e1000e 0000:00:19.0: irq 42 for MSI/MSI-X
May 30 09:49:25 interpol kernel: [43641.928749] ADDRCONF(NETDEV_UP): eth0: link is not ready
May 30 09:49:25 interpol kernel: [43641.930626] iwlwifi 0000:02:00.0: L1 Enabled; Disabling L0S
May 30 09:49:25 interpol NetworkManager[28085]: <info> (wlan0): preparing device.
May 30 09:49:25 interpol NetworkManager[28085]: <info> (wlan0): deactivating device (reason 'managed') [2]
May 30 09:49:25 interpol kernel: [43641.998386] ADDRCONF(NETDEV_UP): wlan0: link is not ready
May 30 09:49:25 interpol wpa_supplicant[22422]: Override interface parameter: ctrl_interface ('(null)' -> '/var/run/wpa_supplicant')
May 30 09:49:25 interpol wpa_supplicant[22422]: Initializing interface 'wlan0' conf 'N/A' driver 'nl80211,wext' ctrl_interface '/var/run/wpa_supplicant' bridge 'N/A'
May 30 09:49:25 interpol wpa_supplicant[22422]: netlink: Operstate: linkmode=1, operstate=5
May 30 09:49:25 interpol wpa_supplicant[22422]: Own MAC address: 00:26:c7:66:09:82
May 30 09:49:25 interpol wpa_supplicant[22422]: wpa_driver_nl80211_set_key: ifindex=3 alg=0 addr=0x495e2c key_idx=0 set_tx=0 seq_len=0 key_len=0
May 30 09:49:25 interpol wpa_supplicant[22422]: wpa_driver_nl80211_set_key: ifindex=3 alg=0 addr=0x495e2c key_idx=1 set_tx=0 seq_len=0 key_len=0
May 30 09:49:25 interpol wpa_supplicant[22422]: wpa_driver_nl80211_set_key: ifindex=3 alg=0 addr=0x495e2c key_idx=2 set_tx=0 seq_len=0 key_len=0
May 30 09:49:25 interpol wpa_supplicant[22422]: wpa_driver_nl80211_set_key: ifindex=3 alg=0 addr=0x495e2c key_idx=3 set_tx=0 seq_len=0 key_len=0
May 30 09:49:25 interpol wpa_supplicant[22422]: wpa_driver_nl80211_set_key: ifindex=3 alg=0 addr=0x495e2c key_idx=4 set_tx=0 seq_len=0 key_len=0
May 30 09:49:25 interpol wpa_supplicant[22422]: wpa_driver_nl80211_set_key: ifindex=3 alg=0 addr=0x495e2c key_idx=5 set_tx=0 seq_len=0 key_len=0
May 30 09:49:25 interpol wpa_supplicant[22422]: RSN: flushing PMKID list in the driver
May 30 09:49:25 interpol wpa_supplicant[22422]: State: DISCONNECTED -> INACTIVE
May 30 09:49:25 interpol wpa_supplicant[22422]: EAPOL: SUPP_PAE entering state DISCONNECTED
May 30 09:49:25 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:49:25 interpol wpa_supplicant[22422]: EAPOL: KEY_RX entering state NO_KEY_RECEIVE
May 30 09:49:25 interpol wpa_supplicant[22422]: EAPOL: SUPP_BE entering state INITIALIZE
May 30 09:49:25 interpol wpa_supplicant[22422]: EAP: EAP entering state DISABLED
May 30 09:49:25 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:49:25 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:49:25 interpol wpa_supplicant[22422]: dbus: Register interface object '/fi/w1/wpa_supplicant1/Interfaces/17'
May 30 09:49:25 interpol wpa_supplicant[22422]: Added interface wlan0
May 30 09:49:25 interpol NetworkManager[28085]: <info> (wlan0): supplicant interface state: starting -> ready
May 30 09:49:25 interpol NetworkManager[28085]: <info> (wlan0): device state change: unavailable -> disconnected (reason 'supplicant-available') [20 30 42]
May 30 09:49:25 interpol wpa_supplicant[22422]: no method handler for fi.w1.wpa_supplicant1.Interface.NetworkReply on /fi/w1/wpa_supplicant1/Interfaces/17
May 30 09:49:25 interpol NetworkManager[28085]: <info> (wlan0): supplicant interface state: ready -> inactive
May 30 09:49:25 interpol NetworkManager[28085]: <warn> Trying to remove a non-existant call id.
May 30 09:49:25 interpol wpa_supplicant[22422]: Scan requested (ret=0) - scan timeout 10 seconds
May 30 09:49:25 interpol wpa_supplicant[22422]: nl80211: Event message available
May 30 09:49:25 interpol wpa_supplicant[22422]: nl80211: Scan trigger
May 30 09:49:26 interpol wpa_supplicant[22422]: nl80211: Scan trigger failed: ret=-16 (Device or resource busy)
May 30 09:49:26 interpol wpa_supplicant[22422]: EAPOL: disable timer tick
May 30 09:49:26 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:49:26 interpol kernel: [43643.108604] e1000e 0000:00:19.0: PME# enabled
May 30 09:49:27 interpol wpa_supplicant[22422]: nl80211: Event message available
May 30 09:49:27 interpol wpa_supplicant[22422]: nl80211: New scan results available
May 30 09:49:27 interpol wpa_supplicant[22422]: Received scan results (24 BSSes)
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Start scan result update 1
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 0 BSSID 58:93:96:0b:e1:b8 SSID 'linaroconnect'
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/0'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 1 BSSID 50:a7:33:15:d7:48 SSID 'linaroconnect'
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/1'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 2 BSSID 58:93:96:0b:de:48 SSID 'linaroconnect'
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/2'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 3 BSSID 58:93:96:0b:e6:c8 SSID 'linaroconnect'
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/3'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 4 BSSID 58:93:96:0b:e1:68 SSID 'linaroconnect'
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/4'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 5 BSSID 58:93:96:0b:e1:78 SSID 'linaroconnect'
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/5'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 6 BSSID 58:93:96:0b:e1:58 SSID 'linaroconnect'
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/6'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 7 BSSID 00:02:6f:4e:b3:31 SSID 'linaroconnect'
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/7'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 8 BSSID 00:02:6f:4e:b2:7f SSID 'linaroconnect'
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/8'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 9 BSSID 58:93:96:0b:de:c8 SSID 'linaroconnect'
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/9'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 10 BSSID 00:02:6f:4e:b3:2f SSID 'linaroconnect'
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/10'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 11 BSSID f8:d1:11:be:35:da SSID 'Bree'
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/11'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 12 BSSID 00:02:6f:4e:b2:7d SSID 'linaroconnect'
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/12'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 13 BSSID 58:93:96:4b:e1:b8 SSID ''
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/13'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 14 BSSID 58:93:96:4b:de:48 SSID ''
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/14'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 15 BSSID 50:a7:33:55:d7:48 SSID ''
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/15'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 16 BSSID 58:93:96:4b:e6:c8 SSID ''
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/16'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 17 BSSID 58:93:96:4b:c1:08 SSID ''
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/17'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 18 BSSID 58:93:96:4b:e1:68 SSID ''
May 30 09:49:27 interpol NetworkManager[28085]: <info> Auto-activating connection 'linaroconnect'.
May 30 09:49:27 interpol NetworkManager[28085]: <info> Activation (wlan0) starting connection 'linaroconnect'
May 30 09:49:27 interpol NetworkManager[28085]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
May 30 09:49:27 interpol NetworkManager[28085]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/18'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 19 BSSID 58:93:96:4b:e1:58 SSID ''
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/19'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 20 BSSID 58:93:96:4b:de:c8 SSID ''
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/20'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 21 BSSID 58:93:96:4b:e1:78 SSID ''
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/21'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 22 BSSID 58:93:96:4b:e0:d8 SSID ''
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/22'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 23 BSSID 00:02:6f:b2:03:c0 SSID 'GOLD COAST HOTEL'
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/23'
May 30 09:49:27 interpol wpa_supplicant[22422]: New scan results available
May 30 09:49:27 interpol wpa_supplicant[22422]: No suitable network found
May 30 09:49:27 interpol wpa_supplicant[22422]: State: INACTIVE -> INACTIVE
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17
May 30 09:49:27 interpol wpa_supplicant[22422]: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
May 30 09:49:27 interpol wpa_supplicant[22422]: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
May 30 09:49:27 interpol NetworkManager[28085]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
May 30 09:49:27 interpol NetworkManager[28085]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
May 30 09:49:27 interpol NetworkManager[28085]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
May 30 09:49:27 interpol NetworkManager[28085]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
May 30 09:49:27 interpol NetworkManager[28085]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
May 30 09:49:27 interpol NetworkManager[28085]: <info> Activation (wlan0/wireless): access point 'linaroconnect' has security, but secrets are required.
May 30 09:49:27 interpol NetworkManager[28085]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
May 30 09:49:27 interpol NetworkManager[28085]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
May 30 09:49:27 interpol NetworkManager[28085]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
May 30 09:49:27 interpol NetworkManager[28085]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
May 30 09:49:27 interpol NetworkManager[28085]: <info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
May 30 09:49:27 interpol NetworkManager[28085]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
May 30 09:49:27 interpol NetworkManager[28085]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
May 30 09:49:27 interpol NetworkManager[28085]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
May 30 09:49:27 interpol NetworkManager[28085]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
May 30 09:49:27 interpol NetworkManager[28085]: <info> Activation (wlan0/wireless): connection 'linaroconnect' has security, and secrets exist.  No new secrets needed.
May 30 09:49:27 interpol NetworkManager[28085]: <info> Config: added 'ssid' value 'linaroconnect'
May 30 09:49:27 interpol NetworkManager[28085]: <info> Config: added 'scan_ssid' value '1'
May 30 09:49:27 interpol NetworkManager[28085]: <info> Config: added 'key_mgmt' value 'WPA-PSK'
May 30 09:49:27 interpol NetworkManager[28085]: <info> Config: added 'psk' value '<omitted>'
May 30 09:49:27 interpol NetworkManager[28085]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
May 30 09:49:27 interpol NetworkManager[28085]: <info> Config: set interface ap_scan to 1
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register network object '/fi/w1/wpa_supplicant1/Interfaces/17/Networks/0'
May 30 09:49:27 interpol wpa_supplicant[22422]: Setting scan request: 0 sec 0 usec
May 30 09:49:27 interpol wpa_supplicant[22422]: State: INACTIVE -> SCANNING
May 30 09:49:27 interpol wpa_supplicant[22422]: Starting AP scan for wildcard SSID
May 30 09:49:27 interpol wpa_supplicant[22422]: Scan requested (ret=0) - scan timeout 30 seconds
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17
May 30 09:49:27 interpol wpa_supplicant[22422]: nl80211: Event message available
May 30 09:49:27 interpol wpa_supplicant[22422]: nl80211: Scan trigger
May 30 09:49:27 interpol NetworkManager[28085]: <info> (wlan0): supplicant interface state: inactive -> scanning
May 30 09:49:27 interpol wpa_supplicant[22422]: nl80211: Event message available
May 30 09:49:27 interpol wpa_supplicant[22422]: nl80211: New scan results available
May 30 09:49:27 interpol wpa_supplicant[22422]: Received scan results (28 BSSes)
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Start scan result update 2
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 24 BSSID 58:93:96:0b:c1:08 SSID 'linaroconnect'
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/24'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 25 BSSID f8:d1:11:84:a4:d0 SSID 'TP-LINK_84A4D0'
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/25'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 26 BSSID c8:3a:35:1c:ec:80 SSID ''
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/26'
May 30 09:49:27 interpol wpa_supplicant[22422]: BSS: Add new id 27 BSSID 00:11:6b:1d:9a:ea SSID 'WBR-6010'
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/27'
May 30 09:49:27 interpol wpa_supplicant[22422]: New scan results available
May 30 09:49:27 interpol wpa_supplicant[22422]: Selecting BSS from priority group 0
May 30 09:49:27 interpol wpa_supplicant[22422]: Try to find WPA-enabled AP
May 30 09:49:27 interpol wpa_supplicant[22422]: 0: 58:93:96:0b:e1:b8 ssid='linaroconnect' wpa_ie_len=0 rsn_ie_len=20 caps=0x431
May 30 09:49:27 interpol wpa_supplicant[22422]:    selected based on RSN IE
May 30 09:49:27 interpol wpa_supplicant[22422]:    selected WPA AP 58:93:96:0b:e1:b8 ssid='linaroconnect'
May 30 09:49:27 interpol wpa_supplicant[22422]: Automatic auth_alg selection: 0x1
May 30 09:49:27 interpol wpa_supplicant[22422]: RSN: using IEEE 802.11i/D9.0
May 30 09:49:27 interpol wpa_supplicant[22422]: WPA: Selected cipher suites: group 16 pairwise 16 key_mgmt 2 proto 2
May 30 09:49:27 interpol wpa_supplicant[22422]: WPA: clearing AP WPA IE
May 30 09:49:27 interpol wpa_supplicant[22422]: WPA: using GTK CCMP
May 30 09:49:27 interpol wpa_supplicant[22422]: WPA: using PTK CCMP
May 30 09:49:27 interpol wpa_supplicant[22422]: WPA: using KEY_MGMT WPA-PSK
May 30 09:49:27 interpol wpa_supplicant[22422]: WPA: not using MGMT group cipher
May 30 09:49:27 interpol wpa_supplicant[22422]: Cancelling scan request
May 30 09:49:27 interpol wpa_supplicant[22422]: Trying to authenticate with 58:93:96:0b:e1:b8 (SSID='linaroconnect' freq=2457 MHz)
May 30 09:49:27 interpol wpa_supplicant[22422]: No keys have been configured - skip key clearing
May 30 09:49:27 interpol wpa_supplicant[22422]: State: SCANNING -> AUTHENTICATING
May 30 09:49:27 interpol wpa_supplicant[22422]: EAPOL: External notification - EAP success=0
May 30 09:49:27 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:49:27 interpol wpa_supplicant[22422]: EAPOL: External notification - EAP fail=0
May 30 09:49:27 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:49:27 interpol wpa_supplicant[22422]: EAPOL: External notification - portControl=Auto
May 30 09:49:27 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:49:27 interpol wpa_supplicant[22422]: nl80211: Authenticate (ifindex=3)
May 30 09:49:27 interpol wpa_supplicant[22422]:   * bssid=58:93:96:0b:e1:b8
May 30 09:49:27 interpol wpa_supplicant[22422]:   * freq=2457
May 30 09:49:27 interpol wpa_supplicant[22422]:   * Auth Type 0
May 30 09:49:27 interpol wpa_supplicant[22422]: nl80211: Authentication request send successfully
May 30 09:49:27 interpol wpa_supplicant[22422]: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
May 30 09:49:27 interpol wpa_supplicant[22422]: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/0
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/3
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/4
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/5
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/8
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/10
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/7
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/9
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/6
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/13
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/17
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/18
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/21
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/19
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/20
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/22
May 30 09:49:27 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/23
May 30 09:49:27 interpol NetworkManager[28085]: <info> (wlan0): supplicant interface state: scanning -> authenticating
May 30 09:49:27 interpol kernel: [43644.225212] wlan0: direct probe to 58:93:96:0b:e1:b8 (try 1/3)
May 30 09:49:28 interpol kernel: [43644.423618] wlan0: direct probe to 58:93:96:0b:e1:b8 (try 2/3)
May 30 09:49:28 interpol kernel: [43644.623318] wlan0: direct probe to 58:93:96:0b:e1:b8 (try 3/3)
May 30 09:49:28 interpol kernel: [43644.822922] wlan0: direct probe to 58:93:96:0b:e1:b8 timed out
May 30 09:49:28 interpol wpa_supplicant[22422]: nl80211: Event message available
May 30 09:49:28 interpol wpa_supplicant[22422]: nl80211: MLME event 37; timeout with 58:93:96:0b:e1:b8
May 30 09:49:28 interpol wpa_supplicant[22422]: SME: Authentication timed out
May 30 09:49:28 interpol wpa_supplicant[22422]: Setting scan request: 5 sec 0 usec
May 30 09:49:33 interpol wpa_supplicant[22422]: Starting AP scan for wildcard SSID
May 30 09:49:33 interpol wpa_supplicant[22422]: Scan requested (ret=0) - scan timeout 30 seconds
May 30 09:49:33 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17
May 30 09:49:33 interpol wpa_supplicant[22422]: nl80211: Event message available
May 30 09:49:33 interpol wpa_supplicant[22422]: nl80211: Scan trigger
May 30 09:49:34 interpol wpa_supplicant[22422]: nl80211: Event message available
May 30 09:49:34 interpol wpa_supplicant[22422]: nl80211: New scan results available
May 30 09:49:34 interpol wpa_supplicant[22422]: Received scan results (28 BSSes)
May 30 09:49:34 interpol wpa_supplicant[22422]: BSS: Start scan result update 3
May 30 09:49:34 interpol wpa_supplicant[22422]: New scan results available
May 30 09:49:34 interpol wpa_supplicant[22422]: RSN: Ignored PMKID candidate without preauth flag
May 30 09:49:34  wpa_supplicant[22422]: last message repeated 12 times
May 30 09:49:34 interpol wpa_supplicant[22422]: Selecting BSS from priority group 0
May 30 09:49:34 interpol wpa_supplicant[22422]: Try to find WPA-enabled AP
May 30 09:49:34 interpol wpa_supplicant[22422]: 0: 58:93:96:0b:e1:b8 ssid='linaroconnect' wpa_ie_len=0 rsn_ie_len=20 caps=0x431
May 30 09:49:34 interpol wpa_supplicant[22422]:    selected based on RSN IE
May 30 09:49:34 interpol wpa_supplicant[22422]:    selected WPA AP 58:93:96:0b:e1:b8 ssid='linaroconnect'
May 30 09:49:34 interpol wpa_supplicant[22422]: Automatic auth_alg selection: 0x1
May 30 09:49:34 interpol wpa_supplicant[22422]: RSN: using IEEE 802.11i/D9.0
May 30 09:49:34 interpol wpa_supplicant[22422]: WPA: Selected cipher suites: group 16 pairwise 16 key_mgmt 2 proto 2
May 30 09:49:34 interpol wpa_supplicant[22422]: WPA: clearing AP WPA IE
May 30 09:49:34 interpol wpa_supplicant[22422]: WPA: using GTK CCMP
May 30 09:49:34 interpol wpa_supplicant[22422]: WPA: using PTK CCMP
May 30 09:49:34 interpol wpa_supplicant[22422]: WPA: using KEY_MGMT WPA-PSK
May 30 09:49:34 interpol wpa_supplicant[22422]: WPA: not using MGMT group cipher
May 30 09:49:34 interpol wpa_supplicant[22422]: Cancelling scan request
May 30 09:49:34 interpol wpa_supplicant[22422]: Trying to authenticate with 58:93:96:0b:e1:b8 (SSID='linaroconnect' freq=2457 MHz)
May 30 09:49:34 interpol wpa_supplicant[22422]: No keys have been configured - skip key clearing
May 30 09:49:34 interpol wpa_supplicant[22422]: State: AUTHENTICATING -> AUTHENTICATING
May 30 09:49:34 interpol wpa_supplicant[22422]: EAPOL: External notification - EAP success=0
May 30 09:49:34 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:49:34 interpol wpa_supplicant[22422]: EAPOL: External notification - EAP fail=0
May 30 09:49:34 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:49:34 interpol wpa_supplicant[22422]: EAPOL: External notification - portControl=Auto
May 30 09:49:34 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:49:34 interpol wpa_supplicant[22422]: nl80211: Authenticate (ifindex=3)
May 30 09:49:34 interpol wpa_supplicant[22422]:   * bssid=58:93:96:0b:e1:b8
May 30 09:49:34 interpol wpa_supplicant[22422]:   * freq=2457
May 30 09:49:34 interpol wpa_supplicant[22422]:   * Auth Type 0
May 30 09:49:34 interpol wpa_supplicant[22422]: nl80211: Authentication request send successfully
May 30 09:49:34 interpol wpa_supplicant[22422]: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
May 30 09:49:34 interpol wpa_supplicant[22422]: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
May 30 09:49:34 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17
May 30 09:49:34 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/0
May 30 09:49:34 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/2
May 30 09:49:34 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/24
May 30 09:49:34 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/5
May 30 09:49:34 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/4
May 30 09:49:34 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/7
May 30 09:49:34 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/6
May 30 09:49:34 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/10
May 30 09:49:34 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/13
May 30 09:49:34 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/17
May 30 09:49:34 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/21
May 30 09:49:34 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/22
May 30 09:49:34 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/23
May 30 09:49:34 interpol kernel: [43650.345214] wlan0: direct probe to 58:93:96:0b:e1:b8 (try 1/3)
May 30 09:49:34 interpol kernel: [43650.541132] wlan0: direct probe to 58:93:96:0b:e1:b8 (try 2/3)
May 30 09:49:34 interpol kernel: [43650.740734] wlan0: direct probe to 58:93:96:0b:e1:b8 (try 3/3)
May 30 09:49:34 interpol kernel: [43650.940459] wlan0: direct probe to 58:93:96:0b:e1:b8 timed out
May 30 09:49:34 interpol wpa_supplicant[22422]: nl80211: Event message available
May 30 09:49:34 interpol wpa_supplicant[22422]: nl80211: MLME event 37; timeout with 58:93:96:0b:e1:b8
May 30 09:49:34 interpol wpa_supplicant[22422]: SME: Authentication timed out
May 30 09:49:34 interpol wpa_supplicant[22422]: Setting scan request: 5 sec 0 usec
May 30 09:49:39 interpol wpa_supplicant[22422]: Starting AP scan for wildcard SSID
May 30 09:49:39 interpol wpa_supplicant[22422]: Scan requested (ret=0) - scan timeout 30 seconds
May 30 09:49:39 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17
May 30 09:49:39 interpol wpa_supplicant[22422]: nl80211: Event message available
May 30 09:49:39 interpol wpa_supplicant[22422]: nl80211: Scan trigger
May 30 09:49:40 interpol wpa_supplicant[22422]: nl80211: Event message available
May 30 09:49:40 interpol wpa_supplicant[22422]: nl80211: New scan results available
May 30 09:49:40 interpol wpa_supplicant[22422]: Received scan results (30 BSSes)
May 30 09:49:40 interpol wpa_supplicant[22422]: BSS: Start scan result update 4
May 30 09:49:40 interpol wpa_supplicant[22422]: BSS: Add new id 28 BSSID fc:75:16:1f:bb:e8 SSID 'Sweet Sweet Home'
May 30 09:49:40 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/28'
May 30 09:49:40 interpol wpa_supplicant[22422]: BSS: Add new id 29 BSSID 00:40:5a:5e:80:4a SSID 'U+zone'
May 30 09:49:40 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/29'
May 30 09:49:40 interpol wpa_supplicant[22422]: New scan results available
May 30 09:49:40 interpol wpa_supplicant[22422]: RSN: Ignored PMKID candidate without preauth flag
May 30 09:49:40  wpa_supplicant[22422]: last message repeated 12 times
May 30 09:49:40 interpol wpa_supplicant[22422]: Selecting BSS from priority group 0
May 30 09:49:40 interpol wpa_supplicant[22422]: Try to find WPA-enabled AP
May 30 09:49:40 interpol wpa_supplicant[22422]: 0: 58:93:96:0b:e1:b8 ssid='linaroconnect' wpa_ie_len=0 rsn_ie_len=20 caps=0x431
May 30 09:49:40 interpol wpa_supplicant[22422]:    selected based on RSN IE
May 30 09:49:40 interpol wpa_supplicant[22422]:    selected WPA AP 58:93:96:0b:e1:b8 ssid='linaroconnect'
May 30 09:49:40 interpol wpa_supplicant[22422]: Automatic auth_alg selection: 0x1
May 30 09:49:40 interpol wpa_supplicant[22422]: RSN: using IEEE 802.11i/D9.0
May 30 09:49:40 interpol wpa_supplicant[22422]: WPA: Selected cipher suites: group 16 pairwise 16 key_mgmt 2 proto 2
May 30 09:49:40 interpol wpa_supplicant[22422]: WPA: clearing AP WPA IE
May 30 09:49:40 interpol wpa_supplicant[22422]: WPA: using GTK CCMP
May 30 09:49:40 interpol wpa_supplicant[22422]: WPA: using PTK CCMP
May 30 09:49:40 interpol wpa_supplicant[22422]: WPA: using KEY_MGMT WPA-PSK
May 30 09:49:40 interpol wpa_supplicant[22422]: WPA: not using MGMT group cipher
May 30 09:49:40 interpol wpa_supplicant[22422]: Cancelling scan request
May 30 09:49:40 interpol wpa_supplicant[22422]: Trying to authenticate with 58:93:96:0b:e1:b8 (SSID='linaroconnect' freq=2457 MHz)
May 30 09:49:40 interpol wpa_supplicant[22422]: No keys have been configured - skip key clearing
May 30 09:49:40 interpol wpa_supplicant[22422]: State: AUTHENTICATING -> AUTHENTICATING
May 30 09:49:40 interpol wpa_supplicant[22422]: EAPOL: External notification - EAP success=0
May 30 09:49:40 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:49:40 interpol wpa_supplicant[22422]: EAPOL: External notification - EAP fail=0
May 30 09:49:40 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:49:40 interpol wpa_supplicant[22422]: EAPOL: External notification - portControl=Auto
May 30 09:49:40 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:49:40 interpol wpa_supplicant[22422]: nl80211: Authenticate (ifindex=3)
May 30 09:49:40 interpol wpa_supplicant[22422]:   * bssid=58:93:96:0b:e1:b8
May 30 09:49:40 interpol wpa_supplicant[22422]:   * freq=2457
May 30 09:49:40 interpol wpa_supplicant[22422]:   * Auth Type 0
May 30 09:49:40 interpol wpa_supplicant[22422]: nl80211: Authentication request send successfully
May 30 09:49:40 interpol wpa_supplicant[22422]: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
May 30 09:49:40 interpol wpa_supplicant[22422]: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
May 30 09:49:40 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17
May 30 09:49:40 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/0
May 30 09:49:40 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/2
May 30 09:49:40 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/24
May 30 09:49:40 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/5
May 30 09:49:40 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/4
May 30 09:49:40 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/6
May 30 09:49:40 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/10
May 30 09:49:40 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/13
May 30 09:49:40 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/16
May 30 09:49:40 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/18
May 30 09:49:40 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/21
May 30 09:49:40 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/27
May 30 09:49:40 interpol kernel: [43656.529717] wlan0: direct probe to 58:93:96:0b:e1:b8 (try 1/3)
May 30 09:49:40 interpol kernel: [43656.726475] wlan0: direct probe to 58:93:96:0b:e1:b8 (try 2/3)
May 30 09:49:40 interpol kernel: [43656.926113] wlan0: direct probe to 58:93:96:0b:e1:b8 (try 3/3)
May 30 09:49:40 interpol kernel: [43657.125725] wlan0: direct probe to 58:93:96:0b:e1:b8 timed out
May 30 09:49:40 interpol wpa_supplicant[22422]: nl80211: Event message available
May 30 09:49:40 interpol wpa_supplicant[22422]: nl80211: MLME event 37; timeout with 58:93:96:0b:e1:b8
May 30 09:49:40 interpol wpa_supplicant[22422]: SME: Authentication timed out
May 30 09:49:40 interpol wpa_supplicant[22422]: Setting scan request: 5 sec 0 usec
May 30 09:49:45 interpol wpa_supplicant[22422]: Starting AP scan for wildcard SSID
May 30 09:49:45 interpol wpa_supplicant[22422]: Scan requested (ret=0) - scan timeout 30 seconds
May 30 09:49:45 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17
May 30 09:49:45 interpol wpa_supplicant[22422]: nl80211: Event message available
May 30 09:49:45 interpol wpa_supplicant[22422]: nl80211: Scan trigger
May 30 09:49:46 interpol wpa_supplicant[22422]: nl80211: Event message available
May 30 09:49:46 interpol wpa_supplicant[22422]: nl80211: New scan results available
May 30 09:49:46 interpol wpa_supplicant[22422]: Received scan results (21 BSSes)
May 30 09:49:46 interpol wpa_supplicant[22422]: BSS: Start scan result update 5
May 30 09:49:46 interpol wpa_supplicant[22422]: New scan results available
May 30 09:49:46 interpol wpa_supplicant[22422]: RSN: Ignored PMKID candidate without preauth flag
May 30 09:49:46  wpa_supplicant[22422]: last message repeated 7 times
May 30 09:49:46 interpol wpa_supplicant[22422]: Selecting BSS from priority group 0
May 30 09:49:46 interpol wpa_supplicant[22422]: Try to find WPA-enabled AP
May 30 09:49:46 interpol wpa_supplicant[22422]: 0: 58:93:96:0b:e1:b8 ssid='linaroconnect' wpa_ie_len=0 rsn_ie_len=20 caps=0x431
May 30 09:49:46 interpol wpa_supplicant[22422]:    selected based on RSN IE
May 30 09:49:46 interpol wpa_supplicant[22422]:    selected WPA AP 58:93:96:0b:e1:b8 ssid='linaroconnect'
May 30 09:49:46 interpol wpa_supplicant[22422]: Automatic auth_alg selection: 0x1
May 30 09:49:46 interpol wpa_supplicant[22422]: RSN: using IEEE 802.11i/D9.0
May 30 09:49:46 interpol wpa_supplicant[22422]: WPA: Selected cipher suites: group 16 pairwise 16 key_mgmt 2 proto 2
May 30 09:49:46 interpol wpa_supplicant[22422]: WPA: clearing AP WPA IE
May 30 09:49:46 interpol wpa_supplicant[22422]: WPA: using GTK CCMP
May 30 09:49:46 interpol wpa_supplicant[22422]: WPA: using PTK CCMP
May 30 09:49:46 interpol wpa_supplicant[22422]: WPA: using KEY_MGMT WPA-PSK
May 30 09:49:46 interpol wpa_supplicant[22422]: WPA: not using MGMT group cipher
May 30 09:49:46 interpol wpa_supplicant[22422]: Cancelling scan request
May 30 09:49:46 interpol wpa_supplicant[22422]: Trying to authenticate with 58:93:96:0b:e1:b8 (SSID='linaroconnect' freq=2457 MHz)
May 30 09:49:46 interpol wpa_supplicant[22422]: No keys have been configured - skip key clearing
May 30 09:49:46 interpol wpa_supplicant[22422]: State: AUTHENTICATING -> AUTHENTICATING
May 30 09:49:46 interpol wpa_supplicant[22422]: EAPOL: External notification - EAP success=0
May 30 09:49:46 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:49:46 interpol wpa_supplicant[22422]: EAPOL: External notification - EAP fail=0
May 30 09:49:46 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:49:46 interpol wpa_supplicant[22422]: EAPOL: External notification - portControl=Auto
May 30 09:49:46 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:49:46 interpol wpa_supplicant[22422]: nl80211: Authenticate (ifindex=3)
May 30 09:49:46 interpol wpa_supplicant[22422]:   * bssid=58:93:96:0b:e1:b8
May 30 09:49:46 interpol wpa_supplicant[22422]:   * freq=2457
May 30 09:49:46 interpol wpa_supplicant[22422]:   * Auth Type 0
May 30 09:49:46 interpol wpa_supplicant[22422]: nl80211: Authentication request send successfully
May 30 09:49:46 interpol wpa_supplicant[22422]: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
May 30 09:49:46 interpol wpa_supplicant[22422]: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
May 30 09:49:46 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17
May 30 09:49:46 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/0
May 30 09:49:46 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/24
May 30 09:49:46 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/5
May 30 09:49:46 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/2
May 30 09:49:46 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/7
May 30 09:49:46 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/6
May 30 09:49:46 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/13
May 30 09:49:46 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/14
May 30 09:49:46 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/21
May 30 09:49:46 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/20
May 30 09:49:46 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/22
May 30 09:49:46 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/19
May 30 09:49:46 interpol kernel: [43662.542762] wlan0: direct probe to 58:93:96:0b:e1:b8 (try 1/3)
May 30 09:49:46 interpol kernel: [43662.740012] wlan0: direct probe to 58:93:96:0b:e1:b8 (try 2/3)
May 30 09:49:46 interpol kernel: [43662.939789] wlan0: direct probe to 58:93:96:0b:e1:b8 (try 3/3)
May 30 09:49:46 interpol kernel: [43663.139348] wlan0: direct probe to 58:93:96:0b:e1:b8 timed out
May 30 09:49:46 interpol wpa_supplicant[22422]: nl80211: Event message available
May 30 09:49:46 interpol wpa_supplicant[22422]: nl80211: MLME event 37; timeout with 58:93:96:0b:e1:b8
May 30 09:49:46 interpol wpa_supplicant[22422]: SME: Authentication timed out
May 30 09:49:46 interpol wpa_supplicant[22422]: Setting scan request: 5 sec 0 usec
May 30 09:49:51 interpol wpa_supplicant[22422]: Starting AP scan for wildcard SSID
May 30 09:49:51 interpol wpa_supplicant[22422]: Scan requested (ret=0) - scan timeout 30 seconds
May 30 09:49:51 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17
May 30 09:49:51 interpol wpa_supplicant[22422]: nl80211: Event message available
May 30 09:49:51 interpol wpa_supplicant[22422]: nl80211: Scan trigger
May 30 09:49:52 interpol wpa_supplicant[22422]: nl80211: Event message available
May 30 09:49:52 interpol wpa_supplicant[22422]: nl80211: New scan results available
May 30 09:49:52 interpol wpa_supplicant[22422]: Received scan results (25 BSSes)
May 30 09:49:52 interpol wpa_supplicant[22422]: BSS: Start scan result update 6
May 30 09:49:52 interpol wpa_supplicant[22422]: BSS: Add new id 30 BSSID 00:02:6f:b4:e3:38 SSID 'GOLD COAST HOTEL'
May 30 09:49:52 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/30'
May 30 09:49:52 interpol wpa_supplicant[22422]: BSS: Expire BSS 1 due to no match in scan
May 30 09:49:52 interpol wpa_supplicant[22422]: BSS: Remove id 1 BSSID 50:a7:33:15:d7:48 SSID 'linaroconnect'
May 30 09:49:52 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/1'
May 30 09:49:52 interpol wpa_supplicant[22422]: BSS: Expire BSS 25 due to no match in scan
May 30 09:49:52 interpol wpa_supplicant[22422]: BSS: Remove id 25 BSSID f8:d1:11:84:a4:d0 SSID 'TP-LINK_84A4D0'
May 30 09:49:52 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/25'
May 30 09:49:52 interpol wpa_supplicant[22422]: BSS: Expire BSS 11 due to no match in scan
May 30 09:49:52 interpol wpa_supplicant[22422]: BSS: Remove id 11 BSSID f8:d1:11:be:35:da SSID 'Bree'
May 30 09:49:52 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/11'
May 30 09:49:52 interpol wpa_supplicant[22422]: BSS: Expire BSS 26 due to no match in scan
May 30 09:49:52 interpol wpa_supplicant[22422]: BSS: Remove id 26 BSSID c8:3a:35:1c:ec:80 SSID ''
May 30 09:49:52 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/26'
May 30 09:49:52 interpol wpa_supplicant[22422]: BSS: Expire BSS 15 due to no match in scan
May 30 09:49:52 interpol wpa_supplicant[22422]: BSS: Remove id 15 BSSID 50:a7:33:55:d7:48 SSID ''
May 30 09:49:52 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/15'
May 30 09:49:52 interpol wpa_supplicant[22422]: New scan results available
May 30 09:49:52 interpol wpa_supplicant[22422]: RSN: Ignored PMKID candidate without preauth flag
May 30 09:49:52  wpa_supplicant[22422]: last message repeated 11 times
May 30 09:49:52 interpol wpa_supplicant[22422]: Selecting BSS from priority group 0
May 30 09:49:52 interpol wpa_supplicant[22422]: Try to find WPA-enabled AP
May 30 09:49:52 interpol wpa_supplicant[22422]: 0: 58:93:96:0b:e1:b8 ssid='linaroconnect' wpa_ie_len=0 rsn_ie_len=20 caps=0x431
May 30 09:49:52 interpol wpa_supplicant[22422]:    selected based on RSN IE
May 30 09:49:52 interpol wpa_supplicant[22422]:    selected WPA AP 58:93:96:0b:e1:b8 ssid='linaroconnect'
May 30 09:49:52 interpol wpa_supplicant[22422]: Automatic auth_alg selection: 0x1
May 30 09:49:52 interpol wpa_supplicant[22422]: RSN: using IEEE 802.11i/D9.0
May 30 09:49:52 interpol wpa_supplicant[22422]: WPA: Selected cipher suites: group 16 pairwise 16 key_mgmt 2 proto 2
May 30 09:49:52 interpol wpa_supplicant[22422]: WPA: clearing AP WPA IE
May 30 09:49:52 interpol wpa_supplicant[22422]: WPA: using GTK CCMP
May 30 09:49:52 interpol wpa_supplicant[22422]: WPA: using PTK CCMP
May 30 09:49:52 interpol wpa_supplicant[22422]: WPA: using KEY_MGMT WPA-PSK
May 30 09:49:52 interpol wpa_supplicant[22422]: WPA: not using MGMT group cipher
May 30 09:49:52 interpol wpa_supplicant[22422]: Cancelling scan request
May 30 09:49:52 interpol wpa_supplicant[22422]: Trying to authenticate with 58:93:96:0b:e1:b8 (SSID='linaroconnect' freq=2457 MHz)
May 30 09:49:52 interpol wpa_supplicant[22422]: No keys have been configured - skip key clearing
May 30 09:49:52 interpol wpa_supplicant[22422]: State: AUTHENTICATING -> AUTHENTICATING
May 30 09:49:52 interpol wpa_supplicant[22422]: EAPOL: External notification - EAP success=0
May 30 09:49:52 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:49:52 interpol wpa_supplicant[22422]: EAPOL: External notification - EAP fail=0
May 30 09:49:52 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:49:52 interpol wpa_supplicant[22422]: EAPOL: External notification - portControl=Auto
May 30 09:49:52 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:49:52 interpol wpa_supplicant[22422]: nl80211: Authenticate (ifindex=3)
May 30 09:49:52 interpol wpa_supplicant[22422]:   * bssid=58:93:96:0b:e1:b8
May 30 09:49:52 interpol wpa_supplicant[22422]:   * freq=2457
May 30 09:49:52 interpol wpa_supplicant[22422]:   * Auth Type 0
May 30 09:49:52 interpol wpa_supplicant[22422]: nl80211: Authentication request send successfully
May 30 09:49:52 interpol wpa_supplicant[22422]: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
May 30 09:49:52 interpol wpa_supplicant[22422]: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
May 30 09:49:52 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17
May 30 09:49:52 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/0
May 30 09:49:52 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/2
May 30 09:49:52 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/3
May 30 09:49:52 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/6
May 30 09:49:52 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/4
May 30 09:49:52 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/8
May 30 09:49:52 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/7
May 30 09:49:52 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/9
May 30 09:49:52 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/13
May 30 09:49:52 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/16
May 30 09:49:52 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/17
May 30 09:49:52 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/18
May 30 09:49:52 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/19
May 30 09:49:52 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/20
May 30 09:49:52 interpol kernel: [43668.739127] wlan0: direct probe to 58:93:96:0b:e1:b8 (try 1/3)
May 30 09:49:52 interpol kernel: [43668.937411] wlan0: direct probe to 58:93:96:0b:e1:b8 (try 2/3)
May 30 09:49:52 interpol kernel: [43669.136979] wlan0: direct probe to 58:93:96:0b:e1:b8 (try 3/3)
May 30 09:49:53 interpol kernel: [43669.340641] wlan0: direct probe to 58:93:96:0b:e1:b8 timed out
May 30 09:49:53 interpol wpa_supplicant[22422]: nl80211: Event message available
May 30 09:49:53 interpol wpa_supplicant[22422]: nl80211: MLME event 37; timeout with 58:93:96:0b:e1:b8
May 30 09:49:53 interpol wpa_supplicant[22422]: SME: Authentication timed out
May 30 09:49:53 interpol wpa_supplicant[22422]: Setting scan request: 5 sec 0 usec
May 30 09:49:58 interpol wpa_supplicant[22422]: Starting AP scan for wildcard SSID
May 30 09:49:58 interpol wpa_supplicant[22422]: Scan requested (ret=0) - scan timeout 30 seconds
May 30 09:49:58 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17
May 30 09:49:58 interpol wpa_supplicant[22422]: nl80211: Event message available
May 30 09:49:58 interpol wpa_supplicant[22422]: nl80211: Scan trigger
May 30 09:49:58 interpol wpa_supplicant[22422]: nl80211: Event message available
May 30 09:49:58 interpol wpa_supplicant[22422]: nl80211: New scan results available
May 30 09:49:58 interpol wpa_supplicant[22422]: Received scan results (23 BSSes)
May 30 09:49:58 interpol wpa_supplicant[22422]: BSS: Start scan result update 7
May 30 09:49:58 interpol wpa_supplicant[22422]: BSS: Add new id 31 BSSID 50:a7:33:55:d7:48 SSID ''
May 30 09:49:58 interpol wpa_supplicant[22422]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/31'
May 30 09:49:58 interpol wpa_supplicant[22422]: BSS: Expire BSS 23 due to no match in scan
May 30 09:49:58 interpol wpa_supplicant[22422]: BSS: Remove id 23 BSSID 00:02:6f:b2:03:c0 SSID 'GOLD COAST HOTEL'
May 30 09:49:58 interpol wpa_supplicant[22422]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/17/BSSs/23'
May 30 09:49:58 interpol wpa_supplicant[22422]: New scan results available
May 30 09:49:58 interpol wpa_supplicant[22422]: RSN: Ignored PMKID candidate without preauth flag
May 30 09:49:58  wpa_supplicant[22422]: last message repeated 10 times
May 30 09:49:58 interpol wpa_supplicant[22422]: Selecting BSS from priority group 0
May 30 09:49:58 interpol wpa_supplicant[22422]: Try to find WPA-enabled AP
May 30 09:49:58 interpol wpa_supplicant[22422]: 0: 58:93:96:0b:de:48 ssid='linaroconnect' wpa_ie_len=0 rsn_ie_len=20 caps=0x431
May 30 09:49:58 interpol wpa_supplicant[22422]:    selected based on RSN IE
May 30 09:49:58 interpol wpa_supplicant[22422]:    selected WPA AP 58:93:96:0b:de:48 ssid='linaroconnect'
May 30 09:49:58 interpol wpa_supplicant[22422]: Automatic auth_alg selection: 0x1
May 30 09:49:58 interpol wpa_supplicant[22422]: RSN: using IEEE 802.11i/D9.0
May 30 09:49:58 interpol wpa_supplicant[22422]: WPA: Selected cipher suites: group 16 pairwise 16 key_mgmt 2 proto 2
May 30 09:49:58 interpol wpa_supplicant[22422]: WPA: clearing AP WPA IE
May 30 09:49:58 interpol wpa_supplicant[22422]: WPA: using GTK CCMP
May 30 09:49:58 interpol wpa_supplicant[22422]: WPA: using PTK CCMP
May 30 09:49:58 interpol wpa_supplicant[22422]: WPA: using KEY_MGMT WPA-PSK
May 30 09:49:58 interpol wpa_supplicant[22422]: WPA: not using MGMT group cipher
May 30 09:49:58 interpol wpa_supplicant[22422]: Cancelling scan request
May 30 09:49:58 interpol wpa_supplicant[22422]: Trying to authenticate with 58:93:96:0b:de:48 (SSID='linaroconnect' freq=2412 MHz)
May 30 09:49:58 interpol wpa_supplicant[22422]: No keys have been configured - skip key clearing
May 30 09:49:58 interpol wpa_supplicant[22422]: State: AUTHENTICATING -> AUTHENTICATING
May 30 09:49:58 interpol wpa_supplicant[22422]: EAPOL: External notification - EAP success=0
May 30 09:49:58 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:49:58 interpol wpa_supplicant[22422]: EAPOL: External notification - EAP fail=0
May 30 09:49:58 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:49:58 interpol wpa_supplicant[22422]: EAPOL: External notification - portControl=Auto
May 30 09:49:58 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:49:58 interpol wpa_supplicant[22422]: nl80211: Authenticate (ifindex=3)
May 30 09:49:58 interpol wpa_supplicant[22422]:   * bssid=58:93:96:0b:de:48
May 30 09:49:58 interpol wpa_supplicant[22422]:   * freq=2412
May 30 09:49:58 interpol wpa_supplicant[22422]:   * Auth Type 0
May 30 09:49:58 interpol wpa_supplicant[22422]: nl80211: Authentication request send successfully
May 30 09:49:58 interpol wpa_supplicant[22422]: RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
May 30 09:49:58 interpol wpa_supplicant[22422]: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
May 30 09:49:58 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17
May 30 09:49:58 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/2
May 30 09:49:58 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/24
May 30 09:49:58 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/4
May 30 09:49:58 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/6
May 30 09:49:58 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/5
May 30 09:49:58 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/7
May 30 09:49:58 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/10
May 30 09:49:58 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/9
May 30 09:49:58 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/13
May 30 09:49:58 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/14
May 30 09:49:58 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17/BSSs/19
May 30 09:49:58 interpol wpa_supplicant[22422]: nl80211: Event message available
May 30 09:49:58 interpol wpa_supplicant[22422]: nl80211: MLME event 37
May 30 09:49:58 interpol wpa_supplicant[22422]: SME: Authentication response: peer=58:93:96:0b:de:48 auth_type=0 status_code=0
May 30 09:49:58 interpol wpa_supplicant[22422]: Trying to associate with 58:93:96:0b:de:48 (SSID='linaroconnect' freq=2412 MHz)
May 30 09:49:58 interpol wpa_supplicant[22422]: State: AUTHENTICATING -> ASSOCIATING
May 30 09:49:58 interpol wpa_supplicant[22422]: wpa_driver_nl80211_set_operstate: operstate 0->0 (DORMANT)
May 30 09:49:58 interpol wpa_supplicant[22422]: netlink: Operstate: linkmode=-1, operstate=5
May 30 09:49:58 interpol wpa_supplicant[22422]: nl80211: Associate (ifindex=3)
May 30 09:49:58 interpol wpa_supplicant[22422]:   * bssid=58:93:96:0b:de:48
May 30 09:49:58 interpol wpa_supplicant[22422]:   * freq=2412
May 30 09:49:58 interpol kernel: [43674.928070] wlan0: authenticate with 58:93:96:0b:de:48 (try 1)
May 30 09:49:58 interpol kernel: [43674.929488] wlan0: authenticated
May 30 09:49:58 interpol wpa_supplicant[22422]: nl80211: Association request send successfully
May 30 09:49:58 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17
May 30 09:49:58 interpol NetworkManager[28085]: <info> (wlan0): supplicant interface state: authenticating -> associating
May 30 09:49:58 interpol kernel: [43674.935208] wlan0: associate with 58:93:96:0b:de:48 (try 1)
May 30 09:49:58 interpol wpa_supplicant[22422]: nl80211: Event message available
May 30 09:49:58 interpol wpa_supplicant[22422]: nl80211: Ignored unknown event (cmd=19)
May 30 09:49:58 interpol kernel: [43674.940061] wlan0: RX AssocResp from 58:93:96:0b:de:48 (capab=0x431 status=0 aid=11)
May 30 09:49:58 interpol kernel: [43674.940069] wlan0: associated
May 30 09:49:58 interpol wpa_supplicant[22422]: RX EAPOL from 58:93:96:0b:de:48
May 30 09:49:58 interpol wpa_supplicant[22422]: Not associated - Delay processing of received EAPOL frame
May 30 09:49:58 interpol wpa_supplicant[22422]: nl80211: Event message available
May 30 09:49:58 interpol wpa_supplicant[22422]: nl80211: MLME event 38
May 30 09:49:58 interpol wpa_supplicant[22422]: Association info event
May 30 09:49:58 interpol wpa_supplicant[22422]: freq=2412 MHz
May 30 09:49:58 interpol wpa_supplicant[22422]: State: ASSOCIATING -> ASSOCIATED
May 30 09:49:58 interpol wpa_supplicant[22422]: wpa_driver_nl80211_set_operstate: operstate 0->0 (DORMANT)
May 30 09:49:58 interpol wpa_supplicant[22422]: netlink: Operstate: linkmode=-1, operstate=5
May 30 09:49:58 interpol wpa_supplicant[22422]: Associated to a new BSS: BSSID=58:93:96:0b:de:48
May 30 09:49:58 interpol wpa_supplicant[22422]: No keys have been configured - skip key clearing
May 30 09:49:58 interpol wpa_supplicant[22422]: Associated with 58:93:96:0b:de:48
May 30 09:49:58 interpol wpa_supplicant[22422]: WPA: Association event - clear replay counter
May 30 09:49:58 interpol wpa_supplicant[22422]: WPA: Clear old PTK
May 30 09:49:58 interpol wpa_supplicant[22422]: EAPOL: External notification - portEnabled=0
May 30 09:49:58 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:49:58 interpol wpa_supplicant[22422]: EAPOL: External notification - portValid=0
May 30 09:49:58 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:49:58 interpol wpa_supplicant[22422]: EAPOL: External notification - EAP success=0
May 30 09:49:58 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Unauthorized
May 30 09:49:58 interpol wpa_supplicant[22422]: EAPOL: External notification - portEnabled=1
May 30 09:49:58 interpol wpa_supplicant[22422]: EAPOL: SUPP_PAE entering state CONNECTING
May 30 09:49:58 interpol wpa_supplicant[22422]: EAPOL: enable timer tick
May 30 09:49:58 interpol wpa_supplicant[22422]: EAPOL: SUPP_BE entering state IDLE
May 30 09:49:58 interpol wpa_supplicant[22422]: Setting authentication timeout: 10 sec 0 usec
May 30 09:49:58 interpol wpa_supplicant[22422]: Cancelling scan request
May 30 09:49:58 interpol wpa_supplicant[22422]: Process pending EAPOL frame that was received just before association notification
May 30 09:49:58 interpol wpa_supplicant[22422]: RX EAPOL from 58:93:96:0b:de:48
May 30 09:49:58 interpol wpa_supplicant[22422]: Setting authentication timeout: 10 sec 0 usec
May 30 09:49:58 interpol wpa_supplicant[22422]: IEEE 802.1X RX: version=1 type=3 length=95
May 30 09:49:58 interpol wpa_supplicant[22422]:   EAPOL-Key type=2
May 30 09:49:58 interpol wpa_supplicant[22422]:   key_info 0x8a (ver=2 keyidx=0 rsvd=0 Pairwise Ack)
May 30 09:49:58 interpol wpa_supplicant[22422]:   key_length=16 key_data_length=0
May 30 09:49:58 interpol wpa_supplicant[22422]: State: ASSOCIATED -> 4WAY_HANDSHAKE
May 30 09:49:58 interpol kernel: [43674.951349] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
May 30 09:49:58 interpol wpa_supplicant[22422]: WPA: RX message 1 of 4-Way Handshake from 58:93:96:0b:de:48 (ver=2)
May 30 09:49:58 interpol wpa_supplicant[22422]: WPA: PTK derivation - A1=00:26:c7:66:09:82 A2=58:93:96:0b:de:48
May 30 09:49:58 interpol wpa_supplicant[22422]: WPA: Sending EAPOL-Key 2/4
May 30 09:49:58 interpol wpa_supplicant[22422]: nl80211: Event message available
May 30 09:49:58 interpol wpa_supplicant[22422]: nl80211: Ignore connect event (cmd=46) when using userspace SME
May 30 09:49:58 interpol wpa_supplicant[22422]: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP])
May 30 09:49:58 interpol wpa_supplicant[22422]: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
May 30 09:49:58 interpol wpa_supplicant[22422]: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP])
May 30 09:49:58 interpol wpa_supplicant[22422]: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
May 30 09:49:58 interpol wpa_supplicant[22422]: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP])
May 30 09:49:58 interpol wpa_supplicant[22422]: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
May 30 09:49:58 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17
May 30 09:49:58 interpol NetworkManager[28085]: <info> (wlan0): supplicant interface state: associating -> 4-way handshake
May 30 09:49:58 interpol wpa_supplicant[22422]: RX EAPOL from 58:93:96:0b:de:48
May 30 09:49:58 interpol wpa_supplicant[22422]: IEEE 802.1X RX: version=1 type=3 length=151
May 30 09:49:58 interpol wpa_supplicant[22422]:   EAPOL-Key type=2
May 30 09:49:58 interpol wpa_supplicant[22422]:   key_info 0x13ca (ver=2 keyidx=0 rsvd=0 Pairwise Install Ack MIC Secure Encr)
May 30 09:49:58 interpol wpa_supplicant[22422]:   key_length=16 key_data_length=56
May 30 09:49:58 interpol wpa_supplicant[22422]: State: 4WAY_HANDSHAKE -> 4WAY_HANDSHAKE
May 30 09:49:58 interpol wpa_supplicant[22422]: WPA: RX message 3 of 4-Way Handshake from 58:93:96:0b:de:48 (ver=2)
May 30 09:49:58 interpol wpa_supplicant[22422]: WPA: Sending EAPOL-Key 4/4
May 30 09:49:58 interpol wpa_supplicant[22422]: WPA: Installing PTK to the driver.
May 30 09:49:58 interpol wpa_supplicant[22422]: wpa_driver_nl80211_set_key: ifindex=3 alg=3 addr=0x1de01e0 key_idx=0 set_tx=1 seq_len=6 key_len=16
May 30 09:49:58 interpol wpa_supplicant[22422]:    addr=58:93:96:0b:de:48
May 30 09:49:58 interpol wpa_supplicant[22422]: EAPOL: External notification - portValid=1
May 30 09:49:58 interpol wpa_supplicant[22422]: State: 4WAY_HANDSHAKE -> GROUP_HANDSHAKE
May 30 09:49:58 interpol wpa_supplicant[22422]: WPA: Installing GTK to the driver (keyidx=1 tx=0 len=16).
May 30 09:49:58 interpol wpa_supplicant[22422]: wpa_driver_nl80211_set_key: ifindex=3 alg=3 addr=0x495e2c key_idx=1 set_tx=0 seq_len=6 key_len=16
May 30 09:49:58 interpol wpa_supplicant[22422]: WPA: Key negotiation completed with 58:93:96:0b:de:48 [PTK=CCMP GTK=CCMP]
May 30 09:49:58 interpol wpa_supplicant[22422]: Cancelling authentication timeout
May 30 09:49:58 interpol wpa_supplicant[22422]: State: GROUP_HANDSHAKE -> COMPLETED
May 30 09:49:58 interpol wpa_supplicant[22422]: CTRL-EVENT-CONNECTED - Connection to 58:93:96:0b:de:48 completed (auth) [id=0 id_str=]
May 30 09:49:58 interpol wpa_supplicant[22422]: wpa_driver_nl80211_set_operstate: operstate 0->1 (UP)
May 30 09:49:58 interpol wpa_supplicant[22422]: netlink: Operstate: linkmode=-1, operstate=6
May 30 09:49:58 interpol wpa_supplicant[22422]: EAPOL: External notification - portValid=1
May 30 09:49:58 interpol wpa_supplicant[22422]: EAPOL: External notification - EAP success=1
May 30 09:49:58 interpol wpa_supplicant[22422]: EAPOL: SUPP_PAE entering state AUTHENTICATING
May 30 09:49:58 interpol wpa_supplicant[22422]: EAPOL: SUPP_BE entering state SUCCESS
May 30 09:49:58 interpol wpa_supplicant[22422]: EAP: EAP entering state DISABLED
May 30 09:49:58 interpol wpa_supplicant[22422]: EAPOL: SUPP_PAE entering state AUTHENTICATED
May 30 09:49:58 interpol wpa_supplicant[22422]: EAPOL: Supplicant port status: Authorized
May 30 09:49:58 interpol wpa_supplicant[22422]: EAPOL: SUPP_BE entering state IDLE
May 30 09:49:58 interpol wpa_supplicant[22422]: EAPOL authentication completed successfully
May 30 09:49:58 interpol wpa_supplicant[22422]: RTM_NEWLINK: operstate=1 ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP])
May 30 09:49:58 interpol wpa_supplicant[22422]: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
May 30 09:49:58 interpol wpa_supplicant[22422]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/17
May 30 09:49:58 interpol NetworkManager[28085]: <info> (wlan0): supplicant interface state: 4-way handshake -> completed
May 30 09:49:58 interpol NetworkManager[28085]: <info> Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful.  Connected to wireless network 'linaroconnect'.
May 30 09:49:58 interpol NetworkManager[28085]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled.
May 30 09:49:58 interpol NetworkManager[28085]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) started...
May 30 09:49:58 interpol NetworkManager[28085]: <info> (wlan0): device state change: config -> ip-config (reason 'none') [50 70 0]
May 30 09:49:58 interpol NetworkManager[28085]: <info> Activation (wlan0) Beginning DHCPv4 transaction (timeout in 45 seconds)
May 30 09:49:58 interpol NetworkManager[28085]: <info> dhclient started with pid 29029
May 30 09:49:58 interpol NetworkManager[28085]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete.
May 30 09:49:58 interpol dhclient: Internet Systems Consortium DHCP Client 4.1-ESV-R4
May 30 09:49:58 interpol dhclient: Copyright 2004-2011 Internet Systems Consortium.
May 30 09:49:58 interpol dhclient: All rights reserved.
May 30 09:49:58 interpol dhclient: For info, please visit https://www.isc.org/software/dhcp/
May 30 09:49:58 interpol dhclient: 
May 30 09:49:58 interpol NetworkManager[28085]: <info> (wlan0): DHCPv4 state changed nbi -> preinit
May 30 09:49:58 interpol dhclient: Listening on LPF/wlan0/00:26:c7:66:09:82
May 30 09:49:58 interpol dhclient: Sending on   LPF/wlan0/00:26:c7:66:09:82
May 30 09:49:58 interpol dhclient: Sending on   Socket/fallback
May 30 09:49:58 interpol dhclient: DHCPREQUEST of 10.28.0.41 on wlan0 to 255.255.255.255 port 67
May 30 09:49:59 interpol wpa_supplicant[22422]: EAPOL: startWhen --> 0
May 30 09:49:59 interpol wpa_supplicant[22422]: EAPOL: disable timer tick
May 30 09:50:00 interpol kernel: [43676.587604] iwlwifi 0000:02:00.0: Tx aggregation enabled on ra = 58:93:96:0b:de:48 tid = 0
May 30 09:50:01 interpol dhclient: DHCPREQUEST of 10.28.0.41 on wlan0 to 255.255.255.255 port 67
May 30 09:50:01 interpol dhclient: DHCPACK of 10.28.0.41 from 10.28.0.1
May 30 09:50:01 interpol dhclient: bound to 10.28.0.41 -- renewal in 274604 seconds.
May 30 09:50:01 interpol NetworkManager[28085]: <info> (wlan0): DHCPv4 state changed preinit -> reboot
May 30 09:50:01 interpol NetworkManager[28085]: <info>   address 10.28.0.41
May 30 09:50:01 interpol NetworkManager[28085]: <info>   prefix 21 (255.255.248.0)
May 30 09:50:01 interpol NetworkManager[28085]: <info>   gateway 10.28.0.1
May 30 09:50:01 interpol NetworkManager[28085]: <info>   nameserver '210.0.128.250'
May 30 09:50:01 interpol NetworkManager[28085]: <info>   nameserver '210.0.128.251'
May 30 09:50:01 interpol NetworkManager[28085]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Configure Commit) scheduled...
May 30 09:50:01 interpol NetworkManager[28085]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Commit) started...
May 30 09:50:02 interpol dnsmasq[28487]: exiting on receipt of SIGTERM
May 30 09:50:02 interpol NetworkManager[28085]: <info> DNS: starting dnsmasq...
May 30 09:50:02 interpol NetworkManager[28085]: <info> (wlan0): writing resolv.conf to /sbin/resolvconf
May 30 09:50:02 interpol dnsmasq[29033]: started, version 2.59 cache disabled
May 30 09:50:02 interpol dnsmasq[29033]: compile time options: IPv6 GNU-getopt DBus i18n DHCP TFTP conntrack IDN
May 30 09:50:02 interpol dnsmasq[29033]: using nameserver 210.0.128.251#53
May 30 09:50:02 interpol dnsmasq[29033]: using nameserver 210.0.128.250#53
May 30 09:50:02 interpol NetworkManager[28085]: <info> (wlan0): device state change: ip-config -> activated (reason 'none') [70 100 0]
May 30 09:50:02 interpol NetworkManager[28085]: <info> (wlan0): roamed from BSSID 58:93:96:0B:E1:58 (linaroconnect) to 58:93:96:0B:DE:48 (linaroconnect)
May 30 09:50:02 interpol NetworkManager[28085]: <info> Policy set 'linaroconnect' (wlan0) as default for IPv4 routing and DNS.
May 30 09:50:02 interpol NetworkManager[28085]: <info> Activation (wlan0) successful, device activated.
May 30 09:50:02 interpol NetworkManager[28085]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Commit) complete.
May 30 09:50:02 interpol dbus[779]: [system] Activating service name='org.freedesktop.nm_dispatcher' (using servicehelper)
May 30 09:50:02 interpol dbus[779]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
May 30 09:50:12 interpol ntpdate[29067]: adjust time server 91.189.94.4 offset -0.325886 sec
May 30 09:50:22 interpol wpa_supplicant[22422]: Trying to authenticate with 58:93:96:0b:e1:b8 (SSID='linaroconnect' freq=2457 MHz)
May 30 09:50:22 interpol NetworkManager[28085]: <info> (wlan0): supplicant interface state: completed -> authenticating
May 30 09:50:22 interpol kernel: [43698.235788] wlan0: direct probe to 58:93:96:0b:e1:b8 (try 1/3)
May 30 09:50:22 interpol kernel: [43698.435080] wlan0: direct probe to 58:93:96:0b:e1:b8 (try 2/3)
May 30 09:50:22 interpol kernel: [43698.634947] wlan0: direct probe to 58:93:96:0b:e1:b8 (try 3/3)
May 30 09:50:22 interpol kernel: [43698.834632] wlan0: direct probe to 58:93:96:0b:e1:b8 timed out