Arch Linux

leonixyz

Member

Registered: 2014-07-12

Posts: 62

NetworkManager having issues with dhcpcd

Hi,

NetworkManager it's giving me troubles with all wireless networks. It seems that it cannot start dhcpcd and fails after 45 secs timeout. Connecting to the same network manually (wpa_supplicant + dhcpcd) works like a charm.

I use nm-applet and can see there are several attempts to configure the network, failing after a timeout. During those phases the journal loops as following:

# journalctl -u NetworkManager -f

Nov 01 23:10:36 banana NetworkManager[3269]: <warn>  [1478038236.6120] dhcp4 (wlp3s0): request timed out
Nov 01 23:10:36 banana NetworkManager[3269]: <info>  [1478038236.6121] dhcp4 (wlp3s0): state changed unknown -> timeout
Nov 01 23:10:36 banana NetworkManager[3269]: <info>  [1478038236.6372] dhcp4 (wlp3s0): canceled DHCP transaction
Nov 01 23:10:36 banana NetworkManager[3269]: <info>  [1478038236.6374] dhcp4 (wlp3s0): state changed timeout -> done
Nov 01 23:10:36 banana NetworkManager[3269]: <info>  [1478038236.6381] device (wlp3s0): state change: ip-config -> failed (reason 'ip-config-unavailable') [70 120 5]
Nov 01 23:10:36 banana NetworkManager[3269]: <info>  [1478038236.6385] manager: NetworkManager state is now DISCONNECTED
Nov 01 23:10:36 banana NetworkManager[3269]: <info>  [1478038236.6387] manager: startup complete
Nov 01 23:10:36 banana NetworkManager[3269]: <warn>  [1478038236.6401] device (wlp3s0): Activation: failed for connection 'HomeNetwork'
Nov 01 23:10:36 banana NetworkManager[3269]: <info>  [1478038236.6424] device (wlp3s0): state change: failed -> disconnected (reason 'none') [120 30 0]
Nov 01 23:10:36 banana NetworkManager[3269]: <info>  [1478038236.7190] device (wlp3s0): set-hw-addr: set MAC address to 56:EF:7B:C4:E1:67 (scanning)
Nov 01 23:10:37 banana NetworkManager[3269]: <warn>  [1478038237.3560] sup-iface[0x17a1ac0,wlp3s0]: connection disconnected (reason -3)
Nov 01 23:10:37 banana NetworkManager[3269]: <info>  [1478038237.3563] device (wlp3s0): supplicant interface state: completed -> disconnected
Nov 01 23:10:37 banana NetworkManager[3269]: <warn>  [1478038237.3565] sup-iface[0x17a1ac0,wlp3s0]: connection disconnected (reason -3)
Nov 01 23:10:37 banana NetworkManager[3269]: <info>  [1478038237.3573] policy: auto-activating connection 'HomeNetwork'
Nov 01 23:10:37 banana NetworkManager[3269]: <info>  [1478038237.3599] device (wlp3s0): Activation: starting connection 'HomeNetwork' (dc31b741-421c-49a9-9ce9-f9c578b2d269)
Nov 01 23:10:37 banana NetworkManager[3269]: <info>  [1478038237.3601] device (wlp3s0): state change: disconnected -> prepare (reason 'none') [30 40 0]
Nov 01 23:10:37 banana NetworkManager[3269]: <info>  [1478038237.3603] manager: NetworkManager state is now CONNECTING
Nov 01 23:10:37 banana NetworkManager[3269]: <info>  [1478038237.3975] device (wlp3s0): set-hw-addr: set-cloned MAC address to AC:D1:B8:2F:2E:A5 (permanent)
Nov 01 23:10:38 banana NetworkManager[3269]: <info>  [1478038238.0640] device (wlp3s0): supplicant interface state: disconnected -> disabled
Nov 01 23:10:38 banana NetworkManager[3269]: <info>  [1478038238.0646] device (wlp3s0): state change: prepare -> config (reason 'none') [40 50 0]
Nov 01 23:10:38 banana NetworkManager[3269]: <info>  [1478038238.0648] device (wlp3s0): Activation: (wifi) access point 'HomeNetwork' has security, but secrets are required.
Nov 01 23:10:38 banana NetworkManager[3269]: <info>  [1478038238.0649] device (wlp3s0): state change: config -> need-auth (reason 'none') [50 60 0]
Nov 01 23:10:38 banana NetworkManager[3269]: <info>  [1478038238.0750] device (wlp3s0): state change: need-auth -> prepare (reason 'none') [60 40 0]
Nov 01 23:10:38 banana NetworkManager[3269]: <info>  [1478038238.0765] device (wlp3s0): state change: prepare -> config (reason 'none') [40 50 0]
Nov 01 23:10:38 banana NetworkManager[3269]: <info>  [1478038238.0774] device (wlp3s0): Activation: (wifi) connection 'HomeNetwork' has security, and secrets exist.  No new secrets needed.
Nov 01 23:10:38 banana NetworkManager[3269]: <info>  [1478038238.0775] Config: added 'ssid' value 'HomeNetwork'
Nov 01 23:10:38 banana NetworkManager[3269]: <info>  [1478038238.0775] Config: added 'scan_ssid' value '1'
Nov 01 23:10:38 banana NetworkManager[3269]: <info>  [1478038238.0776] Config: added 'key_mgmt' value 'WPA-PSK'
Nov 01 23:10:38 banana NetworkManager[3269]: <info>  [1478038238.0776] Config: added 'psk' value '<omitted>'
Nov 01 23:10:38 banana NetworkManager[3269]: <info>  [1478038238.0914] sup-iface[0x17a1ac0,wlp3s0]: config: set interface ap_scan to 1
Nov 01 23:10:38 banana NetworkManager[3269]: <info>  [1478038238.0919] device (wlp3s0): supplicant interface state: disabled -> disconnected
Nov 01 23:10:38 banana NetworkManager[3269]: <info>  [1478038238.1222] device (wlp3s0): supplicant interface state: disconnected -> scanning
Nov 01 23:10:39 banana NetworkManager[3269]: <info>  [1478038239.2100] device (wlp3s0): supplicant interface state: scanning -> authenticating
Nov 01 23:10:39 banana NetworkManager[3269]: <info>  [1478038239.2223] device (wlp3s0): supplicant interface state: authenticating -> associating
Nov 01 23:10:39 banana NetworkManager[3269]: <info>  [1478038239.2380] device (wlp3s0): supplicant interface state: associating -> 4-way handshake
Nov 01 23:10:39 banana NetworkManager[3269]: <info>  [1478038239.2493] device (wlp3s0): supplicant interface state: 4-way handshake -> completed
Nov 01 23:10:39 banana NetworkManager[3269]: <info>  [1478038239.2502] device (wlp3s0): Activation: (wifi) Stage 2 of 5 (Device Configure) successful.  Connected to wireless network 'HomeNetwork'.
Nov 01 23:10:39 banana NetworkManager[3269]: <info>  [1478038239.2505] device (wlp3s0): state change: config -> ip-config (reason 'none') [50 70 0]
Nov 01 23:10:39 banana NetworkManager[3269]: <info>  [1478038239.2511] dhcp4 (wlp3s0): activation: beginning transaction (timeout in 45 seconds)

