• State Not Answered
  • Replies 5 replies
  • Subscribers 68 subscribers
  • Views 241 views
  • Users 0 members are here
Attachments (2) Download All
Nordic Case Info
  • Case ID: 331419
Options

nRF7002 WIFI connection reliability on sta example

veratek1

Hello,

I have been testing the WIFI on the nRF7002-DK board and have found that it drops out if not used. The WIFI sta example running on the nRF7002-DK connects to a router and the ping command from a pc to the board works. After 15 minutes the ping command no longer works. No errors print out the debug UART. The led blink thread is still running.

I have found that if the sta example is modified to have a socket server and sends something to a client every 5 minutes it stays active overnight. Also the line:
CONFIG_NRF_WIFI_LOW_POWER=n
made it last longer but it still lost connection after some hours if not used. I have also tried setting timeout to SYS_FOREVER_MS but it still dropped out.

I am using SDK version v2.6.0.

Parents Reply Children
  • 0 in reply to veratek1

    Hi,

    Can you try setting CONFIG_WPA_SUPP_LOG_LEVEL_DBG=y in prj.conf to get debug logs from the WPA supplicant?

    Can you share your project so I can try reproducing it on my side? Please also include instructions for how to reproduce it. If you do not want to share your code in a public ticket, let me know and I will make it private.

    Best regards,
    Marte

  • 0 in reply to Marte Myrvold

    Hello,

    I have my modified sta example here I found it in "C:\ncs\v2.6.1\nrf\samples\wifi\sta". The only change is the timeout set to SYS_FOREVER_MS and the SSID and CONFIG_STA_KEY_MGMT_NONE for my router.

    To run set the SSID for your router in the prj.conf. Build and flash nrf7002-dk board. The UART prints out:

    Pinging from the pc:

    After 15 minutes:

    No change on serial:

    Here is the example and the log for CONFIG_WPA_SUPP_LOG_LEVEL_DBG:

    8764.sta.zip

    Fullscreen CONFIG_WPA_SUPP_LOG_LEVEL_DBG.txt Download 
    *** Booting nRF Connect SDK v3.5.99-ncs1-1 ***
[00:00:00.637,115] <inf> net_config: Initializing network
[00:00:00.642,974] <inf> net_config: Waiting interface 1 (0x20001470) to be up...
[00:00:00.650,939] <inf> net_config: IPv4 address: 192.168.1.99
[00:00:00.657,226] <inf> net_config: Running dhcpv4 client...
[00:00:00.663,604] <inf> sta: Starting nrf7002dk_nrf5340_cpuapp with CPU frequency: 64 MHz
[00:00:00.672,363] <dbg> wpa_supp: wpa_printf_impl: wpa_supplicant v2.11-devel
[00:00:00.680,145] <inf> wpa_supp: Successfully initialized wpa_supplicant
[00:00:00.687,774] <dbg> wpa_supp: wpa_printf_impl: Adding interface nordic_wlan0

[00:00:00.695,770] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: interface_add, argc: 5

[00:00:00.704,559] <dbg> wpa_supp: wpa_printf_impl: argv[0]: interface_add

[00:00:00.711,914] <dbg> wpa_supp: wpa_printf_impl: argv[1]: nordic_wlan0

[00:00:00.719,177] <dbg> wpa_supp: wpa_printf_impl: argv[2]: zephyr

[00:00:00.725,952] <dbg> wpa_supp: wpa_printf_impl: argv[3]: zephyr

[00:00:00.732,696] <dbg> wpa_supp: wpa_printf_impl: argv[4]: zephyr

[00:00:00.739,746] <dbg> wpa_supp: wpa_printf_impl: RX global ctrl_iface - hexdump_ascii(len=85):
[00:00:00.748,962] <dbg> wpa_supp: _wpa_hexdump_ascii:
                                   49 4e 54 45 52 46 41 43  45 5f 41 44 44 20 6e 6f |INTERFAC E_ADD no
                                   72 64 69 63 5f 77 6c 61  6e 30 09 7a 65 70 68 79 |rdic_wla n0.zephy
                                   72 09 7a 65 70 68 79 72  09 7a 65 70 68 79 72 09 |r.zephyr .zephyr.
                                   09 09 09 20 6e 6f 72 64  69 63 5f 77 6c 61 6e 30 |... nord ic_wlan0
                                   20 7a 65 70 68 79 72 20  7a 65 70 68 79 72 20 7a | zephyr  zephyr z
                                   65 70 68 79 72                                   |ephyr
