You are not logged in.

#1 2016-02-02 16:20:07

rbaj
Member
Registered: 2016-01-27
Posts: 36

wpa_supplicant authentication timeout on eduroam (WPA-EAP)

Having trouble with eduroam. I can associate with an access point but the EAP authentication seems to timeout. This happens with wpa_supplicant, NetworkManager and wicd (wicd says 'Bad password', but the password is definitely correct). I'm running kernel 4.3.3-3 on a Macbook Pro 9,2, with network card BCM4331 and driver b43.

(Edit: I can connect to WPA Personal networks with no problems using the wpa_supplicant, NM and wicd)

The wpa_supplicant config is based on one from Bristol uni with the correct settings for my institution from https://cat.eduroam.org/:

network={
        identity="xxxxx@surrey.ac.uk"
        password="xxxxx"
        ca_cert="/home/robaj/.cat_installer/ca.pem"
        eap=PEAP TTLS
        anonymous_identity="anonymous@surrey.ac.uk"
        phase1="peaplabel=0"
        phase2="auth=MSCHAPV2"
        priority=999
        disabled=0
        ssid="eduroam"
        scan_ssid=0
        mode=0
        auth_alg=OPEN
        proto=WPA RSN
        pairwise=CCMP TKIP
        key_mgmt=WPA-EAP
        proactive_key_caching=1
}

Before running wpa_supplicant I checked no other network services were running:

$ systemctl --type=service

UNIT                                                LOAD   ACTIVE SUB     DESCRIPTION
acpid.service                                       loaded active running ACPI event daemon
alsa-restore.service                                loaded active exited  Save/Restore Sound Card State
dbus.service                                        loaded active running D-Bus System Message Bus
getty@tty1.service                                  loaded active running Getty on tty1
kmod-static-nodes.service                           loaded active exited  Create list of required static device nodes for the current kernel
lm_sensors.service                                  loaded active exited  Initialize hardware monitoring sensors
polkit.service                                      loaded active running Authorization Manager
systemd-backlight@backlight:acpi_video0.service     loaded active exited  Load/Save Screen Backlight Brightness of backlight:acpi_video0
systemd-backlight@backlight:intel_backlight.service loaded active exited  Load/Save Screen Backlight Brightness of backlight:intel_backlight
systemd-backlight@leds:smc::kbd_backlight.service   loaded active exited  Load/Save Screen Backlight Brightness of leds:smc::kbd_backlight
systemd-fsck@dev-sda5.service                       loaded active exited  File System Check on /dev/sda5
systemd-fsck@dev-sda7.service                       loaded active exited  File System Check on /dev/sda7
systemd-fsck@dev-sda8.service                       loaded active exited  File System Check on /dev/sda8
systemd-journal-flush.service                       loaded active exited  Flush Journal to Persistent Storage
systemd-journald.service                            loaded active running Journal Service
systemd-logind.service                              loaded active running Login Service
systemd-modules-load.service                        loaded active exited  Load Kernel Modules
systemd-random-seed.service                         loaded active exited  Load/Save Random Seed
systemd-remount-fs.service                          loaded active exited  Remount Root and Kernel File Systems
systemd-sysctl.service                              loaded active exited  Apply Kernel Variables
systemd-timesyncd.service                           loaded active running Network Time Synchronization
systemd-tmpfiles-setup-dev.service                  loaded active exited  Create Static Device Nodes in /dev
systemd-tmpfiles-setup.service                      loaded active exited  Create Volatile Files and Directories
systemd-udev-trigger.service                        loaded active exited  udev Coldplug all Devices
systemd-udevd.service                               loaded active running udev Kernel Device Manager
systemd-update-utmp.service                         loaded active exited  Update UTMP about System Boot/Shutdown
systemd-user-sessions.service                       loaded active exited  Permit User Sessions
systemd-vconsole-setup.service                      loaded active exited  Setup Virtual Console
tlp.service                                         loaded active exited  TLP system startup/shutdown
ufw.service                                         loaded active exited  CLI Netfilter Manager
user@1000.service                                   loaded active running User Manager for UID 1000

Then I try and connect to eduroam:

$ sudo wpa_supplicant -i wlp2s0b1 -c /etc/wpa_supplicant/eduroam.conf

