search

open-sdr / openwifi

open-source IEEE 802.11 WiFi baseband FPGA (chip) design: driver, software
GNU Affero General Public License v3.0
3.86k stars 654 forks source link

IEEE 802.11: did not acknowledge authentication response. Fail to let an Zynq-Client connect to an Zynq-AP on 5GHz band #26

Closed Leo-Cheung-CUHK closed 3 years ago

Leo-Cheung-CUHK commented 4 years ago

Xianjun, could you help me solve this problem?

I set an Zynq as an AP by hostapd, the hostapd-openwifi.conf is as follows: /////////////////////////////////////////////////////// interface=sdr0 driver=nl80211 country_code=BE ssid=openwifi hw_mode=a channel=44 supported_rates=60 90 120 180 240 360 480 540 basic_rates=60 90 120 180

logger_syslog=-1

logger_syslog_level=2

macaddr_acl=0

auth_algs=1

ignore_broadcast_ssid=1

wpa=2 wpa_passphrase=mytestpwd wpa_key_mgmt=WPA-PSK

wpa_pairwise=TKIP

rsn_pairwise=CCMP

////////////////////////////////////////////////// And on another Zynq, I use wpa_supplicant -i sdr0 -c wpa-connect.conf to connect the "openwifi" wpa-connect.conf is as bellow: network={ ssid="openwifi" psk="mytestpwd"

psk=11f68e99e79769d14354714c7f23d6a7bc3de8360f6f7965e949561f399a174d

} //////////////////////////////////////////////// But in the client's terminal, something wrong during the authentication:

root@analog:~/openwifi# wpa_supplicant -i sdr0 -c wpa-connect.conf Successfully initialized wpa_supplicant sdr0: CTRL-EVENT-SCAN-STARTED sdr0: CTRL-EVENT-SCAN-STARTED sdr0: SME: Trying to authenticate with 66:55:44:33:22:8c (SSID='openwifi' freq=5220 MHz) sdr0: CTRL-EVENT-SCAN-STARTED sdr0: CTRL-EVENT-SCAN-STARTED sdr0: CTRL-EVENT-SCAN-STARTED sdr0: CTRL-EVENT-SCAN-STARTED sdr0: SME: Trying to authenticate with 66:55:44:33:22:8c (SSID='openwifi' freq=5220 MHz) sdr0: CTRL-EVENT-SCAN-STARTED sdr0: CTRL-EVENT-SCAN-STARTED sdr0: CTRL-EVENT-SCAN-STARTED sdr0: SME: Trying to authenticate with 66:55:44:33:22:8c (SSID='openwifi' freq=5220 MHz) sdr0: CTRL-EVENT-SCAN-STARTED sdr0: SME: Trying to authenticate with 66:55:44:33:22:8c (SSID='openwifi' freq=5220 MHz) sdr0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="openwifi" auth_failures=1 duration=10 sdr0: CTRL-EVENT-SCAN-STARTED sdr0: CTRL-EVENT-SCAN-STARTED sdr0: CTRL-EVENT-SSID-REENABLED id=0 ssid="openwifi" sdr0: CTRL-EVENT-SCAN-STARTED sdr0: CTRL-EVENT-SCAN-STARTED sdr0: SME: Trying to authenticate with 66:55:44:33:22:8c (SSID='openwifi' freq=5220 MHz) sdr0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="openwifi" auth_failures=2 duration=20 sdr0: CTRL-EVENT-SCAN-STARTED sdr0: CTRL-EVENT-SCAN-STARTED sdr0: CTRL-EVENT-SSID-REENABLED id=0 ssid="openwifi" sdr0: SME: Trying to authenticate with 66:55:44:33:22:8c (SSID='openwifi' freq=5220 MHz) sdr0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="openwifi" auth_failures=3 duration=20

JiaoXianjun commented 4 years ago

Hello,

Please try following instructions that have been verified. I believe that you can add more things according to your requirement later.

openwifi board 1 (AP):

cd openwifi
./fosdem.sh

openwifi board 2 (Client):

cd openwifi
service network-manager stop
./wgd.sh
iwconfig sdr0 mode managed
ifconfig sdr0 up
iwconfig sdr0 essid openwifi
dhclient sdr0
(Get IP from openwifi dhcp server. It could take a while)
./set_csma_normal.sh
(Turn on random backoff. Another script set_csma_high.sh will turn off backoff)
ping 192.168.13.1
Leo-Cheung-CUHK commented 4 years ago

Hi Xianjun,

Thanks for your kind reply. I follow your instruction but it still doesn't work. The client's terminal is like this:

root@analog:~/openwifi# dhclient sdr0 PING 192.168.1.1 (192.168.1.1) 56(84) bytes of data.

--- 192.168.1.1 ping statistics --- 1 packets transmitted, 0 received, +1 errors, 100% packet loss, time 0ms

PING 192.168.1.1 (192.168.1.1) 56(84) bytes of data.

--- 192.168.1.1 ping statistics --- 1 packets transmitted, 0 received, +1 errors, 100% packet loss, time 0ms

PING 192.168.1.1 (192.168.1.1) 56(84) bytes of data.

--- 192.168.1.1 ping statistics --- 1 packets transmitted, 0 received, +1 errors, 100% packet loss, time 0ms

PING 192.168.1.1 (192.168.1.1) 56(84) bytes of data.

--- 192.168.1.1 ping statistics --- 1 packets transmitted, 0 received, +1 errors, 100% packet loss, time 0ms

PING 192.168.1.1 (192.168.1.1) 56(84) bytes of data.

--- 192.168.1.1 ping statistics --- 1 packets transmitted, 0 received, +1 errors, 100% packet loss, time 0ms

PING 192.168.1.1 (192.168.1.1) 56(84) bytes of data.

--- 192.168.1.1 ping statistics --- 1 packets transmitted, 0 received, +1 errors, 100% packet loss, time 0ms

PING 192.168.1.1 (192.168.1.1) 56(84) bytes of data.

--- 192.168.1.1 ping statistics --- 1 packets transmitted, 0 received, +1 errors, 100% packet loss, time 0ms

PING 192.168.1.1 (192.168.1.1) 56(84) bytes of data.

--- 192.168.1.1 ping statistics --- 1 packets transmitted, 0 received, +1 errors, 100% packet loss, time 0ms

PING 192.168.1.1 (192.168.1.1) 56(84) bytes of data.

--- 192.168.1.1 ping statistics --- 1 packets transmitted, 0 received, +1 errors, 100% packet loss, time 0ms

root@analog:~/openwifi# ip a 1: lo: <LOOPBACK,UP,LOWER_UP> mtu 65536 qdisc noqueue state UNKNOWN group default qlen 1000 link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00 inet 127.0.0.1/8 scope host lo valid_lft forever preferred_lft forever 2: eth0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc pfifo_fast state UP group default qlen 1000 link/ether 00:0a:35:00:01:22 brd ff:ff:ff:ff:ff:ff inet 192.168.10.122/24 brd 192.168.10.255 scope global eth0 valid_lft forever preferred_lft forever 3: sdr0: <NO-CARRIER,BROADCAST,MULTICAST,UP> mtu 1500 qdisc pfifo_fast state DOWN group default qlen 1000 link/ether 66:55:44:33:22:83 brd ff:ff:ff:ff:ff:ff inet 169.254.5.142/16 brd 169.254.255.255 scope link sdr0:avahi valid_lft forever preferred_lft forever

the ifconfig result from the client is as below:

sdr0 Link encap:Ethernet HWaddr 66:55:44:33:22:83
UP BROADCAST MULTICAST MTU:1500 Metric:1 RX packets:0 errors:0 dropped:0 overruns:0 frame:0 TX packets:0 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:1000 RX bytes:0 (0.0 B) TX bytes:0 (0.0 B)

sdr0:avahi Link encap:Ethernet HWaddr 66:55:44:33:22:83
inet addr:169.254.5.142 Bcast:169.254.255.255 Mask:255.255.0.0 UP BROADCAST MULTICAST MTU:1500 Metric:1

Looking for your kind reply

JiaoXianjun commented 4 years ago

“dhclient sdr0” After run above command you need to wait for it exiting by itself. Do not curl+c to quit it. It takes while. This command get your sdr0 IP address like 192.168.13.X

after “iwconfig sdr0 essid openwifi” Could you tell me out put of the AP side? And also output of “iwconfig” at client side? This checks whether your client is associated with AP.

you could also adjust the distance and location of your antenna. Due to the limited tx power and agc range, too close or too far are not good.

Are you using the latest git commit?

Leo-Cheung-CUHK commented 4 years ago

The first printout is the result exiting by dhclient sdr0. And it did take a while.

After "iwconfig sdr0 essid openwifi", it just returns with nothing at the client-side. And there is nothing output from the AP.

I succeed in using Zynq to connect commercial-used AP. May try to adjust the distance as you suggested

JiaoXianjun commented 4 years ago

Normally after you run “iwconfig sdr0 essid openwifi“, you should also see something at AP side printed by hostapd to show you that a client is associated. You run fosdem.sh at ap side, right? You can also paste me output of fosdem.sh.

Which board are you using for AP and client?

Leo-Cheung-CUHK commented 4 years ago

Yes, I run fosdem.sh at ap side. I use the zc706 board for both AP and client. The output of fosdem.sh is:

root@analog:~/openwifi# ./fosdem.sh /bin/bash: warning: setlocale: LC_ALL: cannot change locale (en_US.UTF-8) hostapd: no process found network-manager stop/waiting /bin/bash: warning: setlocale: LC_ALL: cannot change locale (en_US.UTF-8) num_arg 0 last_input xxxxxxxxx test_mode 0 rmmod: ERROR: Module sdr is not currently loaded rmmod: ERROR: Module xilinx_dma is not currently loaded check xilinx_dma module is loaded or not xilinx_dma is loaded! rmmod: ERROR: Module tx_intf is not currently loaded check tx_intf module is loaded or not tx_intf is loaded! rmmod: ERROR: Module ad9361_drv is not currently loaded check ad9361_drv module is loaded or not ad9361_drv is loaded! set RF frontend Found openwifi_ad9361_fir.ftr

sdr,tx_intf dev_probe match! sdr,tx_intf dev_probe io start 0x83c00000 end 0x83c0ffff name /fpga-axi@0/tx_intf@83c00000 flags 0x00000200 desc 0x00000000 sdr,tx_intf dev_probe base_addr 0xf27a0000 sdr,tx_intf dev_probe tx_intf_driver_api_inst 0xbf116284 sdr,tx_intf dev_probe tx_intf_api 0xbf116284 sdr,tx_intf dev_probe succeed! sdr,tx_intf hw_init mode 6 sdr,tx_intf hw_init mode TX_INTF_BW_20MHZ_AT_N_10MHZ_ANT1 sdr,tx_intf hw_init err 0 ad9361 spi0.0: ad9361_probe : enter (ad9361) ad9361 spi0.0: ad9361_probe : AD936x Rev 2 successfully initialized random: crng init done cf_axi_adc 79020000.cf-ad9361-lpc: ADI AIM (10.00.b) at 0x79020000 mapped to 0xf2758000, probed ADC AD9361 as MASTER cf_axi_dds 79024000.cf-ad9361-dds-core-lpc: Analog Devices CF_AXI_DDS_DDS MASTER (9.00.b) at 0x79024000 mapped to 0xf279c000, probed DDS AD9361

sdr,rx_intf dev_probe match! sdr,rx_intf dev_probe io start 0x83c20000 end 0x83c2ffff name /fpga-axi@0/rx_intf@83c20000 flags 0x00000200 desc 0x00000000 sdr,rx_intf dev_probe base_addr 0xf2890000 sdr,rx_intf dev_probe rx_intf_driver_api_inst 0xbf145284 sdr,rx_intf dev_probe rx_intf_api 0xbf145284 sdr,rx_intf dev_probe succeed! sdr,rx_intf hw_init mode 2 sdr,rx_intf hw_init mode DDC_BW_20MHZ_AT_0MHZ sdr,rx_intf hw_init err 0

sdr,openofdm_tx dev_probe match! sdr,openofdm_tx dev_probe io start 0x83c10000 end 0x83c1ffff name /fpga-axi@0/openofdm_tx@83c10000 flags 0x00000200 desc 0x00000000 sdr,openofdm_tx dev_probe base_addr 0xf28d0000 sdr,openofdm_tx dev_probe openofdm_tx_driver_api_inst 0xbf14e284 sdr,openofdm_tx dev_probe openofdm_tx_api 0xbf14e284 sdr,openofdm_tx dev_probe succeed! sdr,openofdm_tx hw_init mode 1 sdr,openofdm_tx hw_init mode OPENOFDM_TX_NORMAL sdr,openofdm_tx hw_init err 0

sdr,openofdm_rx dev_probe match! sdr,openofdm_rx dev_probe io start 0x83c30000 end 0x83c3ffff name /fpga-axi@0/openofdm_rx@83c30000 flags 0x00000200 desc 0x00000000 sdr,openofdm_rx dev_probe base_addr 0xf2910000 sdr,openofdm_rx dev_probe openofdm_rx_driver_api_inst 0xbf156284 sdr,openofdm_rx dev_probe openofdm_rx_api 0xbf156284 sdr,openofdm_rx dev_probe succeed! sdr,openofdm_rx hw_init mode 1 sdr,openofdm_rx hw_init mode OPENOFDM_RX_NORMAL sdr,openofdm_rx hw_init input: power_thres 0 min_plateau 100 sdr,openofdm_rx hw_init err 0

sdr,xpu dev_probe match! sdr,xpu dev_probe io start 0x83c40000 end 0x83c4ffff name /fpga-axi@0/xpu@83c40000 flags 0x00000200 desc 0x00000000 sdr,xpu dev_probe base_addr 0xf2970000 sdr,xpu dev_probe xpu_driver_api_inst 0xbf15f284 sdr,xpu dev_probe xpu_api 0xbf15f284 sdr,xpu dev_probe reset tsf timer sdr,xpu dev_probe XPU_REG_TSF_RUNTIME_VAL_LOW_read 1 33286 100305us sdr,xpu dev_probe succeed! sdr,xpu hw_init mode 1 sdr,xpu hw_init mode XPU_NORMAL sdr,xpu hw_init err 0 sdr: no symbol version for openofdm_rx_api