[00:00:00.808,624] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE GLOBAL INTERFACE_ADD 'nordic_wlan0       zephyr  zephyr  zephyr                           nordic_wlan0 zephyr zephyr zephyr'
[00:00:00.823,150] <dbg> wpa_supp: wpa_printf_impl: Initializing interface 'nordic_wlan0' conf 'zephyr' driver 'zephyr' ctrl_interface 'zephyr' bridge 'N/A'
[00:00:00.848,175] <dbg> wpa_supp: wpa_printf_impl: Add interface nordic_wlan0 to a new radio N/A
[00:00:00.861,511] <dbg> wpa_supp: wpa_printf_impl: wpa_supp: Added 802.11b mode based on 802.11g information
[00:00:00.872,009] <dbg> wpa_supp: wpa_printf_impl: l2_packet_init: iface nordic_wlan0 ifindex 1
[00:00:00.881,286] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Own MAC address: f4:ce:36:00:20:50
[00:00:00.890,869] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: RSN: flushing PMKID list in the driver
[00:00:00.900,787] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: State: DISCONNECTED -> INACTIVE
[00:00:00.910,217] <dbg> wpa_supp: wpa_printf_impl: MBO: Update non-preferred channels, non_pref_chan=N/A
[00:00:00.920,318] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Added interface nordic_wlan0
[00:00:00.929,351] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: State: INACTIVE -> DISCONNECTED
[00:00:01.672,271] <inf> sta: QSPI Encryption disabled
[00:00:01.677,764] <inf> sta: Static IP address (overridable): 192.168.1.99/255.255.255.0 -> 192.168.1.1
[00:00:01.687,683] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: remove_network, argc: 2

[00:00:01.696,563] <dbg> wpa_supp: wpa_printf_impl: argv[0]: remove_network

[00:00:01.704,010] <dbg> wpa_supp: wpa_printf_impl: argv[1]: all

[00:00:01.710,815] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Control interface command 'REMOVE_NETWORK all'
[00:00:01.721,405] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: REMOVE_NETWORK all
[00:00:01.729,797] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Control interface command 'ADD_NETWORK'
[00:00:01.739,776] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: ADD_NETWORK
[00:00:01.747,528] <dbg> wpa_supp: wpa_printf_impl: Received len: 260, msg_len:26 - CTRL-EVENT-NETWORK-ADDED 0->END

[00:00:01.758,728] <dbg> wpa_supp: wpa_printf_impl: NET added: 0

[00:00:01.765,228] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4

[00:00:01.773,864] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network

[00:00:01.781,036] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0

[00:00:01.787,353] <dbg> wpa_supp: wpa_printf_impl: argv[2]: ssid

[00:00:01.793,945] <dbg> wpa_supp: wpa_printf_impl: argv[3]: "SEA_DRAGON"

[00:00:01.801,544] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Control interface command 'SET_NETWORK [REMOVED]'
[00:00:01.812,408] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='ssid'
[00:00:01.821,228] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=12): [REMOVED]
[00:00:01.831,115] <dbg> wpa_supp: wpa_printf_impl: ssid - hexdump_ascii(len=10):
[00:00:01.838,958] <dbg> wpa_supp: _wpa_hexdump_ascii:
                                   53 45 41 5f 44 52 41 47  4f 4e                   |SEA_DRAG ON
[00:00:01.853,851] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4

[00:00:01.862,457] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network

[00:00:01.869,659] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0

[00:00:01.875,976] <dbg> wpa_supp: wpa_printf_impl: argv[2]: scan_ssid

[00:00:01.882,965] <dbg> wpa_supp: wpa_printf_impl: argv[3]: 1