Successfully initialized wpa_supplicant
wlp2s0b1: SME: Trying to authenticate with d8:84:66:37:73:68 (SSID='eduroam' freq=2437 MHz)
wlp2s0b1: Trying to associate with d8:84:66:37:73:68 (SSID='eduroam' freq=2437 MHz)
wlp2s0b1: Associated with d8:84:66:37:73:68
wlp2s0b1: CTRL-EVENT-EAP-STARTED EAP authentication started
wlp2s0b1: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=GB
wlp2s0b1: Authentication with d8:84:66:37:73:68 timed out.
wlp2s0b1: CTRL-EVENT-DISCONNECTED bssid=d8:84:66:37:73:68 reason=3 locally_generated=1
wlp2s0b1: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD
wlp2s0b1: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=GB
wlp2s0b1: SME: Trying to authenticate with d8:84:66:0f:80:58 (SSID='eduroam' freq=2412 MHz)
wlp2s0b1: Trying to associate with d8:84:66:0f:80:58 (SSID='eduroam' freq=2412 MHz)
wlp2s0b1: Associated with d8:84:66:0f:80:58
wlp2s0b1: CTRL-EVENT-EAP-STARTED EAP authentication started
wlp2s0b1: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=GB
wlp2s0b1: Authentication with d8:84:66:0f:80:58 timed out.
wlp2s0b1: CTRL-EVENT-DISCONNECTED bssid=d8:84:66:0f:80:58 reason=3 locally_generated=1
wlp2s0b1: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD
wlp2s0b1: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=GB
wlp2s0b1: SME: Trying to authenticate with d8:84:66:0f:a6:88 (SSID='eduroam' freq=2437 MHz)
wlp2s0b1: Trying to associate with d8:84:66:0f:a6:88 (SSID='eduroam' freq=2437 MHz)
wlp2s0b1: Associated with d8:84:66:0f:a6:88
wlp2s0b1: CTRL-EVENT-EAP-STARTED EAP authentication started
wlp2s0b1: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=GB

The corresponding log:

$ journalctl -xef