sdr,sdr openwifi_dev_probe: match! sdr,sdr custom_match_spi_dev ad9361-phy ad9361-phy 1 sdr,sdr bus_find_device ad9361-phy: (null) sdr,sdr ad9361_spi_to_phy ad9361-phy: ad9361 sdr,sdr openwifi_dev_probe: ad9361_ctrl_outs_setup en_mask 0xff index 0x16 sdr,sdr openwifi_dev_probe: ad9361_spi_read REG_CTRL_OUTPUT_POINTER 0x16 sdr,sdr openwifi_dev_probe: ad9361_spi_read REG_CTRL_OUTPUT_ENABLE 0xff sdr,sdr custom_match_platform_dev 79024000.cf-ad9361-dds-core-lpc sdr,sdr openwifi_dev_probe: cf-ad9361-dds-core-lpc dds_st->version 00090062 chip_info->name AD9361 sdr,sdr openwifi_dev_probe: cf_axi_dds_datasel DATA_SEL_DMA sdr,sdr openwifi_dev_probe: priv->rf_bw == 40000000Hz. bool for 20000000 0, 40000000 1 sdr,sdr openwifi_dev_probe: test_mode 0 sdr,sdr openwifi_dev_probe: rfkill radio on sdr,sdr openwifi_dev_probe: band_2GHz.n_channels 14 n_bitrates 12 band_5GHz.n_channels 11 n_bitrates 12 sdr,sdr openwifi_dev_probe: mac_addr 66:55:44:33:22:b2 ieee80211 phy0: Selected rate control algorithm 'minstrel_ht' sdr,sdr openwifi_dev_probe: ieee80211_register_hw 0 ieee80211 phy0: hwaddr 6655443322b2, ZYNQ + ad9361 sdr,sdr openwifi_rfkill_init: wireless switch is on sdr,sdr openwifi_rfkill_poll: wireless radio switch turned on sdr,sdr fpga-axi@0:sdr sdr0: renamed from wlan0 stop: Unknown instance: isc-dhcp-server start/running, process 2368 Configuration file: hostapd-openwifi.conf sdr0: interface state UNINITIALIZED->COUNTRY_UPDATE Using interface sdr0 with hwaddr 66:55:44:33:22:b2 and ssid "openwifi" sdr0: interface state COUNTRY_UPDATE->ENABLED sdr0: AP-ENABLED

But nothing happened on AP side after running “iwconfig sdr0 essid openwifi“ on client side

In terms of distance, I can find the openwifi using "iwlist sdr0 scan" as bellows Cell 34 - Address: 66:55:44:33:22:B2 Channel:44 Frequency:5.22 GHz (Channel 44) Quality=41/70 Signal level=-69 dBm
Encryption key:off ESSID:"openwifi" Bit Rates:6 Mb/s; 9 Mb/s; 12 Mb/s; 18 Mb/s; 24 Mb/s 36 Mb/s; 48 Mb/s; 54 Mb/s Mode:Master Extra:tsf=000000001178e3ed Extra: Last beacon: 700ms ago IE: Unknown: 00086F70656E77696669 IE: Unknown: 01088C9298A43048606C IE: Unknown: 03012C IE: Unknown: 050401020000 IE: Unknown: 7F080000000000000040

JiaoXianjun commented 4 years ago

You run “ iwlist sdr0 scan” at openwifi client or commercial client. -69dbm is not good, maybe you could move two boards closer.

Also check the antenna type. Some antenna support 2.4GHz only, some support both 2.4 and 5GHz. You need antenna supporting 5GHz. Also check the SMA connector male/femal matching stuffs.

Leo-Cheung-CUHK commented 4 years ago

Yes, the signal strength is too low. But the distance between these two boards are already very close (maybe around 30cm). And under this setting, everything goes well when connecting my board to a commercial AP ( working on Frequency:5.22 GHz, Channel 44) with a distance much more than 2 meters. Bellow is the example when I connect to an AP on 5 GHz using "wpa_supplicant -i sdr0 -c wpa-connect.conf & dhclient sdr0"

root@analog:~/openwifi# wpa_supplicant -i sdr0 -c wpa-connect.conf & dhclient sdr0 [1] 2952 Successfully initialized wpa_supplicant sdr0: CTRL-EVENT-SCAN-STARTED sdr0: SME: Trying to authenticate with c0:56:27:bb:e8:e1 (SSID='806Lab_5GHz' freq=5220 MHz) sdr0: Trying to associate with c0:56:27:bb:e8:e1 (SSID='806Lab_5GHz' freq=5220 MHz) sdr0: Associated with c0:56:27:bb:e8:e1 sdr0: WPA: Key negotiation completed with c0:56:27:bb:e8:e1 [PTK=CCMP GTK=CCMP] sdr0: CTRL-EVENT-CONNECTED - Connection to c0:56:27:bb:e8:e1 completed [id=0 id_str=] root@analog:~/openwifi# ip a 1: lo: <LOOPBACK,UP,LOWER_UP> mtu 65536 qdisc noqueue state UNKNOWN group default qlen 1000 link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00 inet 127.0.0.1/8 scope host lo valid_lft forever preferred_lft forever 2: eth0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc pfifo_fast state UP group default qlen 1000 link/ether 00:0a:35:00:01:22 brd ff:ff:ff:ff:ff:ff inet 192.168.10.122/24 brd 192.168.10.255 scope global eth0 valid_lft forever preferred_lft forever 4: sdr0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc pfifo_fast state UP group default qlen 1000 link/ether 66:55:44:33:22:21 brd ff:ff:ff:ff:ff:ff inet 192.168.1.114/24 brd 192.168.1.255 scope global sdr0 valid_lft forever preferred_lft forever root@analog:~/openwifi# ifconfig eth0 Link encap:Ethernet HWaddr 00:0a:35:00:01:22
inet addr:192.168.10.122 Bcast:192.168.10.255 Mask:255.255.255.0 UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1 RX packets:2165 errors:0 dropped:0 overruns:0 frame:0 TX packets:2048 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:1000 RX bytes:130148 (130.1 KB) TX bytes:444567 (444.5 KB) Interrupt:29 Base address:0xb000

lo Link encap:Local Loopback
inet addr:127.0.0.1 Mask:255.0.0.0 UP LOOPBACK RUNNING MTU:65536 Metric:1 RX packets:26 errors:0 dropped:0 overruns:0 frame:0 TX packets:26 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:1000 RX bytes:2296 (2.2 KB) TX bytes:2296 (2.2 KB)

sdr0 Link encap:Ethernet HWaddr 66:55:44:33:22:21
inet addr:192.168.1.114 Bcast:192.168.1.255 Mask:255.255.255.0 UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1 RX packets:15 errors:0 dropped:0 overruns:0 frame:0 TX packets:24 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:1000 RX bytes:2209 (2.2 KB) TX bytes:5025 (5.0 KB)

JiaoXianjun commented 4 years ago

To rule out the hardware issue, can you switch the role of openwifi AP and client board?

And when you do the experiment (openwifi client to openwifi AP), could you please share me the dmesg output (open another ssh session) on both side, after you run dhclient.

You can also “cat /proc/interrupts” to see whether the number of tx and rx interrupts are growing.

Leo-Cheung-CUHK commented 4 years ago

Hi, xianjun,

I rewrite the SD image by compiling the lastest commit of the driver and follow your previous steps as bellow:

openwifi board 1 (AP):
cd openwifi
./fosdem.sh

openwifi board 2 (Client):
cd openwifi
service network-manager stop
./wgd.sh
iwconfig sdr0 mode managed
ifconfig sdr0 up
iwconfig sdr0 essid openwifi
dhclient sdr0

This time, after the "wconfig sdr0 essid openwifi", the AP finally can show something:

root@analog:~/openwifi# sdr0: STA 66:55:44:33:22:a7 IEEE 802.11: did not acknowledge authentication response
sdr0: STA 66:55:44:33:22:a7 IEEE 802.11: disassociated due to inactivity
sdr0: STA 66:55:44:33:22:a7 IEEE 802.11: deauthenticated due to inactivity (timer DEAUTH/REMOVE)

It seems that the AP fails to decode the authentication response sent by STA

The dmesg on AP is

  Normal zone: 196608 pages, LIFO batch:31
  HighMem zone: 65536 pages, LIFO batch:15
random: fast init done
percpu: Embedded 16 pages/cpu @ef7c6000 s33036 r8192 d24308 u65536
pcpu-alloc: s33036 r8192 d24308 u65536 alloc=16*4096
pcpu-alloc: [0] 0 [0] 1 
Built 1 zonelists, mobility grouping on.  Total pages: 260608
Kernel command line: console=ttyPS0,115200 root=/dev/mmcblk0p2 rw earlycon rootfstype=ext4 rootwait cpuidle.off=1
PID hash table entries: 4096 (order: 2, 16384 bytes)
Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
Memory: 895976K/1048576K available (7168K kernel code, 339K rwdata, 2388K rodata, 1024K init, 165K bss, 21528K reserved, 131072K cma-reserved, 131072K highmem)
Virtual kernel memory layout:
    vector  : 0xffff0000 - 0xffff1000   (   4 kB)
    fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
    vmalloc : 0xf0800000 - 0xff800000   ( 240 MB)
    lowmem  : 0xc0000000 - 0xf0000000   ( 768 MB)
    pkmap   : 0xbfe00000 - 0xc0000000   (   2 MB)
    modules : 0xbf000000 - 0xbfe00000   (  14 MB)
      .text : 0xc0008000 - 0xc0800000   (8160 kB)
      .init : 0xc0b00000 - 0xc0c00000   (1024 kB)
      .data : 0xc0c00000 - 0xc0c54ea0   ( 340 kB)
       .bss : 0xc0c5a894 - 0xc0c83f7c   ( 166 kB)
Preemptible hierarchical RCU implementation.
    RCU restricting CPUs from NR_CPUS=4 to nr_cpu_ids=2.
    Tasks RCU enabled.
RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
efuse mapped to f0802000
slcr mapped to f0804000
L2C: platform modifies aux control register: 0x72360000 -> 0x72760000
L2C: DT/platform modifies aux control register: 0x72360000 -> 0x72760000
L2C-310 erratum 769419 enabled
L2C-310 enabling early BRESP for Cortex-A9
L2C-310 full line of zeros enabled for Cortex-A9
L2C-310 ID prefetch enabled, offset 1 lines
L2C-310 dynamic clock gating enabled, standby mode enabled
L2C-310 cache controller enabled, 8 ways, 512 kB
L2C-310: CACHE_ID 0x410000c8, AUX_CTRL 0x76760001
zynq_clock_init: clkc starts at f0804100
Zynq clock init
sched_clock: 64 bits at 333MHz, resolution 3ns, wraps every 4398046511103ns
clocksource: arm_global_timer: mask: 0xffffffffffffffff max_cycles: 0x4ce07af025, max_idle_ns: 440795209040 ns
Switching to timer-based delay loop, resolution 3ns
clocksource: ttc_clocksource: mask: 0xffff max_cycles: 0xffff, max_idle_ns: 537538477 ns
timer #0 at f080c000, irq=17
Console: colour dummy device 80x30
Calibrating delay loop (skipped), value calculated using timer frequency.. 666.66 BogoMIPS (lpj=3333333)
pid_max: default: 32768 minimum: 301
Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
CPU: Testing write buffer coherency: ok
CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
Setting up static identity map for 0x100000 - 0x100060
Hierarchical SRCU implementation.
smp: Bringing up secondary CPUs ...
CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
smp: Brought up 1 node, 2 CPUs
SMP: Total of 2 processors activated (1333.33 BogoMIPS).
CPU: All CPU(s) started in SVC mode.
devtmpfs: initialized
VFP support v0.3: implementor 41 architecture 3 part 30 variant 9 rev 4
clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
futex hash table entries: 512 (order: 3, 32768 bytes)
pinctrl core: initialized pinctrl subsystem
NET: Registered protocol family 16
DMA: preallocated 256 KiB pool for atomic coherent allocations
hw-breakpoint: found 5 (+1 reserved) breakpoint and 1 watchpoint registers.
hw-breakpoint: maximum watchpoint size is 4 bytes.
zynq-ocm f800c000.ocmc: ZYNQ OCM pool: 256 KiB @ 0xf0880000
zynq-pinctrl 700.pinctrl: zynq pinctrl initialized
e0001000.serial: ttyPS0 at MMIO 0xe0001000 (irq = 25, base_baud = 3125000) is a xuartps
console [ttyPS0] enabled
SCSI subsystem initialized
usbcore: registered new interface driver usbfs
usbcore: registered new interface driver hub
usbcore: registered new device driver usb
media: Linux media interface: v0.10
Linux video capture interface: v2.00
pps_core: LinuxPPS API ver. 1 registered
pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
PTP clock support registered
FPGA manager framework
Advanced Linux Sound Architecture Driver Initialized.
clocksource: Switched to clocksource arm_global_timer
NET: Registered protocol family 2
TCP established hash table entries: 8192 (order: 3, 32768 bytes)
TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
TCP: Hash tables configured (established 8192 bind 8192)
UDP hash table entries: 512 (order: 2, 16384 bytes)
UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
NET: Registered protocol family 1
hw perfevents: no interrupt-affinity property for /pmu@f8891000, guessing.
hw perfevents: enabled with armv7_cortex_a9 PMU driver, 7 counters available
workingset: timestamp_bits=30 max_order=18 bucket_order=0
bounce: pool size: 64 pages
io scheduler noop registered
io scheduler deadline registered
io scheduler cfq registered (default)
io scheduler mq-deadline registered
io scheduler kyber registered
dma-pl330 f8003000.dmac: Loaded driver for PL330 DMAC-241330
dma-pl330 f8003000.dmac:    DBUFF-128x8bytes Num_Chans-8 Num_Peri-4 Num_Events-16
brd: module loaded
loop: module loaded
m25p80 spi2.0: found s25fl128s, expected n25q128a11
m25p80 spi2.0: s25fl128s (32768 Kbytes)
5 ofpart partitions found on MTD device spi2.0
Creating 5 MTD partitions on "spi2.0":
0x000000000000-0x000000500000 : "boot"
0x000000500000-0x000000520000 : "bootenv"
0x000000520000-0x000000540000 : "config"
0x000000540000-0x000000fc0000 : "image"
0x000000fc0000-0x000002000000 : "spare"
MACsec IEEE 802.1AE
libphy: Fixed MDIO Bus: probed
tun: Universal TUN/TAP device driver, 1.6
libphy: MACB_mii_bus: probed
macb e000b000.ethernet eth0: Cadence GEM rev 0x00020118 at 0xe000b000 irq 29 (00:0a:35:00:01:22)
Marvell 88E1116R e000b000.ethernet-ffffffff:07: attached PHY driver [Marvell 88E1116R] (mii_bus:phy_addr=e000b000.ethernet-ffffffff:07, irq=POLL)
ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
usbcore: registered new interface driver usb-storage
usbcore: registered new interface driver usbserial
usbcore: registered new interface driver usbserial_generic
usbserial: USB Serial support registered for generic
usbcore: registered new interface driver ftdi_sio
usbserial: USB Serial support registered for FTDI USB Serial Device
chipidea-usb2 e0002000.usb: e0002000.usb supply vbus not found, using dummy regulator
ULPI transceiver vendor/product ID 0x0424/0x0007
Found SMSC USB3320 ULPI transceiver.
ULPI integrity check: passed.
ci_hdrc ci_hdrc.0: EHCI Host Controller
ci_hdrc ci_hdrc.0: new USB bus registered, assigned bus number 1
ci_hdrc ci_hdrc.0: USB 2.0 started, EHCI 1.00
hub 1-0:1.0: USB hub found
hub 1-0:1.0: 1 port detected
i2c /dev entries driver
si570: probe of 1-005d failed with error -5
i2c i2c-0: Added multiplexed i2c bus 1
adv7511 2-0039: 2-0039 supply avdd not found, using dummy regulator
adv7511 2-0039: 2-0039 supply dvdd not found, using dummy regulator
adv7511 2-0039: 2-0039 supply pvdd not found, using dummy regulator
adv7511 2-0039: 2-0039 supply bgvdd not found, using dummy regulator
adv7511 2-0039: 2-0039 supply dvdd-3v not found, using dummy regulator
i2c i2c-0: Added multiplexed i2c bus 2
at24 3-0054: 1024 byte 24c08 EEPROM, writable, 1 bytes/write
i2c i2c-0: Added multiplexed i2c bus 3
pca953x 4-0021: 4-0021 supply vcc not found, using dummy regulator
pca953x 4-0021: interrupt support not compiled in
i2c i2c-0: Added multiplexed i2c bus 4
rtc-pcf8563 5-0051: rtc core: registered rtc-pcf8563 as rtc0
i2c i2c-0: Added multiplexed i2c bus 5
i2c i2c-0: Added multiplexed i2c bus 6
at24 7-0050: 256 byte 24c02 EEPROM, writable, 1 bytes/write
i2c i2c-0: Added multiplexed i2c bus 7
i2c i2c-0: Added multiplexed i2c bus 8
pca954x 0-0074: registered 8 multiplexed busses for I2C switch pca9548
IR NEC protocol handler initialized
IR RC5(x/sz) protocol handler initialized
IR RC6 protocol handler initialized
IR JVC protocol handler initialized
IR Sony protocol handler initialized
IR SANYO protocol handler initialized
IR Sharp protocol handler initialized
IR MCE Keyboard/mouse protocol handler initialized
IR XMP protocol handler initialized
usbcore: registered new interface driver uvcvideo
USB Video Class driver (1.1.1)
gspca_main: v2.14.0 registered
cdns-wdt f8005000.watchdog: Xilinx Watchdog Timer at f090a000 with timeout 10s
Xilinx Zynq CpuIdle Driver started
failed to register cpuidle driver
sdhci: Secure Digital Host Controller Interface driver
sdhci: Copyright(c) Pierre Ossman
sdhci-pltfm: SDHCI platform and OF driver helper
mmc0: SDHCI controller on e0100000.mmc [e0100000.mmc] using ADMA
ledtrig-cpu: registered to indicate activity on CPUs
hidraw: raw HID events driver (C) Jiri Kosina
usbcore: registered new interface driver usbhid
usbhid: USB HID core driver
adf4350 spi1.0: spi1.0 supply vcc not found, using dummy regulator
adf4350 spi1.0: Probe failed (muxout)
adf4350 spi1.1: spi1.1 supply vcc not found, using dummy regulator
mmc0: new high speed SDHC card at address aaaa
mmcblk0: mmc0:aaaa SS08G 7.40 GiB 
 mmcblk0: p1 p2 p3