[00:00:01.889,617] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Control interface command 'SET_NETWORK [REMOVED]'
[00:00:01.900,512] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='scan_ssid'
[00:00:01.909,759] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=1): [REMOVED]
[00:00:01.919,525] <dbg> wpa_supp: wpa_printf_impl: scan_ssid=1 (0x1)
[00:00:01.926,574] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4

[00:00:01.935,211] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network

[00:00:01.942,382] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0

[00:00:01.948,699] <dbg> wpa_supp: wpa_printf_impl: argv[2]: key_mgmt

[00:00:01.955,627] <dbg> wpa_supp: wpa_printf_impl: argv[3]: NONE

[00:00:01.962,524] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Control interface command 'SET_NETWORK [REMOVED]'
[00:00:01.973,419] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='key_mgmt'
[00:00:01.982,574] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=4): [REMOVED]
[00:00:01.992,401] <dbg> wpa_supp: wpa_printf_impl: key_mgmt: 0x4
[00:00:01.999,084] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: set_network, argc: 4

[00:00:02.007,720] <dbg> wpa_supp: wpa_printf_impl: argv[0]: set_network

[00:00:02.014,892] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0

[00:00:02.021,209] <dbg> wpa_supp: wpa_printf_impl: argv[2]: ieee80211w

[00:00:02.028,320] <dbg> wpa_supp: wpa_printf_impl: argv[3]: 0

[00:00:02.034,973] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Control interface command 'SET_NETWORK [REMOVED]'
[00:00:02.045,837] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SET_NETWORK id=0 name='ieee80211w'
[00:00:02.055,175] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: value - hexdump_ascii(len=1): [REMOVED]
[00:00:02.064,971] <dbg> wpa_supp: wpa_printf_impl: ieee80211w=0 (0x0)
[00:00:02.072,113] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: enable_network, argc: 2

[00:00:02.080,993] <dbg> wpa_supp: wpa_printf_impl: argv[0]: enable_network

[00:00:02.088,439] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0

[00:00:02.095,092] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Control interface command 'ENABLE_NETWORK 0'
[00:00:02.105,499] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: ENABLE_NETWORK id=0
[00:00:02.113,616] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Setting scan request: 0.000000 sec
[00:00:02.123,413] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: State: DISCONNECTED -> SCANNING
[00:00:02.132,720] <dbg> wpa_supp: wpa_printf_impl: Scan SSID - hexdump_ascii(len=10):
[00:00:02.140,960] <dbg> wpa_supp: _wpa_hexdump_ascii:
                                   53 45 41 5f 44 52 41 47  4f 4e                   |SEA_DRAG ON
[00:00:02.155,670] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Include wildcard SSID in the scan request
[00:00:02.166,015] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Add radio work 'scan'@0x200099d0
[00:00:02.175,445] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: First radio work item in the queue - schedule start immediately
[00:00:02.187,774] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Starting radio work 'scan'@0x200099d0 after 0.012299 second wait
[00:00:02.200,378] <dbg> wpa_supp: wpa_printf_impl: Calling wpa_cli: select_network, argc: 2

[00:00:02.209,289] <dbg> wpa_supp: wpa_printf_impl: argv[0]: select_network

[00:00:02.216,705] <dbg> wpa_supp: wpa_printf_impl: argv[1]: 0

[00:00:02.226,135] <dbg> wpa_supp: wpa_printf_impl: wpa_drv_zep_scan2: Scan requested - scan timeout 35 seconds

[00:00:02.239,562] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Control interface command 'SELECT_NETWORK 0'
[00:00:02.251,586] <dbg> wpa_supp: wpa_printf_impl: CTRL_IFACE: SELECT_NETWORK id=0
[00:00:02.260,864] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Setting scan request: 0.000000 sec
[00:00:02.271,270] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Already scanning - Reschedule the incoming scan req
[00:00:02.282,348] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Setting scan request: 1.000000 sec
[00:00:02.292,358] <inf> sta: Connection requested
[00:00:02.297,546] <inf> sta: ==================
[00:00:02.302,520] <inf> sta: State: SCANNING
[00:00:02.307,403] <dbg> wpa_supp: wpa_printf_impl: Passing message 47 to wpa_supplicant
[00:00:02.315,948] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Event SCAN_STARTED (47) received
[00:00:02.325,408] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Own scan request started a scan in 0.085998 seconds
[00:00:02.336,730] <dbg> wpa_supp: wpa_printf_impl: Received len: 260, msg_len:24 - CTRL-EVENT-SCAN-STARTED ->END

