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