Network Manager oddities

CS DBA cs_dba at consistentstate.com
Wed Nov 4 18:40:47 UTC 2015


All;

I'm running Fedora 22 (KDE Spin) on a Lenovo Thinkpad X1 Carbon.

Fedora 22 is great, most everything just works out of the box!  I owe 
much gratitude to the Fedora community!


There is one issue I have not been able to fix, it's more of an 
annoyance than a problem.
The network manager takes a long time to connect (about 60seconds) and 
sometimes it just stops
stops trying to connect to a wireless network after a minute or so and 
when I tell it to connect again it connects right away

Below is some /var/log/message output that I see when the wireless spins 
, stops connecting and then connects after I click on the "connect" 
button again


I'm using this wireless card:

Network controller: Intel Corporation Wireless 7265 (rev 59)


Thanks in advance


- - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - 
- - - - - - - - - - -
*-- Clicked "connect" for the wireless network*
- - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - 
- - - - - - - - - - -
Nov  4 11:35:00 F22Host NetworkManager[1112]: <info> (wlp4s0): 
Activation: starting connection 'ATGWiFi' 
(2ad558e8-7769-4be1-a17d-90bbec6507cf)
Nov  4 11:35:00 F22Host NetworkManager[1112]: <info> (wlp4s0): device 
state change: disconnected -> prepare (reason 'none') [30 40 0]
Nov  4 11:35:00 F22Host NetworkManager[1112]: <info> NetworkManager 
state is now CONNECTING
Nov  4 11:35:00 F22Host NetworkManager[1112]: <info> (wlp4s0): device 
state change: prepare -> config (reason 'none') [40 50 0]
Nov  4 11:35:00 F22Host NetworkManager[1112]: <info> (wlp4s0): 
Activation: (wifi) access point 'ATGWiFi' has security, but secrets are 
required.
Nov  4 11:35:00 F22Host NetworkManager[1112]: <info> (wlp4s0): device 
state change: config -> need-auth (reason 'none') [50 60 0]
Nov  4 11:35:00 F22Host NetworkManager[1112]: <warn>  Failed to 
GDBus.Error:fi.w1.wpa_supplicant1.NotConnected: This interface is not 
connected: disconnect.
Nov  4 11:35:00 F22Host org.kde.kwalletd5: Application ' "kded5" ' using 
kwallet without parent window!
Nov  4 11:35:05 F22Host NetworkManager[1112]: <info> (wlp4s0): device 
state change: need-auth -> prepare (reason 'none') [60 40 0]
Nov  4 11:35:05 F22Host NetworkManager[1112]: <info> (wlp4s0): device 
state change: prepare -> config (reason 'none') [40 50 0]
Nov  4 11:35:05 F22Host NetworkManager[1112]: <info> (wlp4s0): 
Activation: (wifi) connection 'ATGWiFi' has security, and secrets 
exist.  No new secrets needed.
Nov  4 11:35:05 F22Host NetworkManager[1112]: <info>  Config: added 
'ssid' value 'ATGWiFi'
Nov  4 11:35:05 F22Host NetworkManager[1112]: <info>  Config: added 
'scan_ssid' value '1'
Nov  4 11:35:05 F22Host NetworkManager[1112]: <info>  Config: added 
'key_mgmt' value 'WPA-PSK'
Nov  4 11:35:05 F22Host NetworkManager[1112]: <info>  Config: added 
'psk' value '<omitted>'
Nov  4 11:35:05 F22Host NetworkManager[1112]: <info>  Config: added 
'proto' value 'WPA RSN'
Nov  4 11:35:05 F22Host NetworkManager[1112]: <warn>  Failed to 
GDBus.Error:fi.w1.wpa_supplicant1.NotConnected: This interface is not 
connected: disconnect.
Nov  4 11:35:05 F22Host NetworkManager[1112]: <info>  Config: set 
interface ap_scan to 1
Nov  4 11:35:13 F22Host audit: <audit-1131> pid=1 uid=0 auid=4294967295 
ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=fprintd 
comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? 
terminal=? res=success'
Nov  4 11:35:30 F22Host NetworkManager[1112]: <warn> (wlp4s0): 
Activation: (wifi) association took too long, failing activation
Nov  4 11:35:30 F22Host NetworkManager[1112]: <info> (wlp4s0): device 
state change: config -> failed (reason 'ssid-not-found') [50 120 53]
Nov  4 11:35:30 F22Host NetworkManager[1112]: <info> NetworkManager 
state is now CONNECTED_LOCAL
Nov  4 11:35:30 F22Host NetworkManager[1112]: <warn> (wlp4s0): 
Activation: failed for connection 'ATGWiFi'
Nov  4 11:35:30 F22Host NetworkManager[1112]: <info> (wlp4s0): device 
state change: failed -> disconnected (reason 'none') [120 30 0]
Nov  4 11:35:30 F22Host kernel: IPv6: ADDRCONF(NETDEV_UP): wlp4s0: link 
is not ready
Nov  4 11:35:30 F22Host NetworkManager[1112]: <info> (wlp4s0): 
supplicant interface state: scanning -> disconnected
Nov  4 11:35:30 F22Host NetworkManager[1112]: <info> connectivity: check 
for uri 'http://fedoraproject.org/static/hotspot.txt' failed with 'Error 
resolving 'fedoraproject.org': No address associated with hostname'
Nov  4 11:35:30 F22Host vmnetBridge: RTM_NEWLINK: name:wlp4s0 index:3 
flags:0x00001003
Nov  4 11:35:30 F22Host vmnet-natd: RTM_NEWLINK: name:wlp4s0 index:3 
flags:0x00001003
Nov  4 11:35:30 F22Host NetworkManager[1112]: <warn>  Failed to 
GDBus.Error:fi.w1.wpa_supplicant1.NotConnected: This interface is not 
connected: disconnect.
Nov  4 11:35:30 F22Host NetworkManager[1112]: <info> (wlp4s0): 
supplicant interface state: disconnected -> scanning
Nov  4 11:35:30 F22Host firewalld: 2015-11-04 11:35:30 ERROR: 
UNKNOWN_INTERFACE: 'wlp4s0' is not in any zone
Nov  4 11:35:32 F22Host NetworkManager[1112]: <info> (wlp4s0): 
supplicant interface state: scanning -> disconnected



- - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - 
- - - - - - - - - - -
*-- Wireless is disconnected (no longer connecting)**
**-- **Clicked "connect" again for the wireless network*
- - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - - 
- - - - - - - - - - -
Nov  4 11:35:54 F22Host NetworkManager[1112]: <info> (wlp4s0): 
Activation: starting connection 'ATGWiFi' 
(2ad558e8-7769-4be1-a17d-90bbec6507cf)
Nov  4 11:35:54 F22Host NetworkManager[1112]: <info> (wlp4s0): device 
state change: disconnected -> prepare (reason 'none') [30 40 0]
Nov  4 11:35:54 F22Host NetworkManager[1112]: <info> NetworkManager 
state is now CONNECTING
Nov  4 11:35:54 F22Host NetworkManager[1112]: <info> (wlp4s0): device 
state change: prepare -> config (reason 'none') [40 50 0]
Nov  4 11:35:54 F22Host NetworkManager[1112]: <info> (wlp4s0): 
Activation: (wifi) access point 'ATGWiFi' has security, but secrets are 
required.
Nov  4 11:35:54 F22Host NetworkManager[1112]: <info> (wlp4s0): device 
state change: config -> need-auth (reason 'none') [50 60 0]
Nov  4 11:35:54 F22Host NetworkManager[1112]: <info> (wlp4s0): device 
state change: need-auth -> prepare (reason 'none') [60 40 0]
Nov  4 11:35:54 F22Host NetworkManager[1112]: <info> (wlp4s0): device 
state change: prepare -> config (reason 'none') [40 50 0]
Nov  4 11:35:54 F22Host NetworkManager[1112]: <info> (wlp4s0): 
Activation: (wifi) connection 'ATGWiFi' has security, and secrets 
exist.  No new secrets needed.
Nov  4 11:35:54 F22Host NetworkManager[1112]: <info>  Config: added 
'ssid' value 'ATGWiFi'
Nov  4 11:35:54 F22Host NetworkManager[1112]: <info>  Config: added 
'scan_ssid' value '1'
Nov  4 11:35:54 F22Host NetworkManager[1112]: <info>  Config: added 
'key_mgmt' value 'WPA-PSK'
Nov  4 11:35:54 F22Host NetworkManager[1112]: <info>  Config: added 
'psk' value '<omitted>'
Nov  4 11:35:54 F22Host NetworkManager[1112]: <info>  Config: added 
'proto' value 'WPA RSN'
Nov  4 11:35:54 F22Host NetworkManager[1112]: <info>  Config: set 
interface ap_scan to 1
Nov  4 11:35:54 F22Host NetworkManager[1112]: <info> (wlp4s0): 
supplicant interface state: disconnected -> scanning
Nov  4 11:35:54 F22Host kernel: wlp4s0: authenticate with 10:8c:cf:b1:6f:0f
Nov  4 11:35:54 F22Host kernel: wlp4s0: send auth to 10:8c:cf:b1:6f:0f 
(try 1/3)
Nov  4 11:35:54 F22Host NetworkManager[1112]: <info> (wlp4s0): 
supplicant interface state: scanning -> authenticating
Nov  4 11:35:54 F22Host kernel: wlp4s0: authenticated
Nov  4 11:35:54 F22Host kernel: wlp4s0: associate with 10:8c:cf:b1:6f:0f 
(try 1/3)
Nov  4 11:35:54 F22Host NetworkManager[1112]: <info> (wlp4s0): 
supplicant interface state: authenticating -> associating
Nov  4 11:35:54 F22Host kernel: wlp4s0: RX AssocResp from 
10:8c:cf:b1:6f:0f (capab=0x11 status=0 aid=39)
Nov  4 11:35:54 F22Host kernel: wlp4s0: associated
Nov  4 11:35:54 F22Host kernel: IPv6: ADDRCONF(NETDEV_CHANGE): wlp4s0: 
link becomes ready
Nov  4 11:35:54 F22Host vmnet-natd: RTM_NEWLINK: name:wlp4s0 index:3 
flags:0x00011003
Nov  4 11:35:54 F22Host vmnetBridge: RTM_NEWLINK: name:wlp4s0 index:3 
flags:0x00011003
Nov  4 11:35:54 F22Host NetworkManager[1112]: <info> (wlp4s0): 
supplicant interface state: associating -> associated
Nov  4 11:35:54 F22Host NetworkManager[1112]: <info> (wlp4s0): 
supplicant interface state: associated -> 4-way handshake
Nov  4 11:35:55 F22Host vmnet-natd: RTM_NEWLINK: name:wlp4s0 index:3 
flags:0x00011043
Nov  4 11:35:55 F22Host vmnetBridge: RTM_NEWLINK: name:wlp4s0 index:3 
flags:0x00011043
Nov  4 11:35:55 F22Host vmnetBridge: Adding interface wlp4s0 index:3
Nov  4 11:35:55 F22Host vmnetBridge: Started bridge wlp4s0 to virtual 
network 0.
Nov  4 11:35:55 F22Host kernel: bridge-wlp4s0: device is wireless, 
enabling SMAC
Nov  4 11:35:55 F22Host NetworkManager[1112]: <info> (wlp4s0): 
supplicant interface state: 4-way handshake -> completed
Nov  4 11:35:55 F22Host NetworkManager[1112]: <info> (wlp4s0): 
Activation: (wifi) Stage 2 of 5 (Device Configure) successful.  
Connected to wireless network 'ATGWiFi'.
Nov  4 11:35:55 F22Host audit: <audit-1325> table=filter family=2 entries=79
Nov  4 11:35:55 F22Host audit: <audit-1325> table=filter family=10 
entries=80
Nov  4 11:35:55 F22Host audit: <audit-1325> table=filter family=2 entries=80
Nov  4 11:35:55 F22Host audit: <audit-1325> table=filter family=10 
entries=81
Nov  4 11:35:55 F22Host audit: <audit-1325> table=filter family=2 entries=81
Nov  4 11:35:55 F22Host audit: <audit-1325> table=filter family=10 
entries=82
Nov  4 11:35:55 F22Host audit: <audit-1325> table=mangle family=2 entries=39
Nov  4 11:35:55 F22Host audit: <audit-1325> table=mangle family=10 
entries=39
Nov  4 11:35:55 F22Host audit: <audit-1325> table=nat family=2 entries=50
Nov  4 11:35:55 F22Host audit: <audit-1325> table=nat family=10 entries=50
Nov  4 11:35:55 F22Host audit: <audit-1325> table=nat family=2 entries=51
Nov  4 11:35:55 F22Host audit: <audit-1325> table=nat family=10 entries=51
Nov  4 11:35:55 F22Host NetworkManager[1112]: <info> (wlp4s0): device 
state change: config -> ip-config (reason 'none') [50 70 0]
Nov  4 11:35:55 F22Host NetworkManager[1112]: <info> Activation (wlp4s0) 
Beginning DHCPv4 transaction (timeout in 45 seconds)
Nov  4 11:35:55 F22Host NetworkManager[1112]: <info>  dhclient started 
with pid 2640
Nov  4 11:35:55 F22Host vmnet-natd: RTM_NEWLINK: name:wlp4s0 index:3 
flags:0x00011043
Nov  4 11:35:55 F22Host vmnetBridge: RTM_NEWLINK: name:wlp4s0 index:3 
flags:0x00011043
Nov  4 11:35:55 F22Host dhclient[2640]: DHCPREQUEST on wlp4s0 to 
255.255.255.255 port 67 (xid=0xd4fa5f)
Nov  4 11:35:55 F22Host dhclient[2640]: DHCPACK from 10.10.10.10 
(xid=0xd4fa5f)
Nov  4 11:35:55 F22Host NetworkManager[1112]: <info> address 10.100.167.109
Nov  4 11:35:55 F22Host NetworkManager[1112]: <info>    plen 22 
(255.255.252.0)
Nov  4 11:35:55 F22Host NetworkManager[1112]: <info> gateway 10.100.167.254
Nov  4 11:35:55 F22Host NetworkManager[1112]: <info>    server 
identifier 10.10.10.10
Nov  4 11:35:55 F22Host NetworkManager[1112]: <info>    lease time 3600
Nov  4 11:35:55 F22Host NetworkManager[1112]: <info> nameserver '8.8.8.8'
Nov  4 11:35:55 F22Host NetworkManager[1112]: <info> nameserver '8.8.4.4'
Nov  4 11:35:55 F22Host NetworkManager[1112]: <info>    domain name 
'mystro.mystrotv.com'
Nov  4 11:35:55 F22Host NetworkManager[1112]: <info> (wlp4s0): DHCPv4 
state changed unknown -> bound
Nov  4 11:35:55 F22Host vmnet-natd: RTM_NEWADDR: index:3, 
addr:10.100.167.109
Nov  4 11:35:55 F22Host avahi-daemon[820]: Joining mDNS multicast group 
on interface wlp4s0.IPv4 with address 10.100.167.109.
Nov  4 11:35:55 F22Host avahi-daemon[820]: New relevant interface 
wlp4s0.IPv4 for mDNS.
Nov  4 11:35:55 F22Host avahi-daemon[820]: Registering new address 
record for 10.100.167.109 on wlp4s0.IPv4.
Nov  4 11:35:55 F22Host vmnetBridge: RTM_NEWROUTE: index:3
Nov  4 11:35:55 F22Host NetworkManager[1112]: <info> (wlp4s0): device 
state change: ip-config -> ip-check (reason 'none') [70 80 0]
Nov  4 11:35:55 F22Host vmnet-natd: RTM_NEWROUTE: index:3
Nov  4 11:35:55 F22Host dbus[792]: [system] Activating via systemd: 
service name='org.freedesktop.nm_dispatcher' 
unit='dbus-org.freedesktop.nm-dispatcher.service'
Nov  4 11:35:55 F22Host dhclient[2640]: bound to 10.100.167.109 -- 
renewal in 1410 seconds.
Nov  4 11:35:55 F22Host systemd: Starting Network Manager Script 
Dispatcher Service...
Nov  4 11:35:55 F22Host dbus[792]: [system] Successfully activated 
service 'org.freedesktop.nm_dispatcher'
Nov  4 11:35:55 F22Host systemd: Started Network Manager Script 
Dispatcher Service.
Nov  4 11:35:55 F22Host audit: <audit-1130> pid=1 uid=0 auid=4294967295 
ses=4294967295 subj=system_u:system_r:init_t:s0 
msg='unit=NetworkManager-dispatcher comm="systemd" 
exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Nov  4 11:35:55 F22Host nm-dispatcher: Dispatching action 'pre-up' for 
wlp4s0
Nov  4 11:35:55 F22Host NetworkManager[1112]: <info> (wlp4s0): device 
state change: ip-check -> secondaries (reason 'none') [80 90 0]
Nov  4 11:35:55 F22Host NetworkManager[1112]: <info> (wlp4s0): device 
state change: secondaries -> activated (reason 'none') [90 100 0]
Nov  4 11:35:55 F22Host NetworkManager[1112]: <info> NetworkManager 
state is now CONNECTED_LOCAL
Nov  4 11:35:55 F22Host NetworkManager[1112]: <info> NetworkManager 
state is now CONNECTED_SITE
Nov  4 11:35:55 F22Host NetworkManager[1112]: <info>  Policy set 
'ATGWiFi' (wlp4s0) as default for IPv4 routing and DNS.
Nov  4 11:35:55 F22Host NetworkManager[1112]: <info> (wlp4s0): 
Activation: successful, device activated.
Nov  4 11:35:55 F22Host nm-dispatcher: Dispatching action 'up' for wlp4s0
Nov  4 11:35:55 F22Host systemd: Unit iscsi.service cannot be reloaded 
because it is inactive.
Nov  4 11:35:55 F22Host kernel: userif-3: sent link down event.
Nov  4 11:35:55 F22Host kernel: userif-3: sent link up event.
Nov  4 11:35:55 F22Host NetworkManager[1112]: <info> NetworkManager 
state is now CONNECTED_GLOBAL
Nov  4 11:35:55 F22Host PackageKit: uid 1000 is trying to obtain 
org.freedesktop.packagekit.system-sources-refresh auth (only_trusted:0)
Nov  4 11:35:55 F22Host PackageKit: uid 1000 obtained auth for 
org.freedesktop.packagekit.system-sources-refresh
Nov  4 11:35:56 F22Host avahi-daemon[820]: Registering new address 
record for fe80::5ee0:c5ff:fe39:fed1 on wlp4s0.*.
Nov  4 11:35:56 F22Host PackageKit: refresh-cache transaction 
/817_ceaeedce from uid 1000 finished with success after 620ms
Nov  4 11:35:57 F22Host PackageKit: get-updates transaction 
/818_caebecac from uid 1000 finished with success after 582ms
Nov  4 11:36:01 F22Host chronyd[794]: Selected source 72.20.40.62
Nov  4 11:36:01 F22Host kernel: Adjusting tsc more than 11% (8359871 vs 
8115562)
Nov  4 11:36:02 F22Host chronyd[794]: Selected source 76.191.88.3
Nov  4 11:36:06 F22Host audit: <audit-1131> pid=1 uid=0 auid=4294967295 
ses=4294967295 subj=system_u:system_r:init_t:s0 
msg='unit=NetworkManager-dispatcher comm="systemd" 
exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'





-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.fedoraproject.org/pipermail/users/attachments/20151104/e630120f/attachment.html>


More information about the users mailing list