Bug 200525 - iwlwifi: 9260: No beacon heard and the time event is over already...
Summary: iwlwifi: 9260: No beacon heard and the time event is over already...
Status: CLOSED UNREPRODUCIBLE
Alias: None
Product: Drivers
Classification: Unclassified
Component: network-wireless (show other bugs)
Hardware: Intel Linux
: P1 high
Assignee: DO NOT USE - assign "network-wireless-intel" component instead
URL:
Keywords:
Depends on:
Blocks:
 
Reported: 2018-07-17 14:41 UTC by Yichuan Gao
Modified: 2019-07-22 04:20 UTC (History)
1 user (show)

See Also:
Kernel Version: 4.17.6
Subsystem:
Regression: No
Bisected commit-id:


Attachments
dmesg and iwlwifi modinfo (47.18 KB, text/plain)
2018-07-17 14:41 UTC, Yichuan Gao
Details
trace output (1.31 MB, application/gzip)
2018-07-17 15:57 UTC, Yichuan Gao
Details
9260AC as sniffer (604.57 KB, application/vnd.tcpdump.pcap)
2018-07-17 16:33 UTC, Yichuan Gao
Details

Description Yichuan Gao 2018-07-17 14:41:08 UTC
Created attachment 277369 [details]
dmesg and iwlwifi modinfo

When connecting to WPA Wi-Fi networks, iwlwifi reports "No beacon heard and the time event is over already" 0.6 secs after wifi interface "authenticated". However connect to open networks works fine.
Have tried to connect to different APs, reboot APs, and lower DTIM periods, none of them works. 

Related dmesg and modinfo of iwlwifi is attached.

firmware-version: 38.c0e03d94.0
srcversion: A082116DEC439F44B0AAD63
vermagic: 4.17.6-1-ARCH SMP preempt mod_unload modversions
Comment 1 Emmanuel Grumbach 2018-07-17 15:44:59 UTC
Please record tracing of this and if possible, an air sniffer capture with an external device.

Information on how to do so:
https://wireless.wiki.kernel.org/en/users/drivers/iwlwifi/debugging
Comment 2 Yichuan Gao 2018-07-17 15:57:05 UTC
Created attachment 277377 [details]
trace output

Output trace.dat by `sudo trace-cmd record -e iwlwifi -e mac80211 -e cfg80211 -e iwlwifi_msg` attached.

Sorry but I can't provide sniffing data now.
Comment 3 Emmanuel Grumbach 2018-07-17 16:22:47 UTC
You can use your 9260 as an air sniffer.

Of course you won't be able to associate to your AP but it'll help to see how your AP behaves.

What is the model of the AP BTW?
Comment 4 Yichuan Gao 2018-07-17 16:33:27 UTC
Created attachment 277379 [details]
9260AC as sniffer

Did a sniffer on my 9260AC.
I used my OnePlus phone to connect and disconnect on the WiFi network, phone shows as OneplusT_37:8f:5f, AP shows as BelkinIn_96:0b:18.

My AP is LINKSYS EA6400 running AsusWrt-Merlin.
Comment 5 Emmanuel Grumbach 2018-07-17 16:41:09 UTC
Thanks. I'll try to take a look later.
Comment 6 Emmanuel Grumbach 2018-07-17 18:11:38 UTC
Ok, I went to the wrong direction:
Here is the lead to the problem:

[   93.262641] wlp2s0: authenticate with 94:10:3e:96:0b:18
[   93.268848] wlp2s0: send auth to 94:10:3e:96:0b:18 (try 1/3)
[   93.306653] wlp2s0: authenticated
[   93.883282] iwlwifi 0000:02:00.0: No beacon heard and the time event is over already...

We authenticate, but don't associate. The supplicant is in charge of moving to the association step.

What supplicant do you use?
Do you use the driver inside the kernel, or an out of tree driver?
Can you share the logs from the supplicant?
Comment 7 Yichuan Gao 2018-07-17 18:20:41 UTC
I'm using wpa_supplicant v2.6, with nl80211.
driver is in kernel, supplicant log here:

Jul 18 00:29:03 Gyc-Arch-Linux systemd[1]: Starting WPA supplicant...
Jul 18 00:29:03 Gyc-Arch-Linux wpa_supplicant[620]: Successfully initialized wpa_supplicant
Jul 18 00:29:03 Gyc-Arch-Linux systemd[1]: Started WPA supplicant.
Jul 18 02:13:37 Gyc-Arch-Linux wpa_supplicant[620]: wlp2s0: SME: Trying to authenticate with 94:10:3e:96:0b:18 (SSID='<ssid>' freq=5180 MHz)
Jul 18 02:13:45 Gyc-Arch-Linux wpa_supplicant[620]: wlp2s0: SME: Trying to authenticate with 94:10:3e:96:0b:18 (SSID='<ssid>' freq=5180 MHz)
Jul 18 02:13:53 Gyc-Arch-Linux wpa_supplicant[620]: wlp2s0: SME: Trying to authenticate with 94:10:3e:96:0b:18 (SSID='<ssid>' freq=5180 MHz)
Jul 18 02:13:59 Gyc-Arch-Linux wpa_supplicant[620]: wlp2s0: Reject scan trigger since one is already pending
Comment 8 Emmanuel Grumbach 2018-07-17 18:22:46 UTC
ok, we need to increase the log level of the supplicant
Comment 9 Emmanuel Grumbach 2018-07-17 18:23:25 UTC
are you sure you don't have several instances of the supplicant fighting over the same wireless interface?
Comment 10 Yichuan Gao 2018-07-17 18:32:07 UTC
Oh! After some reboots, the bug fixes itself magically :)
I think you may be right, maybe multiple supplicant instances were running. Thanka a lot, you are so helpful!
Comment 11 Emmanuel Grumbach 2018-07-17 18:43:31 UTC
I'm glad I could help.

Note You need to log in before you can comment on or make changes to this bug.