[Solved] Wifi connection lost and can't reinitialize

Kotrfa · 2020-03-26 14:21:41

Hi,

I am having troubles with an unstable connection on my laptop. I can't find anything weird in the logs (see the gist below) - it just gets into a weird loop and can't reconnect again. Sometimes it works fine for hours, sometimes I have to restart netctl-auto (via `sudo systemctl restart netctl-auto@wlp4s0.service;sudo rfkill unblock wifi`), which helps. I can see it's only my device, are three other people on the same network are doing just fine.

The logs are here: https://gist.github.com/hnykda/6f0f79c1 … 2a32f3503f

Any idea where I can look? There is nothing recorded in the router log (although it's pretty low detailed). Anything else I can provide to help me to debug it?

Thank you a lot!

Last edited by Kotrfa (2020-05-04 16:00:29)

Head_on_a_Stick · 2020-03-26 14:57:39

How are you connecting? EDIT: sorry, you say you're using netctl. Have you checked for conflicting network services?

systemctl list-unit-files --state=enabled

The log shows dhcpcd flailing around trying to get a lease, have you tried static IP addresses?

You should probably provide information about the hardware itself, for example:

lspci -knn | grep -A2 Network

See the troubleshooting section on the "Network Configuration/Wireless" ArchWiki page, it has advice pertaining to various types of card.

Last edited by Head_on_a_Stick (2020-03-26 14:58:25)

Kotrfa · 2020-03-26 15:34:51

Thanks! I have a reserved address in the router for my MAC. I will now also try to set static address in my netctl profile and see what it does, report back if it solves the issues. Thank you for now.

Kotrfa · 2020-03-30 08:52:30

> The log shows dhcpcd flailing around trying to get a lease, have you tried static IP addresses?

So I setup a static address via netctl but the problem stills persists. Here are the recent logs: https://gist.github.com/hnykda/3562d924 … 2a0e1e47f0 .

> How are you connecting? EDIT: sorry, you say you're using netctl. Have you checked for conflicting network services?
I don't have anything else but netctl to keep stuff simple.

$ systemctl list-unit-files --state=enabled

   1   │ UNIT FILE                 STATE  
   2   │ autovt@.service           enabled
   3   │ dhcpcd.service            enabled
   4   │ earlyoom.service          enabled
   5   │ getty@.service            enabled
   6   │ lm_sensors.service        enabled
   7   │ systemd-timesyncd.service enabled
   8   │ tlp.service               enabled
   9   │ remote-fs.target          enabled
  10   │ paccache.timer            enabled
  11   │ 
  12   │ 9 unit files listed.
───────┴──────────────────────────────────────

$ lspci -knn | grep -A2 Network
04:00.0 Network controller [0280]: Intel Corporation Wireless 8260 [8086:24f3] (rev 3a)
	Subsystem: Intel Corporation Wireless 8260 [8086:0130]
	Kernel driver in use: iwlwifi

I am now trying to disable ipv6 in dhcpcd as recommended here:

* https://bugs.archlinux.org/task/58457
* https://forum.manjaro.org/t/cannot-conn … rk/48326/3

Next thing will be too disabling 5G or 2.4G and see if it makes difference.

Related:
* https://bugzilla.kernel.org/show_bug.cgi?id=203709

Head_on_a_Stick · 2020-03-30 14:27:16

See also https://wiki.archlinux.org/index.php/Ne … ss#iwlwifi (as I suggested earlier).

Kotrfa · 2020-03-31 15:28:08

I found out that the problem exists only on my 5GHz network. Any hints in that direction (none of the possible resolutions mentions 5GHz as a cause)?

I have exactly the same setting in my netctl profiles:

Description='Automatically generated profile by wifi-menu'
Interface=wlp4s0
Connection=wireless
Security=wpa
ESSID=interbrigada-ff-5G  # or no 5G when on 2GHz in a second profile
IP=static
Address=('192.168.0.52')
Gateway='192.168.0.1'
DNS=('192.168.0.1')
Key=***

Last edited by Kotrfa (2020-03-31 15:29:28)

seth · 2020-03-31 16:33:20

If you're using netctl, you should first and foremost stop and disable the dhcpcd.service

Kotrfa · 2020-03-31 19:11:45

Like, entirely? Does netctl-auto manage it by itself? Or would I have to setup a static URL on every site I login?

Or should I just do https://wiki.archlinux.org/index.php/Ne … HCP_client after disabling dhcpcd? thank you!

Head_on_a_Stick · 2020-03-31 20:12:05

Kotrfa wrote:

Does netctl-auto manage it by itself?

Yes, netctl should start dhcpcd independently. If you also have dhcpcd.service enabled then they will conflict.

seth · 2020-03-31 20:12:38

netctl invokes dhcpcd by default (unless oc. you configure a static IP for the NIC)
If you run the dhcpcd.service on top, they will suffer from the threetwo-stooges-syndrome

Edit: blast.

Last edited by seth (2020-03-31 20:12:55)

Kotrfa · 2020-04-02 18:58:11

Thanks. I disabled dhcpcd but the problem is still the same: https://gist.github.com/hnykda/4e9201a0 … e4762fbd32 . Not sure where to go now :-/

Head_on_a_Stick · 2020-04-02 19:16:44

Have you tried the suggestions on the ArchWiki page I linked to in post #5?

Kotrfa · 2020-04-15 10:28:54

Hey. Yes, I tried to add that, didn't help, it still gets into the weird loop of this: https://gist.github.com/hnykda/c4dd84e8 … 30acf9afdf :

Apr 15 12:21:16 think460s kernel: wlp4s0: Connection to AP 38:43:7d:a5:13:d4 lost
Apr 15 12:21:17 think460s kernel: wlp4s0: authenticate with 38:43:7d:a5:13:d4
Apr 15 12:21:17 think460s kernel: wlp4s0: send auth to 38:43:7d:a5:13:d4 (try 1/3)
Apr 15 12:21:17 think460s kernel: wlp4s0: authenticated
Apr 15 12:21:17 think460s kernel: wlp4s0: associate with 38:43:7d:a5:13:d4 (try 1/3)
Apr 15 12:21:17 think460s kernel: wlp4s0: RX AssocResp from 38:43:7d:a5:13:d4 (capab=0x1511 status=0 aid=2)
Apr 15 12:21:17 think460s kernel: wlp4s0: associated
Apr 15 12:21:17 think460s kernel: iwlwifi 0000:04:00.0: No beacon heard and the time event is over already...
Apr 15 12:21:17 think460s kernel: wlp4s0: Connection to AP 38:43:7d:a5:13:d4 lost
Apr 15 12:21:18 think460s kernel: wlp4s0: authenticate with 38:43:7d:a5:13:d4
Apr 15 12:21:18 think460s kernel: wlp4s0: send auth to 38:43:7d:a5:13:d4 (try 1/3)
Apr 15 12:21:18 think460s kernel: wlp4s0: authenticated
Apr 15 12:21:18 think460s kernel: wlp4s0: associate with 38:43:7d:a5:13:d4 (try 1/3)
Apr 15 12:21:18 think460s kernel: wlp4s0: RX AssocResp from 38:43:7d:a5:13:d4 (capab=0x1511 status=0 aid=2)
Apr 15 12:21:18 think460s kernel: wlp4s0: associated
Apr 15 12:21:19 think460s kernel: iwlwifi 0000:04:00.0: No beacon heard and the time event is over already...
Apr 15 12:21:19 think460s kernel: wlp4s0: Connection to AP 38:43:7d:a5:13:d4 lost

now I am trying to disable ipv6 via kernel parameter.

unixman · 2020-04-15 14:59:07

i dont think its ipv6 related. When some of you have issues with wifi then stop to use high level abstractions (netctl, dhcpcd, systemd ...) and use low lovel tools via command line to see where the issues coming from. So i think you give a try directly via wpa_supplicant. wpa_supplicant.conf give you dozens of tweaks to play with. But you been xp-enced to figure out them. Edit: distrubuted wpa.conf example file have descriptions inside it abouts tweaks.

Last edited by unixman (2020-04-15 15:04:16)

Kotrfa · 2020-04-18 20:48:56

Yes, it's not related to ipv6 because it's still doing the same thing when disabling it via kernel parameter.

Playing with wpa_supplicant was exactly the bit I wanted to avoid...

Kotrfa · 2020-04-26 12:27:06

Hi, so I used WPA supplicant with the following systemd services enabled:

# /etc/systemd/system/wpa_supplicant.service
[Unit]
Description=WPA supplicant
Before=network.target
After=dbus.service
Wants=network.target
IgnoreOnIsolate=true

[Service]
Type=dbus
BusName=fi.w1.wpa_supplicant1
ExecStart=/usr/bin/wpa_supplicant -u -s -c /etc/wpa_supplicant/inter-5G.conf -i wlp4s0

[Install]
WantedBy=multi-user.target
#Alias=dbus-fi.w1.wpa_supplicant1.service


### dhcpcd service
# /usr/lib/systemd/system/dhcpcd.service
[Unit]
Description=dhcpcd on all interfaces
Wants=network.target
Before=network.target

[Service]
Type=forking
PIDFile=/run/dhcpcd/pid
ExecStart=/usr/bin/dhcpcd -q -b
ExecStop=/usr/bin/dhcpcd -x

[Install]
WantedBy=multi-user.target

# /etc/systemd/system/dhcpcd.service.d/override.conf
[Unit]
After=netctl-auto@wlp4s0.service

and it behaves exactly the same. Here is the gist: https://gist.github.com/hnykda/7aceb410 … fe992b95fb . Out of nowhere, I get `wlp4s0: CTRL-EVENT-BEACON-LOSS` and then the loop happens until I restart my controller, restarting wpa_supplicant for this "profile" doesn't help, as you can see on line 584.

Even when I turn off dhcpcd service, this happens on raw wpa_supplicant:

Apr 26 14:31:34 think460s wpa_supplicant[985138]: wlp4s0: WPA: Key negotiation completed with 38:43:7d:a5:13:d4 [PTK=CCMP GTK=TKIP]
Apr 26 14:31:34 think460s wpa_supplicant[985138]: wlp4s0: CTRL-EVENT-CONNECTED - Connection to 38:43:7d:a5:13:d4 completed [id=0 id_str=]
Apr 26 14:31:35 think460s kernel: iwlwifi 0000:04:00.0: No beacon heard and the time event is over already...
Apr 26 14:31:35 think460s kernel: wlp4s0: Connection to AP 38:43:7d:a5:13:d4 lost
Apr 26 14:31:35 think460s wpa_supplicant[985138]: wlp4s0: CTRL-EVENT-DISCONNECTED bssid=38:43:7d:a5:13:d4 reason=4 locally_generated=1
Apr 26 14:31:36 think460s wpa_supplicant[985138]: wlp4s0: SME: Trying to authenticate with 38:43:7d:a5:13:d4 (SSID='interbrigada-ff-5G' freq=5220 MHz)
Apr 26 14:31:36 think460s kernel: wlp4s0: authenticate with 38:43:7d:a5:13:d4
Apr 26 14:31:36 think460s kernel: wlp4s0: send auth to 38:43:7d:a5:13:d4 (try 1/3)
Apr 26 14:31:36 think460s wpa_supplicant[985138]: wlp4s0: Trying to associate with 38:43:7d:a5:13:d4 (SSID='interbrigada-ff-5G' freq=5220 MHz)
Apr 26 14:31:36 think460s kernel: wlp4s0: authenticated
Apr 26 14:31:36 think460s kernel: wlp4s0: associate with 38:43:7d:a5:13:d4 (try 1/3)
Apr 26 14:31:36 think460s wpa_supplicant[985138]: wlp4s0: Associated with 38:43:7d:a5:13:d4
Apr 26 14:31:36 think460s wpa_supplicant[985138]: wlp4s0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Apr 26 14:31:36 think460s kernel: wlp4s0: RX AssocResp from 38:43:7d:a5:13:d4 (capab=0x1511 status=0 aid=6)
Apr 26 14:31:36 think460s kernel: wlp4s0: associated
Apr 26 14:31:36 think460s wpa_supplicant[985138]: wlp4s0: WPA: Key negotiation completed with 38:43:7d:a5:13:d4 [PTK=CCMP GTK=TKIP]
Apr 26 14:31:36 think460s wpa_supplicant[985138]: wlp4s0: CTRL-EVENT-CONNECTED - Connection to 38:43:7d:a5:13:d4 completed [id=0 id_str=]
Apr 26 14:31:37 think460s kernel: iwlwifi 0000:04:00.0: No beacon heard and the time event is over already...
Apr 26 14:31:37 think460s kernel: wlp4s0: Connection to AP 38:43:7d:a5:13:d4 lost
Apr 26 14:31:37 think460s wpa_supplicant[985138]: wlp4s0: CTRL-EVENT-DISCONNECTED bssid=38:43:7d:a5:13:d4 reason=4 locally_generated=1
Apr 26 14:31:38 think460s wpa_supplicant[985138]: wlp4s0: SME: Trying to authenticate with 38:43:7d:a5:13:d4 (SSID='interbrigada-ff-5G' freq=5220 MHz)
Apr 26 14:31:38 think460s kernel: wlp4s0: authenticate with 38:43:7d:a5:13:d4
Apr 26 14:31:38 think460s kernel: wlp4s0: send auth to 38:43:7d:a5:13:d4 (try 1/3)
Apr 26 14:31:38 think460s wpa_supplicant[985138]: wlp4s0: Trying to associate with 38:43:7d:a5:13:d4 (SSID='interbrigada-ff-5G' freq=5220 MHz)
Apr 26 14:31:38 think460s kernel: wlp4s0: authenticated
Apr 26 14:31:38 think460s kernel: wlp4s0: associate with 38:43:7d:a5:13:d4 (try 1/3)
Apr 26 14:31:39 think460s kernel: wlp4s0: RX AssocResp from 38:43:7d:a5:13:d4 (capab=0x1511 status=0 aid=6)
Apr 26 14:31:39 think460s kernel: wlp4s0: associated
Apr 26 14:31:39 think460s wpa_supplicant[985138]: wlp4s0: Associated with 38:43:7d:a5:13:d4
Apr 26 14:31:39 think460s wpa_supplicant[985138]: wlp4s0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Apr 26 14:31:39 think460s wpa_supplicant[985138]: wlp4s0: WPA: Key negotiation completed with 38:43:7d:a5:13:d4 [PTK=CCMP GTK=TKIP]
Apr 26 14:31:39 think460s wpa_supplicant[985138]: wlp4s0: CTRL-EVENT-CONNECTED - Connection to 38:43:7d:a5:13:d4 completed [id=0 id_str=]
Apr 26 14:31:39 think460s kernel: iwlwifi 0000:04:00.0: No beacon heard and the time event is over already...
Apr 26 14:31:39 think460s kernel: wlp4s0: Connection to AP 38:43:7d:a5:13:d4 lost
Apr 26 14:31:39 think460s wpa_supplicant[985138]: wlp4s0: CTRL-EVENT-DISCONNECTED bssid=38:43:7d:a5:13:d4 reason=4 locally_generated=1
Apr 26 14:31:40 think460s wpa_supplicant[985138]: wlp4s0: SME: Trying to authenticate with 38:43:7d:a5:13:d4 (SSID='interbrigada-ff-5G' freq=5220 MHz)
Apr 26 14:31:40 think460s kernel: wlp4s0: authenticate with 38:43:7d:a5:13:d4
Apr 26 14:31:40 think460s kernel: wlp4s0: send auth to 38:43:7d:a5:13:d4 (try 1/3)
Apr 26 14:31:40 think460s wpa_supplicant[985138]: wlp4s0: Trying to associate with 38:43:7d:a5:13:d4 (SSID='interbrigada-ff-5G' freq=5220 MHz)
Apr 26 14:31:40 think460s kernel: wlp4s0: authenticated
Apr 26 14:31:40 think460s kernel: wlp4s0: associate with 38:43:7d:a5:13:d4 (try 1/3)
Apr 26 14:31:40 think460s kernel: wlp4s0: RX AssocResp from 38:43:7d:a5:13:d4 (capab=0x1511 status=0 aid=6)
Apr 26 14:31:40 think460s wpa_supplicant[985138]: wlp4s0: Associated with 38:43:7d:a5:13:d4
Apr 26 14:31:40 think460s wpa_supplicant[985138]: wlp4s0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Apr 26 14:31:40 think460s kernel: wlp4s0: associated
Apr 26 14:31:41 think460s wpa_supplicant[985138]: wlp4s0: WPA: Key negotiation completed with 38:43:7d:a5:13:d4 [PTK=CCMP GTK=TKIP]
Apr 26 14:31:41 think460s wpa_supplicant[985138]: wlp4s0: CTRL-EVENT-CONNECTED - Connection to 38:43:7d:a5:13:d4 completed [id=0 id_str=]
Apr 26 14:31:43 think460s kernel: wlp4s0: Connection to AP 38:43:7d:a5:13:d4 lost
Apr 26 14:31:43 think460s wpa_supplicant[985138]: wlp4s0: CTRL-EVENT-DISCONNECTED bssid=38:43:7d:a5:13:d4 reason=4 locally_generated=1
Apr 26 14:31:44 think460s wpa_supplicant[985138]: wlp4s0: SME: Trying to authenticate with 38:43:7d:a5:13:d4 (SSID='interbrigada-ff-5G' freq=5220 MHz)
Apr 26 14:31:44 think460s kernel: wlp4s0: authenticate with 38:43:7d:a5:13:d4
Apr 26 14:31:44 think460s kernel: wlp4s0: send auth to 38:43:7d:a5:13:d4 (try 1/3)
Apr 26 14:31:44 think460s wpa_supplicant[985138]: wlp4s0: Trying to associate with 38:43:7d:a5:13:d4 (SSID='interbrigada-ff-5G' freq=5220 MHz)
Apr 26 14:31:44 think460s kernel: wlp4s0: authenticated
Apr 26 14:31:44 think460s kernel: wlp4s0: associate with 38:43:7d:a5:13:d4 (try 1/3)
Apr 26 14:31:44 think460s kernel: wlp4s0: RX AssocResp from 38:43:7d:a5:13:d4 (capab=0x1511 status=0 aid=6)
Apr 26 14:31:44 think460s wpa_supplicant[985138]: wlp4s0: Associated with 38:43:7d:a5:13:d4
Apr 26 14:31:44 think460s kernel: wlp4s0: associated
Apr 26 14:31:44 think460s wpa_supplicant[985138]: wlp4s0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Apr 26 14:31:44 think460s wpa_supplicant[985138]: wlp4s0: WPA: Key negotiation completed with 38:43:7d:a5:13:d4 [PTK=CCMP GTK=TKIP]
Apr 26 14:31:44 think460s wpa_supplicant[985138]: wlp4s0: CTRL-EVENT-CONNECTED - Connection to 38:43:7d:a5:13:d4 completed [id=0 id_str=]
Apr 26 14:31:45 think460s kernel: iwlwifi 0000:04:00.0: No beacon heard and the time event is over already...
Apr 26 14:31:45 think460s kernel: wlp4s0: Connection to AP 38:43:7d:a5:13:d4 lost
Apr 26 14:31:45 think460s wpa_supplicant[985138]: wlp4s0: CTRL-EVENT-DISCONNECTED bssid=38:43:7d:a5:13:d4 reason=4 locally_generated=1
Apr 26 14:31:46 think460s wpa_supplicant[985138]: wlp4s0: SME: Trying to authenticate with 38:43:7d:a5:13:d4 (SSID='interbrigada-ff-5G' freq=5220 MHz)
Apr 26 14:31:46 think460s kernel: wlp4s0: authenticate with 38:43:7d:a5:13:d4
Apr 26 14:31:46 think460s kernel: wlp4s0: send auth to 38:43:7d:a5:13:d4 (try 1/3)
Apr 26 14:31:46 think460s wpa_supplicant[985138]: wlp4s0: Trying to associate with 38:43:7d:a5:13:d4 (SSID='interbrigada-ff-5G' freq=5220 MHz)
Apr 26 14:31:46 think460s kernel: wlp4s0: authenticated
Apr 26 14:31:46 think460s kernel: wlp4s0: associate with 38:43:7d:a5:13:d4 (try 1/3)
Apr 26 14:31:46 think460s kernel: wlp4s0: RX AssocResp from 38:43:7d:a5:13:d4 (capab=0x1511 status=0 aid=6)
Apr 26 14:31:46 think460s wpa_supplicant[985138]: wlp4s0: Associated with 38:43:7d:a5:13:d4
Apr 26 14:31:46 think460s wpa_supplicant[985138]: wlp4s0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Apr 26 14:31:46 think460s kernel: wlp4s0: associated
Apr 26 14:31:46 think460s wpa_supplicant[985138]: wlp4s0: WPA: Key negotiation completed with 38:43:7d:a5:13:d4 [PTK=CCMP GTK=TKIP]
Apr 26 14:31:46 think460s wpa_supplicant[985138]: wlp4s0: CTRL-EVENT-CONNECTED - Connection to 38:43:7d:a5:13:d4 completed [id=0 id_str=]
Apr 26 14:31:47 think460s kernel: iwlwifi 0000:04:00.0: No beacon heard and the time event is over already...
Apr 26 14:31:47 think460s kernel: wlp4s0: Connection to AP 38:43:7d:a5:13:d4 lost
Apr 26 14:31:47 think460s wpa_supplicant[985138]: wlp4s0: CTRL-EVENT-DISCONNECTED bssid=38:43:7d:a5:13:d4 reason=4 locally_generated=1

And with the additional `-d` switch for more verbose logging:

Apr 26 14:33:42 think460s wpa_supplicant[1001329]: wlp4s0: radio_work_free('sme-connect'@0x55643dd8a900): num_active_works --> 0
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: wlp4s0: CTRL-EVENT-CONNECTED - Connection to 38:43:7d:a5:13:d4 completed [id=0 id_str=]
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: nl80211: Set wlp4s0 operstate 0->1 (UP)
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: netlink: Operstate: ifindex=3 linkmode=-1 (no change), operstate=6 (IF_OPER_UP)
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: wlp4s0: Determining shared radio frequencies (max len 2)
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: wlp4s0: Shared frequencies (len=1): completed iteration
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: wlp4s0: freq[0]: 5220, flags=0x1
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: P2P: Add operating class 81
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: P2P: Channels - hexdump(len=13): 01 02 03 04 05 06 07 08 09 0a 0b 0c 0d
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: P2P: Add operating class 124
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: P2P: Channels - hexdump(len=4): 95 99 9d a1
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: P2P: Add operating class 125
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: P2P: Channels - hexdump(len=5): 95 99 9d a1 a5
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: P2P: Update channel list
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: P2P: channels: 81:1,2,3,4,5,6,7,8,9,10,11,12,13 124:149,153,157,161 125:149,153,157,161,165
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: P2P: cli_channels:
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: EAPOL: External notification - portValid=1
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: EAPOL: External notification - EAP success=1
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: EAPOL: SUPP_PAE entering state AUTHENTICATING
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: EAPOL: SUPP_BE entering state SUCCESS
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: EAP: EAP entering state DISABLED
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: EAPOL: SUPP_PAE entering state AUTHENTICATED
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: EAPOL: Supplicant port status: Authorized
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: nl80211: Set supplicant port authorized for 38:43:7d:a5:13:d4
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: EAPOL: SUPP_BE entering state IDLE
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: EAPOL authentication completed - result=SUCCESS
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: nl80211: Set rekey offload
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: RTM_NEWLINK: ifi_index=3 ifname=wlp4s0 operstate=6 linkmode=1 ifi_family=0 ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP])
Apr 26 14:33:42 think460s kernel: iwlwifi 0000:04:00.0: No beacon heard and the time event is over already...
Apr 26 14:33:42 think460s kernel: wlp4s0: Connection to AP 38:43:7d:a5:13:d4 lost
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: nl80211: Ignored event 20 (NL80211_CMD_DEL_STATION) for foreign interface (ifindex 3 wdev 0x0)
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: nl80211: Drv Event 20 (NL80211_CMD_DEL_STATION) received for wlp4s0
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: nl80211: Delete station 38:43:7d:a5:13:d4
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: nl80211: Ignored event 39 (NL80211_CMD_DEAUTHENTICATE) for foreign interface (ifindex 3 wdev 0x0)
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: nl80211: Drv Event 39 (NL80211_CMD_DEAUTHENTICATE) received for wlp4s0
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: nl80211: Deauthenticate event
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: wlp4s0: Event DEAUTH (11) received
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: wlp4s0: Deauthentication notification
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: wlp4s0:  * reason 4 (DISASSOC_DUE_TO_INACTIVITY) locally_generated=1
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: wlp4s0:  * address 38:43:7d:a5:13:d4
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: Deauthentication frame IE(s) - hexdump(len=0): [NULL]
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: wlp4s0: CTRL-EVENT-DISCONNECTED bssid=38:43:7d:a5:13:d4 reason=4 locally_generated=1
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: wlp4s0: Auto connect enabled: try to reconnect (wps=0/0 wpa_state=9)
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: wlp4s0: Setting scan request: 0.100000 sec
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: Added BSSID 38:43:7d:a5:13:d4 into blacklist
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: wlp4s0: Blacklist count 1 --> request scan in 100 ms
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: wlp4s0: Ignore new scan request for 0.100000 sec since an earlier request is scheduled to trigger sooner
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: TDLS: Remove peers on disassociation
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: wlp4s0: WPA: Clear old PMK and PTK
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: wlp4s0: Disconnect event - remove keys
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: wpa_driver_nl80211_set_key: ifindex=3 (wlp4s0) alg=0 addr=(nil) key_idx=0 set_tx=0 seq_len=0 key_len=0
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: wpa_driver_nl80211_set_key: ifindex=3 (wlp4s0) alg=0 addr=(nil) key_idx=1 set_tx=0 seq_len=0 key_len=0
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: wpa_driver_nl80211_set_key: ifindex=3 (wlp4s0) alg=0 addr=0x55643dd09b70 key_idx=0 set_tx=0 seq_len=0 key_len=0
Apr 26 14:33:42 think460s wpa_supplicant[1001329]:    addr=38:43:7d:a5:13:d4
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: nl80211: Data frame filter flags=0x0
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: wlp4s0: State: COMPLETED -> DISCONNECTED
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: nl80211: Set wlp4s0 operstate 1->0 (DORMANT)
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: netlink: Operstate: ifindex=3 linkmode=-1 (no change), operstate=5 (IF_OPER_DORMANT)
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: WMM AC: WMM AC is disabled
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: wlp4s0: Determining shared radio frequencies (max len 2)
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: wlp4s0: Shared frequencies (len=0): completed iteration
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: P2P: Add operating class 81
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: P2P: Channels - hexdump(len=13): 01 02 03 04 05 06 07 08 09 0a 0b 0c 0d
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: P2P: Add operating class 124
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: P2P: Channels - hexdump(len=4): 95 99 9d a1
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: P2P: Add operating class 125
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: P2P: Channels - hexdump(len=5): 95 99 9d a1 a5
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: P2P: Update channel list
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: P2P: channels: 81:1,2,3,4,5,6,7,8,9,10,11,12,13 124:149,153,157,161 125:149,153,157,161,165
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: P2P: cli_channels:
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: EAPOL: External notification - portEnabled=0
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: EAPOL: SUPP_PAE entering state DISCONNECTED
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: EAPOL: Supplicant port status: Unauthorized
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: nl80211: Skip set_supp_port(unauthorized) while not associated
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: EAPOL: SUPP_BE entering state INITIALIZE
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: EAPOL: External notification - portValid=0
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: EAPOL: External notification - EAP success=0
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: wlp4s0: BSS: Remove id 61 BSSID 38:43:7d:a5:13:d4 SSID 'interbrigada-ff-5G' due to Connection to AP lost
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/0/BSSs/61'
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: RTM_NEWLINK: ifi_index=3 ifname=wlp4s0 wext ifi_family=0 ifi_flags=0x1043 ([UP][RUNNING])
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: RTM_NEWLINK: ifi_index=3 ifname=wlp4s0 operstate=5 linkmode=1 ifi_family=0 ifi_flags=0x1003 ([UP])
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: nl80211: Ignored event 48 (NL80211_CMD_DISCONNECT) for foreign interface (ifindex 3 wdev 0x0)
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: nl80211: Drv Event 48 (NL80211_CMD_DISCONNECT) received for wlp4s0
Apr 26 14:33:42 think460s wpa_supplicant[1001329]: nl80211: Ignore disconnect event when using userspace SME
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: wlp4s0: State: DISCONNECTED -> SCANNING
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: wlp4s0: Determining shared radio frequencies (max len 2)
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: wlp4s0: Shared frequencies (len=0): completed iteration
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: P2P: Add operating class 81
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: P2P: Channels - hexdump(len=13): 01 02 03 04 05 06 07 08 09 0a 0b 0c 0d
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: P2P: Add operating class 124
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: P2P: Channels - hexdump(len=4): 95 99 9d a1
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: P2P: Add operating class 125
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: P2P: Channels - hexdump(len=5): 95 99 9d a1 a5
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: P2P: Update channel list
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: P2P: channels: 81:1,2,3,4,5,6,7,8,9,10,11,12,13 124:149,153,157,161 125:149,153,157,161,165
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: P2P: cli_channels:
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: wlp4s0: Starting AP scan for wildcard SSID
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: WPS: Building WPS IE for Probe Request
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: WPS:  * Version (hardcoded 0x10)
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: WPS:  * Request Type
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: WPS:  * Config Methods (3148)
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: WPS:  * UUID-E
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: WPS:  * Primary Device Type
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: WPS:  * RF Bands (3)
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: WPS:  * Association State
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: WPS:  * Configuration Error (0)
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: WPS:  * Device Password ID (0)
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: WPS:  * Manufacturer
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: WPS:  * Model Name
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: WPS:  * Model Number
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: WPS:  * Device Name
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: WPS:  * Version2 (0x20)
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: P2P: * P2P IE header
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: P2P: * Capability dev=25 group=00
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: P2P: * Listen Channel: Regulatory Class 81 Channel 6
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: wlp4s0: Add radio work 'scan'@0x55643dd41420
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: wlp4s0: First radio work item in the queue - schedule start immediately
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: wlp4s0: Starting radio work 'scan'@0x55643dd41420 after 0.000026 second wait
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: wlp4s0: nl80211: scan request
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: Scan requested (ret=0) - scan timeout 30 seconds
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: nl80211: Ignored event 33 (NL80211_CMD_TRIGGER_SCAN) for foreign interface (ifindex 3 wdev 0x0)
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: nl80211: Drv Event 33 (NL80211_CMD_TRIGGER_SCAN) received for wlp4s0
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: wlp4s0: nl80211: Scan trigger
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: wlp4s0: Event SCAN_STARTED (47) received
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: wlp4s0: Own scan request started a scan in 0.000079 seconds
Apr 26 14:33:43 think460s wpa_supplicant[1001329]: RTM_NEWLINK: ifi_index=3 ifname=wlp4s0 operstate=2 linkmode=1 ifi_family=0 ifi_flags=0x1003 ([UP])
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Ignored event 34 (NL80211_CMD_NEW_SCAN_RESULTS) for foreign interface (ifindex 3 wdev 0x0)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Drv Event 34 (NL80211_CMD_NEW_SCAN_RESULTS) received for wlp4s0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: nl80211: New scan results available
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Scan probed for SSID ''
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Scan included frequencies: 2412 2417 2422 2427 2432 2437 2442 2447 2452 2457 2462 2467 2472 5180 5200 5220 5240 5260 5280 5300 5320 5500 5520 5540 5560 5580 5600 5620 5640 5660 5680 5700 5720 5745 5765 5785 5805 5825
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Event SCAN_RESULTS (3) received
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Scan completed in 1.229750 seconds
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Received scan results (45 BSSes)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: BSS: Start scan result update 10
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: BSS: Add new id 62 BSSID 38:43:7d:a5:13:d4 SSID 'interbrigada-ff-5G' freq 5220
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/0/BSSs/62'
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: BSS: Add new id 63 BSSID 34:2c:c4:5d:13:0c SSID 'UPC9228008' freq 5240
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: dbus: Register BSS object '/fi/w1/wpa_supplicant1/Interfaces/0/BSSs/63'
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: BSS: Remove id 40 BSSID 28:ff:3e:34:18:16 SSID 'MujO2Internet_341816' due to no match in scan
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: dbus: Unregister BSS object '/fi/w1/wpa_supplicant1/Interfaces/0/BSSs/40'
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: BSS: last_scan_res_used=45/64
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: New scan results available (own=1 ext=0)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP 38:43:7d:a5:13:d4 type 0 added
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP 38:43:7d:a5:13:91 type 0 added
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP 80:f5:03:70:e7:75 type 0 added
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP 90:5c:44:77:ed:b6 type 0 added
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP 38:43:7d:ef:e5:26 type 0 added
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP 90:5c:44:78:1f:b2 type 0 added
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP c4:71:54:b4:a2:33 type 0 added
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP 4c:5e:0c:12:7a:90 type 0 added
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP 34:2c:c4:5d:13:0c type 0 added
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP 34:2c:c4:83:95:75 type 0 added
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP 38:43:7d:ef:e5:16 type 0 added
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP c4:71:54:b4:a2:31 type 0 added
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP 20:e8:82:f7:2d:ac type 0 added
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP 50:78:b3:97:62:80 type 0 added
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP 38:43:7d:88:88:3b type 0 added
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP 54:67:51:c8:67:3a type 0 added
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP 20:e8:82:fd:2a:84 type 0 added
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP c0:25:e9:60:a7:48 type 0 added
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP c0:fd:84:a4:db:2b type 0 added
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP 64:7c:34:54:67:7f type 0 added
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP 00:36:76:6f:66:8a type 0 added
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP a0:c5:62:7a:92:ca type 0 added
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP 30:b5:c2:b4:b1:81 type 0 added
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP[0] 38:43:7d:a5:13:d4 type=0 tries=0 last_attempt=-1 sec ago blacklist=1
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP[1] 38:43:7d:a5:13:91 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP[2] 80:f5:03:70:e7:75 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP[3] 90:5c:44:77:ed:b6 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP[4] 38:43:7d:ef:e5:26 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP[5] 90:5c:44:78:1f:b2 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP[6] c4:71:54:b4:a2:33 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP[7] 4c:5e:0c:12:7a:90 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP[8] 34:2c:c4:5d:13:0c type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP[9] 34:2c:c4:83:95:75 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP[10] 38:43:7d:ef:e5:16 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP[11] c4:71:54:b4:a2:31 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP[12] 20:e8:82:f7:2d:ac type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP[13] 50:78:b3:97:62:80 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP[14] 38:43:7d:88:88:3b type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP[15] 54:67:51:c8:67:3a type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP[16] 20:e8:82:fd:2a:84 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP[17] c0:25:e9:60:a7:48 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP[18] c0:fd:84:a4:db:2b type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP[19] 64:7c:34:54:67:7f type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP[20] 00:36:76:6f:66:8a type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP[21] a0:c5:62:7a:92:ca type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPS: AP[22] 30:b5:c2:b4:b1:81 type=0 tries=0 last_attempt=-1 sec ago blacklist=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Radio work 'scan'@0x55643dd41420 done in 1.236759 seconds
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: radio_work_free('scan'@0x55643dd41420): num_active_works --> 0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Selecting BSS from priority group 0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 0: 38:43:7d:a5:13:d4 ssid='interbrigada-ff-5G' wpa_ie_len=22 rsn_ie_len=20 caps=0x1531 level=-62 freq=5220  wps
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - blacklisted (count=1 limit=0)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 1: 3a:43:7d:a5:12:d5 ssid='UPC Wi-Free' wpa_ie_len=0 rsn_ie_len=20 caps=0x1531 level=-63 freq=5220
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 2: 38:43:7d:a5:13:91 ssid='interbrigada-ff' wpa_ie_len=26 rsn_ie_len=24 caps=0x1411 level=-58 freq=2437  wps
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 3: 3a:43:1d:a5:13:91 ssid='UPC Wi-Free' wpa_ie_len=0 rsn_ie_len=24 caps=0x1411 level=-58 freq=2437
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 4: 74:c1:4f:58:c8:28 ssid='WLAN1-44E00R' wpa_ie_len=26 rsn_ie_len=24 caps=0x1411 level=-70 freq=2427
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 5: 80:f5:03:70:e7:75 ssid='UPC243623016' wpa_ie_len=0 rsn_ie_len=24 caps=0x1411 level=-74 freq=2412  wps
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 6: e4:0e:ee:d5:85:88 ssid='WLAN1-28EMDN' wpa_ie_len=26 rsn_ie_len=24 caps=0x1411 level=-74 freq=2427
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 7: 74:c1:4f:58:c8:2a ssid='WLAN1-5G-44E00R' wpa_ie_len=26 rsn_ie_len=24 caps=0x1111 level=-79 freq=5260
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 8: e4:0e:ee:d5:85:8a ssid='WLAN1-5G-28EMDN' wpa_ie_len=26 rsn_ie_len=24 caps=0x1111 level=-79 freq=5260
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 9: 3a:43:7d:ef:e4:27 ssid='UPC Wi-Free' wpa_ie_len=0 rsn_ie_len=20 caps=0x1531 level=-79 freq=5220
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 10: 92:5c:44:77:ec:b7 ssid='UPC Wi-Free' wpa_ie_len=0 rsn_ie_len=20 caps=0x1531 level=-79 freq=5220
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 11: 90:5c:44:77:ed:b6 ssid='UPCBCC95C1' wpa_ie_len=22 rsn_ie_len=20 caps=0x1531 level=-79 freq=5220  wps
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 12: 38:43:7d:ef:e5:26 ssid='UPC2627721' wpa_ie_len=22 rsn_ie_len=20 caps=0x1531 level=-79 freq=5220  wps
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 13: 90:5c:44:78:1f:b2 ssid='UPCEE4974B' wpa_ie_len=22 rsn_ie_len=20 caps=0x1531 level=-79 freq=5220  wps
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 14: c4:71:54:b4:a2:33 ssid='MujO2Internet_5G_B4A231' wpa_ie_len=0 rsn_ie_len=20 caps=0x11 level=-79 freq=5200  wps
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 15: 4c:5e:0c:12:7a:90 ssid='jul-MM-bub' wpa_ie_len=0 rsn_ie_len=20 caps=0x431 level=-79 freq=5300  wps
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 16: 4c:5e:0c:72:95:66 ssid='' wpa_ie_len=0 rsn_ie_len=20 caps=0x431 level=-79 freq=5260
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID not known
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 17: 36:2c:c4:5d:12:0d ssid='UPC Wi-Free' wpa_ie_len=0 rsn_ie_len=20 caps=0x1531 level=-79 freq=5240
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 18: 34:2c:c4:5d:13:0c ssid='UPC9228008' wpa_ie_len=22 rsn_ie_len=20 caps=0x1531 level=-79 freq=5240  wps
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 19: 34:2c:c4:83:95:75 ssid='UPC7592407' wpa_ie_len=26 rsn_ie_len=24 caps=0x1411 level=-77 freq=2437  wps
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 20: 3a:43:1d:ef:e5:16 ssid='UPC Wi-Free' wpa_ie_len=0 rsn_ie_len=24 caps=0x1411 level=-78 freq=2462
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 21: 36:2c:94:83:95:75 ssid='UPC Wi-Free' wpa_ie_len=0 rsn_ie_len=24 caps=0x1411 level=-78 freq=2437
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 22: 38:43:7d:ef:e5:16 ssid='UPC2627721' wpa_ie_len=26 rsn_ie_len=24 caps=0x1411 level=-79 freq=2462  wps
Apr 26 14:33:44 think460s kernel: wlp4s0: authenticate with 38:43:7d:a5:13:d4
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 23: c4:71:54:b4:a2:31 ssid='MujO2Internet_2.4G_B4A231' wpa_ie_len=0 rsn_ie_len=20 caps=0x411 level=-79 freq=2467  wps
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 24: 44:32:c8:a1:86:e2 ssid='UPC1375357' wpa_ie_len=26 rsn_ie_len=24 caps=0x1511 level=-80 freq=2412
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 25: 20:e8:82:f7:2d:ac ssid='O2-Internet-210' wpa_ie_len=0 rsn_ie_len=20 caps=0x431 level=-81 freq=2412  wps
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 26: 50:78:b3:97:62:80 ssid='O2-Internet-992' wpa_ie_len=0 rsn_ie_len=20 caps=0x431 level=-82 freq=2462  wps
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 27: 56:67:11:c8:67:3a ssid='UPC Wi-Free' wpa_ie_len=0 rsn_ie_len=24 caps=0x1411 level=-82 freq=2437
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 28: 3a:43:1d:88:88:3b ssid='UPC Wi-Free' wpa_ie_len=0 rsn_ie_len=24 caps=0x1411 level=-82 freq=2462
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 29: 38:43:7d:88:88:3b ssid='UPC1660751' wpa_ie_len=26 rsn_ie_len=24 caps=0x1411 level=-83 freq=2462  wps
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 30: 46:32:c8:a1:86:e4 ssid='UPC Wi-Free' wpa_ie_len=0 rsn_ie_len=24 caps=0x1511 level=-83 freq=2412
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 31: 54:67:51:c8:67:3a ssid='UPCA41173C' wpa_ie_len=26 rsn_ie_len=24 caps=0x1411 level=-83 freq=2437  wps
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 32: bc:25:e0:c2:1d:0f ssid='WLAN-310595' wpa_ie_len=26 rsn_ie_len=24 caps=0x411 level=-83 freq=2447
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 33: 80:3f:5d:58:59:af ssid='JBK(2G)' wpa_ie_len=22 rsn_ie_len=20 caps=0x411 level=-83 freq=2412
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 34: 20:e8:82:fd:2a:84 ssid='O2-Internet-453' wpa_ie_len=0 rsn_ie_len=20 caps=0x431 level=-83 freq=2452  wps
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 35: c0:25:e9:60:a7:48 ssid='MujO2Internet_2.4G_60A748' wpa_ie_len=0 rsn_ie_len=20 caps=0x411 level=-83 freq=2457  wps
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 36: c0:fd:84:a4:db:2b ssid='O2-Internet-794' wpa_ie_len=0 rsn_ie_len=20 caps=0x431 level=-83 freq=2412  wps
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 37: 64:7c:34:54:67:7f ssid='UPC4873478' wpa_ie_len=26 rsn_ie_len=24 caps=0x411 level=-83 freq=2457  wps
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 38: 00:36:76:6f:66:8a ssid='Hanzlik 2.4GHz' wpa_ie_len=0 rsn_ie_len=20 caps=0x1411 level=-83 freq=2462  wps
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 39: a0:c5:62:7a:92:ca ssid='STALIN' wpa_ie_len=0 rsn_ie_len=20 caps=0x1411 level=-83 freq=2412  wps
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 40: 4c:5e:0c:e5:73:2b ssid='' wpa_ie_len=0 rsn_ie_len=0 caps=0x421 level=-79 freq=5560
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID not known
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 41: dc:9f:db:4c:e2:9a ssid='WIAaccN3' wpa_ie_len=0 rsn_ie_len=0 caps=0x401 level=-79 freq=5680
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 42: 4c:5e:0c:fe:6b:4b ssid='' wpa_ie_len=0 rsn_ie_len=0 caps=0x421 level=-79 freq=5180
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID not known
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 43: b8:69:f4:3b:70:5f ssid='' wpa_ie_len=0 rsn_ie_len=0 caps=0x421 level=-79 freq=5640
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID not known
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 44: 30:b5:c2:b4:b1:81 ssid='TP-LINK_Extender_B4B181' wpa_ie_len=0 rsn_ie_len=0 caps=0x421 level=-78 freq=2412  wps
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    skip - SSID mismatch
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: No APs found - clear blacklist and try again
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: Removed BSSID 38:43:7d:a5:13:d4 from blacklist (clear)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Selecting BSS from priority group 0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: 0: 38:43:7d:a5:13:d4 ssid='interbrigada-ff-5G' wpa_ie_len=22 rsn_ie_len=20 caps=0x1531 level=-62 freq=5220  wps
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    selected based on RSN IE
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:    selected BSS 38:43:7d:a5:13:d4 ssid='interbrigada-ff-5G'
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Considering connect request: reassociate: 0  selected: 38:43:7d:a5:13:d4  bssid: 00:00:00:00:00:00  pending: 00:00:00:00:00:00  wpa_state: SCANNING  ssid=0x55643dd0c430  current_ssid=(nil)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Request association with 38:43:7d:a5:13:d4
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Re-association to the same ESS
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: TDLS: TDLS is allowed in the target BSS
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: TDLS: TDLS channel switch allowed in the target BSS
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: No ongoing scan/p2p-scan found to abort
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Add radio work 'sme-connect'@0x55643dd41420
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: First radio work item in the queue - schedule start immediately
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: RSN: Ignored PMKID candidate without preauth flag
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: p2p-dev-wlp4s0: Updating scan results from sibling
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Received scan results (45 BSSes)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: p2p-dev-wlp4s0: BSS: Start scan result update 10
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: p2p-dev-wlp4s0: BSS: Add new id 55 BSSID 34:2c:c4:5d:13:0c SSID 'UPC9228008' freq 5240
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: p2p-dev-wlp4s0: BSS: Remove id 40 BSSID 28:ff:3e:34:18:16 SSID 'MujO2Internet_341816' due to no match in scan
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: BSS: last_scan_res_used=45/64
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: RTM_NEWLINK: ifi_index=3 ifname=wlp4s0 wext ifi_family=0 ifi_flags=0x1003 ([UP])
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Starting radio work 'sme-connect'@0x55643dd41420 after 0.007461 second wait
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: WPA: clearing own WPA/RSN IE
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Automatic auth_alg selection: 0x1
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: RSN: PMKSA cache search - network_ctx=(nil) try_opportunistic=0 akmp=0x0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: RSN: Search for BSSID 38:43:7d:a5:13:d4
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: RSN: No PMKSA cache entry found
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: RSN: using IEEE 802.11i/D9.0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: WPA: Selected cipher suites: group 8 pairwise 16 key_mgmt 2 proto 2
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: WPA: Selected mgmt group cipher 32
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: set AP WPA IE - hexdump(len=24): dd 16 00 50 f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50 f2 02
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: set AP RSN IE - hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: WPA: AP group 0x8 network profile group 0x18; available group 0x8
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: WPA: using GTK TKIP
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: WPA: AP pairwise 0x10 network profile pairwise 0x18; available pairwise 0x10
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: WPA: using PTK CCMP
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: WPA: AP key_mgmt 0x2 network profile key_mgmt 0x3; available key_mgmt 0x2
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: WPA: using KEY_MGMT WPA-PSK
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: WPA: AP mgmt_group_cipher 0x20 network profile mgmt_group_cipher 0x0; available mgmt_group_cipher 0x0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: WPA: not using MGMT group cipher
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: Set own WPA IE default - hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: Set PMK based on external data - hexdump(len=32): [REMOVED]
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: FT: Stored MDIE and FTIE from (Re)Association Response - hexdump(len=0):
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: RRM: Determining whether RRM can be used - device support: 0x79
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: RRM: Adding RRM IE to Association Request
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: Added supported operating classes IE - hexdump(len=9): 3b 07 73 51 73 76 79 7c 7d
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: EAPOL: External notification - EAP success=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: EAPOL: External notification - EAP fail=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: EAPOL: External notification - portControl=Auto
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Cancelling scan request
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: SME: Trying to authenticate with 38:43:7d:a5:13:d4 (SSID='interbrigada-ff-5G' freq=5220 MHz)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: EAPOL: External notification - portValid=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: State: SCANNING -> AUTHENTICATING
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Determining shared radio frequencies (max len 2)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Shared frequencies (len=0): completed iteration
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Add operating class 81
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Channels - hexdump(len=13): 01 02 03 04 05 06 07 08 09 0a 0b 0c 0d
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Add operating class 124
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Channels - hexdump(len=4): 95 99 9d a1
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Add operating class 125
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Channels - hexdump(len=5): 95 99 9d a1 a5
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Update channel list
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: channels: 81:1,2,3,4,5,6,7,8,9,10,11,12,13 124:149,153,157,161 125:149,153,157,161,165
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: cli_channels:
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: Not configuring frame filtering - BSS 00:00:00:00:00:00 is not a Hotspot 2.0 network
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Authenticate (ifindex=3)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   * bssid=38:43:7d:a5:13:d4
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   * freq=5220
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   * SSID=interbrigada-ff-5G
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   * IEs - hexdump(len=0): [NULL]
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   * Auth Type 0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Authentication request send successfully
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Ignored event 19 (NL80211_CMD_NEW_STATION) for foreign interface (ifindex 3 wdev 0x0)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Drv Event 19 (NL80211_CMD_NEW_STATION) received for wlp4s0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: New station 38:43:7d:a5:13:d4
Apr 26 14:33:44 think460s kernel: wlp4s0: send auth to 38:43:7d:a5:13:d4 (try 1/3)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Ignored event 37 (NL80211_CMD_AUTHENTICATE) for foreign interface (ifindex 3 wdev 0x0)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Drv Event 37 (NL80211_CMD_AUTHENTICATE) received for wlp4s0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Authenticate event
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Event AUTH (10) received
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: SME: Authentication response: peer=38:43:7d:a5:13:d4 auth_type=0 auth_transaction=2 status_code=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: SME: Association Request IEs - hexdump(len=48): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00 7f 08 04 00 00 00 01 00 00 40 46 05 71 00 00 00 00 3b 07 73 51 73 76 79 7c 7d
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Trying to associate with 38:43:7d:a5:13:d4 (SSID='interbrigada-ff-5G' freq=5220 MHz)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: State: AUTHENTICATING -> ASSOCIATING
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Set wlp4s0 operstate 0->0 (DORMANT)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: netlink: Operstate: ifindex=3 linkmode=-1 (no change), operstate=5 (IF_OPER_DORMANT)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Determining shared radio frequencies (max len 2)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Shared frequencies (len=0): completed iteration
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Add operating class 81
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Channels - hexdump(len=13): 01 02 03 04 05 06 07 08 09 0a 0b 0c 0d
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Add operating class 124
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Channels - hexdump(len=4): 95 99 9d a1
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Add operating class 125
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Channels - hexdump(len=5): 95 99 9d a1 a5
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Update channel list
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: channels: 81:1,2,3,4,5,6,7,8,9,10,11,12,13 124:149,153,157,161 125:149,153,157,161,165
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: cli_channels:
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: set own WPA/RSN IE - hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Associate (ifindex=3)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   * bssid=38:43:7d:a5:13:d4
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   * freq=5220
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   * SSID=interbrigada-ff-5G
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   * IEs - hexdump(len=48): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00 7f 08 04 00 00 00 01 00 00 40 46 05 71 00 00 00 00 3b 07 73 51 73 76 79 7c 7d
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   * WPA Versions 0x2
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   * pairwise=0xfac04
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   * group=0xfac02
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   * akm=0xfac02
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   * htcaps - hexdump(len=26): 63 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   * htcaps_mask - hexdump(len=26): 63 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   * vhtcaps - hexdump(len=12): 00 00 00 00 00 00 00 00 00 00 00 00
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   * vhtcaps_mask - hexdump(len=12): 00 00 00 00 00 00 00 00 00 00 00 00
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Association request send successfully
Apr 26 14:33:44 think460s kernel: wlp4s0: authenticated
Apr 26 14:33:44 think460s kernel: wlp4s0: associate with 38:43:7d:a5:13:d4 (try 1/3)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: EAPOL: startWhen --> 0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: EAPOL: disable timer tick
Apr 26 14:33:44 think460s kernel: wlp4s0: RX AssocResp from 38:43:7d:a5:13:d4 (capab=0x1511 status=0 aid=6)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: RTM_NEWLINK: ifi_index=3 ifname=wlp4s0 wext ifi_family=0 ifi_flags=0x11003 ([UP][LOWER_UP])
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: RTM_NEWLINK: ifi_index=3 ifname=wlp4s0 wext ifi_family=0 ifi_flags=0x11003 ([UP][LOWER_UP])
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: RTM_NEWLINK: ifi_index=3 ifname=wlp4s0 wext ifi_family=0 ifi_flags=0x11003 ([UP][LOWER_UP])
Apr 26 14:33:44 think460s kernel: wlp4s0: associated
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: RTM_NEWLINK: ifi_index=3 ifname=wlp4s0 operstate=5 linkmode=1 ifi_family=0 ifi_flags=0x11003 ([UP][LOWER_UP])
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Ignored event 38 (NL80211_CMD_ASSOCIATE) for foreign interface (ifindex 3 wdev 0x0)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Drv Event 38 (NL80211_CMD_ASSOCIATE) received for wlp4s0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Associate event
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Associated on 5220 MHz
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Associated with 38:43:7d:a5:13:d4
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Set drv->ssid based on scan res info to 'interbrigada-ff-5G'
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Event ASSOC (0) received
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Association info event
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: req_ies - hexdump(len=167): 00 12 69 6e 74 65 72 62 72 69 67 61 64 61 2d 66 66 2d 35 47 01 08 0c 12 18 24 30 48 60 6c 21 02 00 16 24 4a 24 01 28 01 2c 01 30 01 34 01 38 01 3c 01 40 01 44 01 48 01 4c 01 50 01 54 01 58 01 5c 01 60 01 64 01 68 01 6c 01 70 01 74 01 78 01 7c 01 80 01 84 01 88 01 8c 01 90 01 95 01 99 01 9d 01 a1 01 a5 01 a9 01 ad 01 b1 01 b5 01 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00 7f 08 04 00 00 00 01 00 00 40 46 05 71 00 00 00 00 3b 07 73 51 73 76 79 7c 7d dd 07 00 50 f2 02 00 01 00
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: resp_ies - hexdump(len=69): 01 08 8c 12 98 24 b0 48 60 6c dd 18 00 50 f2 02 01 01 80 00 03 a4 00 00 27 a4 00 00 42 43 5e 00 e2 32 2f 00 46 05 22 00 00 00 00 dd 18 00 50 f2 04 10 4a 00 01 10 10 3b 00 01 03 10 49 00 06 00 37 2a 00 01 20
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: freq=5220 MHz
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: set own WPA/RSN IE - hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: FT: Stored MDIE and FTIE from (Re)Association Response - hexdump(len=0):
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: State: ASSOCIATING -> ASSOCIATED
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Set wlp4s0 operstate 0->0 (DORMANT)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: netlink: Operstate: ifindex=3 linkmode=-1 (no change), operstate=5 (IF_OPER_DORMANT)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Determining shared radio frequencies (max len 2)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Shared frequencies (len=1): completed iteration
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: freq[0]: 5220, flags=0x1
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Add operating class 81
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Channels - hexdump(len=13): 01 02 03 04 05 06 07 08 09 0a 0b 0c 0d
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Add operating class 124
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Channels - hexdump(len=4): 95 99 9d a1
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Add operating class 125
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Channels - hexdump(len=5): 95 99 9d a1 a5
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Update channel list
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: channels: 81:1,2,3,4,5,6,7,8,9,10,11,12,13 124:149,153,157,161 125:149,153,157,161,165
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: cli_channels:
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Associated to a new BSS: BSSID=38:43:7d:a5:13:d4
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Associated with 38:43:7d:a5:13:d4
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: WPA: Association event - clear replay counter
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: WPA: Clear old PTK
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: TDLS: Remove peers on association
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: EAPOL: External notification - portEnabled=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: EAPOL: External notification - portValid=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: EAPOL: External notification - EAP success=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: EAPOL: External notification - portEnabled=1
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: EAPOL: SUPP_PAE entering state CONNECTING
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: EAPOL: enable timer tick
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: EAPOL: SUPP_BE entering state IDLE
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Setting authentication timeout: 10 sec 0 usec
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Cancelling scan request
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WMM AC: AC mandatory: AC_BE=0 AC_BK=0 AC_VI=0 AC_VO=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WMM AC: U-APSD queues=0x0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WMM AC: Valid WMM association, WMM AC is enabled
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Ignored event 46 (NL80211_CMD_CONNECT) for foreign interface (ifindex 3 wdev 0x0)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Drv Event 46 (NL80211_CMD_CONNECT) received for wlp4s0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: Ignore connect event (cmd=46) when using userspace SME
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: l2_packet_receive: src=38:43:7d:a5:13:d4 len=99
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: RX EAPOL from 38:43:7d:a5:13:d4
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Setting authentication timeout: 10 sec 0 usec
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: IEEE 802.1X RX: version=2 type=3 length=95
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:   EAPOL-Key type=2
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:   key_info 0x8a (ver=2 keyidx=0 rsvd=0 Pairwise Ack)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:   key_length=16 key_data_length=0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   replay_counter - hexdump(len=8): 00 00 00 00 00 00 00 01
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   key_nonce - hexdump(len=32): 9b dd a4 40 c8 d8 ac bb b6 3e 1d 29 4e 7b 4d eb c1 b2 9a 7a db 62 5e 15 57 55 24 57 f6 d6 48 c6
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   key_iv - hexdump(len=16): 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   key_rsc - hexdump(len=8): 00 00 00 00 00 00 00 00
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   key_id (reserved) - hexdump(len=8): 00 00 00 00 00 00 00 00
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   key_mic - hexdump(len=16): 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: State: ASSOCIATED -> 4WAY_HANDSHAKE
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Determining shared radio frequencies (max len 2)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Shared frequencies (len=1): completed iteration
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: freq[0]: 5220, flags=0x1
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Add operating class 81
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Channels - hexdump(len=13): 01 02 03 04 05 06 07 08 09 0a 0b 0c 0d
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Add operating class 124
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Channels - hexdump(len=4): 95 99 9d a1
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Add operating class 125
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Channels - hexdump(len=5): 95 99 9d a1 a5
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Update channel list
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: channels: 81:1,2,3,4,5,6,7,8,9,10,11,12,13 124:149,153,157,161 125:149,153,157,161,165
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: cli_channels:
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: WPA: RX message 1 of 4-Way Handshake from 38:43:7d:a5:13:d4 (ver=2)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: RSN: msg 1/4 key data - hexdump(len=0):
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: Renewed SNonce - hexdump(len=32): 87 f2 a5 13 c2 03 b8 08 1e 08 d9 d7 47 1e a7 65 e1 9c 10 1b 0a 63 d7 63 52 d2 c2 e1 ea 63 7a d0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: PTK derivation using PRF(SHA1)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: PTK derivation - A1=f4:8c:50:84:c7:e0 A2=38:43:7d:a5:13:d4
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: Nonce1 - hexdump(len=32): 87 f2 a5 13 c2 03 b8 08 1e 08 d9 d7 47 1e a7 65 e1 9c 10 1b 0a 63 d7 63 52 d2 c2 e1 ea 63 7a d0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: Nonce2 - hexdump(len=32): 9b dd a4 40 c8 d8 ac bb b6 3e 1d 29 4e 7b 4d eb c1 b2 9a 7a db 62 5e 15 57 55 24 57 f6 d6 48 c6
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: PMK - hexdump(len=32): [REMOVED]
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: PTK - hexdump(len=48): [REMOVED]
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: KCK - hexdump(len=16): [REMOVED]
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: KEK - hexdump(len=16): [REMOVED]
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: TK - hexdump(len=16): [REMOVED]
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: WPA IE for msg 2/4 - hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: Replay Counter - hexdump(len=8): 00 00 00 00 00 00 00 01
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: WPA: Sending EAPOL-Key 2/4
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: Send EAPOL-Key frame to 38:43:7d:a5:13:d4 ver=2 mic_len=16 key_mgmt=0x2
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: EAPOL-Key MIC using HMAC-SHA1
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: KCK - hexdump(len=16): [REMOVED]
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: Derived Key MIC - hexdump(len=16): c2 c2 fb 2a be 34 82 17 54 59 58 52 cc 6a cb 7e
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: l2_packet_receive: src=38:43:7d:a5:13:d4 len=195
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: RX EAPOL from 38:43:7d:a5:13:d4
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: IEEE 802.1X RX: version=2 type=3 length=191
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:   EAPOL-Key type=2
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:   key_info 0x13ca (ver=2 keyidx=0 rsvd=0 Pairwise Install Ack MIC Secure Encr)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0:   key_length=16 key_data_length=96
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   replay_counter - hexdump(len=8): 00 00 00 00 00 00 00 02
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   key_nonce - hexdump(len=32): 9b dd a4 40 c8 d8 ac bb b6 3e 1d 29 4e 7b 4d eb c1 b2 9a 7a db 62 5e 15 57 55 24 57 f6 d6 48 c6
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   key_iv - hexdump(len=16): 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   key_rsc - hexdump(len=8): 00 00 00 00 00 00 00 00
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   key_id (reserved) - hexdump(len=8): 00 00 00 00 00 00 00 00
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:   key_mic - hexdump(len=16): 20 51 89 c5 87 0d 25 7e 9d 41 7f 9f 91 3e 8b fa
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: EAPOL-Key MIC using HMAC-SHA1
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: RSN: encrypted key data - hexdump(len=96): 77 ff 51 94 6a eb 59 3f 22 db 42 aa 06 c1 4d a0 73 3c ba ac c8 e8 fd 63 d9 00 77 66 55 4e ff b6 14 51 f1 09 d7 52 fd 1f 94 f1 2c 70 4d 2d eb 67 e7 69 bf 1c 80 0b 41 97 18 3c 2b b6 ac c3 35 03 93 96 3f da dc 0f 07 9d 42 0a 45 3f d1 72 ad 94 3d a1 97 fa f8 7a 25 ad ca e2 f0 dd 09 d8 f4 c0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: Decrypt Key Data using AES-UNWRAP (KEK length 16)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: decrypted EAPOL-Key key data - hexdump(len=88): [REMOVED]
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: State: 4WAY_HANDSHAKE -> 4WAY_HANDSHAKE
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: WPA: RX message 3 of 4-Way Handshake from 38:43:7d:a5:13:d4 (ver=2)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: IE KeyData - hexdump(len=88): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00 dd 16 00 50 f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50 f2 02 dd 26 00 0f ac 01 01 00 62 57 c2 0a c2 e9 4f d5 e6 cc 47 8b aa 54 19 74 01 a0 a6 88 7a d9 64 d3 37 5c 09 8d 11 3f a2 a7 dd 00
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: RSN IE in EAPOL-Key - hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: WPA IE in EAPOL-Key - hexdump(len=24): dd 16 00 50 f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50 f2 02
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: GTK in EAPOL-Key - hexdump(len=40): [REMOVED]
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: WPA: Sending EAPOL-Key 4/4
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: Send EAPOL-Key frame to 38:43:7d:a5:13:d4 ver=2 mic_len=16 key_mgmt=0x2
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: EAPOL-Key MIC using HMAC-SHA1
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: KCK - hexdump(len=16): [REMOVED]
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: Derived Key MIC - hexdump(len=16): ad 0f 31 71 53 73 1b 7b 38 49 db 3a 0c 19 a0 79
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: WPA: Installing PTK to the driver
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wpa_driver_nl80211_set_key: ifindex=3 (wlp4s0) alg=3 addr=0x55643dd0d798 key_idx=0 set_tx=1 seq_len=6 key_len=16
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: KEY_DATA - hexdump(len=16): [REMOVED]
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: KEY_SEQ - hexdump(len=6): 00 00 00 00 00 00
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:    addr=38:43:7d:a5:13:d4
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: EAPOL: External notification - portValid=1
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: State: 4WAY_HANDSHAKE -> GROUP_HANDSHAKE
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Determining shared radio frequencies (max len 2)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Shared frequencies (len=1): completed iteration
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: freq[0]: 5220, flags=0x1
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Add operating class 81
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Channels - hexdump(len=13): 01 02 03 04 05 06 07 08 09 0a 0b 0c 0d
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Add operating class 124
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Channels - hexdump(len=4): 95 99 9d a1
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Add operating class 125
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Channels - hexdump(len=5): 95 99 9d a1 a5
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: Update channel list
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: channels: 81:1,2,3,4,5,6,7,8,9,10,11,12,13 124:149,153,157,161 125:149,153,157,161,165
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: P2P: cli_channels:
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: RSN: received GTK in pairwise handshake - hexdump(len=34): [REMOVED]
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: Group Key - hexdump(len=32): [REMOVED]
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: WPA: Installing GTK to the driver (keyidx=1 tx=0 len=32)
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: WPA: RSC - hexdump(len=6): 00 00 00 00 00 00
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wpa_driver_nl80211_set_key: ifindex=3 (wlp4s0) alg=2 addr=0x55643c7be9c9 key_idx=1 set_tx=0 seq_len=6 key_len=32
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: KEY_DATA - hexdump(len=32): [REMOVED]
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: nl80211: KEY_SEQ - hexdump(len=6): 00 00 00 00 00 00
Apr 26 14:33:44 think460s wpa_supplicant[1001329]:    broadcast key
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: WPA: Key negotiation completed with 38:43:7d:a5:13:d4 [PTK=CCMP GTK=TKIP]
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Cancelling authentication timeout
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: State: GROUP_HANDSHAKE -> COMPLETED
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: Radio work 'sme-connect'@0x55643dd41420 done in 0.092358 seconds
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: radio_work_free('sme-connect'@0x55643dd41420): num_active_works --> 0
Apr 26 14:33:44 think460s wpa_supplicant[1001329]: wlp4s0: CTRL-EVENT-CONNECTED - Connection to 38:43:7d:a5:13:d4 completed [id=0 id_str=]