I tried running `ps aux | grep dhcpcd` during the timeout, but I get no result: it seems dhcpcd is not running at all.

I tried manually starting dhcpcd during these pauses, and in this way my network is fully configured for a short time: I can ping and browse the internet even if the nm-applet icon shows that the connection is not ready. After the timeout, however, i get disconnected and the loop restarts.

I don't use particular settings for the network:

# cat /etc/NetworkManager/system-connections/HomeNetwork

[connection]
id=HomeNetwork
uuid=dc31b741-421c-49a9-9ce9-f9c578b2d269
type=wifi
permissions=user:leonixyz:;
secondaries=
timestamp=1478036730

[wifi]
mac-address=AC:D1:B8:2F:2E:A5
mac-address-blacklist=
mac-address-randomization=0
mode=infrastructure
seen-bssids=00:22:3F:61:E4:C0;
ssid=HomeNetwork

[wifi-security]
group=
key-mgmt=wpa-psk
pairwise=
proto=
psk=TheKey

[ipv4]
dns-search=
method=auto

[ipv6]
addr-gen-mode=stable-privacy
dns-search=
ip6-privacy=0
method=auto

I did not changed /etc/NetworkManager/NetworkManager.conf

There was probably a related post on this forum in the past, but both solutions proposed didn't work https://bbs.archlinux.org/viewtopic.php?id=146261