[00:00:02.607,421] <inf> sta: ==================
[00:00:02.613,128] <inf> sta: State: SCANNING
[00:00:02.917,999] <inf> sta: ==================
[00:00:02.922,973] <inf> sta: State: SCANNING
[00:00:03.227,844] <inf> sta: ==================
[00:00:03.232,788] <inf> sta: State: SCANNING
[00:00:03.292,114] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Already scanning - Reschedule the incoming scan req
[00:00:03.303,161] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Setting scan request: 1.000000 sec
[00:00:03.537,689] <inf> sta: ==================
[00:00:03.542,633] <inf> sta: State: SCANNING
[00:00:03.847,534] <inf> sta: ==================
[00:00:03.852,508] <inf> sta: State: SCANNING
[00:00:04.157,409] <inf> sta: ==================
[00:00:04.162,384] <inf> sta: State: SCANNING
[00:00:04.312,927] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Already scanning - Reschedule the incoming scan req
[00:00:04.323,974] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Setting scan request: 1.000000 sec
[00:00:04.467,254] <inf> sta: ==================
[00:00:04.472,198] <inf> sta: State: SCANNING
[00:00:04.777,099] <inf> sta: ==================
[00:00:04.782,043] <inf> sta: State: SCANNING
[00:00:05.086,944] <inf> sta: ==================
[00:00:05.091,888] <inf> sta: State: SCANNING
[00:00:05.333,770] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Already scanning - Reschedule the incoming scan req
[00:00:05.344,818] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Setting scan request: 1.000000 sec
[00:00:05.396,789] <inf> sta: ==================
[00:00:05.401,733] <inf> sta: State: SCANNING
[00:00:05.706,634] <inf> sta: ==================
[00:00:05.711,578] <inf> sta: State: SCANNING
[00:00:06.016,479] <inf> sta: ==================
[00:00:06.021,423] <inf> sta: State: SCANNING
[00:00:06.123,321] <dbg> wpa_supp: wpa_printf_impl: Passing message 3 to wpa_supplicant
[00:00:06.131,774] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Event SCAN_RESULTS (3) received
[00:00:06.141,174] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Scan completed in 4.-184234 seconds
[00:00:06.153,869] <dbg> wpa_supp: wpa_printf_impl: Sorted scan results
[00:00:06.160,949] <dbg> wpa_supp: wpa_printf_impl: b0:39:56:56:9b:28 freq=2412 qual=0 noise=-89~ level=-18 snr=71* flags=0xb age=3847 est=65000
[00:00:06.176,300] <dbg> wpa_supp: wpa_printf_impl: IEs - hexdump(len=172): 00 0a 53 45 41 5f 44 52 41 47 4f 4e 01 08 82 84 8b 96 12 24 48 6c 03 01 01 2a 01 04 32 04 0c 18 30 60 2d 1a ec 11 17 ff ff 00 00 01 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 3d 16 01 00 00 00 00 00 00 00 00 00 00 00 00
[00:00:06.203,765] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: BSS: Start scan result update 1
[00:00:06.213,256] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: BSS: Add new id 0 BSSID b0:39:56:56:9b:28 SSID 'SEA_DRAGON' freq 2412
[00:00:06.226,013] <dbg> wpa_supp: wpa_printf_impl: BSS: last_scan_res_used=1/32
[00:00:06.233,856] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: New scan results available (own=1 ext=0)
[00:00:06.244,140] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Radio work 'scan'@0x200099d0 done in 4.056366 seconds
[00:00:06.255,401] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: radio_work_free('scan'@0x200099d0): num_active_works --> 0
[00:00:06.267,089] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Scan results matching the currently selected network
[00:00:06.278,442] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: 0: b0:39:56:56:9b:28 freq=2412 level=-18 snr=71 est_throughput=65000
[00:00:06.290,985] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Selecting BSS from priority group 0
[00:00:06.300,842] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: 0: b0:39:56:56:9b:28 ssid='SEA_DRAGON' wpa_ie_len=0 rsn_ie_len=0 caps=0x401 level=-18 freq=2412
[00:00:06.315,826] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0:    allow in non-WPA/WPA2
[00:00:06.324,676] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0:    selected BSS b0:39:56:56:9b:28 ssid='SEA_DRAGON'
[00:00:06.336,059] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Considering connect request: reassociate: 1  selected: b0:39:56:56:9b:28  bssid: 00:00:00:00:00:00  pending: 00:00:00:00:00:00  wpa_state: SCANNING  ssid=0x200080b0  current_ssid=0x200080b0
[00:00:06.359,130] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Request association with b0:39:56:56:9b:28
[00:00:06.369,415] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: No ongoing scan/p2p-scan found to abort
[00:00:06.379,455] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Add radio work 'sme-connect'@0x20008338
[00:00:06.389,495] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: First radio work item in the queue - schedule start immediately
[00:00:06.401,794] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Starting AP scan for wildcard SSID
[00:00:06.411,529] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Add radio work 'scan'@0x20009a80
[00:00:06.420,989] <dbg> wpa_supp: wpa_printf_impl: Received len: 260, msg_len:40 - CTRL-EVENT-BSS-ADDED 0 b0:39:56:56:9b:28->END