Feb 02 14:22:35 avocet sudo[1690]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 02 14:22:35 avocet kernel: b43-phy0: Loading firmware version 784.2 (2012-08-15 21:35:19)
Feb 02 14:22:36 avocet kernel: IPv6: ADDRCONF(NETDEV_UP): wlp2s0b1: link is not ready
Feb 02 14:22:37 avocet kernel: wlp2s0b1: authenticate with d8:84:66:37:73:68
Feb 02 14:22:37 avocet kernel: wlp2s0b1: No basic rates, using min rate instead
Feb 02 14:22:37 avocet kernel: wlp2s0b1: send auth to d8:84:66:37:73:68 (try 1/3)
Feb 02 14:22:37 avocet kernel: wlp2s0b1: authenticated
Feb 02 14:22:37 avocet kernel: wlp2s0b1: associate with d8:84:66:37:73:68 (try 1/3)
Feb 02 14:22:37 avocet kernel: wlp2s0b1: RX AssocResp from d8:84:66:37:73:68 (capab=0x411 status=0 aid=1)
Feb 02 14:22:37 avocet kernel: IPv6: ADDRCONF(NETDEV_CHANGE): wlp2s0b1: link becomes ready
Feb 02 14:22:37 avocet kernel: wlp2s0b1: associated
Feb 02 14:22:37 avocet kernel: cfg80211: Regulatory domain changed to country: GB
Feb 02 14:22:37 avocet kernel: cfg80211:  DFS Master region: ETSI
Feb 02 14:22:37 avocet kernel: cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
Feb 02 14:22:37 avocet kernel: cfg80211:   (2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
Feb 02 14:22:37 avocet kernel: cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
Feb 02 14:22:37 avocet kernel: cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
Feb 02 14:22:37 avocet kernel: cfg80211:   (5490000 KHz - 5710000 KHz @ 160000 KHz), (N/A, 2700 mBm), (0 s)
Feb 02 14:22:37 avocet kernel: cfg80211:   (57000000 KHz - 66000000 KHz @ 2160000 KHz), (N/A, 4000 mBm), (N/A)
Feb 02 14:23:47 avocet kernel: wlp2s0b1: deauthenticating from d8:84:66:37:73:68 by local choice (Reason: 3=DEAUTH_LEAVING)
Feb 02 14:23:47 avocet kernel: cfg80211: World regulatory domain updated:
Feb 02 14:23:47 avocet kernel: cfg80211:  DFS Master region: unset
Feb 02 14:23:47 avocet kernel: cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
Feb 02 14:23:47 avocet kernel: cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
Feb 02 14:23:47 avocet kernel: cfg80211:   (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
Feb 02 14:23:47 avocet kernel: cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A)
Feb 02 14:23:47 avocet kernel: cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
Feb 02 14:23:47 avocet kernel: cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
Feb 02 14:23:47 avocet kernel: cfg80211:   (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s)
Feb 02 14:23:47 avocet kernel: cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
Feb 02 14:23:47 avocet kernel: cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A)
Feb 02 14:23:47 avocet kernel: cfg80211: Regulatory domain changed to country: GB
Feb 02 14:23:47 avocet kernel: cfg80211:  DFS Master region: ETSI
Feb 02 14:23:47 avocet kernel: cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
Feb 02 14:23:47 avocet kernel: cfg80211:   (2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
Feb 02 14:23:47 avocet kernel: cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
Feb 02 14:23:47 avocet kernel: cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
Feb 02 14:23:47 avocet kernel: cfg80211:   (5490000 KHz - 5710000 KHz @ 160000 KHz), (N/A, 2700 mBm), (0 s)
Feb 02 14:23:47 avocet kernel: cfg80211:   (57000000 KHz - 66000000 KHz @ 2160000 KHz), (N/A, 4000 mBm), (N/A)
Feb 02 14:23:48 avocet kernel: wlp2s0b1: authenticate with d8:84:66:0f:80:58
Feb 02 14:23:48 avocet kernel: wlp2s0b1: direct probe to d8:84:66:0f:80:58 (try 1/3)
Feb 02 14:23:48 avocet kernel: wlp2s0b1: direct probe to d8:84:66:0f:80:58 (try 2/3)
Feb 02 14:23:48 avocet kernel: wlp2s0b1: send auth to d8:84:66:0f:80:58 (try 3/3)
Feb 02 14:23:48 avocet kernel: wlp2s0b1: authenticated
Feb 02 14:23:48 avocet kernel: wlp2s0b1: associate with d8:84:66:0f:80:58 (try 1/3)
Feb 02 14:23:48 avocet kernel: wlp2s0b1: RX AssocResp from d8:84:66:0f:80:58 (capab=0x411 status=0 aid=2)
Feb 02 14:23:48 avocet kernel: wlp2s0b1: associated
Feb 02 14:23:48 avocet kernel: cfg80211: Regulatory domain changed to country: GB
Feb 02 14:23:48 avocet kernel: cfg80211:  DFS Master region: ETSI
Feb 02 14:23:48 avocet kernel: cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
Feb 02 14:23:48 avocet kernel: cfg80211:   (2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
Feb 02 14:23:48 avocet kernel: cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
Feb 02 14:23:48 avocet kernel: cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
Feb 02 14:23:48 avocet kernel: cfg80211:   (5490000 KHz - 5710000 KHz @ 160000 KHz), (N/A, 2700 mBm), (0 s)
Feb 02 14:23:48 avocet kernel: cfg80211:   (57000000 KHz - 66000000 KHz @ 2160000 KHz), (N/A, 4000 mBm), (N/A)
Feb 02 14:24:58 avocet kernel: wlp2s0b1: deauthenticating from d8:84:66:0f:80:58 by local choice (Reason: 3=DEAUTH_LEAVING)
Feb 02 14:24:58 avocet kernel: cfg80211: World regulatory domain updated:
Feb 02 14:24:58 avocet kernel: cfg80211:  DFS Master region: unset
Feb 02 14:24:58 avocet kernel: cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
Feb 02 14:24:58 avocet kernel: cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
Feb 02 14:24:58 avocet kernel: cfg80211:   (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
Feb 02 14:24:58 avocet kernel: cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A)
Feb 02 14:24:58 avocet kernel: cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
Feb 02 14:24:58 avocet kernel: cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
Feb 02 14:24:58 avocet kernel: cfg80211:   (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s)
Feb 02 14:24:58 avocet kernel: cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
Feb 02 14:24:58 avocet kernel: cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A)

And the log if use NetworkManager instead (with both dhcpcd and wpa_supplicant services stopped):

$ journalctl -xfe 

Feb 02 14:29:31 avocet NetworkManager[2362]: <info>  (wlp2s0b1): Activation: starting connection 'eduroam' (5eefaf9f-5418-47cd-a499-f2ffc683c149)
Feb 02 14:29:31 avocet NetworkManager[2362]: <info>  (wlp2s0b1): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Feb 02 14:29:31 avocet NetworkManager[2362]: <info>  NetworkManager state is now CONNECTING
Feb 02 14:29:31 avocet NetworkManager[2362]: <info>  (wlp2s0b1): device state change: prepare -> config (reason 'none') [40 50 0]
Feb 02 14:29:31 avocet kernel: b43-phy0: Loading firmware version 784.2 (2012-08-15 21:35:19)
Feb 02 14:29:31 avocet NetworkManager[2362]: <info>  (wlp2s0b1): Activation: (wifi) connection 'eduroam' has security, and secrets exist.  No new secrets needed.
Feb 02 14:29:31 avocet NetworkManager[2362]: <info>  Config: added 'ssid' value 'eduroam'
Feb 02 14:29:31 avocet NetworkManager[2362]: <info>  Config: added 'scan_ssid' value '1'
Feb 02 14:29:31 avocet NetworkManager[2362]: <info>  Config: added 'key_mgmt' value 'WPA-EAP'
Feb 02 14:29:31 avocet NetworkManager[2362]: <info>  Config: added 'password' value '<omitted>'
Feb 02 14:29:31 avocet NetworkManager[2362]: <info>  Config: added 'eap' value 'PEAP'
Feb 02 14:29:31 avocet NetworkManager[2362]: <info>  Config: added 'fragment_size' value '1266'
Feb 02 14:29:31 avocet NetworkManager[2362]: <info>  Config: added 'phase2' value 'auth=MSCHAPV2'
Feb 02 14:29:31 avocet NetworkManager[2362]: <info>  Config: added 'ca_cert' value '/home/robaj/.cat_installer/ca.pem'
Feb 02 14:29:31 avocet NetworkManager[2362]: <info>  Config: added 'identity' value 'xxxxxxxx'
Feb 02 14:29:31 avocet NetworkManager[2362]: <info>  Config: added 'anonymous_identity' value 'anonymous@surrey.ac.uk'
Feb 02 14:29:31 avocet NetworkManager[2362]: <info>  Config: added 'bgscan' value 'simple:30:-65:300'
Feb 02 14:29:31 avocet kernel: IPv6: ADDRCONF(NETDEV_UP): wlp2s0b1: link is not ready
Feb 02 14:29:31 avocet NetworkManager[2362]: <info>  Config: added 'proactive_key_caching' value '1'
Feb 02 14:29:31 avocet NetworkManager[2362]: <info>  Config: set interface ap_scan to 1
Feb 02 14:29:31 avocet NetworkManager[2362]: <info>  (wlp2s0b1): supplicant interface state: disabled -> inactive
Feb 02 14:29:31 avocet NetworkManager[2362]: <info>  (wlp2s0b1): supplicant interface state: inactive -> scanning
Feb 02 14:29:32 avocet wpa_supplicant[2370]: wlp2s0b1: SME: Trying to authenticate with d8:84:66:0f:ae:58 (SSID='eduroam' freq=2412 MHz)
Feb 02 14:29:32 avocet kernel: wlp2s0b1: authenticate with d8:84:66:0f:ae:58
Feb 02 14:29:32 avocet NetworkManager[2362]: <info>  (wlp2s0b1): supplicant interface state: scanning -> authenticating
Feb 02 14:29:32 avocet kernel: wlp2s0b1: send auth to d8:84:66:0f:ae:58 (try 1/3)
Feb 02 14:29:32 avocet kernel: wlp2s0b1: authenticated
Feb 02 14:29:32 avocet wpa_supplicant[2370]: wlp2s0b1: Trying to associate with d8:84:66:0f:ae:58 (SSID='eduroam' freq=2412 MHz)
Feb 02 14:29:32 avocet NetworkManager[2362]: <info>  (wlp2s0b1): supplicant interface state: authenticating -> associating
Feb 02 14:29:32 avocet kernel: wlp2s0b1: associate with d8:84:66:0f:ae:58 (try 1/3)
Feb 02 14:29:32 avocet kernel: wlp2s0b1: RX AssocResp from d8:84:66:0f:ae:58 (capab=0x411 status=0 aid=1)
Feb 02 14:29:32 avocet wpa_supplicant[2370]: wlp2s0b1: Associated with d8:84:66:0f:ae:58
Feb 02 14:29:32 avocet wpa_supplicant[2370]: wlp2s0b1: CTRL-EVENT-EAP-STARTED EAP authentication started
Feb 02 14:29:32 avocet kernel: IPv6: ADDRCONF(NETDEV_CHANGE): wlp2s0b1: link becomes ready
Feb 02 14:29:32 avocet kernel: wlp2s0b1: associated
Feb 02 14:29:32 avocet wpa_supplicant[2370]: wlp2s0b1: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=GB
Feb 02 14:29:32 avocet NetworkManager[2362]: <info>  (wlp2s0b1): supplicant interface state: associating -> associated
Feb 02 14:29:32 avocet kernel: cfg80211: Regulatory domain changed to country: GB
Feb 02 14:29:32 avocet kernel: cfg80211:  DFS Master region: ETSI
Feb 02 14:29:32 avocet kernel: cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
Feb 02 14:29:32 avocet kernel: cfg80211:   (2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
Feb 02 14:29:32 avocet kernel: cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
Feb 02 14:29:32 avocet kernel: cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
Feb 02 14:29:32 avocet kernel: cfg80211:   (5490000 KHz - 5710000 KHz @ 160000 KHz), (N/A, 2700 mBm), (0 s)
Feb 02 14:29:32 avocet kernel: cfg80211:   (57000000 KHz - 66000000 KHz @ 2160000 KHz), (N/A, 4000 mBm), (N/A)
Feb 02 14:29:57 avocet NetworkManager[2362]: <warn>  (wlp2s0b1): Activation: (wifi) association took too long
Feb 02 14:29:57 avocet NetworkManager[2362]: <info>  (wlp2s0b1): device state change: config -> need-auth (reason 'none') [50 60 0]
Feb 02 14:29:57 avocet NetworkManager[2362]: <warn>  (wlp2s0b1): Activation: (wifi) asking for new secrets
Feb 02 14:29:57 avocet kernel: wlp2s0b1: deauthenticating from d8:84:66:0f:ae:58 by local choice (Reason: 3=DEAUTH_LEAVING)
Feb 02 14:29:57 avocet dbus-daemon[806]: Activating service name='org.freedesktop.secrets'
Feb 02 14:29:57 avocet wpa_supplicant[2370]: wlp2s0b1: CTRL-EVENT-DISCONNECTED bssid=d8:84:66:0f:ae:58 reason=3 locally_generated=1
Feb 02 14:29:57 avocet NetworkManager[2362]: <warn>  Connection disconnected (reason -3)
Feb 02 14:29:57 avocet NetworkManager[2362]: <info>  (wlp2s0b1): supplicant interface state: associated -> disconnected
Feb 02 14:29:57 avocet NetworkManager[2362]: <warn>  Failed to GDBus.Error:fi.w1.wpa_supplicant1.NotConnected: This interface is not connected: disconnect.
Feb 02 14:29:57 avocet wpa_supplicant[2370]: wlp2s0b1: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD
Feb 02 14:29:57 avocet kernel: cfg80211: World regulatory domain updated:
Feb 02 14:29:57 avocet kernel: cfg80211:  DFS Master region: unset
Feb 02 14:29:57 avocet kernel: cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
Feb 02 14:29:57 avocet kernel: cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
Feb 02 14:29:57 avocet kernel: cfg80211:   (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
Feb 02 14:29:57 avocet kernel: cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A)
Feb 02 14:29:57 avocet kernel: cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
Feb 02 14:29:57 avocet kernel: cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
Feb 02 14:29:57 avocet kernel: cfg80211:   (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s)
Feb 02 14:29:57 avocet kernel: cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
Feb 02 14:29:57 avocet kernel: cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A)
Feb 02 14:29:57 avocet wpa_supplicant[2370]: wlp2s0b1: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=GB
Feb 02 14:29:57 avocet kernel: cfg80211: Regulatory domain changed to country: GB
Feb 02 14:29:57 avocet kernel: cfg80211:  DFS Master region: ETSI
Feb 02 14:29:57 avocet kernel: cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
Feb 02 14:29:57 avocet kernel: cfg80211:   (2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
Feb 02 14:29:57 avocet kernel: cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
Feb 02 14:29:57 avocet kernel: cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
Feb 02 14:29:57 avocet kernel: cfg80211:   (5490000 KHz - 5710000 KHz @ 160000 KHz), (N/A, 2700 mBm), (0 s)
Feb 02 14:29:57 avocet kernel: cfg80211:   (57000000 KHz - 66000000 KHz @ 2160000 KHz), (N/A, 4000 mBm), (N/A)
Feb 02 14:29:57 avocet gnome-keyring-daemon[2789]: couldn't access control socket: /run/user/1000/keyring/control: No such file or directory
Feb 02 14:29:57 avocet org.freedesktop.secrets[806]: ** Message: couldn't access control socket: /run/user/1000/keyring/control: No such file or directory
Feb 02 14:29:57 avocet dbus-daemon[806]: Successfully activated service 'org.freedesktop.secrets'
Feb 02 14:29:57 avocet dbus[540]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service'
Feb 02 14:29:57 avocet systemd[1]: Starting Hostname Service...
-- Subject: Unit systemd-hostnamed.service has begun start-up
-- Defined-By: systemd
-- Support: http://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- Unit systemd-hostnamed.service has begun starting up.
Feb 02 14:29:57 avocet dbus[540]: [system] Successfully activated service 'org.freedesktop.hostname1'
Feb 02 14:29:57 avocet systemd[1]: Started Hostname Service.
-- Subject: Unit systemd-hostnamed.service has finished start-up
-- Defined-By: systemd
-- Support: http://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- Unit systemd-hostnamed.service has finished starting up.
-- 
-- The start-up result is done.
Feb 02 14:29:59 avocet NetworkManager[2362]: <warn>  (wlp2s0b1): User canceled the secrets request.
Feb 02 14:29:59 avocet NetworkManager[2362]: <info>  (wlp2s0b1): device state change: need-auth -> failed (reason 'no-secrets') [60 120 7]
Feb 02 14:29:59 avocet NetworkManager[2362]: <info>  NetworkManager state is now DISCONNECTED
Feb 02 14:29:59 avocet NetworkManager[2362]: <warn>  (wlp2s0b1): Activation: failed for connection 'eduroam'
Feb 02 14:29:59 avocet NetworkManager[2362]: <info>  (wlp2s0b1): device state change: failed -> disconnected (reason 'none') [120 30 0]
Feb 02 14:29:59 avocet kernel: IPv6: ADDRCONF(NETDEV_UP): wlp2s0b1: link is not ready

I've been looking for a solution for days and have tried many things, including setting net.ifnames=0 in grub, installing the crda package, disabling the ipv6 stack in grub, and adding the 11n=1 and swcrypto=1 options to iwlwifi with modprobe. What have I missed?

Edit 2:
The wireless networks wiki page suggests this behaviour (deauthenticating from MAC by local choice, reason=3) might be caused by power management. As far as I can tell power management is disabled:

$ iwconfig

wlp2s0b1  IEEE 802.11bg  ESSID:off/any  
          Mode:Managed  Access Point: Not-Associated   Tx-Power=20 dBm   
          Retry short limit:7   RTS thr:off   Fragment thr:off
          Power Management:off

and with tlp (WIFI_PWR_ON_AC=1, WIFI_PWR_ON_BAT=1 ):

$ tlp-stat -r

--- TLP 0.8 --------------------------------------------

+++ Wireless
bluetooth = off (software)
wifi      = on
wwan      = none (no device)

hci0(btusb)         : not connected
wlp2s0b1(b43)       : not connected, power management = off

I'm unsure whether there are other logs I should be looking at for information.. any advice would be much appreciated!

Last edited by rbaj (2016-02-03 10:49:59)

Offline

Board footer

Powered by FluxBB