You are not logged in.
- Topics: Active | Unanswered
#1 2015-05-26 01:58:25
- jb.1234abcd
- Member
- Registered: 2013-10-14
- Posts: 45
wireless con failure - rt2800usb, wpa_supplicant, or AP problem ?
Could anybody review this con session log ?
I myself have the impression that wpa_supplicant is doing some funny dance - why the repeated authentications for the same AP (SME ... CTRL-EVENT-CONNECTED actions).
$ lsusb
Bus 004 Device 003: ID 148f:5372 Ralink Technology, Corp. RT5372 Wireless Adapter
$ dmesg |grep rt28
[Mon May 25 20:34:01 2015] usbcore: registered new interface driver rt2800usb
[Mon May 25 20:34:02 2015] rt2800usb 4-2:1.0 wlp0s29f7u2: renamed from wlan1
$ rfkill list
0: tpacpi_bluetooth_sw: Bluetooth
Soft blocked: no
Hard blocked: no
1: phy0: Wireless LAN
Soft blocked: no
Hard blocked: no
2: hci0: Bluetooth
Soft blocked: no
Hard blocked: no
3: phy1: Wireless LAN
Soft blocked: no
Hard blocked: no
$ journalctl -f
...
May 23 10:44:14 myhost NetworkManager[224]: <info> (wlp0s29f7u2): supplicant interface state: completed -> disconnected
May 23 10:44:14 myhost dbus[230]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
May 23 10:44:14 myhost systemd[1]: Started Network Manager Script Dispatcher Service.
May 23 10:45:02 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: starting connection 'Studio 6'
May 23 10:45:02 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 1 of 5 (Device Prepare) scheduled...
May 23 10:45:02 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 1 of 5 (Device Prepare) started...
May 23 10:45:02 myhost NetworkManager[224]: <info> (wlp0s29f7u2): device state change: disconnected -> prepare (reason 'none') [30 40 0]
May 23 10:45:02 myhost NetworkManager[224]: <info> NetworkManager state is now CONNECTING
May 23 10:45:02 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 2 of 5 (Device Configure) scheduled...
May 23 10:45:02 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 1 of 5 (Device Prepare) complete.
May 23 10:45:02 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 2 of 5 (Device Configure) starting...
May 23 10:45:02 myhost NetworkManager[224]: <info> (wlp0s29f7u2): device state change: prepare -> config (reason 'none') [40 50 0]
May 23 10:45:02 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: (wifi) connection 'Studio 6' requires no security. No secrets needed.
May 23 10:45:02 myhost NetworkManager[224]: <info> Config: added 'ssid' value 'Studio 6'
May 23 10:45:02 myhost NetworkManager[224]: <info> Config: added 'scan_ssid' value '1'
May 23 10:45:02 myhost NetworkManager[224]: <info> Config: added 'key_mgmt' value 'NONE'
May 23 10:45:02 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 2 of 5 (Device Configure) complete.
May 23 10:45:02 myhost NetworkManager[224]: <info> Config: set interface ap_scan to 1
May 23 10:45:02 myhost NetworkManager[224]: <info> (wlp0s29f7u2): supplicant interface state: disconnected -> scanning
May 23 10:45:03 myhost kernel: wlp0s29f7u2: authenticate with 88:dc:96:20:fd:59
May 23 10:45:03 myhost kernel: wlp0s29f7u2: send auth to 88:dc:96:20:fd:59 (try 1/3)
May 23 10:45:03 myhost kernel: wlp0s29f7u2: authenticated
May 23 10:45:03 myhost kernel: wlp0s29f7u2: associating with AP with corrupt beacon
May 23 10:45:03 myhost kernel: wlp0s29f7u2: associate with 88:dc:96:20:fd:59 (try 1/3)
May 23 10:45:03 myhost NetworkManager[224]: <info> (wlp0s29f7u2): supplicant interface state: scanning -> authenticating
May 23 10:45:03 myhost NetworkManager[224]: <info> (wlp0s29f7u2): supplicant interface state: authenticating -> associating
May 23 10:45:03 myhost kernel: wlp0s29f7u2: RX AssocResp from 88:dc:96:20:fd:59 (capab=0x421 status=0 aid=7)
May 23 10:45:03 myhost kernel: wlp0s29f7u2: associated
May 23 10:45:03 myhost kernel: cfg80211: Calling CRDA to update world regulatory domain
May 23 10:45:03 myhost NetworkManager[224]: <info> (wlp0s29f7u2): supplicant interface state: associating -> completed
May 23 10:45:03 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: (wifi) Stage 2 of 5 (Device Configure) successful. Connected to wireless network 'Studio 6'.
May 23 10:45:03 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 3 of 5 (IP Configure Start) scheduled.
May 23 10:45:03 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 3 of 5 (IP Configure Start) started...
May 23 10:45:03 myhost NetworkManager[224]: <info> (wlp0s29f7u2): device state change: config -> ip-config (reason 'none') [50 70 0]
May 23 10:45:03 myhost NetworkManager[224]: <info> Activation (wlp0s29f7u2) Beginning DHCPv4 transaction (timeout in 45 seconds)
May 23 10:45:03 myhost NetworkManager[224]: <info> dhclient started with pid 15870
May 23 10:45:03 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 3 of 5 (IP Configure Start) complete.
May 23 10:45:03 myhost dhclient[15870]: DHCPREQUEST on wlp0s29f7u2 to 255.255.255.255 port 67
May 23 10:45:06 myhost dhclient[15870]: DHCPREQUEST on wlp0s29f7u2 to 255.255.255.255 port 67
May 23 10:45:09 myhost dhclient[15870]: DHCPREQUEST on wlp0s29f7u2 to 255.255.255.255 port 67
May 23 10:45:17 myhost dhclient[15870]: DHCPDISCOVER on wlp0s29f7u2 to 255.255.255.255 port 67 interval 4
May 23 10:45:21 myhost dhclient[15870]: DHCPDISCOVER on wlp0s29f7u2 to 255.255.255.255 port 67 interval 5
May 23 10:45:26 myhost dhclient[15870]: DHCPDISCOVER on wlp0s29f7u2 to 255.255.255.255 port 67 interval 5
May 23 10:45:31 myhost dhclient[15870]: DHCPDISCOVER on wlp0s29f7u2 to 255.255.255.255 port 67 interval 7
May 23 10:45:35 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 4 of 5 (IPv6 Configure Timeout) scheduled...
May 23 10:45:35 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 4 of 5 (IPv6 Configure Timeout) started...
May 23 10:45:35 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 4 of 5 (IPv6 Configure Timeout) complete.
May 23 10:45:38 myhost dhclient[15870]: DHCPDISCOVER on wlp0s29f7u2 to 255.255.255.255 port 67 interval 14
May 23 10:45:48 myhost NetworkManager[224]: <warn> (wlp0s29f7u2): DHCPv4 request timed out.
May 23 10:45:48 myhost NetworkManager[224]: <info> (wlp0s29f7u2): DHCPv4 state changed unknown -> timeout
May 23 10:45:48 myhost NetworkManager[224]: <info> (wlp0s29f7u2): canceled DHCP transaction, DHCP client pid 15870
May 23 10:45:48 myhost NetworkManager[224]: <info> (wlp0s29f7u2): DHCPv4 state changed timeout -> done
May 23 10:45:48 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 4 of 5 (IPv4 Configure Timeout) scheduled...
May 23 10:45:48 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 4 of 5 (IPv4 Configure Timeout) started...
May 23 10:45:48 myhost NetworkManager[224]: <info> (wlp0s29f7u2): device state change: ip-config -> failed (reason 'ip-config-unavailable') [70 120 5]
May 23 10:45:48 myhost NetworkManager[224]: <info> NetworkManager state is now DISCONNECTED
May 23 10:45:48 myhost NetworkManager[224]: <warn> (wlp0s29f7u2): Activation: failed for connection 'Studio 6'
May 23 10:45:48 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 4 of 5 (IPv4 Configure Timeout) complete.
May 23 10:45:48 myhost NetworkManager[224]: <info> (wlp0s29f7u2): device state change: failed -> disconnected (reason 'none') [120 30 0]
May 23 10:45:48 myhost NetworkManager[224]: <info> (wlp0s29f7u2): deactivating device (reason 'none') [0]
May 23 10:45:48 myhost kernel: wlp0s29f7u2: deauthenticating from 88:dc:96:20:fd:59 by local choice (Reason: 3=DEAUTH_LEAVING)
May 23 10:45:48 myhost kernel: cfg80211: Calling CRDA for country: US
May 23 10:45:48 myhost wpa_supplicant[226]: Successfully initialized wpa_supplicant
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: SME: Trying to authenticate with 88:dc:96:20:fd:59 (SSID='Studio 6' freq=2437 MHz)
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: Trying to associate with 88:dc:96:20:fd:59 (SSID='Studio 6' freq=2437 MHz)
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: Associated with 88:dc:96:20:fd:59
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: CTRL-EVENT-CONNECTED - Connection to 88:dc:96:20:fd:59 completed [id=0 id_str=]
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: SME: Trying to authenticate with 88:dc:96:13:5f:1e (SSID='Studio 6' freq=2412 MHz)
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: Trying to associate with 88:dc:96:13:5f:1e (SSID='Studio 6' freq=2412 MHz)
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: Associated with 88:dc:96:13:5f:1e
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: CTRL-EVENT-CONNECTED - Connection to 88:dc:96:13:5f:1e completed [id=0 id_str=]
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: SME: Trying to authenticate with 88:dc:96:20:fd:59 (SSID='Studio 6' freq=2437 MHz)
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: Trying to associate with 88:dc:96:20:fd:59 (SSID='Studio 6' freq=2437 MHz)
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: Associated with 88:dc:96:20:fd:59
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: CTRL-EVENT-CONNECTED - Connection to 88:dc:96:20:fd:59 completed [id=0 id_str=]
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: SME: Trying to authenticate with 88:dc:96:13:5f:1e (SSID='Studio 6' freq=2412 MHz)
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: Trying to associate with 88:dc:96:13:5f:1e (SSID='Studio 6' freq=2412 MHz)
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: Associated with 88:dc:96:13:5f:1e
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: CTRL-EVENT-CONNECTED - Connection to 88:dc:96:13:5f:1e completed [id=0 id_str=]
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: SME: Trying to authenticate with 88:dc:96:20:fd:59 (SSID='Studio 6' freq=2437 MHz)
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: Trying to associate with 88:dc:96:20:fd:59 (SSID='Studio 6' freq=2437 MHz)
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: Associated with 88:dc:96:20:fd:59
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: CTRL-EVENT-CONNECTED - Connection to 88:dc:96:20:fd:59 completed [id=0 id_str=]
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: SME: Trying to authenticate with 88:dc:96:13:5f:1e (SSID='Studio 6' freq=2412 MHz)
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: Trying to associate with 88:dc:96:13:5f:1e (SSID='Studio 6' freq=2412 MHz)
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: Associated with 88:dc:96:13:5f:1e
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: CTRL-EVENT-CONNECTED - Connection to 88:dc:96:13:5f:1e completed [id=0 id_str=]
May 23 10:45:48 myhost NetworkManager[224]: <warn> Connection disconnected (reason -3)
May 23 10:45:48 myhost NetworkManager[224]: <info> (wlp0s29f7u2): supplicant interface state: completed -> disconnected
May 23 10:45:48 myhost NetworkManager[224]: <info> Auto-activating connection 'Studio 6'.
May 23 10:45:48 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: starting connection 'Studio 6'
May 23 10:45:48 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 1 of 5 (Device Prepare) scheduled...
May 23 10:45:48 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 1 of 5 (Device Prepare) started...
May 23 10:45:48 myhost NetworkManager[224]: <info> (wlp0s29f7u2): device state change: disconnected -> prepare (reason 'none') [30 40 0]
May 23 10:45:48 myhost NetworkManager[224]: <info> NetworkManager state is now CONNECTING
May 23 10:45:48 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 2 of 5 (Device Configure) scheduled...
May 23 10:45:48 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 1 of 5 (Device Prepare) complete.
May 23 10:45:48 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 2 of 5 (Device Configure) starting...
May 23 10:45:48 myhost NetworkManager[224]: <info> (wlp0s29f7u2): device state change: prepare -> config (reason 'none') [40 50 0]
May 23 10:45:48 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: (wifi) connection 'Studio 6' requires no security. No secrets needed.
May 23 10:45:48 myhost NetworkManager[224]: <info> Config: added 'ssid' value 'Studio 6'
May 23 10:45:48 myhost NetworkManager[224]: <info> Config: added 'scan_ssid' value '1'
May 23 10:45:48 myhost NetworkManager[224]: <info> Config: added 'key_mgmt' value 'NONE'
May 23 10:45:48 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 2 of 5 (Device Configure) complete.
May 23 10:45:48 myhost NetworkManager[224]: <info> Config: set interface ap_scan to 1
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: SME: Trying to authenticate with 88:dc:96:20:fd:59 (SSID='Studio 6' freq=2437 MHz)
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: Trying to associate with 88:dc:96:20:fd:59 (SSID='Studio 6' freq=2437 MHz)
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: Associated with 88:dc:96:20:fd:59
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: CTRL-EVENT-CONNECTED - Connection to 88:dc:96:20:fd:59 completed [id=0 id_str=]
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: SME: Trying to authenticate with 88:dc:96:13:5f:1e (SSID='Studio 6' freq=2412 MHz)
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: Trying to associate with 88:dc:96:13:5f:1e (SSID='Studio 6' freq=2412 MHz)
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: Associated with 88:dc:96:13:5f:1e
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: CTRL-EVENT-CONNECTED - Connection to 88:dc:96:13:5f:1e completed [id=0 id_str=]
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: SME: Trying to authenticate with 88:dc:96:20:fd:59 (SSID='Studio 6' freq=2437 MHz)
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: Trying to associate with 88:dc:96:20:fd:59 (SSID='Studio 6' freq=2437 MHz)
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: Associated with 88:dc:96:20:fd:59
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: CTRL-EVENT-CONNECTED - Connection to 88:dc:96:20:fd:59 completed [id=0 id_str=]
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: SME: Trying to authenticate with 88:dc:96:13:5f:1e (SSID='Studio 6' freq=2412 MHz)
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: Trying to associate with 88:dc:96:13:5f:1e (SSID='Studio 6' freq=2412 MHz)
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: Associated with 88:dc:96:13:5f:1e
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: CTRL-EVENT-CONNECTED - Connection to 88:dc:96:13:5f:1e completed [id=0 id_str=]
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: SME: Trying to authenticate with 88:dc:96:20:fd:59 (SSID='Studio 6' freq=2437 MHz)
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: Trying to associate with 88:dc:96:20:fd:59 (SSID='Studio 6' freq=2437 MHz)
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: Associated with 88:dc:96:20:fd:59
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: CTRL-EVENT-CONNECTED - Connection to 88:dc:96:20:fd:59 completed [id=0 id_str=]
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: CTRL-EVENT-DISCONNECTED bssid=88:dc:96:20:fd:59 reason=3 locally_generated=1
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: SME: Trying to authenticate with 88:dc:96:20:fd:59 (SSID='Studio 6' freq=2437 MHz)
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: Trying to associate with 88:dc:96:20:fd:59 (SSID='Studio 6' freq=2437 MHz)
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: Associated with 88:dc:96:20:fd:59
May 23 10:45:48 myhost wpa_supplicant[226]: wlp0s29f7u2: CTRL-EVENT-CONNECTED - Connection to 88:dc:96:20:fd:59 completed [id=0 id_str=]
May 23 10:45:49 myhost kernel: wlp0s29f7u2: authenticate with 88:dc:96:20:fd:59
May 23 10:45:49 myhost kernel: wlp0s29f7u2: send auth to 88:dc:96:20:fd:59 (try 1/3)
May 23 10:45:49 myhost NetworkManager[224]: <info> (wlp0s29f7u2): supplicant interface state: disconnected -> authenticating
May 23 10:45:49 myhost kernel: wlp0s29f7u2: authenticated
May 23 10:45:49 myhost kernel: wlp0s29f7u2: associating with AP with corrupt beacon
May 23 10:45:49 myhost kernel: wlp0s29f7u2: associate with 88:dc:96:20:fd:59 (try 1/3)
May 23 10:45:49 myhost NetworkManager[224]: <info> (wlp0s29f7u2): supplicant interface state: authenticating -> associating
May 23 10:45:49 myhost kernel: wlp0s29f7u2: RX AssocResp from 88:dc:96:20:fd:59 (capab=0x421 status=0 aid=7)
May 23 10:45:49 myhost kernel: wlp0s29f7u2: associated
May 23 10:45:49 myhost NetworkManager[224]: <info> (wlp0s29f7u2): supplicant interface state: associating -> completed
May 23 10:45:49 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: (wifi) Stage 2 of 5 (Device Configure) successful. Connected to wireless network 'Studio 6'.
May 23 10:45:49 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 3 of 5 (IP Configure Start) scheduled.
May 23 10:45:49 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 3 of 5 (IP Configure Start) started...
May 23 10:45:49 myhost NetworkManager[224]: <info> (wlp0s29f7u2): device state change: config -> ip-config (reason 'none') [50 70 0]
May 23 10:45:49 myhost NetworkManager[224]: <info> Activation (wlp0s29f7u2) Beginning DHCPv4 transaction (timeout in 45 seconds)
May 23 10:45:49 myhost NetworkManager[224]: <info> dhclient started with pid 15883
May 23 10:45:49 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 3 of 5 (IP Configure Start) complete.
May 23 10:45:49 myhost dhclient[15883]: DHCPREQUEST on wlp0s29f7u2 to 255.255.255.255 port 67
May 23 10:45:55 myhost dhclient[15883]: DHCPREQUEST on wlp0s29f7u2 to 255.255.255.255 port 67
May 23 10:46:06 myhost dhclient[15883]: DHCPDISCOVER on wlp0s29f7u2 to 255.255.255.255 port 67 interval 5
May 23 10:46:11 myhost dhclient[15883]: DHCPDISCOVER on wlp0s29f7u2 to 255.255.255.255 port 67 interval 8
May 23 10:46:20 myhost dhclient[15883]: DHCPDISCOVER on wlp0s29f7u2 to 255.255.255.255 port 67 interval 15
May 23 10:46:21 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 4 of 5 (IPv6 Configure Timeout) scheduled...
May 23 10:46:21 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 4 of 5 (IPv6 Configure Timeout) started...
May 23 10:46:21 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 4 of 5 (IPv6 Configure Timeout) complete.
May 23 10:46:35 myhost NetworkManager[224]: <warn> (wlp0s29f7u2): DHCPv4 request timed out.
May 23 10:46:35 myhost NetworkManager[224]: <info> (wlp0s29f7u2): DHCPv4 state changed unknown -> timeout
May 23 10:46:35 myhost NetworkManager[224]: <info> (wlp0s29f7u2): canceled DHCP transaction, DHCP client pid 15883
May 23 10:46:35 myhost NetworkManager[224]: <info> (wlp0s29f7u2): DHCPv4 state changed timeout -> done
May 23 10:46:35 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 4 of 5 (IPv4 Configure Timeout) scheduled...
May 23 10:46:35 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 4 of 5 (IPv4 Configure Timeout) started...
May 23 10:46:35 myhost NetworkManager[224]: <info> (wlp0s29f7u2): device state change: ip-config -> failed (reason 'ip-config-unavailable') [70 120 5]
May 23 10:46:35 myhost NetworkManager[224]: <info> NetworkManager state is now DISCONNECTED
May 23 10:46:35 myhost NetworkManager[224]: <warn> (wlp0s29f7u2): Activation: failed for connection 'Studio 6'
May 23 10:46:35 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 4 of 5 (IPv4 Configure Timeout) complete.
May 23 10:46:35 myhost NetworkManager[224]: <info> (wlp0s29f7u2): device state change: failed -> disconnected (reason 'none') [120 30 0]
May 23 10:46:35 myhost NetworkManager[224]: <info> (wlp0s29f7u2): deactivating device (reason 'none') [0]
May 23 10:46:35 myhost kernel: wlp0s29f7u2: deauthenticating from 88:dc:96:20:fd:59 by local choice (Reason: 3=DEAUTH_LEAVING)
May 23 10:46:35 myhost kernel: cfg80211: Calling CRDA to update world regulatory domain
May 23 10:46:35 myhost NetworkManager[224]: <warn> Connection disconnected (reason -3)
May 23 10:46:35 myhost NetworkManager[224]: <info> (wlp0s29f7u2): supplicant interface state: completed -> disconnected
May 23 10:46:35 myhost NetworkManager[224]: <info> Auto-activating connection 'Studio 6'.
May 23 10:46:35 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: starting connection 'Studio 6'
May 23 10:46:35 myhost NetworkManager[224]: <info> (wlp0s29f7u2): Activation: Stage 1 of 5 (Device Prepare) scheduled...
...Last edited by jb.1234abcd (2015-05-26 02:58:23)
Offline
#2 2015-05-26 02:47:36
- ewaller
- Administrator
- From: Pasadena, CA
- Registered: 2009-07-13
- Posts: 19,804
Re: wireless con failure - rt2800usb, wpa_supplicant, or AP problem ?
First, please edit your post and use BBCode code tags around program output (There is also a link for reference under every message post box on the forums.) What is the output of systemctl
?
Nothing is too wonderful to be true, if it be consistent with the laws of nature -- Michael Faraday
Sometimes it is the people no one can imagine anything of who do the things no one can imagine. -- Alan Turing
---
How to Ask Questions the Smart Way
Offline
#3 2015-05-26 03:00:56
- jb.1234abcd
- Member
- Registered: 2013-10-14
- Posts: 45
Re: wireless con failure - rt2800usb, wpa_supplicant, or AP problem ?
$ systemctl
UNIT LOAD ACTIVE SUB DESCRIPTION
proc-sys-fs-binfmt_misc.automount loaded active waiting Arbitrary Executable File Formats File System Automount Point
sys-devices-pci0000:00-0000:00:02.0-backlight-acpi_video0.device loaded active plugged /sys/devices/pci0000:00/0000:00:02.0/backlight/acpi_video0
sys-devices-pci0000:00-0000:00:02.0-drm-card0-card0\x2dLVDS\x2d1-intel_backlight.device loaded active plugged /sys/devices/pci0000:00/0000:00:02.0/drm/card0/card0-LVDS-1/intel_backlight
sys-devices-pci0000:00-0000:00:1a.0-usb1-1\x2d1-1\x2d1:1.0-bluetooth-hci0-rfkill2.device loaded active plugged /sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1:1.0/bluetooth/hci0/rfkill2
sys-devices-pci0000:00-0000:00:1a.0-usb1-1\x2d1-1\x2d1:1.0-bluetooth-hci0.device loaded active plugged /sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1:1.0/bluetooth/hci0
sys-devices-pci0000:00-0000:00:1b.0-sound-card0.device loaded active plugged 82801H (ICH8 Family) HD Audio Controller (ThinkPad T61/R61)
sys-devices-pci0000:00-0000:00:1c.1-0000:03:00.0-ieee80211-phy0-rfkill1.device loaded active plugged /sys/devices/pci0000:00/0000:00:1c.1/0000:03:00.0/ieee80211/phy0/rfkill1
sys-devices-pci0000:00-0000:00:1c.1-0000:03:00.0-net-wls3.device loaded active plugged PRO/Wireless 3945ABG [Golan] Network Connection (ThinkPad T60/R60e/X60s)
sys-devices-pci0000:00-0000:00:1c.2-0000:04:00.0-net-ens4.device loaded active plugged NetLink BCM5787M Gigabit Ethernet PCI Express
sys-devices-pci0000:00-0000:00:1d.7-usb4-4\x2d2-4\x2d2:1.0-ieee80211-phy1-rfkill3.device loaded active plugged /sys/devices/pci0000:00/0000:00:1d.7/usb4/4-2/4-2:1.0/ieee80211/phy1/rfkill3
sys-devices-pci0000:00-0000:00:1d.7-usb4-4\x2d2-4\x2d2:1.0-net-wlp0s29f7u2.device loaded active plugged RT5372 Wireless Adapter
sys-devices-pci0000:00-0000:00:1f.1-ata4-host3-target3:0:0-3:0:0:0-block-sr0.device loaded active plugged HL-DT-STCD-RW_DVD_DRIVE_GCC-4244N
sys-devices-pci0000:00-0000:00:1f.2-ata1-host0-target0:0:0-0:0:0:0-block-sda-sda1.device loaded active plugged WDC_WD1600BEVS-08RST2 WinXP
sys-devices-pci0000:00-0000:00:1f.2-ata1-host0-target0:0:0-0:0:0:0-block-sda-sda2.device loaded active plugged WDC_WD1600BEVS-08RST2 2
sys-devices-pci0000:00-0000:00:1f.2-ata1-host0-target0:0:0-0:0:0:0-block-sda-sda3.device loaded active plugged WDC_WD1600BEVS-08RST2 3
sys-devices-pci0000:00-0000:00:1f.2-ata1-host0-target0:0:0-0:0:0:0-block-sda-sda4.device loaded active plugged WDC_WD1600BEVS-08RST2 4
sys-devices-pci0000:00-0000:00:1f.2-ata1-host0-target0:0:0-0:0:0:0-block-sda-sda5.device loaded active plugged WDC_WD1600BEVS-08RST2 5
sys-devices-pci0000:00-0000:00:1f.2-ata1-host0-target0:0:0-0:0:0:0-block-sda-sda6.device loaded active plugged WDC_WD1600BEVS-08RST2 backup
sys-devices-pci0000:00-0000:00:1f.2-ata1-host0-target0:0:0-0:0:0:0-block-sda-sda7.device loaded active plugged WDC_WD1600BEVS-08RST2 Arch
sys-devices-pci0000:00-0000:00:1f.2-ata1-host0-target0:0:0-0:0:0:0-block-sda.device loaded active plugged WDC_WD1600BEVS-08RST2
sys-devices-platform-serial8250-tty-ttyS0.device loaded active plugged /sys/devices/platform/serial8250/tty/ttyS0
sys-devices-platform-serial8250-tty-ttyS1.device loaded active plugged /sys/devices/platform/serial8250/tty/ttyS1
sys-devices-platform-serial8250-tty-ttyS2.device loaded active plugged /sys/devices/platform/serial8250/tty/ttyS2
sys-devices-platform-serial8250-tty-ttyS3.device loaded active plugged /sys/devices/platform/serial8250/tty/ttyS3
sys-devices-platform-thinkpad_acpi-rfkill-rfkill0.device loaded active plugged /sys/devices/platform/thinkpad_acpi/rfkill/rfkill0
sys-module-configfs.device loaded active plugged /sys/module/configfs
sys-subsystem-bluetooth-devices-hci0.device loaded active plugged /sys/subsystem/bluetooth/devices/hci0
sys-subsystem-net-devices-ens4.device loaded active plugged NetLink BCM5787M Gigabit Ethernet PCI Express
sys-subsystem-net-devices-wlp0s29f7u2.device loaded active plugged RT5372 Wireless Adapter
sys-subsystem-net-devices-wls3.device loaded active plugged PRO/Wireless 3945ABG [Golan] Network Connection (ThinkPad T60/R60e/X60s)
sys-subsystem-rfkill-devices-rfkill0.device loaded active plugged /sys/subsystem/rfkill/devices/rfkill0
sys-subsystem-rfkill-devices-rfkill1.device loaded active plugged /sys/subsystem/rfkill/devices/rfkill1
sys-subsystem-rfkill-devices-rfkill2.device loaded active plugged /sys/subsystem/rfkill/devices/rfkill2
sys-subsystem-rfkill-devices-rfkill3.device loaded active plugged /sys/subsystem/rfkill/devices/rfkill3
-.mount loaded active mounted /
dev-hugepages.mount loaded active mounted Huge Pages File System
dev-mqueue.mount loaded active mounted POSIX Message Queue File System
run-user-1000.mount loaded active mounted /run/user/1000
sys-kernel-config.mount loaded active mounted Configuration File System
sys-kernel-debug.mount loaded active mounted Debug File System
tmp.mount loaded active mounted Temporary Directory
systemd-ask-password-console.path loaded active waiting Dispatch Password Requests to Console Directory Watch
systemd-ask-password-wall.path loaded active waiting Forward Password Requests to Wall Directory Watch
session-c1.scope loaded active running Session c1 of user jb
dbus.service loaded active running D-Bus System Message Bus
getty@tty1.service loaded active running Getty on tty1
ip6tables.service loaded active exited IPv6 Packet Filtering Framework
iptables.service loaded active exited Packet Filtering Framework
keepalive.service loaded active exited net keepalive
kmod-static-nodes.service loaded active exited Create list of required static device nodes for the current kernel
NetworkManager.service loaded active running Network Manager
polkit.service loaded active running Authorization Manager
rtkit-daemon.service loaded active running RealtimeKit Scheduling Policy Service
systemd-backlight@backlight:acpi_video0.service loaded active exited Load/Save Screen Backlight Brightness of backlight:acpi_video0
systemd-backlight@backlight:intel_backlight.service loaded active exited Load/Save Screen Backlight Brightness of backlight:intel_backlight
systemd-journal-flush.service loaded active exited Flush Journal to Persistent Storage
systemd-journald.service loaded active running Journal Service
systemd-logind.service loaded active running Login Service
systemd-random-seed.service loaded active exited Load/Save Random Seed
systemd-remount-fs.service loaded active exited Remount Root and Kernel File Systems
systemd-rfkill@rfkill0.service loaded active exited Load/Save RF Kill Switch Status of rfkill0
systemd-rfkill@rfkill1.service loaded active exited Load/Save RF Kill Switch Status of rfkill1
systemd-rfkill@rfkill2.service loaded active exited Load/Save RF Kill Switch Status of rfkill2
systemd-rfkill@rfkill3.service loaded active exited Load/Save RF Kill Switch Status of rfkill3
systemd-sysctl.service loaded active exited Apply Kernel Variables
systemd-tmpfiles-setup-dev.service loaded active exited Create Static Device Nodes in /dev
systemd-tmpfiles-setup.service loaded active exited Create Volatile Files and Directories
systemd-udev-trigger.service loaded active exited udev Coldplug all Devices
systemd-udevd.service loaded active running udev Kernel Device Manager
systemd-update-utmp.service loaded active exited Update UTMP about System Boot/Shutdown
systemd-user-sessions.service loaded active exited Permit User Sessions
systemd-vconsole-setup.service loaded active exited Setup Virtual Console
user@1000.service loaded active running User Manager for UID 1000
wpa_supplicant.service loaded active running WPA supplicant
-.slice loaded active active Root Slice
system-getty.slice loaded active active system-getty.slice
system-systemd\x2dbacklight.slice loaded active active system-systemd\x2dbacklight.slice
system-systemd\x2drfkill.slice loaded active active system-systemd\x2drfkill.slice
system.slice loaded active active System Slice
user-1000.slice loaded active active user-1000.slice
user.slice loaded active active User and Session Slice
dbus.socket loaded active running D-Bus System Message Bus Socket
dm-event.socket loaded active listening Device-mapper event daemon FIFOs
lvm2-lvmetad.socket loaded active listening LVM2 metadata daemon socket
systemd-initctl.socket loaded active listening /dev/initctl Compatibility Named Pipe
systemd-journald-dev-log.socket loaded active running Journal Socket (/dev/log)
systemd-journald.socket loaded active running Journal Socket
systemd-shutdownd.socket loaded active listening Delayed Shutdown Socket
systemd-udevd-control.socket loaded active running udev Control Socket
systemd-udevd-kernel.socket loaded active running udev Kernel Socket
dev-disk-by\x2duuid-870f12c3\x2df989\x2d4af9\x2d99e1\x2d6411f0a554c9.swap loaded active active /dev/disk/by-uuid/870f12c3-f989-4af9-99e1-6411f0a554c9
basic.target loaded active active Basic System
bluetooth.target loaded active active Bluetooth
cryptsetup.target loaded active active Encrypted Volumes
getty.target loaded active active Login Prompts
graphical.target loaded active active Graphical Interface
local-fs-pre.target loaded active active Local File Systems (Pre)
local-fs.target loaded active active Local File Systems
multi-user.target loaded active active Multi-User System
network-pre.target loaded active active Network (Pre)
network.target loaded active active Network
paths.target loaded active active Paths
remote-fs.target loaded active active Remote File Systems
slices.target loaded active active Slices
sockets.target loaded active active Sockets
sound.target loaded active active Sound Card
swap.target loaded active active Swap
sysinit.target loaded active active System Initialization
timers.target loaded active active Timers
logrotate.timer loaded active waiting Daily rotation of log files
man-db.timer loaded active waiting Daily man-db cache update
shadow.timer loaded active waiting Daily verification of password and group files
systemd-tmpfiles-clean.timer loaded active waiting Daily Cleanup of Temporary Directories
updatedb.timer loaded active waiting Daily locate database update
LOAD = Reflects whether the unit definition was properly loaded.
ACTIVE = The high-level unit activation state, i.e. generalization of SUB.
SUB = The low-level unit activation state, values depend on unit type.
114 loaded units listed. Pass --all to see loaded but inactive units, too.
To show all installed unit files use 'systemctl list-unit-files'.Offline