[00:00:06.433,319] <dbg> wpa_supp: wpa_printf_impl: Received len: 260, msg_len:24 - CTRL-EVENT-SCAN-RESULTS ->END

[00:00:06.444,122] <dbg> wpa_supp: wpa_printf_impl: Event not supported: CTRL-EVENT-SCAN-RESULTS

[00:00:06.453,735] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Starting radio work 'sme-connect'@0x20008338 after 0.064209 second wait
[00:00:06.466,522] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: WPA: clearing own WPA/RSN IE
[00:00:06.475,555] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: RSN: clearing own RSNXE
[00:00:06.484,191] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Automatic auth_alg selection: 0x1
[00:00:06.493,682] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: WPA: clearing AP WPA IE
[00:00:06.502,288] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: WPA: clearing AP RSN IE
[00:00:06.510,894] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: WPA: clearing AP RSNXE
[00:00:06.519,439] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: WPA: clearing own WPA/RSN IE
[00:00:06.528,472] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: RSN: clearing own RSNXE
[00:00:06.537,078] <dbg> wpa_supp: wpa_printf_impl: RRM: Determining whether RRM can be used - device support: 0x50
[00:00:06.547,851] <dbg> wpa_supp: wpa_printf_impl: RRM: No RRM in network
[00:00:06.556,060] <dbg> wpa_supp: wpa_printf_impl: Added supported operating classes IE - hexdump(len=10): 3b 08 51 51 52 73 76 79 7c 7d
[00:00:06.568,878] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Cancelling scan request
[00:00:06.577,606] <inf> wpa_supp: nordic_wlan0: SME: Trying to authenticate with b0:39:56:56:9b:28 (SSID='SEA_DRAGON' freq=2412 MHz)
[00:00:06.590,087] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: State: SCANNING -> AUTHENTICATING
[00:00:06.600,097] <inf> sta: ==================
[00:00:06.605,072] <inf> sta: State: AUTHENTICATING
[00:00:06.615,142] <dbg> wpa_supp: wpa_printf_impl: Received len: 260, msg_len:84 - SME: Trying to authenticate with b0:39:56:56:9b:28 (SSID='SEA_DRAGON' freq=2412 MHz)->END