adf4350 spi1.1: Probe failed (muxout)
fpga_manager fpga0: Xilinx Zynq FPGA Manager registered
Netfilter messages via NETLINK v0.30.
nfnl_acct: registering with nfnetlink.
nf_conntrack version 0.5.0 (16384 buckets, 65536 max)
ctnetlink v0.93: registering with nfnetlink.
nf_tables: (c) 2007-2009 Patrick McHardy <kaber@trash.net>
nf_tables_compat: (c) 2012 Pablo Neira Ayuso <pablo@netfilter.org>
xt_time: kernel timezone is -0000
ip_tables: (C) 2000-2006 Netfilter Core Team
ipt_CLUSTERIP: ClusterIP Version 0.8 loaded successfully
arp_tables: arp_tables: (C) 2002 David S. Miller
NET: Registered protocol family 17
Registering SWP/SWPB emulation handler
asoc-simple-card adv7511_hdmi_snd: spdif-hifi <-> 75c00000.axi-spdif-tx mapping ok
input: gpio_keys as /devices/soc0/gpio_keys/input/input0
rtc-pcf8563 5-0051: setting system clock to 1970-09-12 01:54:25 UTC (21952465)
ALSA device list:
  #0: HDMI monitor
EXT4-fs (mmcblk0p2): recovery complete
EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
VFS: Mounted root (ext4 filesystem) on device 179:2.
devtmpfs: mounted
Freeing unused kernel memory: 1024K
systemd-udevd[1075]: starting version 204
Registered mathworks_ip class
mwipcore 43c00000.mwipcore: Dev memory resource found at 43c00000 0000FFFF. 
mwipcore 43c00000.mwipcore: 'mwipcore' device not found, creating
mwipcore 43c00000.mwipcore: Char dev region registered: major num:242
mwipcore 43c00000.mwipcore: 'mwipcore' device created
init: udev-fallback-graphics main process (1531) terminated with status 1
macb e000b000.ethernet eth0: link up (100/Full)
init: samba-ad-dc main process (1748) terminated with status 1
init: isc-dhcp-server main process (1910) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: isc-dhcp-server main process (1984) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: lightdm main process (1814) terminated with status 1
init: tty1 main process (2007) killed by TERM signal
init: isc-dhcp-server main process (2035) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: isc-dhcp-server main process (2055) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: isc-dhcp-server main process (2079) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: isc-dhcp-server main process (2098) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: isc-dhcp-server main process (2110) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: isc-dhcp-server main process (2120) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: isc-dhcp-server main process (2130) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: isc-dhcp-server main process (2140) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: isc-dhcp-server main process (2150) terminated with status 1
init: isc-dhcp-server respawning too fast, stopped
xilinx_dma: no symbol version for module_layout
xilinx-vdma 80400000.dma: Xilinx AXI DMA Engine Driver Probed!!
xilinx-vdma 80410000.dma: Xilinx AXI DMA Engine Driver Probed!!
tx_intf: loading out-of-tree module taints kernel.

sdr,tx_intf dev_probe match!
sdr,tx_intf dev_probe io start 0x83c0ffff83c00000 end 0x200ef7f56d4 name (null) flags 0xbf11401c desc 0xbf11401c
sdr,tx_intf dev_probe base_addr 0xf2800000
sdr,tx_intf dev_probe tx_intf_driver_api_inst 0xbf114284
sdr,tx_intf dev_probe             tx_intf_api 0xbf114284
sdr,tx_intf dev_probe succeed!
sdr,tx_intf hw_init mode 6
sdr,tx_intf hw_init mode TX_INTF_BW_20MHZ_AT_N_10MHZ_ANT1
sdr,tx_intf hw_init err 0
ad9361 spi0.0: ad9361_probe : enter (ad9361)
ad9361 spi0.0: ad9361_probe : AD936x Rev 2 successfully initialized
random: crng init done
cf_axi_adc 79020000.cf-ad9361-lpc: ADI AIM (10.01.b) at 0x79020000 mapped to 0xf27b8000, probed ADC AD9361 as MASTER
cf_axi_dds 79024000.cf-ad9361-dds-core-lpc: Analog Devices CF_AXI_DDS_DDS MASTER (9.01.b) at 0x79024000 mapped to 0xf2799000, probed DDS AD9361

sdr,rx_intf dev_probe match!
sdr,rx_intf dev_probe io start 0x83c20000 end 0x83c2ffff name /fpga-axi@0/rx_intf@83c20000 flags 0x00000200 desc 0x00000000
sdr,rx_intf dev_probe base_addr 0xf28f0000
sdr,rx_intf dev_probe rx_intf_driver_api_inst 0xbf143284
sdr,rx_intf dev_probe             rx_intf_api 0xbf143284
sdr,rx_intf dev_probe succeed!
sdr,rx_intf hw_init mode 2
sdr,rx_intf hw_init mode DDC_BW_20MHZ_AT_0MHZ
sdr,rx_intf hw_init err 0

sdr,openofdm_tx dev_probe match!
sdr,openofdm_tx dev_probe io start 0x83c10000 end 0x83c1ffff name /fpga-axi@0/openofdm_tx@83c10000 flags 0x00000200 desc 0x00000000
sdr,openofdm_tx dev_probe base_addr 0xf2930000
sdr,openofdm_tx dev_probe openofdm_tx_driver_api_inst 0xbf14c284
sdr,openofdm_tx dev_probe             openofdm_tx_api 0xbf14c284
sdr,openofdm_tx dev_probe succeed!
sdr,openofdm_tx hw_init mode 1
sdr,openofdm_tx hw_init mode OPENOFDM_TX_NORMAL
sdr,openofdm_tx hw_init err 0

sdr,openofdm_rx dev_probe match!
sdr,openofdm_rx dev_probe io start 0x83c30000 end 0x83c3ffff name /fpga-axi@0/openofdm_rx@83c30000 flags 0x00000200 desc 0x00000000
sdr,openofdm_rx dev_probe base_addr 0xf2970000
sdr,openofdm_rx dev_probe openofdm_rx_driver_api_inst 0xbf154284
sdr,openofdm_rx dev_probe             openofdm_rx_api 0xbf154284
sdr,openofdm_rx dev_probe succeed!
sdr,openofdm_rx hw_init mode 1
sdr,openofdm_rx hw_init mode OPENOFDM_RX_NORMAL
sdr,openofdm_rx hw_init input:
power_thres 0
min_plateau 100
sdr,openofdm_rx hw_init err 0

sdr,xpu dev_probe match!
sdr,xpu dev_probe io start 0x83c40000 end 0x83c4ffff name /fpga-axi@0/xpu@83c40000 flags 0x00000200 desc 0x00000000
sdr,xpu dev_probe base_addr 0xf29d0000
sdr,xpu dev_probe xpu_driver_api_inst 0xbf15d284
sdr,xpu dev_probe             xpu_api 0xbf15d284
sdr,xpu dev_probe reset tsf timer
sdr,xpu dev_probe XPU_REG_TSF_RUNTIME_VAL_LOW_read 1 33488 100496us
sdr,xpu dev_probe succeed!
sdr,xpu hw_init mode 1
sdr,xpu hw_init mode XPU_NORMAL
sdr,xpu hw_init err 0

