You are not logged in.

#1 2015-06-08 11:23:05

Lezkus
Member
Registered: 2015-02-23
Posts: 15

DHCPREQUEST & DHCPDISCOVER take way too long

When I start my computer or I resume it from a suspended state, it takes about a solid minute to connect to the wireless network.

From the journalctl -f logs I get the following:

Jun 08 13:14:43 HP NetworkManager[275]: <info>  (wlan0): supplicant interface state: associating -> 4-way handshake
Jun 08 13:14:47 HP NetworkManager[275]: <info>  (wlan0): supplicant interface state: 4-way handshake -> completed
Jun 08 13:14:47 HP NetworkManager[275]: <info>  (wlan0): Activation: (wifi) Stage 2 of 5 (Device Configure) successful.  Connected to wireless network 'Orange-02D4'.
Jun 08 13:14:47 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 3 of 5 (IP Configure Start) scheduled.
Jun 08 13:14:47 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 3 of 5 (IP Configure Start) started...
Jun 08 13:14:47 HP NetworkManager[275]: <info>  (wlan0): device state change: config -> ip-config (reason 'none') [50 70 0]
Jun 08 13:14:47 HP NetworkManager[275]: <info>  Activation (wlan0) Beginning DHCPv4 transaction (timeout in 45 seconds)
Jun 08 13:14:47 HP NetworkManager[275]: <info>  dhclient started with pid 473
Jun 08 13:14:47 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 3 of 5 (IP Configure Start) complete.
Jun 08 13:14:47 HP dhclient[473]: DHCPREQUEST on wlan0 to 255.255.255.255 port 67
Jun 08 13:14:52 HP dhclient[473]: DHCPREQUEST on wlan0 to 255.255.255.255 port 67
Jun 08 13:15:06 HP dhclient[473]: DHCPDISCOVER on wlan0 to 255.255.255.255 port 67 interval 7
Jun 08 13:15:13 HP dhclient[473]: DHCPDISCOVER on wlan0 to 255.255.255.255 port 67 interval 17
Jun 08 13:15:19 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 4 of 5 (IPv6 Configure Timeout) scheduled...
Jun 08 13:15:19 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 4 of 5 (IPv6 Configure Timeout) started...
Jun 08 13:15:19 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 4 of 5 (IPv6 Configure Timeout) complete.
Jun 08 13:15:30 HP dhclient[473]: DHCPDISCOVER on wlan0 to 255.255.255.255 port 67 interval 21
Jun 08 13:15:32 HP NetworkManager[275]: <warn>  (wlan0): DHCPv4 request timed out.
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): DHCPv4 state changed unknown -> timeout
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): canceled DHCP transaction, DHCP client pid 473
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): DHCPv4 state changed timeout -> done
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 4 of 5 (IPv4 Configure Timeout) scheduled...
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 4 of 5 (IPv4 Configure Timeout) started...
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): device state change: ip-config -> failed (reason 'ip-config-unavailable') [70 120 5]
Jun 08 13:15:32 HP NetworkManager[275]: <info>  NetworkManager state is now DISCONNECTED
Jun 08 13:15:32 HP NetworkManager[275]: <info>  startup complete
Jun 08 13:15:32 HP NetworkManager[275]: <warn>  (wlan0): Activation: failed for connection 'Orange-02D4'
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 4 of 5 (IPv4 Configure Timeout) complete.
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): device state change: failed -> disconnected (reason 'none') [120 30 0]
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): deactivating device (reason 'none') [0]
Jun 08 13:15:32 HP kernel: wlan0: deauthenticating from 18:83:bf:61:02:d6 by local choice (Reason: 3=DEAUTH_LEAVING)
Jun 08 13:15:32 HP kernel: cfg80211: Calling CRDA to update world regulatory domain
Jun 08 13:15:32 HP kernel: cfg80211: World regulatory domain updated:
Jun 08 13:15:32 HP kernel: cfg80211:  DFS Master region: unset
Jun 08 13:15:32 HP kernel: cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
Jun 08 13:15:32 HP kernel: cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
Jun 08 13:15:32 HP kernel: cfg80211:   (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
Jun 08 13:15:32 HP kernel: cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A)
Jun 08 13:15:32 HP kernel: cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
Jun 08 13:15:32 HP kernel: cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
Jun 08 13:15:32 HP kernel: cfg80211:   (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s)
Jun 08 13:15:32 HP kernel: cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
Jun 08 13:15:32 HP kernel: cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A)
Jun 08 13:15:32 HP kernel: cfg80211: Calling CRDA for country: ES
Jun 08 13:15:32 HP kernel: cfg80211: Regulatory domain changed to country: ES
Jun 08 13:15:32 HP kernel: cfg80211:  DFS Master region: ETSI
Jun 08 13:15:32 HP kernel: cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
Jun 08 13:15:32 HP kernel: cfg80211:   (2400000 KHz - 2483500 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
Jun 08 13:15:32 HP kernel: cfg80211:   (5150000 KHz - 5250000 KHz @ 80000 KHz, 200000 KHz AUTO), (N/A, 2301 mBm), (N/A)
Jun 08 13:15:32 HP kernel: cfg80211:   (5250000 KHz - 5350000 KHz @ 80000 KHz, 200000 KHz AUTO), (N/A, 2000 mBm), (0 s)
Jun 08 13:15:32 HP kernel: cfg80211:   (5470000 KHz - 5725000 KHz @ 160000 KHz), (N/A, 2698 mBm), (0 s)
Jun 08 13:15:32 HP kernel: cfg80211:   (57000000 KHz - 66000000 KHz @ 2160000 KHz), (N/A, 4000 mBm), (N/A)
Jun 08 13:15:32 HP NetworkManager[275]: <warn>  Connection disconnected (reason -3)
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): supplicant interface state: completed -> disconnected
Jun 08 13:15:32 HP NetworkManager[275]: <info>  Auto-activating connection 'Orange-02D4'.
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): Activation: starting connection 'Orange-02D4'
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 1 of 5 (Device Prepare) scheduled...
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 1 of 5 (Device Prepare) started...
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Jun 08 13:15:32 HP NetworkManager[275]: <info>  NetworkManager state is now CONNECTING
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 2 of 5 (Device Configure) scheduled...
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 1 of 5 (Device Prepare) complete.
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 2 of 5 (Device Configure) starting...
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): Activation: (wifi) access point 'Orange-02D4' has security, but secrets are required.
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 2 of 5 (Device Configure) complete.
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 1 of 5 (Device Prepare) scheduled...
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 1 of 5 (Device Prepare) started...
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 2 of 5 (Device Configure) scheduled...
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 1 of 5 (Device Prepare) complete.
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 2 of 5 (Device Configure) starting...
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): Activation: (wifi) connection 'Orange-02D4' has security, and secrets exist.  No new secrets needed.
Jun 08 13:15:32 HP NetworkManager[275]: <info>  Config: added 'ssid' value 'Orange-02D4'
Jun 08 13:15:32 HP NetworkManager[275]: <info>  Config: added 'scan_ssid' value '1'
Jun 08 13:15:32 HP NetworkManager[275]: <info>  Config: added 'key_mgmt' value 'WPA-PSK'
Jun 08 13:15:32 HP NetworkManager[275]: <info>  Config: added 'psk' value '<omitted>'
Jun 08 13:15:32 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 2 of 5 (Device Configure) complete.
Jun 08 13:15:32 HP NetworkManager[275]: <info>  Config: set interface ap_scan to 1
Jun 08 13:15:33 HP kernel: wlan0: authenticate with 18:83:bf:61:02:d6
Jun 08 13:15:33 HP NetworkManager[275]: <info>  (wlan0): supplicant interface state: disconnected -> authenticating
Jun 08 13:15:33 HP kernel: wlan0: send auth to 18:83:bf:61:02:d6 (try 1/3)
Jun 08 13:15:33 HP kernel: wlan0: authenticated
Jun 08 13:15:33 HP kernel: wlan0: associate with 18:83:bf:61:02:d6 (try 1/3)
Jun 08 13:15:33 HP NetworkManager[275]: <info>  (wlan0): supplicant interface state: authenticating -> associating
Jun 08 13:15:33 HP kernel: wlan0: RX AssocResp from 18:83:bf:61:02:d6 (capab=0x411 status=0 aid=1)
Jun 08 13:15:33 HP kernel: wlan0: associated
Jun 08 13:15:33 HP kernel: cfg80211: Calling CRDA for country: ES
Jun 08 13:15:33 HP kernel: cfg80211: Regulatory domain changed to country: ES
Jun 08 13:15:33 HP kernel: cfg80211:  DFS Master region: ETSI
Jun 08 13:15:33 HP kernel: cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
Jun 08 13:15:33 HP kernel: cfg80211:   (2400000 KHz - 2483500 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
Jun 08 13:15:33 HP kernel: cfg80211:   (5150000 KHz - 5250000 KHz @ 80000 KHz, 200000 KHz AUTO), (N/A, 2301 mBm), (N/A)
Jun 08 13:15:33 HP kernel: cfg80211:   (5250000 KHz - 5350000 KHz @ 80000 KHz, 200000 KHz AUTO), (N/A, 2000 mBm), (0 s)
Jun 08 13:15:33 HP kernel: cfg80211:   (5470000 KHz - 5725000 KHz @ 160000 KHz), (N/A, 2698 mBm), (0 s)
Jun 08 13:15:33 HP kernel: cfg80211:   (57000000 KHz - 66000000 KHz @ 2160000 KHz), (N/A, 4000 mBm), (N/A)
Jun 08 13:15:33 HP NetworkManager[275]: <info>  (wlan0): supplicant interface state: associating -> associated
Jun 08 13:15:33 HP NetworkManager[275]: <info>  (wlan0): supplicant interface state: associated -> 4-way handshake
Jun 08 13:15:33 HP NetworkManager[275]: <info>  (wlan0): supplicant interface state: 4-way handshake -> completed
Jun 08 13:15:33 HP NetworkManager[275]: <info>  (wlan0): Activation: (wifi) Stage 2 of 5 (Device Configure) successful.  Connected to wireless network 'Orange-02D4'.
Jun 08 13:15:33 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 3 of 5 (IP Configure Start) scheduled.
Jun 08 13:15:33 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 3 of 5 (IP Configure Start) started...
Jun 08 13:15:33 HP NetworkManager[275]: <info>  (wlan0): device state change: config -> ip-config (reason 'none') [50 70 0]
Jun 08 13:15:33 HP NetworkManager[275]: <info>  Activation (wlan0) Beginning DHCPv4 transaction (timeout in 45 seconds)
Jun 08 13:15:33 HP NetworkManager[275]: <info>  dhclient started with pid 487
Jun 08 13:15:33 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 3 of 5 (IP Configure Start) complete.
Jun 08 13:15:33 HP dhclient[487]: DHCPREQUEST on wlan0 to 255.255.255.255 port 67
Jun 08 13:15:33 HP dhclient[487]: DHCPACK from 192.168.1.1
Jun 08 13:15:33 HP NetworkManager[275]: <info>    address 192.168.1.101
Jun 08 13:15:33 HP NetworkManager[275]: <info>    plen 24 (255.255.255.0)
Jun 08 13:15:33 HP NetworkManager[275]: <info>    gateway 192.168.1.1
Jun 08 13:15:33 HP NetworkManager[275]: <info>    server identifier 192.168.1.1
Jun 08 13:15:33 HP NetworkManager[275]: <info>    lease time -1
Jun 08 13:15:33 HP NetworkManager[275]: <info>    nameserver '192.168.1.1'
Jun 08 13:15:33 HP NetworkManager[275]: <info>  (wlan0): DHCPv4 state changed unknown -> bound
Jun 08 13:15:33 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 5 of 5 (IPv4 Configure Commit) scheduled...
Jun 08 13:15:33 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 5 of 5 (IPv4 Commit) started...
Jun 08 13:15:33 HP NetworkManager[275]: <info>  (wlan0): device state change: ip-config -> ip-check (reason 'none') [70 80 0]
Jun 08 13:15:33 HP NetworkManager[275]: <info>  (wlan0): Activation: Stage 5 of 5 (IPv4 Commit) complete.
Jun 08 13:15:33 HP dhclient[487]: bound to 192.168.1.101 -- renewal in 2147483648 seconds.
Jun 08 13:15:33 HP NetworkManager[275]: <info>  (wlan0): device state change: ip-check -> secondaries (reason 'none') [80 90 0]
Jun 08 13:15:33 HP NetworkManager[275]: <info>  (wlan0): device state change: secondaries -> activated (reason 'none') [90 100 0]
Jun 08 13:15:33 HP NetworkManager[275]: <info>  NetworkManager state is now CONNECTED_LOCAL
Jun 08 13:15:33 HP NetworkManager[275]: <info>  NetworkManager state is now CONNECTED_GLOBAL
Jun 08 13:15:33 HP NetworkManager[275]: <info>  Policy set 'Orange-02D4' (wlan0) as default for IPv4 routing and DNS.
Jun 08 13:15:33 HP NetworkManager[275]: <info>  Writing DNS information to /usr/bin/resolvconf
Jun 08 13:15:33 HP NetworkManager[275]: <info>  (wlan0): Activation: successful, device activated.

As you can see, it stucks during the following processes

Jun 08 13:14:47 HP dhclient[473]: DHCPREQUEST on wlan0 to 255.255.255.255 port 67
Jun 08 13:14:52 HP dhclient[473]: DHCPREQUEST on wlan0 to 255.255.255.255 port 67
Jun 08 13:15:06 HP dhclient[473]: DHCPDISCOVER on wlan0 to 255.255.255.255 port 67 interval 7
Jun 08 13:15:13 HP dhclient[473]: DHCPDISCOVER on wlan0 to 255.255.255.255 port 67 interval 17

Is this normal?

Can I preconfigure anything so it does faster these opeartions?

Last edited by Lezkus (2015-06-08 11:23:28)

Offline

#2 2015-06-10 16:00:35

Lezkus
Member
Registered: 2015-02-23
Posts: 15

Re: DHCPREQUEST & DHCPDISCOVER take way too long

Any clue anyone?

Offline

Board footer

Powered by FluxBB