[00:00:06.865,478] <dbg> wpa_supp: wpa_printf_impl: Passing message 10 to wpa_supplicant
[00:00:06.874,023] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Event AUTH (10) received
[00:00:06.882,843] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: SME: Authentication response: peer=b0:39:56:56:9b:28 auth_type=0 auth_transaction=2 status_code=0
[00:00:06.897,827] <dbg> wpa_supp: wpa_printf_impl: SME: Authentication response IEs - hexdump(len=0): [NULL]
[00:00:06.908,416] <dbg> wpa_supp: wpa_printf_impl: SME: Association Request IEs - hexdump(len=23): 7f 0b 04 00 4a 02 00 40 40 40 00 20 20 3b 08 51 51 52 73 76 79 7c 7d
[00:00:06.923,980] <inf> wpa_supp: nordic_wlan0: Trying to associate with b0:39:56:56:9b:28 (SSID='SEA_DRAGON' freq=2412 MHz)
[00:00:06.935,760] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: State: AUTHENTICATING -> ASSOCIATING
[00:00:06.945,800] <inf> sta: ==================
[00:00:06.950,805] <inf> sta: State: AUTHENTICATING
[00:00:06.961,212] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: WPA: clearing own WPA/RSN IE
[00:00:06.970,397] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: RSN: clearing own RSNXE
[00:00:06.986,236] <dbg> wpa_supp: wpa_printf_impl: Received len: 260, msg_len:76 - Trying to associate with b0:39:56:56:9b:28 (SSID='SEA_DRAGON' freq=2412 MHz)->END

[00:00:07.007,843] <dbg> wpa_supp: wpa_printf_impl: Event: -805240830
[00:00:07.015,899] <dbg> wpa_supp: wpa_printf_impl: Passing message 0 to wpa_supplicant
[00:00:07.024,444] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Event ASSOC (0) received
[00:00:07.033,172] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Association info event
[00:00:07.042,785] <dbg> wpa_supp: wpa_printf_impl: req_ies - hexdump(len=100): 00 0a 53 45 41 5f 44 52 41 47 4f 4e 01 08 02 04 0b 16 0c 12 18 24 32 04 30 48 60 6c 21 02 00 1e 5a 03 24 01 00 c7 01 00 2d 1a 0c 88 1e ff 00 00 00 00 00 00 00 00 00 00 00 01 00 00 00 00 00 00 00 00 00 00 7f 0b 04 00 4a 02 00 40
[00:00:07.072,326] <dbg> wpa_supp: wpa_printf_impl: resp_ies - hexdump(len=189): 01 08 82 84 8b 96 12 24 48 6c 32 04 0c 18 30 60 dd 18 00 50 f2 02 01 01 00 00 03 a4 00 00 27 a4 00 00 42 43 5e 00 62 32 2f 00 2d 1a ee 11 17 ff ff 00 00 01 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 3d 16 01 00 06 0
[00:00:07.099,761] <dbg> wpa_supp: wpa_printf_impl: Unknown Broadcom information element ignored (type=52 len=26)
[00:00:07.110,382] <dbg> wpa_supp: wpa_printf_impl: IEEE 802.11 element parse ignored unknown element (id=74 elen=14)
[00:00:07.121,398] <dbg> wpa_supp: wpa_printf_impl: unknown vendor specific information element ignored (vendor OUI 00:0c:43 len=7)
[00:00:07.133,605] <dbg> wpa_supp: wpa_printf_impl: Unknown Broadcom information element ignored (type=52 len=26)
[00:00:07.144,256] <dbg> wpa_supp: wpa_printf_impl: IEEE 802.11 element parse ignored unknown element (id=74 elen=14)
[00:00:07.155,273] <dbg> wpa_supp: wpa_printf_impl: unknown vendor specific information element ignored (vendor OUI 00:0c:43 len=7)
[00:00:07.167,480] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: freq=2412 MHz
[00:00:07.175,231] <dbg> wpa_supp: wpa_printf_impl: Unknown Broadcom information element ignored (type=52 len=26)
[00:00:07.185,882] <dbg> wpa_supp: wpa_printf_impl: unknown vendor specific information element ignored (vendor OUI 00:0c:43 len=7)
[00:00:07.198,120] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: WPA: clearing own WPA/RSN IE
[00:00:07.207,153] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: RSN: clearing own RSNXE
[00:00:07.215,789] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: State: ASSOCIATING -> ASSOCIATED
[00:00:07.233,276] <inf> net_config: IPv6 address: fe80::f6ce:36ff:fe00:2050
[00:00:07.241,363] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Associated to a new BSS: BSSID=b0:39:56:56:9b:28
[00:00:07.252,471] <dbg> wpa_supp: wpa_printf_impl: wpa_drv_zep_get_ssid: SSID size: 10

