wpa_supplicant's control socket disappears after suspend (regression?)

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]

 



Hello,

Shortly after wpa_supplicant 2.6 was released, I uploaded it to Debian
experimental and started using it on my work machine (which runs
Ubuntu). I soon noticed I often have no wireless connection upon resume
from suspend, much more often than what I had with either 2.4 or 2.5.
Also, previously wpa_cli scan would reconnect to the network, now it
fails to talk to wpa_supplicant:

Could not connect to wpa_supplicant: (nil) - re-trying

Restarting both wpa_supplicant and network manager often helps, but
drives nm-applet crazy for some reason, and I have to restart it. Until
I restart NM, the interface shows as unmanaged in the applet's menu.

I attempted to run wpa_supplicant manually using the command line from
its .service file and use wpa_cli, and found out it stopped creating the
control socket.

In Debian, we use the following patch by Kel Modderman:

https://sources.debian.net/src/wpa/2.6-1/debian/patches/07_dbus_service_syslog.patch/

Unfortunately, when I prepared 2.6-1 upload, I dropped the description
by mistake, here is it:

Description: Tweak D-Bus/systemd service activation configuration files:
 * log wpa_supplicant messages to syslog
 * activate control socket interface so that wpa_cli can be used by
   D-Bus activated wpa_supplicant daemon

I ran wpa_supplicant with this command line and a couple of -d appended,
attempted wpa_cli again, and again it failed, as there was nothing at
/run/wpa_supplicant.

Then I restarted network-manager and saw this in the logs:

Nov 16 10:16:46 nuevo NetworkManager[20514]: <debug> [1479287806.1988]
supplicant: (wlan0): creating new supplicant interface
Nov 16 10:16:46 nuevo kernel: IPv6: ADDRCONF(NETDEV_UP): wlan0: link is
not ready
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: dbus:
org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1) [s]
Nov 16 10:16:46 nuevo NetworkManager[20514]: <info>  [1479287806.2739]
supplicant: wpa_supplicant running
Nov 16 10:16:46 nuevo NetworkManager[20514]: <debug> [1479287806.2740]
sup-iface[0x18b18c0,wlan0]: adding interface to supplicant
Nov 16 10:16:46 nuevo NetworkManager[20514]: <info>  [1479287806.2740]
device (wlan0): supplicant interface state: init -> starting
Nov 16 10:16:46 nuevo NetworkManager[20514]: <debug> [1479287806.2740]
supplicant: AP mode is supported
Nov 16 10:16:46 nuevo NetworkManager[20514]: <debug> [1479287806.2741]
supplicant: EAP-FAST is not supported
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: dbus:
fi.w1.wpa_supplicant1.CreateInterface (/fi/w1/wpa_supplicant1) [a{sv}]
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wpa_dbus_dict_open_read:
start reading a dict entry
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wpa_dbus_dict_get_entry:
dict entry key: Driver
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wpa_dbus_dict_get_entry:
dict entry variant content type: s
Nov 16 10:16:46 nuevo wpa_supplicant[20507]:
_wpa_dbus_dict_fill_value_from_variant: string value: [omitted]
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wpa_dbus_dict_get_entry:
dict entry key: Ifname
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wpa_dbus_dict_get_entry:
dict entry variant content type: s
Nov 16 10:16:46 nuevo wpa_supplicant[20507]:
_wpa_dbus_dict_fill_value_from_variant: string value: [omitted]
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: Override interface
parameter: ctrl_interface ('(null)' -> '/run/wpa_supplicant')
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: Initializing interface
'wlan0' conf 'N/A' driver 'nl80211,wext' ctrl_interface
'/run/wpa_supplicant' bridge 'N/A'

(the full unwrapped log is in the attachment)

So somehow NM enables the control socket, but until NM prods
wpa_supplicant in some magic way, wpa_supplicant doesn't think it's
necessary to create it.