Found another linked bug: https://bugzilla.kernel.org/show_bug.cgi?id=203709.

I don't see anything useful in logs :-( . Any ideas please?

Last edited by Kotrfa (2020-04-26 13:07:25)

aravind · 2020-04-28 18:27:53

Kotrfa wrote:

Found another linked bug: https://bugzilla.kernel.org/show_bug.cgi?id=203709.
I don't see anything useful in logs :-( . Any ideas please?

So I followed the suggestion here: https://bugzilla.kernel.org/show_bug.cgi?id=203709#c40 and that fixed the problem for me. I basically lowered my beacon interval on my wireless router to 50. Hope that helps. If you have the energy for it, you might want to try the patch in that bug report.

Kotrfa · 2020-04-28 18:59:05

You are lucky to have a flexible enough router. I am stuck with a stupid Compal from UPC where this beacon interval setting is not possible to adjust...

May I know what I would have to do for that patch? Does it mean basically editing those two line from post 28, compiling iwlwifi from scratch and then somehow installing it instead of my pacman iwlwifi.

aravind · 2020-04-28 22:11:59

Kotrfa wrote:

You are lucky to have a flexible enough router. I am stuck with a stupid Compal from UPC where this beacon interval setting is not possible to adjust...
May I know what I would have to do for that patch? Does it mean basically editing those two line from post 28, compiling iwlwifi from scratch and then somehow installing it instead of my pacman iwlwifi.