[00:00:07.261,077] <inf> wpa_supp: nordic_wlan0: Associated with b0:39:56:56:9b:28
[00:00:07.269,104] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: WPA: Association event - clear replay counter
[00:00:07.279,632] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: WPA: Clear old PTK
[00:00:07.287,811] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Cancelling authentication timeout
[00:00:07.297,302] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: State: ASSOCIATED -> COMPLETED
[00:00:07.306,610] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Radio work 'sme-connect'@0x20008338 done in 1.-147125 seconds
[00:00:07.318,572] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: radio_work_free('sme-connect'@0x20008338): num_active_works --> 0
[00:00:07.330,963] <inf> wpa_supp: nordic_wlan0: CTRL-EVENT-CONNECTED - Connection to b0:39:56:56:9b:28 completed [id=0 id_str=]
[00:00:07.347,229] <inf> sta: Connected
[00:00:07.351,837] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Cancelling scan request
[00:00:07.360,595] <inf> wpa_supp: nordic_wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
[00:00:07.369,537] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Starting radio work 'scan'@0x20009a80 after 1.-51483 second wait
[00:00:07.385,406] <dbg> wpa_supp: wpa_printf_impl: wpa_drv_zep_scan2: Scan requested - scan timeout 35 seconds

[00:00:07.396,209] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Control interface command 'SIGNAL_POLL'
[00:00:07.422,180] <dbg> wpa_supp: wpa_printf_impl: Received len: 260, msg_len:33 - Associated with b0:39:56:56:9b:28->END

[00:00:07.433,776] <dbg> wpa_supp: wpa_printf_impl: Received len: 260, msg_len:79 - CTRL-EVENT-CONNECTED - Connection to b0:39:56:56:9b:28 completed [id=0 id_str=]->END

[00:00:07.449,493] <dbg> wpa_supp: wpa_printf_impl: Received len: 260, msg_len:40 - CTRL-EVENT-SUBNET-STATUS-UPDATE status=0->END

[00:00:07.461,669] <dbg> wpa_supp: wpa_printf_impl: Event not supported: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0

[00:00:07.472,564] <dbg> wpa_supp: wpa_printf_impl: Passing message 47 to wpa_supplicant
[00:00:07.481,109] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Event SCAN_STARTED (47) received
[00:00:07.490,539] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Own scan request started a scan in 0.094391 seconds
[00:00:07.501,861] <dbg> wpa_supp: wpa_printf_impl: Received len: 260, msg_len:24 - CTRL-EVENT-SCAN-STARTED ->END