Are we doing something wrong in Debian, am I doing something wrong when
investigating, or is it a regression?

Thanks in advance.

-- 
Cheers,
  Andrew


Nov 16 03:21:13 nuevo wpa_supplicant[15173]: wlan0: WPA: Group rekeying completed with 04:f0:21:24:13:47 [GTK=TKIP]
Nov 16 03:31:13 nuevo wpa_supplicant[15173]: wlan0: WPA: Group rekeying completed with 04:f0:21:24:13:47 [GTK=TKIP]
Nov 16 03:36:33 nuevo wpa_supplicant[15173]: wlan0: CTRL-EVENT-DISCONNECTED bssid=04:f0:21:24:13:47 reason=3 locally_generated=1
Nov 16 03:36:34 nuevo wpa_supplicant[15173]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD
[suspend]
[resume]
Nov 16 10:09:50 nuevo NetworkManager[19081]: <warn>  [1479287390.0287] sup-iface[0x1ffc8a0,wlan0]: connection disconnected (reason -3)
Nov 16 10:09:50 nuevo NetworkManager[19081]: <info>  [1479287390.0310] device (wlan0): supplicant interface state: completed -> disconnected
Nov 16 10:09:50 nuevo NetworkManager[19081]: <info>  [1479287390.0597] device (wlan0): supplicant interface state: disconnected -> disabled
Nov 16 10:09:50 nuevo NetworkManager[19081]: <info>  [1479287390.0603] device (wlan0): supplicant interface state: disabled -> disconnected
Nov 16 10:09:50 nuevo NetworkManager[19081]: <info>  [1479287390.3806] device (wlan0): supplicant interface state: disconnected -> disabled
Nov 16 10:09:50 nuevo NetworkManager[19081]: <info>  [1479287390.3813] device (wlan0): supplicant interface state: disabled -> disconnected
Nov 16 10:09:50 nuevo wpa_supplicant[15173]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0
Nov 16 10:12:38 nuevo NetworkManager[19081]: <info>  [1479287558.8383] supplicant: wpa_supplicant stopped
Nov 16 10:12:38 nuevo wpa_supplicant[20369]: Successfully initialized wpa_supplicant
Nov 16 10:12:38 nuevo NetworkManager[19081]: <info>  [1479287558.8903] supplicant: wpa_supplicant running
Nov 16 10:12:38 nuevo NetworkManager[19081]: <debug> [1479287558.8904] supplicant: AP mode is supported
Nov 16 10:12:38 nuevo NetworkManager[19081]: <debug> [1479287558.8904] supplicant: EAP-FAST is not supported
Nov 16 10:12:43 nuevo NetworkManager[19081]: <info>  [1479287563.8346] supplicant: wpa_supplicant stopped
Nov 16 10:12:43 nuevo wpa_supplicant[20374]: Successfully initialized wpa_supplicant
Nov 16 10:12:43 nuevo NetworkManager[19081]: <info>  [1479287563.8645] supplicant: wpa_supplicant running
Nov 16 10:12:43 nuevo NetworkManager[19081]: <debug> [1479287563.8646] supplicant: AP mode is supported
Nov 16 10:12:43 nuevo NetworkManager[19081]: <debug> [1479287563.8646] supplicant: EAP-FAST is not supported
Nov 16 10:12:54 nuevo NetworkManager[19081]: <info>  [1479287574.3795] supplicant: wpa_supplicant die count reset
Nov 16 10:12:59 nuevo NetworkManager[19081]: <info>  [1479287579.9250] supplicant: wpa_supplicant stopped
Nov 16 10:13:02 nuevo wpa_supplicant[20385]: Successfully initialized wpa_supplicant
Nov 16 10:13:02 nuevo NetworkManager[19081]: <info>  [1479287582.9783] supplicant: wpa_supplicant running
Nov 16 10:13:02 nuevo NetworkManager[19081]: <debug> [1479287582.9784] supplicant: AP mode is supported
Nov 16 10:13:02 nuevo NetworkManager[19081]: <debug> [1479287582.9784] supplicant: EAP-FAST is not supported
Nov 16 10:13:10 nuevo NetworkManager[19081]: <info>  [1479287590.3760] supplicant: wpa_supplicant die count reset
Nov 16 10:14:11 nuevo NetworkManager[19081]: <info>  [1479287651.4959] supplicant: wpa_supplicant stopped
Nov 16 10:14:21 nuevo NetworkManager[19081]: <info>  [1479287661.3767] supplicant: wpa_supplicant die count reset
Nov 16 10:14:57 nuevo wpa_supplicant[20488]: wpa_supplicant v2.6
Nov 16 10:14:57 nuevo wpa_supplicant[20488]: random: Trying to read entropy from /dev/random
Nov 16 10:14:57 nuevo wpa_supplicant[20488]: dbus: Register D-Bus object '/fi/w1/wpa_supplicant1'
Nov 16 10:14:57 nuevo wpa_supplicant[20488]: Providing DBus service 'fi.w1.wpa_supplicant1'.
Nov 16 10:14:57 nuevo wpa_supplicant[20488]: Providing DBus service 'fi.epitest.hostap.WPASupplicant'.
Nov 16 10:14:57 nuevo wpa_supplicant[20488]: Successfully initialized wpa_supplicant
Nov 16 10:14:57 nuevo NetworkManager[19081]: <info>  [1479287697.3882] supplicant: wpa_supplicant running
Nov 16 10:14:57 nuevo wpa_supplicant[20488]: random: Got 20/20 bytes from /dev/random
Nov 16 10:14:57 nuevo NetworkManager[19081]: <debug> [1479287697.3882] supplicant: AP mode is supported
Nov 16 10:14:57 nuevo NetworkManager[19081]: <debug> [1479287697.3883] supplicant: EAP-FAST is not supported
Nov 16 10:15:02 nuevo wpa_supplicant[20488]: dbus: Unregister D-Bus object '/fi/w1/wpa_supplicant1'
Nov 16 10:15:02 nuevo NetworkManager[19081]: <info>  [1479287702.0214] supplicant: wpa_supplicant stopped
Nov 16 10:15:04 nuevo wpa_supplicant[20489]: wpa_supplicant v2.6
Nov 16 10:15:04 nuevo wpa_supplicant[20489]: random: Trying to read entropy from /dev/random
Nov 16 10:15:04 nuevo wpa_supplicant[20489]: dbus: Register D-Bus object '/fi/w1/wpa_supplicant1'
Nov 16 10:15:04 nuevo wpa_supplicant[20489]: Providing DBus service 'fi.w1.wpa_supplicant1'.
Nov 16 10:15:04 nuevo wpa_supplicant[20489]: Providing DBus service 'fi.epitest.hostap.WPASupplicant'.
Nov 16 10:15:04 nuevo wpa_supplicant[20489]: Successfully initialized wpa_supplicant
Nov 16 10:15:04 nuevo wpa_supplicant[20489]: random: Got 20/20 bytes from /dev/random
Nov 16 10:15:04 nuevo wpa_supplicant[20489]: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1) [s]
Nov 16 10:15:04 nuevo NetworkManager[19081]: <info>  [1479287704.0525] supplicant: wpa_supplicant running
Nov 16 10:15:04 nuevo NetworkManager[19081]: <debug> [1479287704.0526] supplicant: AP mode is supported
Nov 16 10:15:04 nuevo NetworkManager[19081]: <debug> [1479287704.0526] supplicant: EAP-FAST is not supported
Nov 16 10:15:12 nuevo NetworkManager[19081]: <info>  [1479287712.3777] supplicant: wpa_supplicant die count reset
Nov 16 10:16:01 nuevo wpa_supplicant[20489]: dbus: Unregister D-Bus object '/fi/w1/wpa_supplicant1'
Nov 16 10:16:01 nuevo NetworkManager[19081]: <info>  [1479287761.8361] supplicant: wpa_supplicant stopped
Nov 16 10:16:12 nuevo NetworkManager[19081]: <info>  [1479287772.3832] supplicant: wpa_supplicant die count reset
Nov 16 10:16:17 nuevo wpa_supplicant[20507]: wpa_supplicant v2.6
Nov 16 10:16:17 nuevo wpa_supplicant[20507]: random: Trying to read entropy from /dev/random
Nov 16 10:16:17 nuevo wpa_supplicant[20507]: dbus: Register D-Bus object '/fi/w1/wpa_supplicant1'
Nov 16 10:16:17 nuevo wpa_supplicant[20507]: Providing DBus service 'fi.w1.wpa_supplicant1'.
Nov 16 10:16:17 nuevo wpa_supplicant[20507]: Providing DBus service 'fi.epitest.hostap.WPASupplicant'.
Nov 16 10:16:17 nuevo wpa_supplicant[20507]: Successfully initialized wpa_supplicant
Nov 16 10:16:17 nuevo wpa_supplicant[20507]: random: Got 20/20 bytes from /dev/random
Nov 16 10:16:17 nuevo NetworkManager[19081]: <info>  [1479287777.3267] supplicant: wpa_supplicant running
Nov 16 10:16:17 nuevo wpa_supplicant[20507]: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1) [s]
Nov 16 10:16:17 nuevo NetworkManager[19081]: <debug> [1479287777.3267] supplicant: AP mode is supported
Nov 16 10:16:17 nuevo NetworkManager[19081]: <debug> [1479287777.3267] supplicant: EAP-FAST is not supported
Nov 16 10:16:45 nuevo NetworkManager[20514]: <debug> [1479287805.4081] genl_ctrl_resolve: resolved "nl80211" as 0x1b
Nov 16 10:16:45 nuevo NetworkManager[20514]: <debug> [1479287805.4085] Don't know the meaning of NL80211_ATTR_CIPHER_SUITE 0x000fac0a.
Nov 16 10:16:45 nuevo NetworkManager[20514]: <debug> [1479287805.4086] Don't know the meaning of NL80211_ATTR_CIPHER_SUITE 0x000fac09.
Nov 16 10:16:45 nuevo NetworkManager[20514]: <info>  [1479287805.4086] (wlan0): using nl80211 for WiFi device control
Nov 16 10:16:45 nuevo NetworkManager[20514]: <info>  [1479287805.4088] device (wlan0): driver supports Access Point (AP) mode
Nov 16 10:16:45 nuevo NetworkManager[20514]: <debug> [1479287805.4091] device[0x16ac920] (wlan0): device now enabled
Nov 16 10:16:45 nuevo NetworkManager[20514]: <debug> [1479287805.4091] device[0x16ac920] (wlan0): (enable): device blocked by UNMANAGED state
Nov 16 10:16:46 nuevo NetworkManager[20514]: <debug> [1479287806.1988] supplicant: (wlan0): creating new supplicant interface
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1) [s]
Nov 16 10:16:46 nuevo NetworkManager[20514]: <info>  [1479287806.2739] supplicant: wpa_supplicant running
Nov 16 10:16:46 nuevo NetworkManager[20514]: <debug> [1479287806.2740] sup-iface[0x18b18c0,wlan0]: adding interface to supplicant
Nov 16 10:16:46 nuevo NetworkManager[20514]: <info>  [1479287806.2740] device (wlan0): supplicant interface state: init -> starting
Nov 16 10:16:46 nuevo NetworkManager[20514]: <debug> [1479287806.2740] supplicant: AP mode is supported
Nov 16 10:16:46 nuevo NetworkManager[20514]: <debug> [1479287806.2741] supplicant: EAP-FAST is not supported
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: dbus: fi.w1.wpa_supplicant1.CreateInterface (/fi/w1/wpa_supplicant1) [a{sv}]
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wpa_dbus_dict_open_read: start reading a dict entry
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wpa_dbus_dict_get_entry: dict entry key: Driver
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wpa_dbus_dict_get_entry: dict entry variant content type: s
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: _wpa_dbus_dict_fill_value_from_variant: string value: [omitted]
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wpa_dbus_dict_get_entry: dict entry key: Ifname
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wpa_dbus_dict_get_entry: dict entry variant content type: s
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: _wpa_dbus_dict_fill_value_from_variant: string value: [omitted]
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: Override interface parameter: ctrl_interface ('(null)' -> '/run/wpa_supplicant')
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: Initializing interface 'wlan0' conf 'N/A' driver 'nl80211,wext' ctrl_interface '/run/wpa_supplicant' bridge 'N/A'
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Supported cipher 00-0f-ac:1
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Supported cipher 00-0f-ac:5
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Supported cipher 00-0f-ac:2
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Supported cipher 00-0f-ac:4
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Supported cipher 00-0f-ac:10
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Supported cipher 00-0f-ac:8
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Supported cipher 00-0f-ac:9
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Using driver-based off-channel TX
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Driver-advertised extended capabilities (default) - hexdump(len=8): 00 00 00 00 00 00 00 40
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Driver-advertised extended capabilities mask (default) - hexdump(len=8): 00 00 00 00 00 00 00 40
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: interface wlan0 in phy phy0
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Set mode ifindex 3 iftype 2 (STATION)
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Subscribe to mgmt frames with non-AP handle 0x55e612605350
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x55e612605350 match=040a
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x55e612605350 match=040b
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x55e612605350 match=040c
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x55e612605350 match=040d
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x55e612605350 match=090a
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x55e612605350 match=090b
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x55e612605350 match=090c
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x55e612605350 match=090d
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x55e612605350 match=0409506f9a09
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x55e612605350 match=7f506f9a09
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x55e612605350 match=0801
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x55e612605350 match=06
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x55e612605350 match=0a07
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x55e612605350 match=0a11
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x55e612605350 match=1101
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x55e612605350 match=1102
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x55e612605350 match=0505
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Register frame type=0xd0 (WLAN_FC_STYPE_ACTION) nl_handle=0x55e612605350 match=0500
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: rfkill: initial event: idx=2 type=1 op=0 soft=0 hard=0
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: netlink: Operstate: ifindex=3 linkmode=1 (userspace-control), operstate=5 (IF_OPER_DORMANT)
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: Add interface wlan0 to a new radio phy0
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Regulatory information - country=00
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: 2402-2472 @ 40 MHz 20 mBm
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: 2457-2482 @ 40 MHz 20 mBm (no IR)
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: 2474-2494 @ 20 MHz 20 mBm (no OFDM) (no IR)
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: 5170-5250 @ 80 MHz 20 mBm (no IR)
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: 5250-5330 @ 80 MHz 20 mBm (DFS) (no IR)
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: 5490-5730 @ 160 MHz 20 mBm (DFS) (no IR)
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: 5735-5835 @ 80 MHz 20 mBm (no IR)
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: 57240-63720 @ 2160 MHz 0 mBm
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Added 802.11b mode based on 802.11g information
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wlan0: Own MAC address: d2:b1:fe:9d:60:bd
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wpa_driver_nl80211_set_key: ifindex=3 (wlan0) alg=0 addr=(nil) key_idx=0 set_tx=0 seq_len=0 key_len=0
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wpa_driver_nl80211_set_key: ifindex=3 (wlan0) alg=0 addr=(nil) key_idx=1 set_tx=0 seq_len=0 key_len=0
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wpa_driver_nl80211_set_key: ifindex=3 (wlan0) alg=0 addr=(nil) key_idx=2 set_tx=0 seq_len=0 key_len=0
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wpa_driver_nl80211_set_key: ifindex=3 (wlan0) alg=0 addr=(nil) key_idx=3 set_tx=0 seq_len=0 key_len=0
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wpa_driver_nl80211_set_key: ifindex=3 (wlan0) alg=0 addr=(nil) key_idx=4 set_tx=0 seq_len=0 key_len=0
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wpa_driver_nl80211_set_key: ifindex=3 (wlan0) alg=0 addr=(nil) key_idx=5 set_tx=0 seq_len=0 key_len=0
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wlan0: RSN: flushing PMKID list in the driver
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Flush PMKIDs
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wlan0: State: DISCONNECTED -> INACTIVE
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: TDLS: TDLS operation not supported by driver
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: TDLS: Driver uses internal link setup
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: TDLS: Driver does not support TDLS channel switching
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wlan0: WPS: UUID based on MAC address: 9e0c25de-5a87-5d67-a5e0-db55d5956fd4
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: ENGINE: Loading dynamic engine
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: ENGINE: Loading dynamic engine
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: EAPOL: SUPP_PAE entering state DISCONNECTED
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: EAPOL: Supplicant port status: Unauthorized
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Skip set_supp_port(unauthorized) while not associated
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: EAPOL: KEY_RX entering state NO_KEY_RECEIVE
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: EAPOL: SUPP_BE entering state INITIALIZE
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: EAP: EAP entering state DISABLED
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: dbus: Register interface object '/fi/w1/wpa_supplicant1/Interfaces/1'
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wlan0: Added interface wlan0
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wlan0: State: INACTIVE -> DISCONNECTED
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Set wlan0 operstate 0->0 (DORMANT)
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: netlink: Operstate: ifindex=3 linkmode=-1 (no change), operstate=5 (IF_OPER_DORMANT)
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: RTM_NEWLINK: ifi_index=3 ifname=wlan0 operstate=2 linkmode=1 ifi_family=0 ifi_flags=0x1003 ([UP])
Nov 16 10:16:46 nuevo NetworkManager[20514]: <debug> [1479287806.4071] sup-iface[0x18b18c0,wlan0]: interface added to supplicant
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: dbus: org.freedesktop.DBus.Properties.GetAll (/fi/w1/wpa_supplicant1/Interfaces/1) [s]
Nov 16 10:16:46 nuevo NetworkManager[20514]: <info>  [1479287806.4125] sup-iface[0x18b18c0,wlan0]: supports 5 scan SSIDs
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: dbus: org.freedesktop.DBus.Properties.Set (/fi/w1/wpa_supplicant1/Interfaces/1) [ssv]
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: properties_get_or_set: Set(BSSExpireAge)
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wlan0: Setting bss expiration age: 250 sec
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: dbus: org.freedesktop.DBus.Properties.Set (/fi/w1/wpa_supplicant1/Interfaces/1) [ssv]
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: properties_get_or_set: Set(BSSExpireCount)
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wlan0: Setting bss expiration scan count: 2
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: dbus: fi.w1.wpa_supplicant1.Interface.NetworkReply (/fi/w1/wpa_supplicant1/Interfaces/1) [oss]
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: dbus: org.freedesktop.DBus.Introspectable.Introspect (/fi/w1/wpa_supplicant1/Interfaces/1) []
Nov 16 10:16:46 nuevo NetworkManager[20514]: <debug> [1479287806.4208] sup-iface[0x18b18c0,wlan0]: supplicant supports network credentials requests
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: dbus: org.freedesktop.DBus.Properties.Set (/fi/w1/wpa_supplicant1/Interfaces/1) [ssv]
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: properties_get_or_set: Set(PreassocMacAddr)
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: preassoc_mac_addr=0
Nov 16 10:16:46 nuevo NetworkManager[20514]: <info>  [1479287806.4355] device (wlan0): supplicant interface state: starting -> ready
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: RTM_NEWLINK: ifi_index=3 ifname=wlan0 operstate=2 linkmode=1 ifi_family=0 ifi_flags=0x1003 ([UP])
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: dbus: fi.w1.wpa_supplicant1.Interface.Scan (/fi/w1/wpa_supplicant1/Interfaces/1) [a{sv}]
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wlan0: Add radio work 'scan'@0x55e61262c060
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wlan0: First radio work item in the queue - schedule start immediately
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wlan0: Starting radio work 'scan'@0x55e61262c060 after 0.000113 second wait
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wlan0: nl80211: scan request
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: Scan requested (ret=0) - scan timeout 10 seconds
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: dbus: flush_object_timeout_handler: Timeout - sending changed properties of object /fi/w1/wpa_supplicant1/Interfaces/1
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Event message available
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: nl80211: Drv Event 33 (NL80211_CMD_TRIGGER_SCAN) received for wlan0
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wlan0: nl80211: Scan trigger
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wlan0: Event SCAN_STARTED (47) received
Nov 16 10:16:46 nuevo wpa_supplicant[20507]: wlan0: Own scan request started a scan in 0.000110 seconds
Nov 16 10:16:47 nuevo wpa_supplicant[20507]: EAPOL: disable timer tick
Nov 16 10:16:49 nuevo wpa_supplicant[20507]: dbus: fi.w1.wpa_supplicant1.Interface.Scan (/fi/w1/wpa_supplicant1/Interfaces/1) [a{sv}]
Nov 16 10:16:49 nuevo wpa_supplicant[20507]: wlan0: Reject scan trigger since one is already pending
Nov 16 10:16:49 nuevo NetworkManager[20514]: <debug> [1479287809.3792] sup-iface[0x18b18c0,wlan0]: could not get scan request result: GDBus.Error:fi.w1.wpa_supplicant1.Interface.ScanError: Scan request rejected
Nov 16 10:16:49 nuevo wpa_supplicant[20507]: nl80211: Event message available
Nov 16 10:16:49 nuevo wpa_supplicant[20507]: nl80211: Drv Event 34 (NL80211_CMD_NEW_SCAN_RESULTS) received for wlan0
Nov 16 10:16:49 nuevo wpa_supplicant[20507]: wlan0: nl80211: New scan results available
Nov 16 10:16:49 nuevo wpa_supplicant[20507]: nl80211: Scan probed for SSID ''
Nov 16 10:16:49 nuevo wpa_supplicant[20507]: nl80211: Scan included frequencies: 2412 2417 2422 2427 2432 2437 2442 2447 2452 2457 2462 2467 2472 5180 5200 5220 5240 5260 5280 5300 5320 5500 5520 5540 5560 5580 5600 5620 5640 5660 5680 5700 5745 5765 5785 5805 5825
Nov 16 10:16:49 nuevo wpa_supplicant[20507]: wlan0: Event SCAN_RESULTS (3) received
Nov 16 10:16:49 nuevo wpa_supplicant[20507]: wlan0: Scan completed in 3.215993 seconds
Nov 16 10:16:49 nuevo wpa_supplicant[20507]: nl80211: Received scan results (8 BSSes)
[snip]

Attachment: signature.asc
Description: OpenPGP digital signature

_______________________________________________
Hostap mailing list
Hostap@xxxxxxxxxxxxxxxxxxx
http://lists.infradead.org/mailman/listinfo/hostap

[Index of Archives]     [Linux Wireless]     [Linux Kernel]     [ATH6KL]     [Linux Bluetooth]     [Linux Netdev]     [Kernel Newbies]     [IDE]     [Security]     [Git]     [Netfilter]     [Bugtraq]     [Yosemite News]     [MIPS Linux]     [ARM Linux]     [Linux Security]     [Linux RAID]     [Linux ATA RAID]     [Samba]     [Device Mapper]

  Powered by Linux