* dhcpcd systemd unit file is disabled
* using the Link-local setting I get no IP address from the router

What else should I do?

thanks in advance

leonixyz

Member

Registered: 2014-07-12

Posts: 62

Re: NetworkManager having issues with dhcpcd

still here

ewaller

Administrator

From: Pasadena, CA

Registered: 2009-07-13

Posts: 19,774

Re: NetworkManager having issues with dhcpcd

still here

https://wiki.archlinux.org/index.php/Co … ct#Bumping

---

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

leonixyz

Member

Registered: 2014-07-12

Posts: 62

Re: NetworkManager having issues with dhcpcd

Still cannot get it working :-(
it's so weird!

Is there something else which I should consider for debugging this?

journalctl -u NetworkManager

-- Reboot --
Dec 04 01:16:43 banana systemd[1]: Starting Network Manager...
Dec 04 01:16:43 banana NetworkManager[396]: <info>  [1480810603.6930] NetworkManager (version 1.4.2) is starting...
Dec 04 01:16:43 banana NetworkManager[396]: <info>  [1480810603.6931] Read config: /etc/NetworkManager/NetworkManager.conf
Dec 04 01:16:43 banana NetworkManager[396]: <info>  [1480810603.7039] manager[0x17ca040]: monitoring kernel firmware directory '/usr/lib/firmware'.
Dec 04 01:16:43 banana NetworkManager[396]: <info>  [1480810603.7078] dns-mgr[0x17c3030]: init: dns=default, rc-manager=resolvconf
Dec 04 01:16:43 banana NetworkManager[396]: <info>  [1480810603.7162] rfkill2: found WiFi radio killswitch (at /sys/devices/pci0000:00/0000:00:03.3/0000:03:00.0/ieee80211/phy0/rfkill2) (driver rtl8723be)
Dec 04 01:16:43 banana NetworkManager[396]: <info>  [1480810603.7166] rfkill0: found WiFi radio killswitch (at /sys/devices/pci0000:00/0000:00:14.3/PNP0C09:00/VPC2004:00/rfkill/rfkill0) (platform driver ideapad_acpi)
Dec 04 01:16:43 banana NetworkManager[396]: <info>  [1480810603.7224] manager[0x17ca040]: WiFi hardware radio set enabled
Dec 04 01:16:43 banana NetworkManager[396]: <info>  [1480810603.7224] manager[0x17ca040]: WWAN hardware radio set enabled
Dec 04 01:16:43 banana systemd[1]: Started Network Manager.
Dec 04 01:16:43 banana NetworkManager[396]: <info>  [1480810603.7616] settings: loaded plugin keyfile: (c) 2007 - 2015 Red Hat, Inc.  To report bugs please use the NetworkManager mailing list.
Dec 04 01:16:43 banana NetworkManager[396]: <info>  [1480810603.8000] keyfile: new connection /etc/NetworkManager/system-connections/b.WiFi_Hotspot (ae65bed2-a90d-4049-a0c5-630445272324,"b.WiFi_Hotspot")
Dec 04 01:16:43 banana NetworkManager[396]: <info>  [1480810603.8317] keyfile: new connection /etc/NetworkManager/system-connections/b-wireless (6e83d63b-6076-42d5-a1b1-b60a30ab4d68,"b-wireless")
Dec 04 01:16:43 banana NetworkManager[396]: <info>  [1480810603.8636] keyfile: new connection /etc/NetworkManager/system-connections/gentoo (dc31b741-421c-49a9-9ce9-f9c578b2d269,"gentoo")
Dec 04 01:16:43 banana NetworkManager[396]: <info>  [1480810603.8942] keyfile: new connection /etc/NetworkManager/system-connections/WiFi Frecciargento (99b46f9f-ba0f-4990-995a-55409f8f6f18,"WiFi Frecciargento")
Dec 04 01:16:43 banana NetworkManager[396]: <info>  [1480810603.9239] keyfile: new connection /etc/NetworkManager/system-connections/GONG (408f859a-bbd7-42c0-92d2-ea11b68ffb2a,"GONG")
Dec 04 01:16:43 banana NetworkManager[396]: <info>  [1480810603.9493] keyfile: new connection /etc/NetworkManager/system-connections/free (94dbc27b-a859-4a50-8c48-4b39903f9b9f,"free")
Dec 04 01:16:43 banana NetworkManager[396]: <info>  [1480810603.9748] keyfile: new connection /etc/NetworkManager/system-connections/ScientificNetworkSouthTyrol (1b346d4c-d886-4c5c-8df0-2d5bc114f3f8,"ScientificNetworkSouthTyrol")
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1231] settings: hostname: using hostnamed
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1231] settings: hostname changed from (none) to "banana"
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1235] dhcp-init: Using DHCP client 'internal'
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1236] manager: WiFi enabled by radio killswitch; enabled by state file
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1236] manager: WWAN enabled by radio killswitch; enabled by state file
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1237] manager: Networking is enabled by state file
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1238] Loaded device plugin: NMVxlanFactory (internal)
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1238] Loaded device plugin: NMVlanFactory (internal)
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1238] Loaded device plugin: NMVethFactory (internal)
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1239] Loaded device plugin: NMTunFactory (internal)
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1239] Loaded device plugin: NMMacvlanFactory (internal)
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1240] Loaded device plugin: NMIPTunnelFactory (internal)
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1240] Loaded device plugin: NMInfinibandFactory (internal)
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1241] Loaded device plugin: NMEthernetFactory (internal)
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1241] Loaded device plugin: NMBridgeFactory (internal)
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1242] Loaded device plugin: NMBondFactory (internal)
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1297] Loaded device plugin: NMAtmManager (/usr/lib/NetworkManager/libnm-device-plugin-adsl.so)
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1364] Loaded device plugin: NMBluezManager (/usr/lib/NetworkManager/libnm-device-plugin-bluetooth.so)
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1382] Loaded device plugin: NMWwanFactory (/usr/lib/NetworkManager/libnm-device-plugin-wwan.so)
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1400] Loaded device plugin: NMWifiFactory (/usr/lib/NetworkManager/libnm-device-plugin-wifi.so)
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1569] Loaded device plugin: NMTeamFactory (/usr/lib/NetworkManager/libnm-device-plugin-team.so)
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1589] device (lo): link connected
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1604] manager: (lo): new Generic device (/org/freedesktop/NetworkManager/Devices/0)
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1634] manager: (enp2s0): new Ethernet device (/org/freedesktop/NetworkManager/Devices/1)
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1661] keyfile: add connection in-memory (1ff53b85-cdd1-3c17-84aa-a556652f9d08,"Wired connection 1")
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1683] settings: (enp2s0): created default wired connection 'Wired connection 1'
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1705] device (enp2s0): state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1728] (wlp3s0): using nl80211 for WiFi device control
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1732] device (wlp3s0): driver supports Access Point (AP) mode
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1752] manager: (wlp3s0): new 802.11 WiFi device (/org/freedesktop/NetworkManager/Devices/2)
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1771] device (wlp3s0): state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.9975] device (wlp3s0): set-hw-addr: set MAC address to A2:38:37:5B:9F:59 (scanning)
Dec 04 01:16:45 banana NetworkManager[396]: <info>  [1480810605.6533] supplicant: wpa_supplicant running
Dec 04 01:16:45 banana NetworkManager[396]: <info>  [1480810605.6534] device (wlp3s0): supplicant interface state: init -> starting
Dec 04 01:16:45 banana NetworkManager[396]: <info>  [1480810605.7117] sup-iface[0x188c350,wlp3s0]: supports 4 scan SSIDs
Dec 04 01:16:45 banana NetworkManager[396]: <info>  [1480810605.7141] device (wlp3s0): supplicant interface state: starting -> ready
Dec 04 01:16:45 banana NetworkManager[396]: <info>  [1480810605.7143] device (wlp3s0): state change: unavailable -> disconnected (reason 'supplicant-available') [20 30 42]
Dec 04 01:16:47 banana NetworkManager[396]: <info>  [1480810607.3532] device (wlp3s0): supplicant interface state: ready -> inactive
Dec 04 01:16:49 banana NetworkManager[396]: <info>  [1480810609.6010] manager: startup complete
Dec 04 01:16:54 banana NetworkManager[396]: <info>  [1480810614.4166] policy: auto-activating connection 'gentoo'
Dec 04 01:16:54 banana NetworkManager[396]: <info>  [1480810614.4191] device (wlp3s0): Activation: starting connection 'gentoo' (dc31b741-421c-49a9-9ce9-f9c578b2d269)
Dec 04 01:16:54 banana NetworkManager[396]: <info>  [1480810614.4195] device (wlp3s0): state change: disconnected -> prepare (reason 'none') [30 40 0]
Dec 04 01:16:54 banana NetworkManager[396]: <info>  [1480810614.4197] manager: NetworkManager state is now CONNECTING
Dec 04 01:16:55 banana NetworkManager[396]: <info>  [1480810615.1650] device (wlp3s0): set-hw-addr: set-cloned MAC address to AC:D1:B8:2F:2E:A5 (permanent)
Dec 04 01:16:55 banana NetworkManager[396]: <info>  [1480810615.8514] device (wlp3s0): supplicant interface state: inactive -> disabled
Dec 04 01:16:55 banana NetworkManager[396]: <info>  [1480810615.8520] device (wlp3s0): state change: prepare -> config (reason 'none') [40 50 0]
Dec 04 01:16:55 banana NetworkManager[396]: <info>  [1480810615.8524] device (wlp3s0): Activation: (wifi) access point 'gentoo' has security, but secrets are required.
Dec 04 01:16:55 banana NetworkManager[396]: <info>  [1480810615.8524] device (wlp3s0): state change: config -> need-auth (reason 'none') [50 60 0]
Dec 04 01:16:55 banana NetworkManager[396]: <info>  [1480810615.8602] device (wlp3s0): state change: need-auth -> prepare (reason 'none') [60 40 0]
Dec 04 01:16:55 banana NetworkManager[396]: <info>  [1480810615.8609] device (wlp3s0): state change: prepare -> config (reason 'none') [40 50 0]
Dec 04 01:16:55 banana NetworkManager[396]: <info>  [1480810615.8612] device (wlp3s0): Activation: (wifi) connection 'gentoo' has security, and secrets exist.  No new secrets needed.
Dec 04 01:16:55 banana NetworkManager[396]: <info>  [1480810615.8613] Config: added 'ssid' value 'gentoo'
Dec 04 01:16:55 banana NetworkManager[396]: <info>  [1480810615.8613] Config: added 'scan_ssid' value '1'
Dec 04 01:16:55 banana NetworkManager[396]: <info>  [1480810615.8614] Config: added 'key_mgmt' value 'WPA-PSK'
Dec 04 01:16:55 banana NetworkManager[396]: <info>  [1480810615.8614] Config: added 'psk' value '<omitted>'
Dec 04 01:16:55 banana NetworkManager[396]: <info>  [1480810615.8668] sup-iface[0x188c350,wlp3s0]: config: set interface ap_scan to 1
Dec 04 01:16:55 banana NetworkManager[396]: <info>  [1480810615.8671] device (wlp3s0): supplicant interface state: disabled -> inactive
Dec 04 01:16:55 banana NetworkManager[396]: <info>  [1480810615.8885] device (wlp3s0): supplicant interface state: inactive -> scanning
Dec 04 01:16:56 banana NetworkManager[396]: <info>  [1480810616.9848] device (wlp3s0): supplicant interface state: scanning -> authenticating
Dec 04 01:16:56 banana NetworkManager[396]: <info>  [1480810616.9989] device (wlp3s0): supplicant interface state: authenticating -> associating
Dec 04 01:16:57 banana NetworkManager[396]: <info>  [1480810617.0212] device (wlp3s0): supplicant interface state: associating -> 4-way handshake
Dec 04 01:16:57 banana NetworkManager[396]: <info>  [1480810617.0640] device (wlp3s0): supplicant interface state: 4-way handshake -> completed
Dec 04 01:16:57 banana NetworkManager[396]: <info>  [1480810617.0642] device (wlp3s0): Activation: (wifi) Stage 2 of 5 (Device Configure) successful.  Connected to wireless network 'gentoo'.
Dec 04 01:16:57 banana NetworkManager[396]: <info>  [1480810617.0643] device (wlp3s0): state change: config -> ip-config (reason 'none') [50 70 0]
Dec 04 01:16:57 banana NetworkManager[396]: <info>  [1480810617.0650] dhcp4 (wlp3s0): activation: beginning transaction (timeout in 45 seconds)
Dec 04 01:17:42 banana NetworkManager[396]: <warn>  [1480810662.6042] dhcp4 (wlp3s0): request timed out
Dec 04 01:17:42 banana NetworkManager[396]: <info>  [1480810662.6043] dhcp4 (wlp3s0): state changed unknown -> timeout
Dec 04 01:17:42 banana NetworkManager[396]: <info>  [1480810662.6261] dhcp4 (wlp3s0): canceled DHCP transaction
Dec 04 01:17:42 banana NetworkManager[396]: <info>  [1480810662.6262] dhcp4 (wlp3s0): state changed timeout -> done
Dec 04 01:17:42 banana NetworkManager[396]: <info>  [1480810662.6271] device (wlp3s0): state change: ip-config -> failed (reason 'ip-config-unavailable') [70 120 5]
Dec 04 01:17:42 banana NetworkManager[396]: <info>  [1480810662.6276] manager: NetworkManager state is now DISCONNECTED
Dec 04 01:17:42 banana NetworkManager[396]: <warn>  [1480810662.6295] device (wlp3s0): Activation: failed for connection 'gentoo'
Dec 04 01:17:42 banana NetworkManager[396]: <info>  [1480810662.6318] device (wlp3s0): state change: failed -> disconnected (reason 'none') [120 30 0]
Dec 04 01:17:42 banana NetworkManager[396]: <info>  [1480810662.6757] device (wlp3s0): set-hw-addr: set MAC address to 0A:49:E8:4E:D3:10 (scanning)
Dec 04 01:17:43 banana NetworkManager[396]: <warn>  [1480810663.3905] sup-iface[0x188c350,wlp3s0]: connection disconnected (reason -3)
Dec 04 01:17:43 banana NetworkManager[396]: <info>  [1480810663.3913] device (wlp3s0): supplicant interface state: completed -> disconnected
Dec 04 01:17:44 banana NetworkManager[396]: <info>  [1480810664.4711] policy: auto-activating connection 'gentoo'
Dec 04 01:17:44 banana NetworkManager[396]: <info>  [1480810664.4741] device (wlp3s0): Activation: starting connection 'gentoo' (dc31b741-421c-49a9-9ce9-f9c578b2d269)
Dec 04 01:17:44 banana NetworkManager[396]: <info>  [1480810664.4760] device (wlp3s0): state change: disconnected -> prepare (reason 'none') [30 40 0]
Dec 04 01:17:44 banana NetworkManager[396]: <info>  [1480810664.4770] manager: NetworkManager state is now CONNECTING
Dec 04 01:17:44 banana NetworkManager[396]: <info>  [1480810664.5889] device (wlp3s0): set-hw-addr: set-cloned MAC address to AC:D1:B8:2F:2E:A5 (permanent)
Dec 04 01:17:45 banana NetworkManager[396]: <info>  [1480810665.2002] device (wlp3s0): supplicant interface state: disconnected -> disabled
Dec 04 01:17:45 banana NetworkManager[396]: <info>  [1480810665.2008] device (wlp3s0): state change: prepare -> config (reason 'none') [40 50 0]
Dec 04 01:17:45 banana NetworkManager[396]: <info>  [1480810665.2011] device (wlp3s0): Activation: (wifi) access point 'gentoo' has security, but secrets are required.
Dec 04 01:17:45 banana NetworkManager[396]: <info>  [1480810665.2012] device (wlp3s0): state change: config -> need-auth (reason 'none') [50 60 0]
Dec 04 01:17:45 banana NetworkManager[396]: <info>  [1480810665.2110] device (wlp3s0): state change: need-auth -> prepare (reason 'none') [60 40 0]
Dec 04 01:17:45 banana NetworkManager[396]: <info>  [1480810665.2116] device (wlp3s0): state change: prepare -> config (reason 'none') [40 50 0]
Dec 04 01:17:45 banana NetworkManager[396]: <info>  [1480810665.2119] device (wlp3s0): Activation: (wifi) connection 'gentoo' has security, and secrets exist.  No new secrets needed.
Dec 04 01:17:45 banana NetworkManager[396]: <info>  [1480810665.2119] Config: added 'ssid' value 'gentoo'
Dec 04 01:17:45 banana NetworkManager[396]: <info>  [1480810665.2120] Config: added 'scan_ssid' value '1'
Dec 04 01:17:45 banana NetworkManager[396]: <info>  [1480810665.2120] Config: added 'key_mgmt' value 'WPA-PSK'
Dec 04 01:17:45 banana NetworkManager[396]: <info>  [1480810665.2121] Config: added 'psk' value '<omitted>'
Dec 04 01:17:45 banana NetworkManager[396]: <info>  [1480810665.2304] sup-iface[0x188c350,wlp3s0]: config: set interface ap_scan to 1
Dec 04 01:17:45 banana NetworkManager[396]: <info>  [1480810665.2308] device (wlp3s0): supplicant interface state: disabled -> disconnected
Dec 04 01:17:45 banana NetworkManager[396]: <info>  [1480810665.2534] device (wlp3s0): supplicant interface state: disconnected -> scanning
Dec 04 01:17:46 banana NetworkManager[396]: <info>  [1480810666.2829] device (wlp3s0): supplicant interface state: scanning -> authenticating
Dec 04 01:17:46 banana NetworkManager[396]: <info>  [1480810666.2923] device (wlp3s0): supplicant interface state: authenticating -> associating
Dec 04 01:17:46 banana NetworkManager[396]: <info>  [1480810666.3119] device (wlp3s0): supplicant interface state: associating -> 4-way handshake
Dec 04 01:17:46 banana NetworkManager[396]: <info>  [1480810666.3244] device (wlp3s0): supplicant interface state: 4-way handshake -> completed
Dec 04 01:17:46 banana NetworkManager[396]: <info>  [1480810666.3250] device (wlp3s0): Activation: (wifi) Stage 2 of 5 (Device Configure) successful.  Connected to wireless network 'gentoo'.
Dec 04 01:17:46 banana NetworkManager[396]: <info>  [1480810666.3251] device (wlp3s0): state change: config -> ip-config (reason 'none') [50 70 0]
Dec 04 01:17:46 banana NetworkManager[396]: <info>  [1480810666.3258] dhcp4 (wlp3s0): activation: beginning transaction (timeout in 45 seconds)