sdr,sdr openwifi_dev_probe: match!
sdr,sdr custom_match_spi_dev ad9361-phy ad9361-phy 1
sdr,sdr bus_find_device ad9361-phy: ad9361. driver_data pointer ee42b010
sdr,sdr ad9361_spi_to_phy ad9361-phy: ad9361
sdr,sdr openwifi_dev_probe: ad9361_ctrl_outs_setup en_mask 0xff index 0x16
sdr,sdr openwifi_dev_probe: ad9361_spi_read REG_CTRL_OUTPUT_POINTER 0x16
sdr,sdr openwifi_dev_probe: ad9361_spi_read REG_CTRL_OUTPUT_ENABLE 0xff
sdr,sdr custom_match_platform_dev 79024000.cf-ad9361-dds-core-lpc
sdr,sdr openwifi_dev_probe: cf-ad9361-dds-core-lpc dds_st->version 00090162 chip_info->name AD9361
sdr,sdr openwifi_dev_probe: cf_axi_dds_datasel DATA_SEL_DMA
sdr,sdr openwifi_dev_probe: priv->rf_bw == 40000000Hz. bool for 20000000 0, 40000000 1
sdr,sdr openwifi_dev_probe: test_mode 0
sdr,sdr openwifi_dev_probe: rfkill radio on
sdr,sdr openwifi_dev_probe: band_2GHz.n_channels 14 n_bitrates 12 band_5GHz.n_channels 11 n_bitrates 12
sdr,sdr openwifi_dev_probe: mac_addr 66:55:44:33:22:73
ieee80211 phy0: Selected rate control algorithm 'minstrel_ht'
sdr,sdr openwifi_dev_probe: ieee80211_register_hw 0
ieee80211 phy0: hwaddr 665544332273, ZYNQ + ad9361
sdr,sdr openwifi_rfkill_init: wireless switch is on
sdr,sdr fpga-axi@0:sdr sdr0: renamed from wlan0
systemd-udevd[2304]: renamed network interface wlan0 to sdr0
sdr,sdr openwifi_start: rfkill radio on
sdr,sdr openwifi_start: ad9361_ctrl_outs_setup en_mask 0xff index 0x16
sdr,rx_intf hw_init mode 2
sdr,rx_intf hw_init mode DDC_BW_20MHZ_AT_0MHZ
sdr,rx_intf hw_init err 0
sdr,tx_intf hw_init mode 4
sdr,tx_intf hw_init mode TX_INTF_BW_20MHZ_AT_N_10MHZ_ANT0
sdr,tx_intf hw_init err 0
sdr,openofdm_tx hw_init mode 1
sdr,openofdm_tx hw_init mode OPENOFDM_TX_NORMAL
sdr,openofdm_tx hw_init err 0
sdr,openofdm_rx hw_init mode 1
sdr,openofdm_rx hw_init mode OPENOFDM_RX_NORMAL
sdr,openofdm_rx hw_init input:
power_thres 0
min_plateau 100
sdr,openofdm_rx hw_init err 0
sdr,xpu hw_init mode 1
sdr,xpu hw_init mode XPU_NORMAL
sdr,xpu hw_init err 0
sdr,sdr openwifi_start: rx_intf_cfg 2 openofdm_rx_cfg 1 tx_intf_cfg 4 openofdm_tx_cfg 1
sdr,sdr openwifi_start: rx_freq_offset_to_lo_MHz 0 tx_freq_offset_to_lo_MHz -10
sdr,sdr openwifi_start: DMA channel setup successfully.
sdr,sdr openwifi_start: irq_rx 53
sdr,sdr openwifi_start: irq_tx 55
sdr,sdr openwifi_start: normal end
sdr,sdr openwifi_add_interface start. vif for loop result 0
sdr,sdr openwifi_add_interface end with vif idx 0
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_ERP_CTS_PROT 0
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_ERP_SLOT 8 BSS_CHANGED_ERP_PREAMBLE 4 short slot 0
sdr,sdr openwifi_conf_tx: WARNING [queue 0], aifs: 2, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr openwifi_conf_tx: WARNING [queue 1], aifs: 2, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr openwifi_conf_tx: WARNING [queue 2], aifs: 2, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr openwifi_conf_tx: WARNING [queue 3], aifs: 2, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr ad9361_rf_set_channel 2412M rssi_correction 153 (change flag 1)
sdr,sdr openwifi_prepare_multicast
sdr,sdr openwifi_configure_filter MON 0 M_BCN 1 BST0 1 BST1 1 UST 1 PB_RQ 0 PS_PL 1 O_BSS 0 CTL 0 BCN_PRP 0 PCP_FL 0 FCS_FL 0 ALL_MUT 0
sdr,sdr openwifi_prepare_multicast
sdr,sdr openwifi_configure_filter MON 0 M_BCN 1 BST0 1 BST1 1 UST 1 PB_RQ 0 PS_PL 1 O_BSS 0 CTL 0 BCN_PRP 0 PCP_FL 0 FCS_FL 0 ALL_MUT 0
sdr,sdr openwifi_prepare_multicast
sdr,sdr openwifi_configure_filter MON 0 M_BCN 1 BST0 1 BST1 1 UST 1 PB_RQ 0 PS_PL 1 O_BSS 0 CTL 0 BCN_PRP 0 PCP_FL 0 FCS_FL 0 ALL_MUT 0
sdr,sdr openwifi_prepare_multicast
sdr,sdr openwifi_configure_filter MON 0 M_BCN 1 BST0 1 BST1 1 UST 1 PB_RQ 0 PS_PL 1 O_BSS 0 CTL 0 BCN_PRP 0 PCP_FL 0 FCS_FL 0 ALL_MUT 0
sdr,sdr openwifi_remove_interface vif idx 0
sdr,sdr openwifi_stop: rfkill radio off
sdr,sdr openwifi_stop: dropped channel dma5chan1
sdr,sdr openwifi_stop: dropped channel dma4chan0
sdr,sdr openwifi_stop
sdr,sdr openwifi_start: rfkill radio on
sdr,sdr openwifi_start: ad9361_ctrl_outs_setup en_mask 0xff index 0x16
sdr,rx_intf hw_init mode 2
sdr,rx_intf hw_init mode DDC_BW_20MHZ_AT_0MHZ
sdr,rx_intf hw_init err 0
sdr,tx_intf hw_init mode 4
sdr,tx_intf hw_init mode TX_INTF_BW_20MHZ_AT_N_10MHZ_ANT0
sdr,tx_intf hw_init err 0
sdr,openofdm_tx hw_init mode 1
sdr,openofdm_tx hw_init mode OPENOFDM_TX_NORMAL
sdr,openofdm_tx hw_init err 0
sdr,openofdm_rx hw_init mode 1
sdr,openofdm_rx hw_init mode OPENOFDM_RX_NORMAL
sdr,openofdm_rx hw_init input:
power_thres 0
min_plateau 100
sdr,openofdm_rx hw_init err 0
sdr,xpu hw_init mode 1
sdr,xpu hw_init mode XPU_NORMAL
sdr,xpu hw_init err 0
sdr,sdr openwifi_start: rx_intf_cfg 2 openofdm_rx_cfg 1 tx_intf_cfg 4 openofdm_tx_cfg 1
sdr,sdr openwifi_start: rx_freq_offset_to_lo_MHz 0 tx_freq_offset_to_lo_MHz -10
sdr,sdr openwifi_start: DMA channel setup successfully.
sdr,sdr openwifi_start: irq_rx 53
sdr,sdr openwifi_start: irq_tx 55
sdr,sdr openwifi_start: normal end
sdr,sdr openwifi_add_interface start. vif for loop result 0
sdr,sdr openwifi_add_interface end with vif idx 0
sdr,sdr openwifi_prepare_multicast
sdr,sdr openwifi_configure_filter MON 0 M_BCN 1 BST0 1 BST1 1 UST 1 PB_RQ 1 PS_PL 1 O_BSS 0 CTL 0 BCN_PRP 0 PCP_FL 0 FCS_FL 0 ALL_MUT 0
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_ERP_CTS_PROT 0
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_ERP_SLOT 8 BSS_CHANGED_ERP_PREAMBLE 4 short slot 0
sdr,sdr openwifi_conf_tx: WARNING [queue 0], aifs: 2, cw_min: 3, cw_max: 7, txop: 47
sdr,sdr openwifi_conf_tx: WARNING [queue 1], aifs: 2, cw_min: 7, cw_max: 15, txop: 94
sdr,sdr openwifi_conf_tx: WARNING [queue 2], aifs: 3, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr openwifi_conf_tx: WARNING [queue 3], aifs: 7, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr ad9361_rf_set_channel 2412M rssi_correction 153 (change flag 0)
sdr,sdr openwifi_prepare_multicast
sdr,sdr openwifi_configure_filter MON 0 M_BCN 1 BST0 1 BST1 1 UST 1 PB_RQ 1 PS_PL 1 O_BSS 0 CTL 0 BCN_PRP 0 PCP_FL 0 FCS_FL 0 ALL_MUT 0
sdr,sdr openwifi_prepare_multicast
sdr,sdr openwifi_configure_filter MON 0 M_BCN 1 BST0 1 BST1 1 UST 1 PB_RQ 1 PS_PL 1 O_BSS 0 CTL 0 BCN_PRP 0 PCP_FL 0 FCS_FL 0 ALL_MUT 0
sdr,sdr openwifi_prepare_multicast
sdr,sdr openwifi_configure_filter MON 0 M_BCN 1 BST0 1 BST1 1 UST 1 PB_RQ 1 PS_PL 1 O_BSS 0 CTL 0 BCN_PRP 0 PCP_FL 0 FCS_FL 0 ALL_MUT 0
8021q: 802.1Q VLAN Support v1.8
sdr,sdr openwifi_config changed flag 00000100
sdr,sdr ad9361_rf_set_channel 5220M rssi_correction 145 (change flag 1)
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_TXPOWER 14
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_BEACON_INT 64
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_TXPOWER 14
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_BEACON_ENABLED
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_BEACON_ENABLED 512 BSS_CHANGED_BEACON 256
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_ERP_CTS_PROT 0
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_BASIC_RATES f0
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_ERP_SLOT 8 BSS_CHANGED_ERP_PREAMBLE 4 short slot 1
sdr,sdr openwifi_conf_tx: WARNING [queue 0], aifs: 1, cw_min: 3, cw_max: 7, txop: 47
sdr,sdr openwifi_conf_tx: WARNING [queue 1], aifs: 1, cw_min: 7, cw_max: 15, txop: 94
sdr,sdr openwifi_conf_tx: WARNING [queue 2], aifs: 3, cw_min: 15, cw_max: 63, txop: 0
sdr,sdr openwifi_conf_tx: WARNING [queue 3], aifs: 7, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr openwifi_rx_interrupt: WARNING content!
sdr,sdr openwifi_rx_interrupt: WARNING content!
sdr,sdr openwifi_rx_interrupt: WARNING content!
sdr,sdr openwifi_rx_interrupt: WARNING content!
sdr,sdr openwifi_rx_interrupt: WARNING content!
sdr,sdr openwifi_rx_interrupt: WARNING content!
sdr,sdr openwifi_rx_interrupt: WARNING content!
sdr,sdr openwifi_rx_interrupt: WARNING content!
sdr,sdr openwifi_rx_interrupt: WARNING content!
sdr,sdr openwifi_rx_interrupt: WARNING content!
sdr,sdr openwifi_rx_interrupt: WARNING content!
sdr,sdr openwifi_rx_interrupt: WARNING content!
sdr,sdr openwifi_rx_interrupt: WARNING content!

That of STA is :

root@analog:~/openwifi# dmesg 
sdhci-pltfm: SDHCI platform and OF driver helper
mmc0: SDHCI controller on e0100000.mmc [e0100000.mmc] using ADMA
ledtrig-cpu: registered to indicate activity on CPUs
hidraw: raw HID events driver (C) Jiri Kosina
usbcore: registered new interface driver usbhid
usbhid: USB HID core driver
adf4350 spi1.0: spi1.0 supply vcc not found, using dummy regulator
adf4350 spi1.0: Probe failed (muxout)
adf4350 spi1.1: spi1.1 supply vcc not found, using dummy regulator
adf4350 spi1.1: Probe failed (muxout)
fpga_manager fpga0: Xilinx Zynq FPGA Manager registered
Netfilter messages via NETLINK v0.30.
nfnl_acct: registering with nfnetlink.
mmc0: new high speed SDHC card at address aaaa
nf_conntrack version 0.5.0 (16384 buckets, 65536 max)
ctnetlink v0.93: registering with nfnetlink.
mmcblk0: mmc0:aaaa SS08G 7.40 GiB 
nf_tables: (c) 2007-2009 Patrick McHardy <kaber@trash.net>
nf_tables_compat: (c) 2012 Pablo Neira Ayuso <pablo@netfilter.org>
xt_time: kernel timezone is -0000
ip_tables: (C) 2000-2006 Netfilter Core Team
ipt_CLUSTERIP: ClusterIP Version 0.8 loaded successfully
arp_tables: arp_tables: (C) 2002 David S. Miller
NET: Registered protocol family 17
Registering SWP/SWPB emulation handler
 mmcblk0: p1 p2 p3
asoc-simple-card adv7511_hdmi_snd: spdif-hifi <-> 75c00000.axi-spdif-tx mapping ok
input: gpio_keys as /devices/soc0/gpio_keys/input/input0
rtc-pcf8563 5-0051: setting system clock to 1970-07-12 03:29:34 UTC (16601374)
ALSA device list:
  #0: HDMI monitor
EXT4-fs (mmcblk0p2): recovery complete
EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
VFS: Mounted root (ext4 filesystem) on device 179:2.
devtmpfs: mounted
Freeing unused kernel memory: 1024K
systemd-udevd[1075]: starting version 204
systemd-udevd[1105]: could not open builtin file '/lib/modules/4.14.0-g4fea7c58ad92-dirty/modules.builtin.bin'
systemd-udevd[1105]: could not open builtin file '/lib/modules/4.14.0-g4fea7c58ad92-dirty/modules.builtin.bin'
Registered mathworks_ip class
systemd-udevd[1105]: could not open builtin file '/lib/modules/4.14.0-g4fea7c58ad92-dirty/modules.builtin.bin'
systemd-udevd[1105]: could not open builtin file '/lib/modules/4.14.0-g4fea7c58ad92-dirty/modules.builtin.bin'
mwipcore 43c00000.mwipcore: Dev memory resource found at 43c00000 0000FFFF. 
mwipcore 43c00000.mwipcore: 'mwipcore' device not found, creating
mwipcore 43c00000.mwipcore: Char dev region registered: major num:242
mwipcore 43c00000.mwipcore: 'mwipcore' device created
init: udev-fallback-graphics main process (1543) terminated with status 1
init: samba-ad-dc main process (1762) terminated with status 1
macb e000b000.ethernet eth0: link up (1000/Full)
init: isc-dhcp-server main process (1873) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: isc-dhcp-server main process (1983) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: lightdm main process (1813) terminated with status 1
init: tty1 main process (2005) killed by TERM signal
init: isc-dhcp-server main process (2033) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: isc-dhcp-server main process (2063) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: isc-dhcp-server main process (2085) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: isc-dhcp-server main process (2101) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: isc-dhcp-server main process (2111) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: isc-dhcp-server main process (2121) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: isc-dhcp-server main process (2131) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: isc-dhcp-server main process (2141) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: isc-dhcp-server main process (2151) terminated with status 1
init: isc-dhcp-server respawning too fast, stopped
init: isc-dhcp-server main process (2307) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: isc-dhcp-server main process (2387) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: isc-dhcp-server main process (2419) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: isc-dhcp-server main process (2429) terminated with status 1
init: isc-dhcp-server main process ended, respawning
xilinx_dma: no symbol version for module_layout
xilinx-vdma 80400000.dma: Xilinx AXI DMA Engine Driver Probed!!
xilinx-vdma 80410000.dma: Xilinx AXI DMA Engine Driver Probed!!
tx_intf: loading out-of-tree module taints kernel.

sdr,tx_intf dev_probe match!
sdr,tx_intf dev_probe io start 0x83c0ffff83c00000 end 0x200ef7f56d4 name (null) flags 0xbf11401c desc 0xbf11401c
sdr,tx_intf dev_probe base_addr 0xf2910000
sdr,tx_intf dev_probe tx_intf_driver_api_inst 0xbf114284
sdr,tx_intf dev_probe             tx_intf_api 0xbf114284
sdr,tx_intf dev_probe succeed!
sdr,tx_intf hw_init mode 6
sdr,tx_intf hw_init mode TX_INTF_BW_20MHZ_AT_N_10MHZ_ANT1
sdr,tx_intf hw_init err 0
init: isc-dhcp-server main process (2453) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: isc-dhcp-server main process (2471) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: isc-dhcp-server main process (2481) terminated with status 1
init: isc-dhcp-server main process ended, respawning
ad9361 spi0.0: ad9361_probe : enter (ad9361)
init: isc-dhcp-server main process (2491) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: isc-dhcp-server main process (2504) terminated with status 1
init: isc-dhcp-server main process ended, respawning
ad9361 spi0.0: ad9361_probe : AD936x Rev 2 successfully initialized
random: crng init done
init: isc-dhcp-server main process (2514) terminated with status 1
init: isc-dhcp-server main process ended, respawning
init: isc-dhcp-server main process (2531) terminated with status 1
init: isc-dhcp-server respawning too fast, stopped
cf_axi_adc 79020000.cf-ad9361-lpc: ADI AIM (10.01.b) at 0x79020000 mapped to 0xf2a40000, probed ADC AD9361 as MASTER
cf_axi_dds 79024000.cf-ad9361-dds-core-lpc: Analog Devices CF_AXI_DDS_DDS MASTER (9.01.b) at 0x79024000 mapped to 0xf290d000, probed DDS AD9361