[00:00:07.524,078] <inf> sta: ==================
[00:00:07.529,113] <inf> sta: State: ASSOCIATED
[00:00:07.534,027] <inf> sta: Interface Mode: STATION
[00:00:07.539,489] <inf> sta: Link Mode: WIFI 4 (802.11n/HT)
[00:00:07.545,532] <inf> sta: SSID: SEA_DRAGON
[00:00:07.550,384] <inf> sta: BSSID: B0:39:56:56:9B:28
[00:00:07.556,243] <inf> sta: Band: 2.4GHz
[00:00:07.560,729] <inf> sta: Channel: 1
[00:00:07.565,185] <inf> sta: Security: OPEN
[00:00:07.569,854] <inf> sta: MFP: Disable
[00:00:07.574,371] <inf> sta: RSSI: -19
[00:00:07.879,058] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Control interface command 'SIGNAL_POLL'
[00:00:07.893,798] <inf> sta: ==================
[00:00:07.898,773] <inf> sta: State: COMPLETED
[00:00:07.903,717] <inf> sta: Interface Mode: STATION
[00:00:07.909,149] <inf> sta: Link Mode: WIFI 4 (802.11n/HT)
[00:00:07.915,649] <inf> sta: SSID: SEA_DRAGON
[00:00:07.921,173] <inf> sta: BSSID: B0:39:56:56:9B:28
[00:00:07.927,062] <inf> sta: Band: 2.4GHz
[00:00:07.931,976] <inf> sta: Channel: 1
[00:00:07.936,798] <inf> sta: Security: OPEN
[00:00:07.941,467] <inf> sta: MFP: Disable
[00:00:07.945,983] <inf> sta: RSSI: -72
[00:00:08.109,008] <inf> net_dhcpv4: Received: 192.168.1.100
[00:00:08.115,203] <inf> net_config: IPv4 address: 192.168.1.100
[00:00:08.121,551] <inf> net_config: Lease time: 86400 seconds
[00:00:08.127,807] <inf> net_config: Subnet: 255.255.255.0
[00:00:08.133,697] <inf> net_config: Router: 192.168.1.1
[00:00:08.139,465] <inf> sta: DHCP IP address: 192.168.1.100
[00:00:10.200,134] <dbg> wpa_supp: wpa_printf_impl: Passing message 3 to wpa_supplicant
[00:00:10.209,014] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Event SCAN_RESULTS (3) received
[00:00:10.218,444] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Scan completed in 3.-272125 seconds
[00:00:10.231,719] <dbg> wpa_supp: wpa_printf_impl: Sorted scan results
[00:00:10.238,800] <dbg> wpa_supp: wpa_printf_impl: b0:39:56:56:9b:28 freq=2412 qual=0 noise=-89~ level=-18 snr=71* flags=0xb age=2770 est=65000
[00:00:10.254,364] <dbg> wpa_supp: wpa_printf_impl: IEs - hexdump(len=188): 00 0a 53 45 41 5f 44 52 41 47 4f 4e 01 08 82 84 8b 96 12 24 48 6c 03 01 01 32 04 0c 18 30 60 07 06 55 53 20 01 0b 14 33 08 20 01 02 03 04 05 06 07 33 08 21 05 06 07 08 09 0a 0b 05 04 00 01 00 00 2a 01 04 2d 1a ec 11 17 ff ff 00 00
[00:00:10.283,874] <dbg> wpa_supp: wpa_printf_impl: Beacon IEs - hexdump(len=188): 00 0a 53 45 41 5f 44 52 41 47 4f 4e 01 08 82 84 8b 96 12 24 48 6c 03 01 01 32 04 0c 18 30 60 07 06 55 53 20 01 0b 14 33 08 20 01 02 03 04 05 06 07 33 08 21 05 06 07 08 09 0a 0b 05 04 00 01 00 00 2a 01 04 2d 1a ec 11 17 ff ff
[00:00:10.311,340] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: BSS: Start scan result update 2
[00:00:10.320,770] <dbg> wpa_supp: wpa_printf_impl: BSS: last_scan_res_used=1/32
[00:00:10.328,613] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: New scan results available (own=1 ext=0)
[00:00:10.338,897] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Radio work 'scan'@0x20009a80 done in 3.-30609 seconds
[00:00:10.350,158] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: radio_work_free('scan'@0x20009a80): num_active_works --> 0
[00:00:10.361,846] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Scan results matching the currently selected network
[00:00:10.373,229] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: 0: b0:39:56:56:9b:28 freq=2412 level=-18 snr=71 est_throughput=65000
[00:00:10.385,742] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: Selecting BSS from priority group 0
[00:00:10.395,629] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0: 0: b0:39:56:56:9b:28 ssid='SEA_DRAGON' wpa_ie_len=0 rsn_ie_len=0 caps=0x401 level=-18 freq=2412
[00:00:10.410,583] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0:    allow in non-WPA/WPA2
[00:00:10.419,433] <dbg> wpa_supp: wpa_printf_impl: nordic_wlan0:    selected current BSS b0:39:56:56:9b:28 ssid='SEA_DRAGON'
[00:00:10.431,365] <dbg> wpa_supp: wpa_printf_impl: Received len: 260, msg_len:24 - CTRL-EVENT-SCAN-RESULTS ->END

[00:00:10.442,138] <dbg> wpa_supp: wpa_printf_impl: Event not supported: CTRL-EVENT-SCAN-RESULTS

  • 0 in reply to veratek1

    Hi,

    Are you able to reproduce the issue when connecting to other networks?

    I was not able to reproduce the issue on my side.

    Best regards,
    Marte

Related