journalctl -u wpa_supplicant

-- Reboot --
Dec 04 01:16:45 banana systemd[1]: Starting WPA supplicant...
Dec 04 01:16:45 banana wpa_supplicant[978]: Successfully initialized wpa_supplicant
Dec 04 01:16:45 banana systemd[1]: Started WPA supplicant.
Dec 04 01:16:56 banana wpa_supplicant[978]: wlp3s0: SME: Trying to authenticate with 00:22:3f:61:e4:c0 (SSID='gentoo' freq=2472 MHz)
Dec 04 01:16:56 banana wpa_supplicant[978]: wlp3s0: Trying to associate with 00:22:3f:61:e4:c0 (SSID='gentoo' freq=2472 MHz)
Dec 04 01:16:57 banana wpa_supplicant[978]: wlp3s0: Associated with 00:22:3f:61:e4:c0
Dec 04 01:16:57 banana wpa_supplicant[978]: wlp3s0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Dec 04 01:16:57 banana wpa_supplicant[978]: wlp3s0: WPA: Key negotiation completed with 00:22:3f:61:e4:c0 [PTK=CCMP GTK=CCMP]
Dec 04 01:16:57 banana wpa_supplicant[978]: wlp3s0: CTRL-EVENT-CONNECTED - Connection to 00:22:3f:61:e4:c0 completed [id=0 id_str=]
Dec 04 01:17:42 banana wpa_supplicant[978]: wlp3s0: CTRL-EVENT-DISCONNECTED bssid=00:22:3f:61:e4:c0 reason=3 locally_generated=1
Dec 04 01:17:46 banana wpa_supplicant[978]: wlp3s0: SME: Trying to authenticate with 00:22:3f:61:e4:c0 (SSID='gentoo' freq=2472 MHz)
Dec 04 01:17:46 banana wpa_supplicant[978]: wlp3s0: Trying to associate with 00:22:3f:61:e4:c0 (SSID='gentoo' freq=2472 MHz)
Dec 04 01:17:46 banana wpa_supplicant[978]: wlp3s0: Associated with 00:22:3f:61:e4:c0
Dec 04 01:17:46 banana wpa_supplicant[978]: wlp3s0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Dec 04 01:17:46 banana wpa_supplicant[978]: wlp3s0: WPA: Key negotiation completed with 00:22:3f:61:e4:c0 [PTK=CCMP GTK=CCMP]
Dec 04 01:17:46 banana wpa_supplicant[978]: wlp3s0: CTRL-EVENT-CONNECTED - Connection to 00:22:3f:61:e4:c0 completed [id=0 id_str=]
Dec 04 01:18:31 banana wpa_supplicant[978]: wlp3s0: CTRL-EVENT-DISCONNECTED bssid=00:22:3f:61:e4:c0 reason=3 locally_generated=1
Dec 04 01:18:35 banana wpa_supplicant[978]: wlp3s0: SME: Trying to authenticate with 00:22:3f:61:e4:c0 (SSID='gentoo' freq=2472 MHz)
Dec 04 01:18:35 banana wpa_supplicant[978]: wlp3s0: Trying to associate with 00:22:3f:61:e4:c0 (SSID='gentoo' freq=2472 MHz)
Dec 04 01:18:35 banana wpa_supplicant[978]: wlp3s0: Associated with 00:22:3f:61:e4:c0
Dec 04 01:18:35 banana wpa_supplicant[978]: wlp3s0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Dec 04 01:18:35 banana wpa_supplicant[978]: wlp3s0: WPA: Key negotiation completed with 00:22:3f:61:e4:c0 [PTK=CCMP GTK=CCMP]
Dec 04 01:18:35 banana wpa_supplicant[978]: wlp3s0: CTRL-EVENT-CONNECTED - Connection to 00:22:3f:61:e4:c0 completed [id=0 id_str=]