sdr,rx_intf dev_probe match!
sdr,rx_intf dev_probe io start 0x83c20000 end 0x83c2ffff name /fpga-axi@0/rx_intf@83c20000 flags 0x00000200 desc 0x00000000
sdr,rx_intf dev_probe base_addr 0xf2a90000
sdr,rx_intf dev_probe rx_intf_driver_api_inst 0xbf143284
sdr,rx_intf dev_probe             rx_intf_api 0xbf143284
sdr,rx_intf dev_probe succeed!
sdr,rx_intf hw_init mode 2
sdr,rx_intf hw_init mode DDC_BW_20MHZ_AT_0MHZ
sdr,rx_intf hw_init err 0

sdr,openofdm_tx dev_probe match!
sdr,openofdm_tx dev_probe io start 0x83c10000 end 0x83c1ffff name /fpga-axi@0/openofdm_tx@83c10000 flags 0x00000200 desc 0x00000000
sdr,openofdm_tx dev_probe base_addr 0xf2ad0000
sdr,openofdm_tx dev_probe openofdm_tx_driver_api_inst 0xbf14c284
sdr,openofdm_tx dev_probe             openofdm_tx_api 0xbf14c284
sdr,openofdm_tx dev_probe succeed!
sdr,openofdm_tx hw_init mode 1
sdr,openofdm_tx hw_init mode OPENOFDM_TX_NORMAL
sdr,openofdm_tx hw_init err 0

sdr,openofdm_rx dev_probe match!
sdr,openofdm_rx dev_probe io start 0x83c30000 end 0x83c3ffff name /fpga-axi@0/openofdm_rx@83c30000 flags 0x00000200 desc 0x00000000
sdr,openofdm_rx dev_probe base_addr 0xf2b10000
sdr,openofdm_rx dev_probe openofdm_rx_driver_api_inst 0xbf154284
sdr,openofdm_rx dev_probe             openofdm_rx_api 0xbf154284
sdr,openofdm_rx dev_probe succeed!
sdr,openofdm_rx hw_init mode 1
sdr,openofdm_rx hw_init mode OPENOFDM_RX_NORMAL
sdr,openofdm_rx hw_init input:
power_thres 0
min_plateau 100
sdr,openofdm_rx hw_init err 0

sdr,xpu dev_probe match!
sdr,xpu dev_probe io start 0x83c40000 end 0x83c4ffff name /fpga-axi@0/xpu@83c40000 flags 0x00000200 desc 0x00000000
sdr,xpu dev_probe base_addr 0xf2b70000
sdr,xpu dev_probe xpu_driver_api_inst 0xbf15d284
sdr,xpu dev_probe             xpu_api 0xbf15d284
sdr,xpu dev_probe reset tsf timer
sdr,xpu dev_probe XPU_REG_TSF_RUNTIME_VAL_LOW_read 1 33186 100194us
sdr,xpu dev_probe succeed!
sdr,xpu hw_init mode 1
sdr,xpu hw_init mode XPU_NORMAL
sdr,xpu hw_init err 0

sdr,sdr openwifi_dev_probe: match!
sdr,sdr custom_match_spi_dev ad9361-phy ad9361-phy 1
sdr,sdr bus_find_device ad9361-phy: ad9361. driver_data pointer ee42fa10
sdr,sdr ad9361_spi_to_phy ad9361-phy: ad9361
sdr,sdr openwifi_dev_probe: ad9361_ctrl_outs_setup en_mask 0xff index 0x16
sdr,sdr openwifi_dev_probe: ad9361_spi_read REG_CTRL_OUTPUT_POINTER 0x16
sdr,sdr openwifi_dev_probe: ad9361_spi_read REG_CTRL_OUTPUT_ENABLE 0xff
sdr,sdr custom_match_platform_dev 79024000.cf-ad9361-dds-core-lpc
sdr,sdr openwifi_dev_probe: cf-ad9361-dds-core-lpc dds_st->version 00090162 chip_info->name AD9361
sdr,sdr openwifi_dev_probe: cf_axi_dds_datasel DATA_SEL_DMA
sdr,sdr openwifi_dev_probe: priv->rf_bw == 40000000Hz. bool for 20000000 0, 40000000 1
sdr,sdr openwifi_dev_probe: test_mode 0
sdr,sdr openwifi_dev_probe: rfkill radio on
sdr,sdr openwifi_dev_probe: band_2GHz.n_channels 14 n_bitrates 12 band_5GHz.n_channels 11 n_bitrates 12
sdr,sdr openwifi_dev_probe: mac_addr 66:55:44:33:22:a7
ieee80211 phy0: Selected rate control algorithm 'minstrel_ht'
sdr,sdr openwifi_dev_probe: ieee80211_register_hw 0
ieee80211 phy0: hwaddr 6655443322a7, ZYNQ + ad9361
sdr,sdr openwifi_rfkill_init: wireless switch is on
sdr,sdr fpga-axi@0:sdr sdr0: renamed from wlan0
systemd-udevd[2586]: renamed network interface wlan0 to sdr0
sdr,sdr openwifi_start: rfkill radio on
sdr,sdr openwifi_start: ad9361_ctrl_outs_setup en_mask 0xff index 0x16
sdr,rx_intf hw_init mode 2
sdr,rx_intf hw_init mode DDC_BW_20MHZ_AT_0MHZ
sdr,rx_intf hw_init err 0
sdr,tx_intf hw_init mode 4
sdr,tx_intf hw_init mode TX_INTF_BW_20MHZ_AT_N_10MHZ_ANT0
sdr,tx_intf hw_init err 0
sdr,openofdm_tx hw_init mode 1
sdr,openofdm_tx hw_init mode OPENOFDM_TX_NORMAL
sdr,openofdm_tx hw_init err 0
sdr,openofdm_rx hw_init mode 1
sdr,openofdm_rx hw_init mode OPENOFDM_RX_NORMAL
sdr,openofdm_rx hw_init input:
power_thres 0
min_plateau 100
sdr,openofdm_rx hw_init err 0
sdr,xpu hw_init mode 1
sdr,xpu hw_init mode XPU_NORMAL
sdr,xpu hw_init err 0
sdr,sdr openwifi_start: rx_intf_cfg 2 openofdm_rx_cfg 1 tx_intf_cfg 4 openofdm_tx_cfg 1
sdr,sdr openwifi_start: rx_freq_offset_to_lo_MHz 0 tx_freq_offset_to_lo_MHz -10
sdr,sdr openwifi_start: DMA channel setup successfully.
sdr,sdr openwifi_start: irq_rx 53
sdr,sdr openwifi_start: irq_tx 55
sdr,sdr openwifi_start: normal end
sdr,sdr openwifi_add_interface start. vif for loop result 0
sdr,sdr openwifi_add_interface end with vif idx 0
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_ERP_CTS_PROT 0
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_ERP_SLOT 8 BSS_CHANGED_ERP_PREAMBLE 4 short slot 0
sdr,sdr openwifi_conf_tx: WARNING [queue 0], aifs: 2, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr openwifi_conf_tx: WARNING [queue 1], aifs: 2, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr openwifi_conf_tx: WARNING [queue 2], aifs: 2, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr openwifi_conf_tx: WARNING [queue 3], aifs: 2, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr ad9361_rf_set_channel 2412M rssi_correction 153 (change flag 1)
sdr,sdr openwifi_prepare_multicast
sdr,sdr openwifi_configure_filter MON 0 M_BCN 1 BST0 1 BST1 1 UST 1 PB_RQ 0 PS_PL 1 O_BSS 0 CTL 0 BCN_PRP 0 PCP_FL 0 FCS_FL 0 ALL_MUT 0
sdr,sdr openwifi_prepare_multicast
sdr,sdr openwifi_configure_filter MON 0 M_BCN 1 BST0 1 BST1 1 UST 1 PB_RQ 0 PS_PL 1 O_BSS 0 CTL 0 BCN_PRP 0 PCP_FL 0 FCS_FL 0 ALL_MUT 0
sdr,sdr openwifi_config changed flag 00000100
sdr,sdr openwifi_prepare_multicast
sdr,sdr openwifi_configure_filter MON 0 M_BCN 0 BST0 1 BST1 1 UST 1 PB_RQ 0 PS_PL 1 O_BSS 0 CTL 0 BCN_PRP 1 PCP_FL 0 FCS_FL 0 ALL_MUT 0
sdr,sdr ad9361_rf_set_channel 2412M rssi_correction 153 (change flag 0)
sdr,sdr ad9361_rf_set_channel 2417M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 2422M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 2427M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 2432M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 2437M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 2442M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 2447M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 2452M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 2457M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 2462M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 2467M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 2472M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 2484M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 5180M rssi_correction 145 (change flag 1)
sdr,sdr ad9361_rf_set_channel 5190M rssi_correction 145 (change flag 1)
sdr,sdr ad9361_rf_set_channel 5200M rssi_correction 145 (change flag 1)
sdr,sdr ad9361_rf_set_channel 5210M rssi_correction 145 (change flag 1)
sdr,sdr ad9361_rf_set_channel 5220M rssi_correction 145 (change flag 1)
sdr,sdr ad9361_rf_set_channel 5230M rssi_correction 145 (change flag 1)
sdr,sdr ad9361_rf_set_channel 5240M rssi_correction 145 (change flag 1)
sdr,sdr ad9361_rf_set_channel 5260M rssi_correction 148 (change flag 1)
sdr,sdr ad9361_rf_set_channel 5280M rssi_correction 148 (change flag 1)
sdr,sdr ad9361_rf_set_channel 5300M rssi_correction 148 (change flag 1)
sdr,sdr ad9361_rf_set_channel 5320M rssi_correction 148 (change flag 1)
sdr0: authenticate with 66:55:44:33:22:73
sdr0: Allocated STA 66:55:44:33:22:73
sdr,sdr ad9361_rf_set_channel 2412M rssi_correction 153 (change flag 1)
sdr,sdr openwifi_prepare_multicast
sdr,sdr openwifi_configure_filter MON 0 M_BCN 1 BST0 1 BST1 1 UST 1 PB_RQ 0 PS_PL 1 O_BSS 0 CTL 0 BCN_PRP 0 PCP_FL 0 FCS_FL 0 ALL_MUT 0
sdr,sdr openwifi_config changed flag 00000100
sdr,sdr openwifi_config changed flag 00000100
sdr,sdr ad9361_rf_set_channel 5220M rssi_correction 145 (change flag 1)
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_TXPOWER 14
sdr,sdr openwifi_bss_info_changed BSS_CHANGED_BSSID 665544332273
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_BEACON_INT 64
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_BASIC_RATES f0
sdr0: Inserted STA 66:55:44:33:22:73
sdr0: send auth to 66:55:44:33:22:73 (try 1/3)
sdr0: send auth to 66:55:44:33:22:73 (try 2/3)
sdr0: authenticated
sdr0: moving STA 66:55:44:33:22:73 to state 2
sdr,sdr fpga-axi@0:sdr sdr0: disabling HT as WMM/QoS is not supported by the AP
sdr,sdr fpga-axi@0:sdr sdr0: disabling VHT as WMM/QoS is not supported by the AP
sdr0: associate with 66:55:44:33:22:73 (try 1/3)
sdr,sdr openwifi_tx: WARNING sn 23 skb_headroom(skb)<LEN_PHY_HEADER
sdr0: RX AssocResp from 66:55:44:33:22:73 (capab=0x1 status=0 aid=1)
sdr0: moving STA 66:55:44:33:22:73 to state 3
sdr0: moving STA 66:55:44:33:22:73 to state 4
sdr,sdr openwifi_conf_tx: WARNING [queue 0], aifs: 2, cw_min: 3, cw_max: 7, txop: 47
sdr,sdr openwifi_conf_tx: WARNING [queue 1], aifs: 2, cw_min: 7, cw_max: 15, txop: 94
sdr,sdr openwifi_conf_tx: WARNING [queue 2], aifs: 3, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr openwifi_conf_tx: WARNING [queue 3], aifs: 7, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_ERP_SLOT 8 BSS_CHANGED_ERP_PREAMBLE 0 short slot 1
sdr0: associated
sdr,sdr openwifi_prepare_multicast
sdr,sdr openwifi_configure_filter MON 0 M_BCN 1 BST0 1 BST1 1 UST 1 PB_RQ 0 PS_PL 1 O_BSS 0 CTL 0 BCN_PRP 0 PCP_FL 0 FCS_FL 0 ALL_MUT 0
sdr0: disassociated from 66:55:44:33:22:73 (Reason: 7=CLASS3_FRAME_FROM_NONASSOC_STA)
sdr0: moving STA 66:55:44:33:22:73 to state 3
sdr0: moving STA 66:55:44:33:22:73 to state 2
sdr0: moving STA 66:55:44:33:22:73 to state 1
sdr0: Removed STA 66:55:44:33:22:73
sdr0: Destroyed STA 66:55:44:33:22:73
sdr,sdr openwifi_bss_info_changed BSS_CHANGED_BSSID 000000000000
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_ERP_CTS_PROT 0
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_ERP_SLOT 8 BSS_CHANGED_ERP_PREAMBLE 4 short slot 0
sdr,sdr openwifi_conf_tx: WARNING [queue 0], aifs: 2, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr openwifi_conf_tx: WARNING [queue 1], aifs: 2, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr openwifi_conf_tx: WARNING [queue 2], aifs: 2, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr openwifi_conf_tx: WARNING [queue 3], aifs: 2, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr ad9361_rf_set_channel 5220M rssi_correction 145 (change flag 0)
sdr,sdr openwifi_config changed flag 00000100
sdr,sdr openwifi_prepare_multicast
sdr,sdr openwifi_configure_filter MON 0 M_BCN 1 BST0 1 BST1 1 UST 1 PB_RQ 0 PS_PL 1 O_BSS 0 CTL 0 BCN_PRP 0 PCP_FL 0 FCS_FL 0 ALL_MUT 0
sdr,sdr openwifi_prepare_multicast
sdr,sdr openwifi_configure_filter MON 0 M_BCN 1 BST0 1 BST1 1 UST 1 PB_RQ 0 PS_PL 1 O_BSS 0 CTL 0 BCN_PRP 0 PCP_FL 0 FCS_FL 0 ALL_MUT 0
sdr,sdr openwifi_config changed flag 00000100
sdr,sdr openwifi_prepare_multicast
sdr,sdr openwifi_configure_filter MON 0 M_BCN 0 BST0 1 BST1 1 UST 1 PB_RQ 0 PS_PL 1 O_BSS 0 CTL 0 BCN_PRP 1 PCP_FL 0 FCS_FL 0 ALL_MUT 0
sdr,sdr ad9361_rf_set_channel 2412M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 2417M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 2422M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 2427M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 2432M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 2437M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 2442M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 2447M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 2452M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 2457M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 2462M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 2467M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 2472M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 2484M rssi_correction 153 (change flag 1)
sdr,sdr ad9361_rf_set_channel 5180M rssi_correction 145 (change flag 1)
sdr,sdr ad9361_rf_set_channel 5190M rssi_correction 145 (change flag 1)
sdr,sdr ad9361_rf_set_channel 5200M rssi_correction 145 (change flag 1)
sdr,sdr ad9361_rf_set_channel 5210M rssi_correction 145 (change flag 1)
sdr,sdr ad9361_rf_set_channel 5220M rssi_correction 145 (change flag 1)
sdr,sdr ad9361_rf_set_channel 5230M rssi_correction 145 (change flag 1)
sdr,sdr ad9361_rf_set_channel 5240M rssi_correction 145 (change flag 1)
sdr,sdr ad9361_rf_set_channel 5260M rssi_correction 148 (change flag 1)
sdr,sdr ad9361_rf_set_channel 5280M rssi_correction 148 (change flag 1)
sdr,sdr ad9361_rf_set_channel 5300M rssi_correction 148 (change flag 1)
sdr,sdr ad9361_rf_set_channel 5320M rssi_correction 148 (change flag 1)
sdr0: authenticate with 66:55:44:33:22:73
sdr0: Allocated STA 66:55:44:33:22:73
sdr,sdr ad9361_rf_set_channel 5220M rssi_correction 145 (change flag 1)
sdr,sdr openwifi_prepare_multicast
sdr,sdr openwifi_configure_filter MON 0 M_BCN 1 BST0 1 BST1 1 UST 1 PB_RQ 0 PS_PL 1 O_BSS 0 CTL 0 BCN_PRP 0 PCP_FL 0 FCS_FL 0 ALL_MUT 0
sdr,sdr openwifi_config changed flag 00000100
sdr,sdr openwifi_config changed flag 00000100
sdr,sdr ad9361_rf_set_channel 5220M rssi_correction 145 (change flag 0)
sdr,sdr openwifi_bss_info_changed BSS_CHANGED_BSSID 665544332273
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_BEACON_INT 64
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_BASIC_RATES f0
sdr0: Inserted STA 66:55:44:33:22:73
sdr0: send auth to 66:55:44:33:22:73 (try 1/3)
sdr0: authenticated
sdr0: moving STA 66:55:44:33:22:73 to state 2
sdr,sdr fpga-axi@0:sdr sdr0: disabling HT as WMM/QoS is not supported by the AP
sdr,sdr fpga-axi@0:sdr sdr0: disabling VHT as WMM/QoS is not supported by the AP
sdr0: associate with 66:55:44:33:22:73 (try 1/3)
sdr,sdr openwifi_tx: WARNING sn 46 skb_headroom(skb)<LEN_PHY_HEADER
sdr0: RX AssocResp from 66:55:44:33:22:73 (capab=0x1 status=0 aid=1)
sdr0: moving STA 66:55:44:33:22:73 to state 3
sdr0: moving STA 66:55:44:33:22:73 to state 4
sdr,sdr openwifi_conf_tx: WARNING [queue 0], aifs: 2, cw_min: 3, cw_max: 7, txop: 47
sdr,sdr openwifi_conf_tx: WARNING [queue 1], aifs: 2, cw_min: 7, cw_max: 15, txop: 94
sdr,sdr openwifi_conf_tx: WARNING [queue 2], aifs: 3, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr openwifi_conf_tx: WARNING [queue 3], aifs: 7, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_ERP_SLOT 8 BSS_CHANGED_ERP_PREAMBLE 0 short slot 1
sdr0: associated
sdr0: disassociated from 66:55:44:33:22:73 (Reason: 7=CLASS3_FRAME_FROM_NONASSOC_STA)
sdr0: moving STA 66:55:44:33:22:73 to state 3
sdr0: moving STA 66:55:44:33:22:73 to state 2
sdr0: moving STA 66:55:44:33:22:73 to state 1
sdr0: Removed STA 66:55:44:33:22:73
sdr0: Destroyed STA 66:55:44:33:22:73
sdr,sdr openwifi_bss_info_changed BSS_CHANGED_BSSID 000000000000
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_ERP_CTS_PROT 0
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_ERP_SLOT 8 BSS_CHANGED_ERP_PREAMBLE 4 short slot 0
sdr,sdr openwifi_conf_tx: WARNING [queue 0], aifs: 2, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr openwifi_conf_tx: WARNING [queue 1], aifs: 2, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr openwifi_conf_tx: WARNING [queue 2], aifs: 2, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr openwifi_conf_tx: WARNING [queue 3], aifs: 2, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr ad9361_rf_set_channel 5220M rssi_correction 145 (change flag 0)
sdr,sdr openwifi_config changed flag 00000100
sdr0: authenticate with 66:55:44:33:22:73
sdr0: Allocated STA 66:55:44:33:22:73
sdr,sdr openwifi_config changed flag 00000100
sdr,sdr ad9361_rf_set_channel 5220M rssi_correction 145 (change flag 0)
sdr,sdr openwifi_bss_info_changed BSS_CHANGED_BSSID 665544332273
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_BEACON_INT 64
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_BASIC_RATES f0
sdr0: Inserted STA 66:55:44:33:22:73
sdr0: send auth to 66:55:44:33:22:73 (try 1/3)
sdr0: send auth to 66:55:44:33:22:73 (try 2/3)
sdr0: authenticated
sdr0: moving STA 66:55:44:33:22:73 to state 2
sdr,sdr fpga-axi@0:sdr sdr0: disabling HT as WMM/QoS is not supported by the AP
sdr,sdr fpga-axi@0:sdr sdr0: disabling VHT as WMM/QoS is not supported by the AP
sdr0: associate with 66:55:44:33:22:73 (try 1/3)
sdr,sdr openwifi_tx: WARNING sn 49 skb_headroom(skb)<LEN_PHY_HEADER
sdr0: associate with 66:55:44:33:22:73 (try 2/3)
sdr,sdr openwifi_tx: WARNING sn 50 skb_headroom(skb)<LEN_PHY_HEADER
sdr0: associate with 66:55:44:33:22:73 (try 3/3)
sdr,sdr openwifi_tx: WARNING sn 51 skb_headroom(skb)<LEN_PHY_HEADER
sdr0: RX AssocResp from 66:55:44:33:22:73 (capab=0x1 status=0 aid=1)
sdr0: moving STA 66:55:44:33:22:73 to state 3
sdr0: moving STA 66:55:44:33:22:73 to state 4
sdr,sdr openwifi_conf_tx: WARNING [queue 0], aifs: 2, cw_min: 3, cw_max: 7, txop: 47
sdr,sdr openwifi_conf_tx: WARNING [queue 1], aifs: 2, cw_min: 7, cw_max: 15, txop: 94
sdr,sdr openwifi_conf_tx: WARNING [queue 2], aifs: 3, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr openwifi_conf_tx: WARNING [queue 3], aifs: 7, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_ERP_SLOT 8 BSS_CHANGED_ERP_PREAMBLE 0 short slot 1
sdr0: associated
sdr0: disassociated from 66:55:44:33:22:73 (Reason: 7=CLASS3_FRAME_FROM_NONASSOC_STA)
sdr0: moving STA 66:55:44:33:22:73 to state 3
sdr0: moving STA 66:55:44:33:22:73 to state 2
sdr0: moving STA 66:55:44:33:22:73 to state 1
sdr0: Removed STA 66:55:44:33:22:73
sdr0: Destroyed STA 66:55:44:33:22:73
sdr,sdr openwifi_bss_info_changed BSS_CHANGED_BSSID 000000000000
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_ERP_CTS_PROT 0
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_ERP_SLOT 8 BSS_CHANGED_ERP_PREAMBLE 4 short slot 0
sdr,sdr openwifi_conf_tx: WARNING [queue 0], aifs: 2, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr openwifi_conf_tx: WARNING [queue 1], aifs: 2, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr openwifi_conf_tx: WARNING [queue 2], aifs: 2, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr openwifi_conf_tx: WARNING [queue 3], aifs: 2, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr ad9361_rf_set_channel 5220M rssi_correction 145 (change flag 0)
sdr,sdr openwifi_config changed flag 00000100
JiaoXianjun commented 4 years ago