Yeah, it looks like you'd have patch those two lines and recompile the iwlwifi driver. You might want to look at Arch kernel docs: https://wiki.archlinux.org/index.php/Ke … ild_System. Also, the 4.* series is apparently fine, it's quite a step back - but probably a lot quicker.

Kotrfa · 2020-05-02 19:38:14

Oh dear oh dear .

Thanks Aravind for the help. I am now compiling linux-lts419 from aur and also compiling iwlwifi with that patch as a fallback, but what a journey ... I feel like a monkey randomly trying to make `make` finish without having a clue about what it does.

After I compile iwlwifi, I expect I will have some binaries/libraries in the out repo. Is there a simple way how to replace the system ones with these? I know it has something to do with modules, but is this considered "kernel module" (https://wiki.archlinux.org/index.php/Co … nel_module)? Could you please point me to some guide?

Kotrfa · 2020-05-04 16:00:08

OK, I will live with 4.19 for now and it works. I wasn't able to compile iwlwifi-next.

Thanks everyone for help.

Note to myself:

$ yay -S linux-lts419

# as I use `systemd-boot`
# /boot/loader/entries/arch-lts419.conf
title Arch Linux LTS 4.19
linux /vmlinuz-linux-lts419
initrd /initramfs-linux-lts419.img
initrd /intel-ucode.img
options root=PARTUUID=8d411a1d-fd6b-4916-b21f-f745a70a39d3 rw intel_iommu=off

$ bootctl update

cocid65956 · 2020-05-05 23:01:32

I'm having the same issues as above
I'm not bother as it automatically disconnects and reconnects back

also I hate to be the guy asking for ETAs

but for people that have experience is this gonna ever be included in 5.6 or 5.7 if it gets fixed
I mean bugs like this do they get included in the current release of the kernel or they have to be approved for future releases

thanks for providing the workarounds

Kotrfa · 2020-05-06 06:26:00

I have no idea how likely it is this gets incorporated in the future kernels, if at all. Unfortunately, the bugzilla doesn't seem to be even acknowledged as an issue (status: INFO NEEDED), therefore I don't have much hope :-( .

progandy · 2020-05-06 09:09:16

Kotrfa wrote:

I have no idea how likely it is this gets incorporated in the future kernels, if at all. Unfortunately, the bugzilla doesn't seem to be even acknowledged as an issue (status: INFO NEEDED), therefore I don't have much hope :-( .

That means they need more info, i.e.

https://bugzilla.kernel.org/show_bug.cgi?id=203709#c41 wrote:

do you have additional system with Linux and an Intel WiFi device?
If set, I'd like you to try to record an air sniffer capture of the connection.

Maybe they cannot reproduce it in their own test environment.

Kotrfa · 2020-05-06 09:12:28

I offered all logs I could provide + ask about what else is needed. As you can see, it's extremely hard to reproduce :-( .

Arch Linux

#1 2020-03-26 14:21:41

[Solved] Wifi connection lost and can't reinitialize

#2 2020-03-26 14:57:39

Re: [Solved] Wifi connection lost and can't reinitialize

#3 2020-03-26 15:34:51

Re: [Solved] Wifi connection lost and can't reinitialize

#4 2020-03-30 08:52:30

Re: [Solved] Wifi connection lost and can't reinitialize

#5 2020-03-30 14:27:16

Re: [Solved] Wifi connection lost and can't reinitialize

#6 2020-03-31 15:28:08

Re: [Solved] Wifi connection lost and can't reinitialize

#7 2020-03-31 16:33:20

Re: [Solved] Wifi connection lost and can't reinitialize

#8 2020-03-31 19:11:45

Re: [Solved] Wifi connection lost and can't reinitialize

#9 2020-03-31 20:12:05

Re: [Solved] Wifi connection lost and can't reinitialize

#10 2020-03-31 20:12:38

Re: [Solved] Wifi connection lost and can't reinitialize

#11 2020-04-02 18:58:11

Re: [Solved] Wifi connection lost and can't reinitialize

#12 2020-04-02 19:16:44

Re: [Solved] Wifi connection lost and can't reinitialize

#13 2020-04-15 10:28:54

Re: [Solved] Wifi connection lost and can't reinitialize

#14 2020-04-15 14:59:07

Re: [Solved] Wifi connection lost and can't reinitialize

#15 2020-04-18 20:48:56

Re: [Solved] Wifi connection lost and can't reinitialize

#16 2020-04-26 12:27:06

Re: [Solved] Wifi connection lost and can't reinitialize

#17 2020-04-28 18:27:53

Re: [Solved] Wifi connection lost and can't reinitialize

#18 2020-04-28 18:59:05

Re: [Solved] Wifi connection lost and can't reinitialize

#19 2020-04-28 22:11:59

Re: [Solved] Wifi connection lost and can't reinitialize

#20 2020-05-02 19:38:14

Re: [Solved] Wifi connection lost and can't reinitialize

#21 2020-05-04 16:00:08

Re: [Solved] Wifi connection lost and can't reinitialize

#22 2020-05-05 23:01:32

Re: [Solved] Wifi connection lost and can't reinitialize

#23 2020-05-06 06:26:00

Re: [Solved] Wifi connection lost and can't reinitialize

#24 2020-05-06 09:09:16

Re: [Solved] Wifi connection lost and can't reinitialize

#25 2020-05-06 09:12:28

Re: [Solved] Wifi connection lost and can't reinitialize

Board footer