seth

Member

Registered: 2012-09-03

Posts: 51,071

Re: NetworkManager having issues with dhcpcd

cough!

Look at the journal you posted!
Your problem isn't dhcp but this line

---

How to upload text · How to boot w/o GUI · Disable Windows Fast-Start! · Fix your xinitrc

bryan.paradis

Member

Registered: 2016-10-22

Posts: 43

Re: NetworkManager having issues with dhcpcd

1) What is your NetworkManager.conf?
2) What changed since it was working?
3) I think NetworkManager is using it's own internet dhcp client no?
4) Have you tried using dhcp=dhclient or whatever else there is available instead of the internal client?

Dec 04 01:16:44 banana NetworkManager[396]: <info>  [1480810604.1235] dhcp-init: Using DHCP client 'internal'

GrimBandito

Member

Registered: 2016-12-04

Posts: 41

Re: NetworkManager having issues with dhcpcd

You don't need to use dhcpcd when you have NetworkManager (NM) configured to start at boot. Afaik, NM has it's own method of obtaining an IP address. Either leave dhcpcd disabled via

sudo systemctl disable dhcpcd

or uninstall it.

Dhcpcd is useful for after your initial Arch install to get you back onto the network, but once a graphical environment is installed and NM is installed, it is no longer needed.

Hope this is useful.