Seems like an issue we are working on internally. If you try more, there will be a chance to connect.

Have you tried to “switch the role of openwifi AP and client board”. ?

Leo-Cheung-CUHK commented 4 years ago

Yes, I switch the role of openwifi AP and client board, but nothing changes. I try many times, but so far, I haven't got a chance to connect it. I think it may because that the Zynq-client somehow did not send back an ACK during the association procedure with a Zynq-AP.

Find a related problem in this link https://eznemegy.blog.hu/2008/12/14/using_rt2x00_wireless_driver_with_hostapd

JiaoXianjun commented 4 years ago

But both openwifi AP and client can work with commercial device. Right?

If so, it could be the same issue we are tracking internally. Could be because that the client send out ack, but somehow the AP receiver doesn’t decode it successfully.

I will send you a temporary work around tomorrow.

Leo-Cheung-CUHK commented 4 years ago

Yes, both openwifi AP and client can work with the commercial devices.

Looking for your kind reply!!!

FYI: 1) Everything goes well when setting up an ad-hoc network among Zynqs.
2) When connecting to a commercial AP on 2.4GHz (802.11g) rather than 5GHz (802.11a), Zynq-STA cannot pass the authentication and fail to connect to this AP.

JiaoXianjun commented 4 years ago

Hi,

Attached is a quick and dirty patch to avoid the issue temporarily. patch_public_issue_26.txt

Patch is very simple. At AP side, just replace (sdr.c): if ((tx_result_report&0x10)==0) by: if ((tx_result_report&0x10)==0 || priv->drv_xpu_reg_val[0])

Then recompile the driver (you could use driver/make_all.sh), and put/load the new driver on AP board. For client, you don't need to update the driver.

Usage:

  1. Before your openwifi client tries to connect openwifi AP, issue the follow command at AP side: ./sdrctl dev sdr0 set reg drv_xpu 0 1 This command will always tell Linux mac80211 (AP side) the packet is sent successfully, even the ACK is not decoded well.

  2. After your client is connected successfully, you could disable this "fake ACK status" at AP side by: ./sdrctl dev sdr0 set reg drv_xpu 0 0

Good luck!

Leo-Cheung-CUHK commented 4 years ago

Xianjun, it works!!! Thanks a lot for your kind help.

JiaoXianjun commented 4 years ago

Hi,

Nice to know.

This simple patch also reveal many connected information: how does sdrctl channel work, how to pass the tx status to Linux, etc. I believe you can modify the design further according to your idea.

I will leave this issue open until we have formal/decent solution for this issue.

Have fun!

Leo-Cheung-CUHK commented 4 years ago

Yes, it takes me some time to figure out these related parts in the driver. I May ask you some detailed questions later, and thanks for your help again.

DatPhungThe commented 4 years ago

Yes, both openwifi AP and client can work with the commercial devices.

Looking for your kind reply!!!

FYI: 1) Everything goes well when setting up an ad-hoc network among Zynqs. 2) When connecting to a commercial AP on 2.4GHz (802.11g) rather than 5GHz (802.11a), Zynq-STA cannot pass the authentication and fail to connect to this AP.

Hello Leo-Cheung-CUHK, Did you resolve the 2nd issue in your above comment ? I am involved in the same problem. My Zynq-STA client (is implemented in Zedboard) is only connect to 2 commercial APs at channels: Channel 1 (2.412 GHz) and Channel 11 (2.462 GHz). It cannot find the other commercial APs (at Channel 4, Channel 6, Channel 9,...) If you know the reason and solution of this issue, please share it with me.

Thank you very very much !!

JiaoXianjun commented 4 years ago

Hello,

We have performance update recently. Would you please help us do a test to check whether the issue has gone in our latest update (you can pull the code and build or use the image directly) at your side (do not apply the work around)

Thanks!

DatPhungThe commented 4 years ago

Hello Xianjun,

Thanks for your great efforts !

I have tried to connect an Zynq-Client (Zedboard) to an Zynq-AP (Zedboard) on 2.4 GHz and 5GHz band (AP-Client mode). But the connection process always fail in Authentication or Association phase (most of them are Authentication Failed). I followed your instruction in the file: _openwifi/doc/appnotes/ap-client-two-sdr.md

In AP Board:

cd openwifi
./fosdem.sh
./sdrctl dev sdr0 set reg drv_xpu 0 1
./sdrctl dev sdr0 set reg drv_tx 7 3
./sdrctl dev sdr0 set reg drv_rx 7 3

In Client Board:

service network-manager stop
cd openwifi
./wgd.sh
ifconfig sdr0 up
./sdrctl dev sdr0 set reg drv_xpu 0 1
./sdrctl dev sdr0 set reg drv_tx 7 3
./sdrctl dev sdr0 set reg drv_rx 7 3
iwlist sdr0 scan
=> The "openwifi" AP is shown in the scanning results.
iwconfig sdr0 essid openwifi

When I observed the "dmesg" output on both side, I saw that:

The dmesg on Client is:

