You are not logged in.

#1 2018-03-31 06:56:55

shein
Member
Registered: 2017-04-20
Posts: 7

[SOLVED] dhcpcd upgrade makes wifi constantly disconnect

Hi All,

After I upgraded from dhcpcd-6.11.5-1 to dhcpcd-7.0.1-1 my wifi connection  is constantly disconnecting.
There's an error message in NetworkManager logs:

NetworkManager[568]: <warn>  [1522478420.8553] dhcp6 (wlp3s0): failed to start client (-98)

Full NetworkManager log:

-- Logs begin at Sat 2018-01-20 10:10:31 EET. --
Mar 31 09:38:54 think-arch NetworkManager[568]: <info>  [1522478334.3440] device (lxcbr0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'external')
Mar 31 09:38:54 think-arch NetworkManager[568]: <info>  [1522478334.3444] device (lxcbr0): state change: prepare -> config (reason 'none', sys-iface-state: 'external')
Mar 31 09:38:54 think-arch NetworkManager[568]: <info>  [1522478334.3445] device (lxcbr0): state change: config -> ip-config (reason 'none', sys-iface-state: 'external')
Mar 31 09:38:54 think-arch NetworkManager[568]: <info>  [1522478334.3446] device (lxcbr0): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'external')
Mar 31 09:38:54 think-arch NetworkManager[568]: <info>  [1522478334.3449] device (lxcbr0): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'external')
Mar 31 09:38:54 think-arch NetworkManager[568]: <info>  [1522478334.3451] device (lxcbr0): state change: secondaries -> activated (reason 'none', sys-iface-state: 'external')
Mar 31 09:38:54 think-arch NetworkManager[568]: <info>  [1522478334.3452] manager: NetworkManager state is now CONNECTED_LOCAL
Mar 31 09:38:54 think-arch NetworkManager[568]: <info>  [1522478334.5806] device (lxcbr0): Activation: successful, device activated.
Mar 31 09:38:54 think-arch NetworkManager[568]: <info>  [1522478334.6480] supplicant: wpa_supplicant running
Mar 31 09:39:00 think-arch NetworkManager[568]: <info>  [1522478340.3300] manager: startup complete
Mar 31 09:40:11 think-arch NetworkManager[568]: <info>  [1522478411.6564] manager: rfkill: WiFi now enabled by radio killswitch
Mar 31 09:40:12 think-arch NetworkManager[568]: <info>  [1522478412.0738] sup-iface[0x5596daf662d0,wlp3s0]: supports 5 scan SSIDs
Mar 31 09:40:12 think-arch NetworkManager[568]: <info>  [1522478412.0747] device (wlp3s0): supplicant interface state: starting -> ready
Mar 31 09:40:12 think-arch NetworkManager[568]: <info>  [1522478412.0748] device (wlp3s0): state change: unavailable -> disconnected (reason 'supplicant-available', sys-iface-state: 'managed')
Mar 31 09:40:12 think-arch NetworkManager[568]: <info>  [1522478412.9612] bluez: use BlueZ version 5
Mar 31 09:40:13 think-arch NetworkManager[568]: <info>  [1522478413.1422] bluez5: NAP: added interface 0C:84:DC:D9:D1:E3
Mar 31 09:40:13 think-arch NetworkManager[568]: <info>  [1522478413.3717] keyfile: add connection in-memory (5a2f0d5b-702f-48b7-a65f-0663abcddb2c,"Mi Phone Network")
Mar 31 09:40:13 think-arch NetworkManager[568]: <info>  [1522478413.3732] bluez: BT device Mi Phone (34:80:B3:3A:F9:7E) added (NAP)
Mar 31 09:40:13 think-arch NetworkManager[568]: <info>  [1522478413.3738] manager: (34:80:B3:3A:F9:7E): new Bluetooth device (/org/freedesktop/NetworkManager/Devices/5)
Mar 31 09:40:13 think-arch NetworkManager[568]: <info>  [1522478413.3739] device (34:80:B3:3A:F9:7E): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
Mar 31 09:40:13 think-arch NetworkManager[568]: <info>  [1522478413.3750] keyfile: add connection in-memory (5037c672-3ccb-4757-a45a-8a4211610e6e,"Xiaomi 4c Network")
Mar 31 09:40:13 think-arch NetworkManager[568]: <info>  [1522478413.3761] bluez: BT device Xiaomi 4c (10:2A:B3:98:34:D4) added (DUN NAP)
Mar 31 09:40:13 think-arch NetworkManager[568]: <info>  [1522478413.3769] manager: (10:2A:B3:98:34:D4): new Bluetooth device (/org/freedesktop/NetworkManager/Devices/6)
Mar 31 09:40:13 think-arch NetworkManager[568]: <info>  [1522478413.3775] device (10:2A:B3:98:34:D4): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
Mar 31 09:40:13 think-arch NetworkManager[568]: <info>  [1522478413.3838] device (34:80:B3:3A:F9:7E): state change: unavailable -> disconnected (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:13 think-arch NetworkManager[568]: <info>  [1522478413.3841] device (10:2A:B3:98:34:D4): state change: unavailable -> disconnected (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:15 think-arch NetworkManager[568]: <info>  [1522478415.2716] policy: auto-activating connection 'kindray 5g'
Mar 31 09:40:15 think-arch NetworkManager[568]: <info>  [1522478415.2724] device (wlp3s0): Activation: starting connection 'kindray 5g' (1eaeae33-0417-4861-b2de-34bc45508217)
Mar 31 09:40:15 think-arch NetworkManager[568]: <info>  [1522478415.2726] device (wlp3s0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:15 think-arch NetworkManager[568]: <info>  [1522478415.2728] manager: NetworkManager state is now CONNECTING
Mar 31 09:40:15 think-arch NetworkManager[568]: <info>  [1522478415.2883] device (wlp3s0): set-hw-addr: reset MAC address to 6C:88:14:53:38:F4 (preserve)
Mar 31 09:40:15 think-arch NetworkManager[568]: <info>  [1522478415.6777] device (wlp3s0): supplicant interface state: ready -> disabled
Mar 31 09:40:15 think-arch NetworkManager[568]: <info>  [1522478415.6782] device (wlp3s0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:15 think-arch NetworkManager[568]: <info>  [1522478415.6786] device (wlp3s0): Activation: (wifi) access point 'kindray 5g' has security, but secrets are required.
Mar 31 09:40:15 think-arch NetworkManager[568]: <info>  [1522478415.6786] device (wlp3s0): state change: config -> need-auth (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:15 think-arch NetworkManager[568]: <info>  [1522478415.6809] device (wlp3s0): supplicant interface state: disabled -> inactive
Mar 31 09:40:15 think-arch NetworkManager[568]: <info>  [1522478415.6845] device (wlp3s0): state change: need-auth -> prepare (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:15 think-arch NetworkManager[568]: <info>  [1522478415.6848] device (wlp3s0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:15 think-arch NetworkManager[568]: <info>  [1522478415.6851] device (wlp3s0): Activation: (wifi) connection 'kindray 5g' has security, and secrets exist.  No new secrets needed.
Mar 31 09:40:15 think-arch NetworkManager[568]: <info>  [1522478415.6852] Config: added 'ssid' value 'kindray 5g'
Mar 31 09:40:15 think-arch NetworkManager[568]: <info>  [1522478415.6852] Config: added 'scan_ssid' value '1'
Mar 31 09:40:15 think-arch NetworkManager[568]: <info>  [1522478415.6852] Config: added 'bgscan' value 'simple:30:-80:86400'
Mar 31 09:40:15 think-arch NetworkManager[568]: <info>  [1522478415.6852] Config: added 'key_mgmt' value 'WPA-PSK'
Mar 31 09:40:15 think-arch NetworkManager[568]: <info>  [1522478415.6852] Config: added 'auth_alg' value 'OPEN'
Mar 31 09:40:15 think-arch NetworkManager[568]: <info>  [1522478415.6852] Config: added 'psk' value '<hidden>'
Mar 31 09:40:15 think-arch NetworkManager[568]: <info>  [1522478415.7027] device (wlp3s0): supplicant interface state: inactive -> scanning
Mar 31 09:40:18 think-arch NetworkManager[568]: <info>  [1522478418.9455] device (wlp3s0): supplicant interface state: scanning -> authenticating
Mar 31 09:40:18 think-arch NetworkManager[568]: <info>  [1522478418.9878] device (wlp3s0): supplicant interface state: authenticating -> associating
Mar 31 09:40:19 think-arch NetworkManager[568]: <info>  [1522478419.0256] device (wlp3s0): supplicant interface state: associating -> completed
Mar 31 09:40:19 think-arch NetworkManager[568]: <info>  [1522478419.0256] device (wlp3s0): Activation: (wifi) Stage 2 of 5 (Device Configure) successful.  Connected to wireless network 'kindray 5g'.
Mar 31 09:40:19 think-arch NetworkManager[568]: <info>  [1522478419.0266] device (wlp3s0): state change: config -> ip-config (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:19 think-arch NetworkManager[568]: <info>  [1522478419.0270] dhcp4 (wlp3s0): activation: beginning transaction (timeout in 45 seconds)
Mar 31 09:40:19 think-arch NetworkManager[568]: <info>  [1522478419.0921] dhcp4 (wlp3s0):   address 192.168.1.167
Mar 31 09:40:19 think-arch NetworkManager[568]: <info>  [1522478419.0921] dhcp4 (wlp3s0):   plen 24
Mar 31 09:40:19 think-arch NetworkManager[568]: <info>  [1522478419.0921] dhcp4 (wlp3s0):   expires in 43200 seconds
Mar 31 09:40:19 think-arch NetworkManager[568]: <info>  [1522478419.0921] dhcp4 (wlp3s0):   nameserver '192.168.1.1'
Mar 31 09:40:19 think-arch NetworkManager[568]: <info>  [1522478419.0922] dhcp4 (wlp3s0):   domain name 'lan'
Mar 31 09:40:19 think-arch NetworkManager[568]: <info>  [1522478419.0922] dhcp4 (wlp3s0):   hostname 'think-arch'
Mar 31 09:40:19 think-arch NetworkManager[568]: <info>  [1522478419.0922] dhcp4 (wlp3s0):   gateway 192.168.1.1
Mar 31 09:40:19 think-arch NetworkManager[568]: <info>  [1522478419.0924] dhcp4 (wlp3s0): state changed unknown -> bound
Mar 31 09:40:19 think-arch NetworkManager[568]: <info>  [1522478419.0937] device (wlp3s0): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:19 think-arch NetworkManager[568]: <info>  [1522478419.0943] device (wlp3s0): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:19 think-arch NetworkManager[568]: <info>  [1522478419.0946] device (wlp3s0): state change: secondaries -> activated (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:19 think-arch NetworkManager[568]: <info>  [1522478419.0947] manager: NetworkManager state is now CONNECTED_LOCAL
Mar 31 09:40:19 think-arch NetworkManager[568]: <info>  [1522478419.1332] manager: NetworkManager state is now CONNECTED_SITE
Mar 31 09:40:19 think-arch NetworkManager[568]: <info>  [1522478419.1333] policy: set 'kindray 5g' (wlp3s0) as default for IPv4 routing and DNS
Mar 31 09:40:19 think-arch NetworkManager[568]: <info>  [1522478419.1683] device (wlp3s0): Activation: successful, device activated.
Mar 31 09:40:20 think-arch NetworkManager[568]: <info>  [1522478420.2724] manager: NetworkManager state is now CONNECTED_GLOBAL
Mar 31 09:40:20 think-arch NetworkManager[568]: <info>  [1522478420.8552] dhcp6 (wlp3s0): activation: beginning transaction (timeout in 45 seconds)
Mar 31 09:40:20 think-arch NetworkManager[568]: <warn>  [1522478420.8553] dhcp6 (wlp3s0): failed to start client (-98)
Mar 31 09:40:20 think-arch NetworkManager[568]: <info>  [1522478420.8554] device (wlp3s0): state change: activated -> failed (reason 'dhcp-start-failed', sys-iface-state: 'managed')
Mar 31 09:40:20 think-arch NetworkManager[568]: <warn>  [1522478420.8948] device (wlp3s0): Activation: failed for connection 'kindray 5g'
Mar 31 09:40:20 think-arch NetworkManager[568]: <info>  [1522478420.8958] manager: NetworkManager state is now CONNECTED_LOCAL
Mar 31 09:40:20 think-arch NetworkManager[568]: <info>  [1522478420.8978] device (wlp3s0): state change: failed -> disconnected (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:20 think-arch NetworkManager[568]: <info>  [1522478420.8988] dhcp4 (wlp3s0): canceled DHCP transaction
Mar 31 09:40:20 think-arch NetworkManager[568]: <info>  [1522478420.8989] dhcp4 (wlp3s0): state changed bound -> done
Mar 31 09:40:20 think-arch NetworkManager[568]: <info>  [1522478420.9441] device (wlp3s0): set-hw-addr: set MAC address to 56:CC:D8:B0:98:5B (scanning)
Mar 31 09:40:21 think-arch NetworkManager[568]: <warn>  [1522478421.3574] sup-iface[0x5596daf662d0,wlp3s0]: connection disconnected (reason -3)
Mar 31 09:40:21 think-arch NetworkManager[568]: <info>  [1522478421.3580] device (wlp3s0): supplicant interface state: completed -> disconnected
Mar 31 09:40:21 think-arch NetworkManager[568]: <info>  [1522478421.3632] device (wlp3s0): supplicant interface state: disconnected -> disabled
Mar 31 09:40:21 think-arch NetworkManager[568]: <info>  [1522478421.3633] device (wlp3s0): supplicant interface state: disabled -> disconnected
Mar 31 09:40:24 think-arch NetworkManager[568]: <info>  [1522478424.4926] policy: auto-activating connection 'kindray 5g'
Mar 31 09:40:24 think-arch NetworkManager[568]: <info>  [1522478424.4937] device (wlp3s0): Activation: starting connection 'kindray 5g' (1eaeae33-0417-4861-b2de-34bc45508217)
Mar 31 09:40:24 think-arch NetworkManager[568]: <info>  [1522478424.4939] device (wlp3s0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:24 think-arch NetworkManager[568]: <info>  [1522478424.4941] manager: NetworkManager state is now CONNECTING
Mar 31 09:40:24 think-arch NetworkManager[568]: <info>  [1522478424.5116] device (wlp3s0): set-hw-addr: reset MAC address to 6C:88:14:53:38:F4 (preserve)
Mar 31 09:40:24 think-arch NetworkManager[568]: <info>  [1522478424.9190] device (wlp3s0): supplicant interface state: disconnected -> disabled
Mar 31 09:40:24 think-arch NetworkManager[568]: <info>  [1522478424.9194] device (wlp3s0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:24 think-arch NetworkManager[568]: <info>  [1522478424.9197] device (wlp3s0): Activation: (wifi) access point 'kindray 5g' has security, but secrets are required.
Mar 31 09:40:24 think-arch NetworkManager[568]: <info>  [1522478424.9197] device (wlp3s0): state change: config -> need-auth (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:24 think-arch NetworkManager[568]: <info>  [1522478424.9232] device (wlp3s0): state change: need-auth -> prepare (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:24 think-arch NetworkManager[568]: <info>  [1522478424.9235] device (wlp3s0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:24 think-arch NetworkManager[568]: <info>  [1522478424.9238] device (wlp3s0): Activation: (wifi) connection 'kindray 5g' has security, and secrets exist.  No new secrets needed.
Mar 31 09:40:24 think-arch NetworkManager[568]: <info>  [1522478424.9238] Config: added 'ssid' value 'kindray 5g'
Mar 31 09:40:24 think-arch NetworkManager[568]: <info>  [1522478424.9238] Config: added 'scan_ssid' value '1'
Mar 31 09:40:24 think-arch NetworkManager[568]: <info>  [1522478424.9238] Config: added 'bgscan' value 'simple:30:-80:86400'
Mar 31 09:40:24 think-arch NetworkManager[568]: <info>  [1522478424.9238] Config: added 'key_mgmt' value 'WPA-PSK'
Mar 31 09:40:24 think-arch NetworkManager[568]: <info>  [1522478424.9238] Config: added 'auth_alg' value 'OPEN'
Mar 31 09:40:24 think-arch NetworkManager[568]: <info>  [1522478424.9238] Config: added 'psk' value '<hidden>'
Mar 31 09:40:24 think-arch NetworkManager[568]: <info>  [1522478424.9256] device (wlp3s0): supplicant interface state: disabled -> disconnected
Mar 31 09:40:24 think-arch NetworkManager[568]: <info>  [1522478424.9372] device (wlp3s0): supplicant interface state: disconnected -> scanning
Mar 31 09:40:28 think-arch NetworkManager[568]: <info>  [1522478428.0629] device (wlp3s0): supplicant interface state: scanning -> authenticating
Mar 31 09:40:28 think-arch NetworkManager[568]: <info>  [1522478428.0653] device (wlp3s0): supplicant interface state: authenticating -> associating
Mar 31 09:40:28 think-arch NetworkManager[568]: <info>  [1522478428.0852] device (wlp3s0): supplicant interface state: associating -> completed
Mar 31 09:40:28 think-arch NetworkManager[568]: <info>  [1522478428.0854] device (wlp3s0): Activation: (wifi) Stage 2 of 5 (Device Configure) successful.  Connected to wireless network 'kindray 5g'.
Mar 31 09:40:28 think-arch NetworkManager[568]: <info>  [1522478428.0863] device (wlp3s0): state change: config -> ip-config (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:28 think-arch NetworkManager[568]: <info>  [1522478428.0867] dhcp4 (wlp3s0): activation: beginning transaction (timeout in 45 seconds)
Mar 31 09:40:28 think-arch NetworkManager[568]: <info>  [1522478428.3144] dhcp4 (wlp3s0):   address 192.168.1.167
Mar 31 09:40:28 think-arch NetworkManager[568]: <info>  [1522478428.3144] dhcp4 (wlp3s0):   plen 24
Mar 31 09:40:28 think-arch NetworkManager[568]: <info>  [1522478428.3145] dhcp4 (wlp3s0):   expires in 43200 seconds
Mar 31 09:40:28 think-arch NetworkManager[568]: <info>  [1522478428.3145] dhcp4 (wlp3s0):   nameserver '192.168.1.1'
Mar 31 09:40:28 think-arch NetworkManager[568]: <info>  [1522478428.3145] dhcp4 (wlp3s0):   domain name 'lan'
Mar 31 09:40:28 think-arch NetworkManager[568]: <info>  [1522478428.3145] dhcp4 (wlp3s0):   hostname 'think-arch'
Mar 31 09:40:28 think-arch NetworkManager[568]: <info>  [1522478428.3146] dhcp4 (wlp3s0):   gateway 192.168.1.1
Mar 31 09:40:28 think-arch NetworkManager[568]: <info>  [1522478428.3151] dhcp4 (wlp3s0): state changed unknown -> bound
Mar 31 09:40:28 think-arch NetworkManager[568]: <info>  [1522478428.3182] device (wlp3s0): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:28 think-arch NetworkManager[568]: <info>  [1522478428.3197] device (wlp3s0): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:28 think-arch NetworkManager[568]: <info>  [1522478428.3200] device (wlp3s0): state change: secondaries -> activated (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:28 think-arch NetworkManager[568]: <info>  [1522478428.3202] manager: NetworkManager state is now CONNECTED_LOCAL
Mar 31 09:40:28 think-arch NetworkManager[568]: <info>  [1522478428.3614] manager: NetworkManager state is now CONNECTED_SITE
Mar 31 09:40:28 think-arch NetworkManager[568]: <info>  [1522478428.3615] policy: set 'kindray 5g' (wlp3s0) as default for IPv4 routing and DNS
Mar 31 09:40:28 think-arch NetworkManager[568]: <info>  [1522478428.3967] device (wlp3s0): Activation: successful, device activated.
Mar 31 09:40:28 think-arch NetworkManager[568]: <info>  [1522478428.4944] manager: NetworkManager state is now CONNECTED_GLOBAL
Mar 31 09:40:29 think-arch NetworkManager[568]: <info>  [1522478429.3697] dhcp6 (wlp3s0): activation: beginning transaction (timeout in 45 seconds)
Mar 31 09:40:29 think-arch NetworkManager[568]: <warn>  [1522478429.3697] dhcp6 (wlp3s0): failed to start client (-98)
Mar 31 09:40:29 think-arch NetworkManager[568]: <info>  [1522478429.3698] device (wlp3s0): state change: activated -> failed (reason 'dhcp-start-failed', sys-iface-state: 'managed')
Mar 31 09:40:29 think-arch NetworkManager[568]: <warn>  [1522478429.3972] device (wlp3s0): Activation: failed for connection 'kindray 5g'
Mar 31 09:40:29 think-arch NetworkManager[568]: <info>  [1522478429.3976] manager: NetworkManager state is now CONNECTED_LOCAL
Mar 31 09:40:29 think-arch NetworkManager[568]: <info>  [1522478429.3984] device (wlp3s0): state change: failed -> disconnected (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:29 think-arch NetworkManager[568]: <info>  [1522478429.3989] dhcp4 (wlp3s0): canceled DHCP transaction
Mar 31 09:40:29 think-arch NetworkManager[568]: <info>  [1522478429.3989] dhcp4 (wlp3s0): state changed bound -> done
Mar 31 09:40:29 think-arch NetworkManager[568]: <info>  [1522478429.4402] device (wlp3s0): set-hw-addr: set MAC address to BA:1C:95:DF:8E:71 (scanning)
Mar 31 09:40:29 think-arch NetworkManager[568]: <warn>  [1522478429.8552] sup-iface[0x5596daf662d0,wlp3s0]: connection disconnected (reason -3)
Mar 31 09:40:29 think-arch NetworkManager[568]: <info>  [1522478429.8553] device (wlp3s0): supplicant interface state: completed -> disconnected
Mar 31 09:40:32 think-arch NetworkManager[568]: <info>  [1522478432.9957] policy: auto-activating connection 'kindray 5g'
Mar 31 09:40:32 think-arch NetworkManager[568]: <info>  [1522478432.9967] device (wlp3s0): Activation: starting connection 'kindray 5g' (1eaeae33-0417-4861-b2de-34bc45508217)
Mar 31 09:40:32 think-arch NetworkManager[568]: <info>  [1522478432.9970] device (wlp3s0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:32 think-arch NetworkManager[568]: <info>  [1522478432.9972] manager: NetworkManager state is now CONNECTING
Mar 31 09:40:33 think-arch NetworkManager[568]: <info>  [1522478433.0149] device (wlp3s0): set-hw-addr: reset MAC address to 6C:88:14:53:38:F4 (preserve)
Mar 31 09:40:33 think-arch NetworkManager[568]: <info>  [1522478433.4118] device (wlp3s0): supplicant interface state: disconnected -> disabled
Mar 31 09:40:33 think-arch NetworkManager[568]: <info>  [1522478433.4123] device (wlp3s0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:33 think-arch NetworkManager[568]: <info>  [1522478433.4125] device (wlp3s0): Activation: (wifi) access point 'kindray 5g' has security, but secrets are required.
Mar 31 09:40:33 think-arch NetworkManager[568]: <info>  [1522478433.4125] device (wlp3s0): state change: config -> need-auth (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:33 think-arch NetworkManager[568]: <info>  [1522478433.4163] device (wlp3s0): state change: need-auth -> prepare (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:33 think-arch NetworkManager[568]: <info>  [1522478433.4167] device (wlp3s0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:33 think-arch NetworkManager[568]: <info>  [1522478433.4169] device (wlp3s0): Activation: (wifi) connection 'kindray 5g' has security, and secrets exist.  No new secrets needed.
Mar 31 09:40:33 think-arch NetworkManager[568]: <info>  [1522478433.4170] Config: added 'ssid' value 'kindray 5g'
Mar 31 09:40:33 think-arch NetworkManager[568]: <info>  [1522478433.4170] Config: added 'scan_ssid' value '1'
Mar 31 09:40:33 think-arch NetworkManager[568]: <info>  [1522478433.4170] Config: added 'bgscan' value 'simple:30:-80:86400'
Mar 31 09:40:33 think-arch NetworkManager[568]: <info>  [1522478433.4170] Config: added 'key_mgmt' value 'WPA-PSK'
Mar 31 09:40:33 think-arch NetworkManager[568]: <info>  [1522478433.4171] Config: added 'auth_alg' value 'OPEN'
Mar 31 09:40:33 think-arch NetworkManager[568]: <info>  [1522478433.4171] Config: added 'psk' value '<hidden>'
Mar 31 09:40:33 think-arch NetworkManager[568]: <info>  [1522478433.4174] device (wlp3s0): supplicant interface state: disabled -> disconnected
Mar 31 09:40:33 think-arch NetworkManager[568]: <info>  [1522478433.4310] device (wlp3s0): supplicant interface state: disconnected -> scanning
Mar 31 09:40:36 think-arch NetworkManager[568]: <info>  [1522478436.6674] device (wlp3s0): supplicant interface state: scanning -> associating
Mar 31 09:40:36 think-arch NetworkManager[568]: <info>  [1522478436.6877] device (wlp3s0): supplicant interface state: associating -> associated
Mar 31 09:40:36 think-arch NetworkManager[568]: <info>  [1522478436.7742] device (wlp3s0): supplicant interface state: associated -> completed
Mar 31 09:40:36 think-arch NetworkManager[568]: <info>  [1522478436.7743] device (wlp3s0): Activation: (wifi) Stage 2 of 5 (Device Configure) successful.  Connected to wireless network 'kindray 5g'.
Mar 31 09:40:36 think-arch NetworkManager[568]: <info>  [1522478436.7744] device (wlp3s0): state change: config -> ip-config (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:36 think-arch NetworkManager[568]: <info>  [1522478436.7754] dhcp4 (wlp3s0): activation: beginning transaction (timeout in 45 seconds)
Mar 31 09:40:36 think-arch NetworkManager[568]: <info>  [1522478436.9162] dhcp4 (wlp3s0):   address 192.168.1.167
Mar 31 09:40:36 think-arch NetworkManager[568]: <info>  [1522478436.9162] dhcp4 (wlp3s0):   plen 24
Mar 31 09:40:36 think-arch NetworkManager[568]: <info>  [1522478436.9163] dhcp4 (wlp3s0):   expires in 43200 seconds
Mar 31 09:40:36 think-arch NetworkManager[568]: <info>  [1522478436.9163] dhcp4 (wlp3s0):   nameserver '192.168.1.1'
Mar 31 09:40:36 think-arch NetworkManager[568]: <info>  [1522478436.9163] dhcp4 (wlp3s0):   domain name 'lan'
Mar 31 09:40:36 think-arch NetworkManager[568]: <info>  [1522478436.9163] dhcp4 (wlp3s0):   hostname 'think-arch'
Mar 31 09:40:36 think-arch NetworkManager[568]: <info>  [1522478436.9164] dhcp4 (wlp3s0):   gateway 192.168.1.1
Mar 31 09:40:36 think-arch NetworkManager[568]: <info>  [1522478436.9168] dhcp4 (wlp3s0): state changed unknown -> bound
Mar 31 09:40:36 think-arch NetworkManager[568]: <info>  [1522478436.9224] device (wlp3s0): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:36 think-arch NetworkManager[568]: <info>  [1522478436.9241] device (wlp3s0): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:36 think-arch NetworkManager[568]: <info>  [1522478436.9245] device (wlp3s0): state change: secondaries -> activated (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:36 think-arch NetworkManager[568]: <info>  [1522478436.9248] manager: NetworkManager state is now CONNECTED_LOCAL
Mar 31 09:40:36 think-arch NetworkManager[568]: <info>  [1522478436.9465] manager: NetworkManager state is now CONNECTED_SITE
Mar 31 09:40:36 think-arch NetworkManager[568]: <info>  [1522478436.9467] policy: set 'kindray 5g' (wlp3s0) as default for IPv4 routing and DNS
Mar 31 09:40:36 think-arch NetworkManager[568]: <info>  [1522478436.9722] device (wlp3s0): Activation: successful, device activated.
Mar 31 09:40:37 think-arch NetworkManager[568]: <info>  [1522478437.0722] manager: NetworkManager state is now CONNECTED_GLOBAL
Mar 31 09:40:38 think-arch NetworkManager[568]: <info>  [1522478438.3254] dhcp6 (wlp3s0): activation: beginning transaction (timeout in 45 seconds)
Mar 31 09:40:38 think-arch NetworkManager[568]: <warn>  [1522478438.3256] dhcp6 (wlp3s0): failed to start client (-98)
Mar 31 09:40:38 think-arch NetworkManager[568]: <info>  [1522478438.3256] device (wlp3s0): state change: activated -> failed (reason 'dhcp-start-failed', sys-iface-state: 'managed')
Mar 31 09:40:38 think-arch NetworkManager[568]: <warn>  [1522478438.3513] device (wlp3s0): Activation: failed for connection 'kindray 5g'
Mar 31 09:40:38 think-arch NetworkManager[568]: <info>  [1522478438.3521] manager: NetworkManager state is now CONNECTED_LOCAL
Mar 31 09:40:38 think-arch NetworkManager[568]: <info>  [1522478438.3534] device (wlp3s0): state change: failed -> disconnected (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:38 think-arch NetworkManager[568]: <info>  [1522478438.3543] dhcp4 (wlp3s0): canceled DHCP transaction
Mar 31 09:40:38 think-arch NetworkManager[568]: <info>  [1522478438.3544] dhcp4 (wlp3s0): state changed bound -> done
Mar 31 09:40:38 think-arch NetworkManager[568]: <info>  [1522478438.4018] device (wlp3s0): set-hw-addr: set MAC address to 62:A7:8E:1B:53:C1 (scanning)
Mar 31 09:40:38 think-arch NetworkManager[568]: <warn>  [1522478438.8206] sup-iface[0x5596daf662d0,wlp3s0]: connection disconnected (reason -3)
Mar 31 09:40:38 think-arch NetworkManager[568]: <info>  [1522478438.8207] device (wlp3s0): supplicant interface state: completed -> disconnected
Mar 31 09:40:42 think-arch NetworkManager[568]: <info>  [1522478442.1115] policy: auto-activating connection 'kindray 5g'
Mar 31 09:40:42 think-arch NetworkManager[568]: <info>  [1522478442.1126] device (wlp3s0): Activation: starting connection 'kindray 5g' (1eaeae33-0417-4861-b2de-34bc45508217)
Mar 31 09:40:42 think-arch NetworkManager[568]: <info>  [1522478442.1129] device (wlp3s0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
Mar 31 09:40:42 think-arch NetworkManager[568]: <info>  [1522478442.1131] manager: NetworkManager state is now CONNECTING
Mar 31 09:40:42 think-arch NetworkManager[568]: <info>  [1522478442.1298] device (wlp3s0): set-hw-addr: reset MAC address to 6C:88:14:53:38:F4 (preserve)

Full dhcpcd log:

-- Logs begin at Sat 2018-01-20 10:10:31 EET. --
Mar 31 09:38:54 think-arch dhcpcd[731]: lxcbr0: waiting for carrier
Mar 31 09:38:54 think-arch dhcpcd[731]: lxcbr0: new hardware address: 6e:8b:0a:09:e2:49
Mar 31 09:38:54 think-arch dhcpcd[731]: lxcbr0: new hardware address: 00:16:3e:00:00:00
Mar 31 09:38:54 think-arch dhcpcd[731]: lxcbr0: carrier acquired
Mar 31 09:38:54 think-arch dhcpcd[731]: DUID 00:01:00:01:22:4f:f0:ee:00:16:3e:00:00:00
Mar 31 09:38:54 think-arch dhcpcd[731]: lxcbr0: IAID 3e:00:00:00
Mar 31 09:38:54 think-arch dhcpcd[731]: lxcbr0: adding address fe80::8fad:1822:7104:aaf5
Mar 31 09:38:54 think-arch dhcpcd[731]: lxcbr0: carrier lost
Mar 31 09:38:54 think-arch dhcpcd[731]: lxcbr0: deleting address fe80::8fad:1822:7104:aaf5
Mar 31 09:38:54 think-arch dhcpcd[731]: wlp3s0: new hardware address: 16:51:dc:35:c8:af
Mar 31 09:40:12 think-arch dhcpcd[731]: wlp3s0: carrier acquired
Mar 31 09:40:12 think-arch dhcpcd[731]: wlp3s0: IAID dc:35:c8:af
Mar 31 09:40:12 think-arch dhcpcd[731]: wlp3s0: adding address fe80::fe22:f9c1:577:73b7
Mar 31 09:40:12 think-arch dhcpcd[731]: wlp3s0: carrier lost
Mar 31 09:40:12 think-arch dhcpcd[731]: wlp3s0: deleting address fe80::fe22:f9c1:577:73b7
Mar 31 09:40:15 think-arch dhcpcd[731]: wlp3s0: new hardware address: 6c:88:14:53:38:f4
Mar 31 09:40:19 think-arch dhcpcd[731]: wlp3s0: carrier acquired
Mar 31 09:40:19 think-arch dhcpcd[731]: wlp3s0: IAID 14:53:38:f4
Mar 31 09:40:19 think-arch dhcpcd[731]: wlp3s0: adding address fe80::c9d:a14:9295:6576
Mar 31 09:40:19 think-arch dhcpcd[731]: wlp3s0: soliciting a DHCP lease
Mar 31 09:40:19 think-arch dhcpcd[731]: wlp3s0: offered 192.168.1.158 from 192.168.1.1
Mar 31 09:40:19 think-arch dhcpcd[731]: wlp3s0: probing address 192.168.1.158/24
Mar 31 09:40:19 think-arch dhcpcd[731]: wlp3s0: soliciting an IPv6 router
Mar 31 09:40:20 think-arch dhcpcd[731]: wlp3s0: Router Advertisement from fe80::c261:18ff:fefb:817d
Mar 31 09:40:20 think-arch dhcpcd[731]: wlp3s0: adding address fd14:ef86:bd65:0:5fa6:1e55:ce37:415a/64
Mar 31 09:40:20 think-arch dhcpcd[731]: wlp3s0: adding route to fd14:ef86:bd65::/64
Mar 31 09:40:20 think-arch dhcpcd[731]: wlp3s0: accepted reconfigure key
Mar 31 09:40:20 think-arch dhcpcd[731]: wlp3s0: confirming prior DHCPv6 lease
Mar 31 09:40:20 think-arch dhcpcd[731]: wlp3s0: deleted route to fd14:ef86:bd65::/64
Mar 31 09:40:20 think-arch dhcpcd[731]: wlp3s0: carrier lost
Mar 31 09:40:20 think-arch dhcpcd[731]: wlp3s0: adding route to fd14:ef86:bd65::/64
Mar 31 09:40:20 think-arch dhcpcd[731]: if_route (ADD): Network is down
Mar 31 09:40:20 think-arch dhcpcd[731]: wlp3s0: deleting address fd14:ef86:bd65:0:5fa6:1e55:ce37:415a/64
Mar 31 09:40:21 think-arch dhcpcd[731]: wlp3s0: deleting address fe80::c9d:a14:9295:6576
Mar 31 09:40:21 think-arch dhcpcd[731]: wlp3s0: new hardware address: 56:cc:d8:b0:98:5b
Mar 31 09:40:24 think-arch dhcpcd[731]: wlp3s0: new hardware address: 6c:88:14:53:38:f4
Mar 31 09:40:28 think-arch dhcpcd[731]: wlp3s0: carrier acquired
Mar 31 09:40:28 think-arch dhcpcd[731]: wlp3s0: IAID 14:53:38:f4
Mar 31 09:40:28 think-arch dhcpcd[731]: wlp3s0: adding address fe80::c9d:a14:9295:6576
Mar 31 09:40:28 think-arch dhcpcd[731]: wlp3s0: soliciting a DHCP lease
Mar 31 09:40:28 think-arch dhcpcd[731]: wlp3s0: offered 192.168.1.158 from 192.168.1.1
Mar 31 09:40:28 think-arch dhcpcd[731]: wlp3s0: probing address 192.168.1.158/24
Mar 31 09:40:29 think-arch dhcpcd[731]: wlp3s0: soliciting an IPv6 router
Mar 31 09:40:29 think-arch dhcpcd[731]: wlp3s0: Router Advertisement from fe80::c261:18ff:fefb:817d
Mar 31 09:40:29 think-arch dhcpcd[731]: wlp3s0: adding address fd14:ef86:bd65:0:5fa6:1e55:ce37:415a/64
Mar 31 09:40:29 think-arch dhcpcd[731]: wlp3s0: adding route to fd14:ef86:bd65::/64
Mar 31 09:40:29 think-arch dhcpcd[731]: wlp3s0: accepted reconfigure key
Mar 31 09:40:29 think-arch dhcpcd[731]: wlp3s0: confirming prior DHCPv6 lease
Mar 31 09:40:29 think-arch dhcpcd[731]: wlp3s0: deleted route to fd14:ef86:bd65::/64
Mar 31 09:40:29 think-arch dhcpcd[731]: wlp3s0: carrier lost
Mar 31 09:40:29 think-arch dhcpcd[731]: wlp3s0: adding route to fd14:ef86:bd65::/64
Mar 31 09:40:29 think-arch dhcpcd[731]: wlp3s0: deleting address fd14:ef86:bd65:0:5fa6:1e55:ce37:415a/64
Mar 31 09:40:29 think-arch dhcpcd[731]: wlp3s0: deleting route to fd14:ef86:bd65::/64
Mar 31 09:40:29 think-arch dhcpcd[731]: wlp3s0: new hardware address: ba:1c:95:df:8e:71
Mar 31 09:40:33 think-arch dhcpcd[731]: wlp3s0: new hardware address: 6c:88:14:53:38:f4
Mar 31 09:40:36 think-arch dhcpcd[731]: wlp3s0: carrier acquired
Mar 31 09:40:36 think-arch dhcpcd[731]: wlp3s0: IAID 14:53:38:f4
Mar 31 09:40:36 think-arch dhcpcd[731]: wlp3s0: adding address fe80::c9d:a14:9295:6576
Mar 31 09:40:37 think-arch dhcpcd[731]: wlp3s0: soliciting an IPv6 router
Mar 31 09:40:37 think-arch dhcpcd[731]: wlp3s0: soliciting a DHCP lease
Mar 31 09:40:37 think-arch dhcpcd[731]: wlp3s0: offered 192.168.1.158 from 192.168.1.1
Mar 31 09:40:37 think-arch dhcpcd[731]: wlp3s0: probing address 192.168.1.158/24
Mar 31 09:40:38 think-arch dhcpcd[731]: wlp3s0: Router Advertisement from fe80::c261:18ff:fefb:817d
Mar 31 09:40:38 think-arch dhcpcd[731]: wlp3s0: adding address fd14:ef86:bd65:0:5fa6:1e55:ce37:415a/64
Mar 31 09:40:38 think-arch dhcpcd[731]: wlp3s0: adding route to fd14:ef86:bd65::/64
Mar 31 09:40:38 think-arch dhcpcd[731]: wlp3s0: accepted reconfigure key
Mar 31 09:40:38 think-arch dhcpcd[731]: wlp3s0: confirming prior DHCPv6 lease
Mar 31 09:40:38 think-arch dhcpcd[731]: wlp3s0: deleted route to fd14:ef86:bd65::/64
Mar 31 09:40:38 think-arch dhcpcd[731]: wlp3s0: carrier lost
Mar 31 09:40:38 think-arch dhcpcd[731]: wlp3s0: adding route to fd14:ef86:bd65::/64
Mar 31 09:40:38 think-arch dhcpcd[731]: wlp3s0: deleting address fd14:ef86:bd65:0:5fa6:1e55:ce37:415a/64
Mar 31 09:40:38 think-arch dhcpcd[731]: wlp3s0: deleting route to fd14:ef86:bd65::/64
Mar 31 09:40:38 think-arch dhcpcd[731]: wlp3s0: new hardware address: 62:a7:8e:1b:53:c1
Mar 31 09:40:42 think-arch dhcpcd[731]: wlp3s0: new hardware address: 6c:88:14:53:38:f4

Reverting dhcpcd to the older version fixes the issue.
I would appreciate any help on how to narrow down the problem to help resolve it.
Thanks.

Last edited by shein (2018-03-31 09:15:27)

Offline

#2 2018-03-31 07:27:09

seth
Member
From: Won't reply 2 private help req
Registered: 2012-09-03
Posts: 78,849

Re: [SOLVED] dhcpcd upgrade makes wifi constantly disconnect

NetworkManager [...] dhcpcd

You're not supposed to run concurrent network managing services - they start a race and things will go south:

systemctl list-units | grep -iE '(wicd|dhcp|net|conn)'

Offline

#3 2018-03-31 09:14:26

shein
Member
Registered: 2017-04-20
Posts: 7

Re: [SOLVED] dhcpcd upgrade makes wifi constantly disconnect

Thank you.
I didn't know that dhcpcd is like a network manager. I though NetworkManager uses it as a dhcp client.
Disabling dhcpcd resolved the issue.

Offline

Board footer

Powered by FluxBB