sdr0: Inserted STA 66:55:44:33:22:d5
sdr0: send auth to 66:55:44:33:22:d5 (try 1/3)
sdr,sdr openwifi_tx:   30bytes  1M FC00b0 DI013a addr1/2/3:6655443322d5/66554433226e/6655443322d5 SC1b90 flag40010012 retr1 ack1 prio0 q0 wr57 rd56
sdr,sdr openwifi_tx_interrupt: WARNING loop_count 0
sdr0: send auth to 66:55:44:33:22:d5 (try 2/3)
sdr,sdr openwifi_tx:   30bytes  1M FC00b0 DI013a addr1/2/3:6655443322d5/66554433226e/6655443322d5 SC1ba0 flag40010012 retr1 ack1 prio0 q0 wr58 rd57
sdr,sdr openwifi_tx_interrupt: WARNING loop_count 0
sdr0: send auth to 66:55:44:33:22:d5 (try 3/3)
sdr,sdr openwifi_tx:   30bytes  1M FC00b0 DI013a addr1/2/3:6655443322d5/66554433226e/6655443322d5 SC1bb0 flag40010012 retr1 ack1 prio0 q0 wr59 rd58
sdr0: authentication with 66:55:44:33:22:d5 timed out
sdr0: Removed STA 66:55:44:33:22:d5
sdr0: Destroyed STA 66:55:44:33:22:d5

The dmesg on AP is:

sdr,sdr openwifi_tx:   72bytes  6M FC0050 DI00ac addr1/2/3:66554433226e/6655443322d5/6655443322d5 SC0410 flag4000001e retr1 ack0 prio0 q0 wr20 rd19
sdr,sdr openwifi_tx_interrupt: WARNING loop_count 0
sdr,sdr openwifi_tx:   72bytes  6M FC0050 DI00ac addr1/2/3:66554433226e/6655443322d5/6655443322d5 SC0420 flag4000001e retr1 ack0 prio0 q0 wr52 rd51
sdr,sdr openwifi_tx_interrupt: WARNING loop_count 0
sdr,sdr openwifi_tx_interrupt: WARNING loop_count 0
sdr,sdr openwifi_rx_interrupt:  34bytes  6M FC08b0 DI013a addr1/2/3:6655443322d5/66554433226e/6655443322d5 SC1ba0 fcs1 buf_idx15 -45dBm
sdr,sdr openwifi_tx:   30bytes  1M FC00b0 DI013a addr1/2/3:66554433226e/6655443322d5/6655443322d5 SC0430 flag4020001b retr1 ack1 prio0 q0 wr63 rd62
sdr,sdr openwifi_tx_interrupt: WARNING loop_count 0
sdr,sdr openwifi_rx_interrupt:  34bytes  6M FC08b0 DI013a addr1/2/3:6655443322d5/66554433226e/6655443322d5 SC1bb0 fcs1 buf_idx0 -46dBm
sdr,sdr openwifi_tx:   30bytes  1M FC00b0 DI013a addr1/2/3:66554433226e/6655443322d5/6655443322d5 SC0440 flag4020001b retr1 ack1 prio0 q0 wr1 rd0
sdr,sdr openwifi_tx_interrupt: WARNING loop_count 0
sdr,sdr openwifi_tx_interrupt: WARNING loop_count 0
sdr,sdr openwifi_tx_interrupt: WARNING loop_count 0

I tried to switch the role of openwifi AP and client board, but the result did not change.

Could you give me some advices on how to solve the above problem? Thank you very much !

JiaoXianjun commented 4 years ago

Are you using the image provided by us? The issue only happens when you use two SDR boards? Each board can communicate with commercial devices?

DatPhungThe commented 4 years ago

Hi Xianjun,

I am using the SD Cards whose contents I built myself from your project, based on your instructions in the section: "Build openwifi Linux img from scratch". The issue appears when I try to connect 2 Openwifi Zedboards. Openwifi AP and client can communicate with the commercial devices seperately.

BTW, I am going to download your latest image and check whether the problem happens with it.

Best Regards,

DatPhungThe commented 4 years ago

I have tested with your image. Now I can connect 2 Openwifi boards at the certain time, but it looks like unstable. There are some unexpected cases I met during testing:

  1. It is still authenticated Failed, same as my above description.

The dmesg output on Client:

sdr0: Inserted STA 66:55:44:33:22:d2
sdr0: send auth to 66:55:44:33:22:d2 (try 1/3)
sdr,sdr openwifi_tx:   30bytes  1M FC00b0 DI00ac addr1/2/3:6655443322d2/6655443322dc/6655443322d2 SC0160 flag40010012 retr1 ack1 prio0 q0 wr21 rd20
sdr,sdr openwifi_tx_interrupt: WARNING tx_result 10 prio0 wr22 rd21
sdr0: send auth to 66:55:44:33:22:d2 (try 2/3)
sdr,sdr openwifi_tx:   30bytes  1M FC00b0 DI00ac addr1/2/3:6655443322d2/6655443322dc/6655443322d2 SC0170 flag40010012 retr1 ack1 prio0 q0 wr22 rd21
sdr,sdr openwifi_tx_interrupt: WARNING tx_result 10 prio0 wr23 rd22
sdr0: send auth to 66:55:44:33:22:d2 (try 3/3)
sdr,sdr openwifi_tx:   30bytes  1M FC00b0 DI00ac addr1/2/3:6655443322d2/6655443322dc/6655443322d2 SC0180 flag40010012 retr1 ack1 prio0 q0 wr23 rd22
sdr,sdr openwifi_tx_interrupt: WARNING tx_result 10 prio0 wr24 rd23
sdr0: authentication with 66:55:44:33:22:d2 timed out
sdr0: Removed STA 66:55:44:33:22:d2
sdr0: Destroyed STA 66:55:44:33:22:d2

The dmesg output on AP:

sdr,sdr openwifi_tx:   69bytes  6M FC0050 DI00ac addr1/2/3:ba3bf50fd1ae/6655443322d2/6655443322d2 SC42e0 flag4000001e retr1 ack0 prio0 q0 wr45 rd44
sdr,sdr openwifi_rx_interrupt:  34bytes ht0  6M FC00b0 DI00ac addr1/2/3:6655443322d2/6655443322dc/6655443322d2 SC0170 fcs1 buf_idx6 -64dBm
sdr,sdr openwifi_tx:   30bytes  1M FC00b0 DI00ac addr1/2/3:6655443322dc/6655443322d2/6655443322d2 SC4530 flag4020001b retr1 ack1 prio0 q0 wr18 rd17
sdr,sdr openwifi_tx_interrupt: WARNING tx_result 10 prio0 wr19 rd18
sdr,sdr openwifi_rx_interrupt:  34bytes ht0  6M FC00b0 DI00ac addr1/2/3:6655443322d2/6655443322dc/6655443322d2 SC0180 fcs1 buf_idx7 -64dBm
sdr,sdr openwifi_tx:   30bytes  1M FC00b0 DI00ac addr1/2/3:6655443322dc/6655443322d2/6655443322d2 SC4550 flag4020001b retr1 ack1 prio0 q0 wr20 rd19
sdr,sdr openwifi_tx_interrupt: WARNING tx_result 10 prio0 wr21 rd20

When I repeated the command: "iwconfig sdr0 essid openwifi" 2-3 times, AP and STA were handshaked again and could be associated successfully.

  1. AP and STA were authenticated and associated successfully, but then DHCP process can not allocate IP to STA.

In Client Openwifi Board:

dhclient sdr0 
=> Wait for it exiting by itself and check ifconfig.
It shows: sdr0:avahi .... with IP Address: 169.254.x.x

The dmesg output on Client:

sdr0: Inserted STA 66:55:44:33:22:a9
sdr0: send auth to 66:55:44:33:22:a9 (try 1/3)
sdr,sdr openwifi_tx:   30bytes  1M FC00b0 DI013a addr1/2/3:6655443322a9/66554433220a/6655443322a9 SC06a0 flag40010012 retr1 ack1 prio0 q0 wr41 rd40
sdr,sdr openwifi_tx_interrupt: WARNING tx_result 10 prio0 wr42 rd41
sdr0: send auth to 66:55:44:33:22:a9 (try 2/3)
sdr,sdr openwifi_tx:   30bytes  1M FC00b0 DI013a addr1/2/3:6655443322a9/66554433220a/6655443322a9 SC06b0 flag40010012 retr1 ack1 prio0 q0 wr42 rd41
sdr,sdr openwifi_tx_interrupt: WARNING tx_result 10 prio0 wr43 rd42
sdr,sdr openwifi_rx_interrupt:  34bytes ht0  6M FC00b0 DI013a addr1/2/3:66554433220a/6655443322a9/6655443322a9 SC6570 fcs1 buf_idx2 -50dBm
sdr0: authenticated
sdr0: moving STA 66:55:44:33:22:a9 to state 2
sdr,sdr fpga-axi@0:sdr sdr0: disabling HT as WMM/QoS is not supported by the AP
sdr,sdr fpga-axi@0:sdr sdr0: disabling VHT as WMM/QoS is not supported by the AP
sdr0: associate with 66:55:44:33:22:a9 (try 1/3)
sdr,sdr openwifi_tx:   58bytes  1M FC0000 DI013a addr1/2/3:6655443322a9/66554433220a/6655443322a9 SC06c0 flag40010012 retr1 ack1 prio0 q0 wr43 rd42
sdr,sdr openwifi_tx: WARNING sn 43 skb_headroom(skb)<LEN_PHY_HEADER
sdr,sdr openwifi_tx_interrupt: WARNING tx_result 10 prio0 wr44 rd43
sdr,sdr openwifi_rx_interrupt:  54bytes ht0  6M FC0010 DI013a addr1/2/3:66554433220a/6655443322a9/6655443322a9 SC6580 fcs1 buf_idx3 -50dBm
sdr0: RX AssocResp from 66:55:44:33:22:a9 (capab=0x401 status=0 aid=1)
sdr0: moving STA 66:55:44:33:22:a9 to state 3
sdr0: moving STA 66:55:44:33:22:a9 to state 4
sdr,sdr openwifi_conf_tx: WARNING [queue 0], aifs: 2, cw_min: 3, cw_max: 7, txop: 47
sdr,sdr openwifi_conf_tx: WARNING [queue 1], aifs: 2, cw_min: 7, cw_max: 15, txop: 94
sdr,sdr openwifi_conf_tx: WARNING [queue 2], aifs: 3, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr openwifi_conf_tx: WARNING [queue 3], aifs: 7, cw_min: 15, cw_max: 1023, txop: 0
sdr,sdr openwifi_bss_info_changed WARNING BSS_CHANGED_ERP_SLOT 8 BSS_CHANGED_ERP_PREAMBLE 0 short slot 1
sdr0: associated
sdr,sdr openwifi_tx:   50bytes  6M FC0040 DI0040 addr1/2/3:6655443322a9/66554433220a/6655443322a9 SC06d0 flag40010012 retr1 ack1 prio0 q0 wr44 rd43
sdr,sdr openwifi_tx_interrupt: WARNING tx_result 10 prio0 wr45 rd44
sdr0: No probe response from AP 66:55:44:33:22:a9 after 500ms, try 1/5
sdr,sdr openwifi_tx:   50bytes  6M FC0040 DI0040 addr1/2/3:6655443322a9/66554433220a/6655443322a9 SC06e0 flag40010012 retr1 ack1 prio0 q0 wr45 rd44
sdr,sdr openwifi_tx_interrupt: WARNING tx_result 10 prio0 wr46 rd45
sdr,sdr openwifi_rx_interrupt:  76bytes ht0  6M FC0050 DI013a addr1/2/3:66554433220a/6655443322a9/6655443322a9 SC75f0 fcs1 buf_idx2 -51dBm
sdr,sdr openwifi_tx:   50bytes  6M FC0040 DI0040 addr1/2/3:6655443322a9/66554433220a/6655443322a9 SC06f0 flag40010012 retr1 ack1 prio0 q0 wr46 rd45
sdr,sdr openwifi_tx_interrupt: WARNING tx_result 10 prio0 wr47 rd46
sdr,sdr openwifi_rx_interrupt:  76bytes ht0  6M FC0050 DI013a addr1/2/3:66554433220a/6655443322a9/6655443322a9 SC8660 fcs1 buf_idx5 -51dBm
sdr,sdr openwifi_prepare_multicast
sdr,sdr openwifi_configure_filter MON 0 M_BCN 1 BST0 1 BST1 1 UST 1 PB_RQ 0 PS_PL 1 O_BSS 0 CTL 0 BCN_PRP 0 PCP_FL 0 FCS_FL 0 ALL_MUT 0
sdr,sdr openwifi_tx:  360bytes 54M FC0108 DI002c addr1/2/3:6655443322a9/66554433220a/ffffffffffff SC0700 flag40000012 retr2 ack1 prio2 q2 wr0 rd0
sdr,sdr openwifi_tx_interrupt: WARNING tx_result 11 prio2 wr1 rd0
sdr,sdr openwifi_tx:  360bytes  6M FC0108 DI0040 addr1/2/3:6655443322a9/66554433220a/ffffffffffff SC0710 flag40000012 retr1 ack1 prio2 q2 wr1 rd0
sdr,sdr openwifi_tx_interrupt: WARNING tx_result 10 prio2 wr2 rd1
sdr,sdr openwifi_tx:   50bytes  6M FC0040 DI0040 addr1/2/3:6655443322a9/66554433220a/6655443322a9 SC0720 flag40010012 retr1 ack1 prio0 q0 wr47 rd46
sdr,sdr openwifi_tx_interrupt: WARNING tx_result 10 prio0 wr48 rd47
sdr0: No probe response from AP 66:55:44:33:22:a9 after 500ms, try 1/5
sdr,sdr openwifi_tx:   50bytes  6M FC0040 DI0040 addr1/2/3:6655443322a9/66554433220a/6655443322a9 SC0730 flag40010012 retr1 ack1 prio0 q0 wr48 rd47
sdr,sdr openwifi_tx_interrupt: WARNING tx_result 10 prio0 wr49 rd48
sdr0: cancelling AP probe due to a received beacon
sdr,sdr openwifi_tx:  360bytes  6M FC0108 DI0040 addr1/2/3:6655443322a9/66554433220a/ffffffffffff SC0740 flag40000012 retr1 ack1 prio2 q2 wr2 rd1
sdr,sdr openwifi_tx_interrupt: WARNING tx_result 10 prio2 wr3 rd2
sdr,sdr openwifi_tx:  360bytes  6M FC0108 DI0040 addr1/2/3:6655443322a9/66554433220a/ffffffffffff SC0750 flag40000012 retr1 ack1 prio2 q2 wr3 rd2
sdr,sdr openwifi_tx_interrupt: WARNING tx_result 10 prio2 wr4 rd3
sdr,sdr openwifi_rx_interrupt:  30bytes ht0  6M FC00a0 DI013a addr1/2/3:66554433220a/6655443322a9/6655443322a9 SC00a0 fcs1 buf_idx5 -48dBm
sdr0: disassociated from 66:55:44:33:22:a9 (Reason: 7=CLASS3_FRAME_FROM_NONASSOC_STA)
sdr0: moving STA 66:55:44:33:22:a9 to state 3
sdr0: moving STA 66:55:44:33:22:a9 to state 2
sdr0: moving STA 66:55:44:33:22:a9 to state 1
sdr0: Removed STA 66:55:44:33:22:a9
sdr0: Destroyed STA 66:55:44:33:22:a9

The dmesg output on AP:

sdr,sdr openwifi_tx:   72bytes  6M FC0050 DI00ac addr1/2/3:66554433220a/6655443322a9/6655443322a9 SC3f10 flag4000001e retr1 ack0 prio0 q0 wr48 rd47
sdr,sdr openwifi_tx:   72bytes  6M FC0050 DI00ac addr1/2/3:66554433220a/6655443322a9/6655443322a9 SC4380 flag4000001e retr1 ack0 prio0 q0 wr55 rd54
sdr,sdr openwifi_tx:   72bytes  6M FC0050 DI00ac addr1/2/3:66554433220a/6655443322a9/6655443322a9 SC6230 flag4000001e retr1 ack0 prio0 q0 wr34 rd33
sdr,sdr openwifi_tx:   72bytes  6M FC0050 DI00ac addr1/2/3:66554433220a/6655443322a9/6655443322a9 SC6270 flag4000001e retr1 ack0 prio0 q0 wr38 rd37
sdr,sdr openwifi_rx_interrupt:  34bytes ht0  6M FC00b0 DI013a addr1/2/3:6655443322a9/66554433220a/6655443322a9 SC06b0 fcs1 buf_idx6 -47dBm
sdr,sdr openwifi_tx:   30bytes  1M FC00b0 DI013a addr1/2/3:66554433220a/6655443322a9/6655443322a9 SC6570 flag4020001b retr1 ack1 prio0 q0 wr22 rd21
sdr,sdr openwifi_rx_interrupt:  62bytes ht0  6M FC0000 DI013a addr1/2/3:6655443322a9/66554433220a/6655443322a9 SC06c0 fcs1 buf_idx7 -47dBm
sdr,sdr openwifi_tx:   50bytes  1M FC0010 DI013a addr1/2/3:66554433220a/6655443322a9/6655443322a9 SC6580 flag4020001b retr1 ack1 prio0 q0 wr23 rd22
sdr,sdr openwifi_tx_interrupt: WARNING tx_result 10 prio0 wr24 rd23
sdr,sdr openwifi_rx_interrupt:1469bytes ht0  9M FC7441 DI8db1 addr1/2/3:b967ed0f3060/7e64226ae697/af257f110025 SC3a8b fcs0 buf_idx8 -64dBm
sdr,sdr openwifi_rx_interrupt:  54bytes ht0  6M FC0040 DI0040 addr1/2/3:6655443322a9/66554433220a/6655443322a9 SC06d0 fcs1 buf_idx9 -47dBm
sdr,sdr openwifi_tx:   72bytes  1M FC0050 DI013a addr1/2/3:66554433220a/6655443322a9/6655443322a9 SC7590 flag4020001b retr1 ack1 prio0 q0 wr24 rd23
sdr,sdr openwifi_tx_interrupt: WARNING tx_result 10 prio0 wr25 rd24
sdr,sdr openwifi_rx_interrupt:  54bytes ht0  6M FC0040 DI0040 addr1/2/3:6655443322a9/66554433220a/6655443322a9 SC06e0 fcs1 buf_idx10 -47dBm
sdr,sdr openwifi_tx:   72bytes  1M FC0050 DI013a addr1/2/3:66554433220a/6655443322a9/6655443322a9 SC75f0 flag4020001b retr1 ack1 prio0 q0 wr30 rd29
sdr,sdr openwifi_rx_interrupt:  54bytes ht0  6M FC0040 DI0040 addr1/2/3:6655443322a9/66554433220a/6655443322a9 SC06f0 fcs1 buf_idx3 -47dBm
sdr,sdr openwifi_tx:   72bytes  1M FC0050 DI013a addr1/2/3:66554433220a/6655443322a9/6655443322a9 SC8660 flag4020001b retr1 ack1 prio0 q0 wr37 rd36
sdr,sdr openwifi_tx_interrupt: WARNING tx_result 10 prio0 wr38 rd37
sdr,sdr openwifi_rx_interrupt:  54bytes ht0  6M FC0040 DI0040 addr1/2/3:6655443322a9/66554433220a/6655443322a9 SC0720 fcs1 buf_idx11 -48dBm
sdr,sdr openwifi_tx:   72bytes  1M FC0050 DI013a addr1/2/3:66554433220a/6655443322a9/6655443322a9 SC9670 flag4020001b retr1 ack1 prio0 q0 wr38 rd37
sdr,sdr openwifi_tx_interrupt: WARNING tx_result 10 prio0 wr39 rd38
sdr,sdr openwifi_rx_interrupt: 364bytes ht0  6M FC0108 DI0040 addr1/2/3:6655443322a9/66554433220a/ffffffffffff SC0750 fcs1 buf_idx12 -47dBm
sdr,sdr openwifi_tx:   26bytes  1M FC00a0 DI013a addr1/2/3:66554433220a/6655443322a9/6655443322a9 SC0000 flag4020001b retr1 ack1 prio0 q0 wr59 rd58
sdr,sdr openwifi_rx_interrupt:1986bytes ht0 54M FCb442 DI2449 addr1/2/3:ad75573daef8/ac8993bc69c8/1191e6b45cf0 SC9712 fcs0 buf_idx13 -64dBm
sdr,sdr openwifi_rx_interrupt: WARNING content!
sdr,sdr openwifi_rx_interrupt:  11bytes ht0  6M FC94fc DI67e2 addr1/2/3:9604f3e409da/000000000000/000000000000 SC0000 fcs0 buf_idx9 -64dBm
sdr,sdr openwifi_rx_interrupt:3825bytes ht0 12M FC7d43 DIb74e addr1/2/3:e56eb3f4222a/ca90602efdeb/b7fe2656f3e2 SC64b3 fcs0 buf_idx10 -59dBm
sdr,sdr openwifi_rx_interrupt:1084bytes ht0 18M FC98a4 DI05d9 addr1/2/3:91f88a32ee2f/61e3e44232dc/d0443c3e8cd1 SC46fb fcs0 buf_idx11 -60dBm
sdr,sdr openwifi_rx_interrupt: 241bytes ht0 12M FC1640 DI1e92 addr1/2/3:399ad5b698c9/3338ce396dd7/0197891af25e SC86db fcs0 buf_idx12 -60dBm
sdr,sdr openwifi_tx:   26bytes  1M FC00a0 DI013a addr1/2/3:66554433220a/6655443322a9/6655443322a9 SC0000 flag4020001b retr1 ack1 prio0 q0 wr33 rd32
sdr,sdr openwifi_tx_interrupt: WARNING tx_result 10 prio0 wr34 rd33
sdr,sdr openwifi_tx:   26bytes  1M FC00a0 DI013a addr1/2/3:66554433220a/6655443322a9/6655443322a9 SC0000 flag4020001b retr1 ack1 prio0 q0 wr42 rd41
sdr,sdr openwifi_tx_interrupt: WARNING tx_result 10 prio0 wr43 rd42
sdr,sdr openwifi_tx:   26bytes  1M FC00c0 DI013a addr1/2/3:66554433220a/6655443322a9/6655443322a9 SC0000 flag4020001b retr1 ack1 prio0 q0 wr51 rd50
  1. When AP and STA see each other, I can ping between them. However, if I use iperf tool to measure the throughput of wireless channel, I can not transfer TCP packets and trace the throughput, as is described in the following screenshots: https://drive.google.com/file/d/1RkBqPjlHUQnDPBzxSCu6W_g2EufCV_dO/view?usp=sharing https://drive.google.com/file/d/1LPy61LhPvLPjpe2zxRxE5feNxtCcTmSv/view?usp=sharing

Have you ever seen the same situations ? Please give me some advices or explanations about the above results. Thank you so much !!

Best Regards,

JiaoXianjun commented 4 years ago

which board (type/model) are you using?

DatPhungThe commented 4 years ago

I am using Zynq Zedboard with AD-FMCOMMS2-EBZ on both side: AP and Client. Thank you !

JiaoXianjun commented 4 years ago

make sure per board your two antennas are separated enough. far away to each other or vertical/orthogonal to each other. You can also make them closer. You can also try the quick and dirty patch here: https://github.com/open-sdr/openwifi/issues/26#issuecomment-657430988

DatPhungThe commented 4 years ago

Yes, I added the dirty patch #26 in AP side. I am placing 2 boards as the following photo: https://drive.google.com/file/d/1P72sepJQnLEJoPFR5GFj9LfnSDs8WdnZ/view?usp=sharing Is this Ok ? I think the distance between AP and STA is already enough close.

JiaoXianjun commented 4 years ago

  1. You need only two antennas per board, not four antennas. One rx and one tx. Please make tx rx antenna vertical/orthogonal to each other. (Not closely parallel to each other like in your photo!)

  2. When you have difficulty on connection, can you try script: set_csma_normal.sh? (Both sides or one side)? To see whether the connection becomes easier.

DatPhungThe commented 4 years ago

Hi Xianjun,

Thank you very much ! Now, I can connect easier thanks to your tips.

I have looked for the way to go through the issue: "IEEE 802.11: did not acknowledge authentication response"

I think the dirty patch: #26 is only a temporary solution, not an official solution, so it can not resolve the root cause.

I set up an AP Openwifi on Zedboard (with AD-FMCOMMS2-EBZ) without using the above dirty patch. Meanwhile, I put involved signals in xpu/tx_control (tx_control_state,tx_fail_lock,ack_timeout_count) to ILA core for monitoring and debugging. Then I try connecting a Client Linux-PC to AP Openwifi.

In ILA Monitor, I captured the rising edge of tx_fail_lock signal and observed that tx_control_state is RECV_ACK_WAIT_SIG_VALID and ack_timeout_count reaches to recv_ack_sig_valid_timeout_top_scale (5050) at that time.

I am wondering whether the timeout value is enough long to detect ACK packets, and whether COUNT_SCALE factor is correct.

I still confuse about the assumption: ASSUMED_COUNTER_CLK_MHZ = 10 MHz in board_def.v. Why is not it another number (5 MHz or 20 MHz) ?

Have you any ideas or approaches ? Please share it with me to discuss and overcome this problem together.

Best Regards,

JiaoXianjun commented 4 years ago

Yes. We know there is some issue with short packet rx performance sometimes. We are working on it.

DatPhungThe commented 4 years ago

Hi Xianjun, I am also researching on this problem. Could you please share some hints or ideas about your way ? Let's find the solution together. Best Regards,

JiaoXianjun commented 4 years ago

You can try our latest IQ sample tool to try to debug it.

DatPhungThe commented 4 years ago

Ok, I got it. I will use your Side Channel modules for debugging. Thank you for your great effort !

Best Regards,

JiaoXianjun commented 3 years ago

Hello @Leo-Cheung-CUHK ,

Since our latest release (1.2.0) has improved the low MAC, it should improve this issue a lot. Would you please try the new release, and tell us whether the problem is still serious or not?

Thanks!

Leo-Cheung-CUHK commented 3 years ago

Dear Xianjun,

The latest release is exciting.

I will do the testing in a few days and let you know the result.

Best, Lihao

Jiao Xianjun notifications@github.com 于2020年12月18日周五 下午11:09写道：

Hello @Leo-Cheung-CUHK https://github.com/Leo-Cheung-CUHK ,

Since our latest release (1.2.0) has improved the low MAC; it should improve this issue a lot. Would you please try the new release, and tell us whether the problem is still serious or not?

Thanks!

— You are receiving this because you were mentioned. Reply to this email directly, view it on GitHub https://github.com/open-sdr/openwifi/issues/26#issuecomment-748139530, or unsubscribe https://github.com/notifications/unsubscribe-auth/AHAI65C2KBJQJVIDBJWO3KDSVNWCFANCNFSM4OXG6B7Q .

Leo-Cheung-CUHK commented 3 years ago

Hello @Leo-Cheung-CUHK ,

Since our latest release (1.2.0) has improved the low MAC; it should improve this issue a lot. Would you please try the new release, and tell us whether the problem is still serious or not?

Thanks!

Hi @JiaoXianjun,

I used one ZC706 as AP, creating a WLAN. The hostapd.conf is: `interface=sdr0 driver=nl80211 country_code=BE ssid=openwifi hw_mode=g/a channel=4/44 supported_rates=60 90 120 180 240 360 480 540 basic_rates=60 90 120 180 ieee80211n=1 ht_capab=[SHORT-GI-20] require_ht=1 ieee80211d=1 ieee80211h=1

wpa=3

wpa_passphrase=myrabbit

wpa_key_mgmt=WPA-PSK

`

Then, my PC working as STA with NIC supporting 802.11agn tried to connect to this AP. Here is the testing result:

1) When the AP uses 802.11a on the No.44 channel, STA can connect to the AP. 2) When using 802.11g, STA can see the beacon sent from AP. But the establishment fails.

I think it's because openwifi does not support DSSS. I tried to patch the wpa_supplicant as "Special note for 11b" part in Readme. But it still cannot work.

JiaoXianjun commented 3 years ago

In channel 44, the dsss shouldn’t be there because it is in 5GHz. So far we almost always test in 5GHz.

My question is: does this issue (didn’t not acknowledge) disappear at your side?

Leo-Cheung-CUHK commented 3 years ago

In channel 44, the dsss shouldn’t be there because it is in 5GHz. So far we almost always test in 5GHz.

My question is: does this issue (didn’t not acknowledge) disappear at your side?

Yes, the problem has gone.

JiaoXianjun commented 3 years ago

thanks. finally we solve it! I believe it is a low mac issue (collision) that has been solved recently.