- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
Using WICED 6.4.0.61 and WLAN Firmware May 2 2019 02:39:20 version 7.45.98.83 (r714225 CY) FWID 01-476cc09d with ThreadX + NetX.
MCU is STM32F412 in partner module.
Module and applications work fine with a variety of wifi access points except for Linksys EA7200.
Symptoms & observations:
- When sending high UDP data rates over connected wifi link, after several thousand UDP packets the 4343w stops responding at the WWD level.
- Detailed investigation indicates the 4343w stops responding to sdio ioctl calls in wwd_sdpcm_send_ioctl().
- Once this happens recovery requires a reset of 4343w and going back through wifi join sequence.
- Same problem happens with ThreadX + NetX_Duo and with FreeRTOS + LwIP.
- I have adjusted a variety of settings on the Linksys EA7200 and same problem.
- I have inspected the wifi rf packet traffic and don't see anything in particular -- the 4343w just stops responding and access point continues to send periodic beacon.
Questions:
1. Has this problem been seen before with Linksys EA7200 or similar wifi routers using MediaTek chipsets?
2. Is there a later version of 4343w WLAN firmware than 7.45.98.83?
3. Are there any suggestions for how to further investigate and resolve this issue?
Thanks
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
Hello:
I have a R6220 router which used mt7621s , will have a test based on your setting.
would you please confirm it can be found in our TCP release demo code.
According this line: When sending high UDP data rates over connected wifi link ....
low UDP data rates will have no problem , is that right ?
what is the high speed value in your test ? thanks.
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
The problem occurs with snip/udp_transmit at sending rates varying from 2ms to 500ms. The problem eventually occurs at all of these data rates that I've tested: 2ms, 3ms, 5ms, 10ms, 25ms, 50ms, 100ms, 200ms, 250ms, 500ms.
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
Any updates on this?
Thanks
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
hello:
I can't find it in my test by using our udp_echo_server.py, Did you change your UDP_MAX_DATA_LENGTH in your test ?
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
I am using UDP_MAX_DATA_LENGTH 30 (no change). I have also tested other sizes and they all have the same problem. The hang-up problem happens after a random number of packets have been sent. Somethings it happens after a few hundred packets, other times it's after a few thousand packets. I also have GET_UDP_RESPONSE commented out, so it's just sending UDP packets and not even trying to read a response. You can run it without even having udp_echo_server.py running since it's not trying to read a reply UDP packet.
The MediaTek chips in the Linksys EA7200 router are these:
- MEDIATEK MT7621AT
- MEDIATEK MT7603EN
- MEDIATEK MT7615N
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
My router is MT7621s, seems no error found in my last test.
and 7.45.98.83 is my firmware also with 6.4 SDK.
I will try to find one router with same chips .
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
MT7621 is cpu, network processor and ethernet switch chip.
MT7603 and MT7615 are 802.11 wi-fi chips.
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
yes, I am buying a XIAOMi pro router which is using the same solution , hope I can duplicate it tomorrow.
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
Hello:
I just received my router , and test for more than one hour, can't find the issue at all.
will continue the test next week, and the router is exactly using MT7621A + MT7615 ,
by the way would you please check the problem by using iperf in the sdk to see if still having the problems.
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
I will try iperf.
Additional findings:
- If I send udp packets to a non-existent IP on same wireless lan subnet (no device at that IP) it never fails. But if I send to a connected device IP on same wireless lan subnet or to any IP outside of the wlan subnet (such as a device on Internet) it always eventually fails.
- Problem happens with or without WICED_DISABLE_MCU_POWERSAVE. When using WICED_DISABLE_MCU_POWERSAVE I have added the patches described in https://community.cypress.com/thread/49942
- I have tried all of the Type of Service settings and problem still occurs with any of them.
- I have tried WLAN Firmware 7.45.98.50 from WICED 6.2 and problem still occurs.
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
I tested iperf in command app and problem still occurs.
When it happens the server side stops receiving udp packets from client and client hangs.
When client hangs it stops printing out the 10 second status messages for a while, then all of a sudden it prints a bunch of 0 bits/sec messages like below.
I repeated this test multiple times and it failed each time after different amounts of elapsed time: 430 sec, 170 sec, 90 sec, 510 sec, 90 sec.
CLIENT SIDE
> iperf --client xx.xx.xx.xx --udp --port 5001 --time 3600 -i 10
------------------------------------------------------------
Client connecting to xx.xx.xx.xx, UDP port 5001
Sending 1470 byte datagrams
UDP buffer size: 7.54 KByte (default)
------------------------------------------------------------
[ ID] Interval Transfer Bandwidth
[ 0] 0.0-10.0 sec 1.25 MBytes 1.05 Mbits/sec
[ 0] 10.0-20.0 sec 1.25 MBytes 1.05 Mbits/sec
[ 0] 20.0-30.0 sec 1.25 MBytes 1.05 Mbits/sec
[ 0] 30.0-40.0 sec 1.25 MBytes 1.05 Mbits/sec
[ 0] 40.0-50.0 sec 1.25 MBytes 1.05 Mbits/sec
[ 0] 50.0-60.0 sec 1.25 MBytes 1.05 Mbits/sec
[ 0] 60.0-70.0 sec 1.25 MBytes 1.05 Mbits/sec
[ 0] 70.0-80.0 sec 1.25 MBytes 1.05 Mbits/sec
[ 0] 80.0-90.0 sec 1.25 MBytes 1.05 Mbits/sec
[ 0] 90.0-100.0 sec 1.25 MBytes 1.05 Mbits/sec
[ 0] 100.0-110.0 sec 1.25 MBytes 1.05 Mbits/sec
[ 0] 110.0-120.0 sec 1.25 MBytes 1.05 Mbits/sec
[ 0] 120.0-130.0 sec 1.25 MBytes 1.05 Mbits/sec
[ 0] 130.0-140.0 sec 1.25 MBytes 1.05 Mbits/sec
[ 0] 140.0-150.0 sec 1.25 MBytes 1.05 Mbits/sec
[ 0] 150.0-160.0 sec 1.25 MBytes 1.05 Mbits/sec
[ 0] 160.0-170.0 sec 1.25 MBytes 1.05 Mbits/sec
<LONG PAUSE HERE WITH NO CONSOLE OUTPUT, THEN BURST OF MESSAGES BELOW>
[ 0] 170.0-180.0 sec 705 KBytes 577 Kbits/sec
[ 0] 180.0-190.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 190.0-200.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 200.0-210.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 210.0-220.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 220.0-230.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 230.0-240.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 240.0-250.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 250.0-260.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 260.0-270.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 270.0-280.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 280.0-290.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 290.0-300.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 300.0-310.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 310.0-320.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 320.0-330.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 330.0-340.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 340.0-350.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 350.0-360.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 360.0-370.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 370.0-380.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 380.0-390.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 390.0-400.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 400.0-410.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 410.0-420.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 420.0-430.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 430.0-440.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 440.0-450.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 450.0-460.0 sec 0.00 Bytes 0.00 bits/sec
[ 0] 460.0-470.0 sec 0.00 Bytes 0.00 bits/sec
SERVER SIDE
$ iperf -s -u -i 10
------------------------------------------------------------
Server listening on UDP port 5001
Receiving 1470 byte datagrams
UDP buffer size: 208 KByte (default)
------------------------------------------------------------
[ 3] local 10.0.0.19 port 5001 connected with xx.xx.xx.xx port 15503
[ ID] Interval Transfer Bandwidth Jitter Lost/Total Datagrams
[ 3] 0.0-10.0 sec 1.25 MBytes 1.05 Mbits/sec 1.151 ms 3/ 893 (0.34%)
[ 3] 10.0-20.0 sec 1.23 MBytes 1.03 Mbits/sec 1.047 ms 12/ 892 (1.3%)
[ 3] 20.0-30.0 sec 1.24 MBytes 1.04 Mbits/sec 1.083 ms 8/ 891 (0.9%)
[ 3] 30.0-40.0 sec 1.23 MBytes 1.03 Mbits/sec 1.164 ms 17/ 893 (1.9%)
[ 3] 40.0-50.0 sec 1.23 MBytes 1.03 Mbits/sec 1.004 ms 15/ 891 (1.7%)
[ 3] 50.0-60.0 sec 1.24 MBytes 1.04 Mbits/sec 1.135 ms 7/ 891 (0.79%)
[ 3] 60.0-70.0 sec 1.23 MBytes 1.03 Mbits/sec 1.321 ms 16/ 892 (1.8%)
[ 3] 70.0-80.0 sec 1.24 MBytes 1.04 Mbits/sec 1.075 ms 10/ 891 (1.1%)
[ 3] 80.0-90.0 sec 1.24 MBytes 1.04 Mbits/sec 1.176 ms 11/ 892 (1.2%)
[ 3] 90.0-100.0 sec 1.24 MBytes 1.04 Mbits/sec 1.050 ms 5/ 892 (0.56%)
[ 3] 100.0-110.0 sec 1.24 MBytes 1.04 Mbits/sec 1.162 ms 8/ 892 (0.9%)
[ 3] 110.0-120.0 sec 1.23 MBytes 1.03 Mbits/sec 1.097 ms 12/ 891 (1.3%)
[ 3] 120.0-130.0 sec 1.24 MBytes 1.04 Mbits/sec 1.029 ms 11/ 892 (1.2%)
[ 3] 130.0-140.0 sec 1.23 MBytes 1.03 Mbits/sec 1.090 ms 13/ 891 (1.5%)
[ 3] 140.0-150.0 sec 1.23 MBytes 1.03 Mbits/sec 1.143 ms 14/ 892 (1.6%)
[ 3] 150.0-160.0 sec 1.24 MBytes 1.04 Mbits/sec 1.035 ms 11/ 892 (1.2%)
[ 3] 160.0-170.0 sec 1.23 MBytes 1.03 Mbits/sec 1.161 ms 11/ 891 (1.2%)
[ 3] 170.0-180.0 sec 637 KBytes 522 Kbits/sec 1.386 ms 6/ 450 (1.3%)
[ 3] 180.0-190.0 sec 0.00 Bytes 0.00 bits/sec 0.000 ms 0/ 0 (0%)
[ 3] 190.0-200.0 sec 0.00 Bytes 0.00 bits/sec 0.000 ms 0/ 0 (0%)
[ 3] 200.0-210.0 sec 0.00 Bytes 0.00 bits/sec 0.000 ms 0/ 0 (0%)
[ 3] 210.0-220.0 sec 0.00 Bytes 0.00 bits/sec 0.000 ms 0/ 0 (0%)
[ 3] 220.0-230.0 sec 0.00 Bytes 0.00 bits/sec 0.000 ms 0/ 0 (0%)
[ 3] 230.0-240.0 sec 0.00 Bytes 0.00 bits/sec 0.000 ms 0/ 0 (0%)
[ 3] 240.0-250.0 sec 0.00 Bytes 0.00 bits/sec 0.000 ms 0/ 0 (0%)
[ 3] 250.0-260.0 sec 0.00 Bytes 0.00 bits/sec 0.000 ms 0/ 0 (0%)
[ 3] 260.0-270.0 sec 0.00 Bytes 0.00 bits/sec 0.000 ms 0/ 0 (0%)
[ 3] 270.0-280.0 sec 0.00 Bytes 0.00 bits/sec 0.000 ms 0/ 0 (0%)
[ 3] 280.0-290.0 sec 0.00 Bytes 0.00 bits/sec 0.000 ms 0/ 0 (0%)
[ 3] 290.0-300.0 sec 0.00 Bytes 0.00 bits/sec 0.000 ms 0/ 0 (0%)
[ 3] 300.0-310.0 sec 0.00 Bytes 0.00 bits/sec 0.000 ms 0/ 0 (0%)
[ 3] 310.0-320.0 sec 0.00 Bytes 0.00 bits/sec 0.000 ms 0/ 0 (0%)
[ 3] 320.0-330.0 sec 0.00 Bytes 0.00 bits/sec 0.000 ms 0/ 0 (0%)
[ 3] 330.0-340.0 sec 0.00 Bytes 0.00 bits/sec 0.000 ms 0/ 0 (0%)
[ 3] 340.0-350.0 sec 0.00 Bytes 0.00 bits/sec 0.000 ms 0/ 0 (0%)
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
Could you please capture some sniffer packet to analyze the difference between your Linksys with my AP which are using the same host and wifi chip ?
By the way I think you can disable some optional setting in AP side to check if it can help.
and are you testing the issue with our EVB ? or you are designing your own boards.
if you have our 43438 board, you can have a compare.
My testing board is CYW43438WWCD1_EVB.
Until now I can't find the issue .
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
need your help to capture a whole sniffer log for this issue , thanks.
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
I have a whole sniffer log for this issue ready. How get it to you?
I've adjusted all of the settings on AP including hidden extended settings. Nothing fixes the problem.
I'm testing this both on our own board design (mp) and with Inventek ISM4343-WBM-L151 EVB eval board. Both use same wifi module which is ISM4343-WBM-L151 containing 4343w.
If send UDP packets to IP address on wlan subnet that doesn't have any computer at that address, the problem does not occur. But if send to IP address on wlan when computer is present at that address, the problem always occurs. And if send to IP address on Internet the problem always occurs.
I have ordered CYW94343WWCD1_EVB and will also test with that.
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
ok, need your help to have a check the results when issue happened, if 4343W sent a probe request to AP, and AP had a probe response to the chip, but the chip was still connected at that time.
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
I do not see any probe request at the time of the issue.
Here's a snippet of the packet sniff right at the point of the issue.
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
I have been tracing the lower levels of WWD calls by enabling debug constants and adding some extra checkpoint printouts.
Below is trace when problem occurs. It starts out with udp packets transmitting successfully. Problem starts where you see "ERROR: UDP tx packet creation failed" line. This test application also makes some extra wwd calls after it detects problem.
sent: 9448
Outgoing datagram: 'wiced datagram 9449xxxxxx [truc]' Wcd:> DATA pkt 0x2000AC24 len 1514
Wiced Thread: Woke
sent: 9449
Outgoing datagram: 'wiced datagram 9450xxxxxx [truc]' Wcd:> DATA pkt 0x2000B260 len 1514
Wiced Thread: Woke
sent: 9450
Outgoing datagram: 'wiced datagram 9451xxxxxx [truc]' Wcd:> DATA pkt 0x2000B89C len 1514
Wiced Thread: Woke
sent: 9451
Outgoing datagram: 'wiced datagram 9452xxxxxx [truc]' Wcd:> DATA pkt 0x2000BED8 len 1514
Wiced Thread: Woke
sent: 9452
Outgoing datagram: 'wiced datagram 9453xxxxxx [truc]' Wcd:> DATA pkt 0x2000C514 len 1514
Wiced Thread: Woke
sent: 9453
Outgoing datagram: 'wiced datagram 9454xxxxxx [truc]' Wcd:> DATA pkt 0x2000CB50 len 1514
Wiced Thread: Woke
sent: 9454
Outgoing datagram: 'wiced datagram 9455xxxxxx [truc]' Wcd:> DATA pkt 0x2000D18C len 1514
Wiced Thread: Woke
sent: 9455
Outgoing datagram: 'wiced datagram 9456xxxxxx [truc]' Wcd:> DATA pkt 0x2000D7C8 len 1514
Wiced Thread: Woke
sent: 9456
Outgoing datagram: 'wiced datagram 9457xxxxxx [truc]' Wcd:> DATA pkt 0x2000DE04 len 1514
Wiced Thread: Woke
sent: 9457
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
credit update =20
Wcd:> Sending pkt 0x20004864
Wcd:> Sending pkt 0x20002938
Outg> Sending pkt 0x20002F74
agram 9458xxxxxx [truc]' Wcd:> DATA pkt 0x20004864 len 1514
Wcd:> Sending pkt 0x20002F74
sent: SendinWcd:> Sending pkt 0x20003BEC
Outg> Sending pkt 0x20006154
agram 9459xxxxxx [truc]' Wcd:> DATA pkt 0x20002F74 len 1514
Wcd:> Sending pkt 0x20006154
sent: SendinWcd:> Sending pkt 0x200054DC
Outg> Sending pkt 0x20004EA0
agram 9460xxxxxx [truc]' Wcd:> DATA pkt 0x20006154 len 1514
Wcd:> Sending pkt 0x20004EA0
sent: SendinWcd:> Sending pkt 0x200035B0
Outg> Sending pkt 0x20004228
agram 9461xxxxxx [truc]' Wcd:> DATA pkt 0x20004EA0 len 1514
Wcd:> Sending pkt 0x20004228
sent: SendinWcd:> Sending pkt 0x20005B18
Outg> Sending pkt 0x20006790
agram 9462xxxxxx [truc]' Wcd:> DATA pkt 0x20004228 len 1514
Wcd:> Sending pkt 0x20006790
sent: SendinWcd:> Sending pkt 0x20006DCC
Outgd Thread: Woke
'wiced datagram 9463xxxxxx [truc]' Wcd:> DATA pkt 0x20006790 len 1514
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
sent: 9463
Outgoing datagram: 'wiced datagram 9464xxxxxx [truc]' Wcd:> DATA pkt 0x20006DCC len 1514
Wiced Thread: Woke
sent: 9464
Outgoing datagram: 'wiced datagram 9465xxxxxx [truc]' Wcd:> DATA pkt 0x20005B18 len 1514
Wiced Thread: Woke
sent: 9465
Outgoing datagram: 'wiced datagram 9466xxxxxx [truc]' Wcd:> DATA pkt 0x200035B0 len 1514
Wiced Thread: Woke
sent: 9466
Outgoing datagram: 'wiced datagram 9467xxxxxx [truc]' Wcd:> DATA pkt 0x200054DC len 1514
Wiced Thread: Woke
sent: 9467
Outgoing datagram: 'wiced datagram 9468xxxxxx [truc]' Wcd:> DATA pkt 0x20003BEC len 1514
Wiced Thread: Woke
sent: 9468
Outgoing datagram: 'wiced datagram 9469xxxxxx [truc]' Wcd:> DATA pkt 0x20002938 len 1514
Wiced Thread: Woke
sent: 9469
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
ERROR: UDP tx packet creation failed
CHECKPOINT 99
Calling wwd_thread_poll_all()
CHECKPOINT 100
After pkt create (ERROR): CHECKPOINT 200: wiced_wifi_get_channel()
wwd_sdpcm_get_ioctl_buffer(): checkpoint 1
Wiced Thread: Woke
internal_host_buffer_get(): checkpoint 1
internal_host_buffer_get(): checkpoint 3
internal_host_buffer_get(): checkpoint 3A
internal_host_buffer_get(): checkpoint 3B
internal_host_buffer_get(): checkpoint 3C
internal_host_buffer_get(): checkpoint 3D
internal_host_buffer_get(): checkpoint 7
internal_host_buffer_get(): checkpoint 11
internal_host_buffer_get(): checkpoint 13
internal_host_buffer_get(): checkpoint 15
internal_host_buffer_get(): checkpoint 16 [SUCCESS]
wwd_sdpcm_get_ioctl_buffer(): checkpoint 2 [SUCCESS]
wwd_sdpcm_send_ioctl(): checkpoint 1: command: 29
wwd_sdpcm_send_ioctl(): checkpoint 2
wwd_sdpcm_send_ioctl(): checkpoint 3
wwd_sdpcm_send_ioctl(): checkpoint 6
wwd_sdpcm_send_ioctl(): checkpoint 7
wwd_sdpcm_send_ioctl(): checkpoint 8
wwd_sdpcm_send_ioctl(): checkpoint 9
wwd_sdpcm_send_ioctl(): checkpoint 10
wwd_sdpcm_send_ioctl(): checkpoint 11
wwd_sdpcm_send_ioctl(): checkpoint 13
Wiced Thread: Woke
wwd_sdpcm_send_ioctl(): checkpoint 14: host_rtos_get_semaphore() timeout will be 5000
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
internal_host_buffer_get(): checkpoint 1
internal_host_buffer_get(): checkpoint 3
internal_host_buffer_get(): checkpoint 3A
internal_host_buffer_get(): checkpoint 3B
internal_host_buffer_get(): checkpoint 3C
internal_host_buffer_get(): checkpoint 3D
internal_host_buffer_get(): checkpoint 7
internal_host_buffer_get(): checkpoint 11
internal_host_buffer_get(): checkpoint 13
internal_host_buffer_get(): checkpoint 15
internal_host_buffer_get(): checkpoint 16 [SUCCESS]
Wcd:< Rcvd pkt 0x20001400
credit update =20
Wcd:< Procd pkt 0x20001400: Data (64 bytes)
internal_host_buffer_get(): checkpoint 1
internal_host_buffer_get(): checkpoint 3
internal_host_buffer_get(): checkpoint 3A
internal_host_buffer_get(): checkpoint 3B
internal_host_buffer_get(): checkpoint 3C
internal_host_buffer_get(): checkpoint 3D
internal_host_buffer_get(): checkpoint 7
internal_host_buffer_get(): checkpoint 11
internal_host_buffer_get(): checkpoint 13
internal_host_buffer_get(): checkpoint 15
internal_host_buffer_get(): checkpoint 16 [SUCCESS]
Wcd:< Rcvd pkt 0x20001568
credit update =20
Wcd:< Procd pkt 0x20001568: Data (64 bytes)
internal_host_buffer_get(): checkpoint 1
internal_host_buffer_get(): checkpoint 3
internal_host_buffer_get(): checkpoint 3A
internal_host_buffer_get(): checkpoint 3B
internal_host_buffer_get(): checkpoint 3C
internal_host_buffer_get(): checkpoint 3D
internal_host_buffer_get(): checkpoint 7
internal_host_buffer_get(): checkpoint 11
internal_host_buffer_get(): checkpoint 13
internal_host_buffer_get(): checkpoint 15
internal_host_buffer_get(): checkpoint 16 [SUCCESS]
Wcd:< Rcvd pkt 0x20001400
credit update =20
Wcd:< Procd pkt 0x20001400: Data (64 bytes)
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
wwd_sdpcm_send_ioctl(): checkpoint 15: retval=2 (WWD_TIMEOUT)
wwd_sdpcm_send_ioctl(): checkpoint 16 [FAILED]
wwd_sdpcm_send_ioctl(): checkpoint 17 [FAILED]
CHECKPOINT 201: wiced_wifi_get_counters()
wwd_sdpcm_get_iovar_buffer(): checkpoint 1: name=counters
internal_host_buffer_get(): checkpoint 1
internal_host_buffer_get(): checkpoint 3
internal_host_buffer_get(): checkpoint 3D
internal_host_buffer_get(): checkpoint 4
internal_host_buffer_get(): checkpoint 5
internal_host_buffer_get(): checkpoint 6: timeout_ms=4294967295
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
internal_host_buffer_get(): checkpoint 1
internal_host_buffer_get(): checkpoint 3
internal_host_buffer_get(): checkpoint 3A
internal_host_buffer_get(): checkpoint 3B
internal_host_buffer_get(): checkpoint 3C
internal_host_buffer_get(): checkpoint 3D
internal_host_buffer_get(): checkpoint 7
internal_host_buffer_get(): checkpoint 11
internal_host_buffer_get(): checkpoint 13
internal_host_buffer_get(): checkpoint 15
internal_host_buffer_get(): checkpoint 16 [SUCCESS]
Wcd:< Rcvd pkt 0x20001400
credit update =20
Wcd:< Procd pkt 0x20001400: Data (64 bytes)
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wcd:> DATA pkt 0x20001400 len 42
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
internal_host_buffer_get(): checkpoint 1
internal_host_buffer_get(): checkpoint 3
internal_host_buffer_get(): checkpoint 3A
internal_host_buffer_get(): checkpoint 3B
internal_host_buffer_get(): checkpoint 3C
internal_host_buffer_get(): checkpoint 3D
internal_host_buffer_get(): checkpoint 7
internal_host_buffer_get(): checkpoint 11
internal_host_buffer_get(): checkpoint 13
internal_host_buffer_get(): checkpoint 15
internal_host_buffer_get(): checkpoint 16 [SUCCESS]
Wcd:< Rcvd pkt 0x20001568
credit update =20
Wcd:< Procd pkt 0x20001568: Data (64 bytes)
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wcd:> DATA pkt 0x20001568 len 42
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
internal_host_buffer_get(): checkpoint 1
internal_host_buffer_get(): checkpoint 3
internal_host_buffer_get(): checkpoint 3A
internal_host_buffer_get(): checkpoint 3B
internal_host_buffer_get(): checkpoint 3C
internal_host_buffer_get(): checkpoint 3D
internal_host_buffer_get(): checkpoint 7
internal_host_buffer_get(): checkpoint 11
internal_host_buffer_get(): checkpoint 13
internal_host_buffer_get(): checkpoint 15
internal_host_buffer_get(): checkpoint 16 [SUCCESS]
Wcd:< Rcvd pkt 0x2000161C
credit update =20
Wcd:< Procd pkt 0x2000161C: Data (64 bytes)
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wcd:> DATA pkt 0x2000161C len 42
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
internal_host_buffer_get(): checkpoint 1
internal_host_buffer_get(): checkpoint 3
internal_host_buffer_get(): checkpoint 3A
internal_host_buffer_get(): checkpoint 3B
internal_host_buffer_get(): checkpoint 3C
internal_host_buffer_get(): checkpoint 3D
internal_host_buffer_get(): checkpoint 7
internal_host_buffer_get(): checkpoint 11
internal_host_buffer_get(): checkpoint 13
internal_host_buffer_get(): checkpoint 15
internal_host_buffer_get(): checkpoint 16 [SUCCESS]
Wcd:< Rcvd pkt 0x200016D0
credit update =20
Wcd:< Procd pkt 0x200016D0: Data (64 bytes)
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wcd:> DATA pkt 0x200016D0 len 42
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
internal_host_buffer_get(): checkpoint 1
internal_host_buffer_get(): checkpoint 3
internal_host_buffer_get(): checkpoint 3A
internal_host_buffer_get(): checkpoint 3B
internal_host_buffer_get(): checkpoint 3C
internal_host_buffer_get(): checkpoint 3D
internal_host_buffer_get(): checkpoint 7
internal_host_buffer_get(): checkpoint 11
internal_host_buffer_get(): checkpoint 13
internal_host_buffer_get(): checkpoint 15
internal_host_buffer_get(): checkpoint 16 [SUCCESS]
Wcd:< Rcvd pkt 0x20001784
credit update =20
Wcd:< Procd pkt 0x20001784: Data (64 bytes)
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wcd:> DATA pkt 0x20001784 len 42
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
Wiced Thread: Woke
<KEEPS REPEATING OVER AND OVER>
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
I find your "credit update =20" always equal to 20 , that means we have no resource for packet transmit.
Would you please add print to check this method?
wwd_result_t wwd_bus_set_flow_control( uint8_t value )
{
if ( value != 0 )
{
// add print here , to see if flow control is set to TRUE when issue happened.
wwd_bus_flow_controlled = WICED_TRUE;
}
else
{
wwd_bus_flow_controlled = WICED_FALSE;
}
return WWD_SUCCESS;
}
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
It is always wwd_bus_flow_controlled = WICED_FALSE at time of failure and I never see wwd_bus_flow_controlled = WICED_TRUE at all.
I have detailed traces if needed.
Below is credit update values from last trace.
-----
credit update =34
credit update =35
credit update =36
credit update =37
credit update =38
credit update =39
credit update =40
credit update =41
credit update =42
credit update =43
credit update =44
credit update =45
credit update =46
credit update =46
credit update =46
credit update =46
credit update =46
credit update =47
credit update =48
credit update =49
credit update =50
credit update =51
credit update =52
credit update =56
credit update =57
credit update =58
credit update =59
credit update =60
credit update =61
credit update =62
credit update =63
credit update =64
credit update =65
credit update =66
credit update =67
credit update =68
credit update =69
credit update =29
credit update =43
credit update =57
credit update =71
credit update =85
credit update =99
credit update =113
credit update =127
credit update =141
credit update =155
credit update =169
credit update =183
credit update =197
credit update =211
credit update =225
credit update =239
credit update =253
credit update =11
credit update =25
credit update =39
credit update =53
credit update =67
credit update =81
credit update =95
credit update =109
credit update =123
credit update =137
credit update =151
credit update =165
credit update =179
credit update =193
credit update =207
credit update =221
credit update =235
credit update =249
credit update =7
credit update =21
credit update =35
credit update =49
credit update =63
credit update =77
credit update =91
credit update =105
credit update =119
credit update =133
credit update =147
credit update =161
credit update =175
credit update =189
credit update =203
credit update =217
credit update =231
credit update =245
credit update =3
credit update =17
credit update =31
credit update =45
credit update =59
credit update =73
credit update =87
credit update =101
credit update =115
credit update =129
credit update =143
credit update =157
credit update =171
credit update =185
credit update =199
credit update =213
credit update =227
credit update =241
credit update =255
credit update =13
credit update =27
credit update =41
credit update =55
credit update =69
credit update =83
credit update =97
credit update =111
credit update =125
credit update =139
credit update =153
credit update =167
credit update =181
credit update =195
credit update =209
credit update =223
credit update =237
credit update =251
credit update =9
credit update =23
credit update =37
credit update =51
credit update =65
credit update =79
credit update =93
credit update =107
credit update =121
credit update =135
credit update =149
credit update =163
credit update =177
credit update =191
credit update =205
credit update =219
credit update =233
credit update =247
credit update =5
credit update =19
credit update =33
credit update =47
credit update =61
credit update =75
credit update =89
credit update =103
credit update =117
credit update =131
credit update =145
credit update =159
credit update =173
credit update =187
credit update =201
credit update =215
credit update =229
credit update =243
credit update =1
credit update =15
credit update =29
credit update =43
credit update =57
credit update =71
credit update =85
credit update =99
credit update =113
credit update =127
credit update =141
credit update =155
credit update =169
credit update =183
credit update =197
credit update =211
credit update =225
credit update =239
credit update =253
credit update =11
credit update =25
credit update =39
credit update =53
credit update =67
credit update =81
credit update =95
credit update =109
credit update =123
credit update =137
credit update =151
credit update =165
credit update =179
credit update =193
credit update =207
credit update =221
credit update =235
credit update =249
credit update =7
credit update =21
credit update =35
credit update =49
credit update =63
credit update =77
credit update =91
credit update =105
credit update =119
credit update =133
credit update =147
credit update =161
credit update =175
credit update =189
credit update =203
credit update =217
credit update =231
credit update =245
credit update =3
credit update =17
credit update =31
credit update =45
credit update =59
credit update =73
credit update =87
credit update =101
credit update =115
credit update =129
credit update =143
credit update =157
credit update =171
credit update =185
credit update =199
credit update =213
credit update =227
credit update =241
credit update =255
credit update =13
credit update =27
credit update =41
credit update =55
credit update =69
credit update =83
credit update =97
credit update =111
credit update =125
credit update =139
credit update =153
credit update =167
credit update =181
credit update =195
credit update =209
credit update =223
credit update =237
credit update =251
credit update =9
credit update =23
credit update =37
credit update =51
credit update =65
credit update =79
credit update =93
credit update =107
credit update =121
credit update =135
credit update =149
credit update =163
credit update =177
credit update =191
credit update =205
credit update =219
credit update =233
credit update =247
credit update =5
credit update =19
credit update =33
credit update =47
credit update =61
credit update =75
credit update =89
credit update =103
credit update =117
credit update =131
credit update =145
credit update =159
credit update =173
credit update =187
credit update =201
credit update =215
credit update =229
credit update =243
credit update =1
credit update =15
credit update =29
credit update =43
credit update =57
credit update =71
credit update =85
credit update =99
credit update =113
credit update =127
credit update =141
credit update =155
credit update =169
credit update =183
credit update =197
credit update =211
credit update =225
credit update =239
credit update =253
credit update =11
credit update =25
credit update =39
credit update =53
credit update =67
credit update =81
credit update =95
credit update =109
credit update =123
credit update =137
credit update =151
credit update =165
credit update =179
credit update =193
credit update =207
credit update =221
credit update =235
credit update =249
credit update =7
credit update =21
credit update =35
credit update =49
credit update =63
credit update =77
credit update =91
credit update =105
credit update =119
credit update =133
credit update =147
credit update =161
credit update =175
credit update =189
credit update =203
credit update =217
credit update =231
credit update =245
credit update =3
credit update =17
credit update =31
credit update =45
credit update =59
credit update =73
credit update =87
credit update =101
credit update =115
credit update =129
credit update =143
credit update =157
credit update =171
credit update =185
credit update =199
credit update =213
credit update =217
credit update =217
credit update =217
credit update =231
credit update =245
credit update =3
credit update =17
credit update =31
credit update =45
credit update =59
credit update =73
credit update =87
credit update =101
credit update =115
credit update =129
credit update =143
credit update =157
credit update =171
credit update =185
credit update =199
credit update =213
credit update =227
credit update =241
credit update =255
credit update =13
credit update =27
credit update =41
credit update =55
credit update =69
credit update =83
credit update =97
credit update =102
credit update =114
credit update =114
credit update =114
credit update =114
credit update =114
credit update =114
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
wiced_network_up( WICED_STA_INTERFACE, WICED_USE_EXTERNAL_DHCP_SERVER, NULL ); |
wwd_wifi_set_iovar_void("down",WWD_STA_INTERFACE);
tmp =10;
wwd_wifi_set_iovar_value("lrl", tmp, WWD_STA_INTERFACE); |
tmp =10;
wwd_wifi_set_iovar_value("srl", tmp, WWD_STA_INTERFACE); |
wwd_wifi_set_iovar_void("up",WWD_STA_INTERFACE);
need your help to test if lrl srl parameter can influence the UDP transfer.
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
I will try this.
The problem also occurs with CYW94343WWCD1_EVB
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
Problem still occurs with lrl srl parameters set to 10.
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
Hello:
Recently, I have tests about the credit update, from my observation:
#define UDP_MAX_DATA_LENGTH | 30 |
#define UDP_RX_TIMEOUT | 1 |
#define UDP_TX_INTERVAL | 20 |
if I set the TX interval to 20ms or above, the credit difference value between transmit sequence and credit update is below:
credit update bus_data_credit wwd_sdpcm_packet_transmit_sequence_number***********=40
credit update bus_data_credit wwd_sdpcm_last_bus_data_credit***********=55
echo: 96693
echo: 96694
credit update bus_data_credit wwd_sdpcm_packet_transmit_sequence_number***********=41
credit update bus_data_credit wwd_sdpcm_last_bus_data_credit***********=57
You can see the difference is about 15 .
the print is here:
wwd_result_t wwd_sdpcm_get_packet_to_send( /*@special@*/ /*@out@*/ wiced_buffer_t* buffer) /*@allocates *buffer@*/ /*@defines **buffer@*/
{
sdpcm_common_header_t* packet;
if ( wwd_sdpcm_send_queue_head != NULL )
{
/* Check if we're being flow controlled */
if ( wwd_bus_is_flow_controlled() == WICED_TRUE )
{
WWD_STATS_INCREMENT_VARIABLE( flow_control );
return WWD_FLOW_CONTROLLED;
}
printf("credit update bus_data_credit wwd_sdpcm_packet_transmit_sequence_number***********=%d\n ",wwd_sdpcm_packet_transmit_sequence_number) ;
printf("credit update bus_data_credit wwd_sdpcm_last_bus_data_credit***********=%d\n ",wwd_sdpcm_last_bus_data_credit) ;
if you set TX interval to 10ms or below, the difference value will be close to 1, or sometimes it will show no credits.
credit update bus_data_credit wwd_sdpcm_packet_transmit_sequence_number***********=241
credit update bus_data_credit wwd_sdpcm_last_bus_data_credit***********=242
credit update bus_data_credit wwd_sdpcm_packet_transmit_sequence_number***********=242
credit update bus_data_credit wwd_sdpcm_last_bus_data_credit***********=242
**o: 2207
****************no credit **************** echo: 2207
// we have credits update here
credit update bus_data_credit wwd_sdpcm_packet_transmit_sequence_number***********=242a
credit update bus_data_credit wwd_sdpcm_last_bus_data_credit***********=247
credit update bus_data_credit wwd_sdpcm_packet_transmit_sequence_number***********=243
cro: 2209
ate bus_data_credit wwd_sdpcm_last_bus_data_credit***********=247
echo: 2209
credit update bus_data_credit wwd_sdpcm_packet_transmit_sequence_number***********=244
credit update bus_data_credit wwd_sdpcm_last_bus_data_credit***********=247
credit update bus_data_credit wwd_sdpcm_packet_transmit_sequence_number***********=245
credit update bus_data_credit wwd_sdpcm_last_bus_data_credit***********=247
cro: 2210
ate bus_data_credit wwd_sdpcm_packet_transmit_sequence_number***********=246
echo: 2210
credit update bus_data_credit wwd_sdpcm_last_bus_data_credit***********=247
credit update bus_data_credit wwd_sdpcm_packet_transmit_sequence_number***********=247
credit update bus_data_credit wwd_sdpcm_last_bus_data_credit***********=247
**************************no credit ****************
// if packet interval is set to transmit more quickly, the credit will go to no credits, but never hang, or can't recover in my tests.
because the credit value is updated from firmware or lower layer, it has no relevance with the wwd or UDP layer .
I suspect the connection between evb and MTK router can be created successfully every time, but the physical trasmission will be blocked always.
That will reflect to wwd and UDP layer, UDP packet creation failed.
So my suggestions are :
1. change the router to different channel , or if you have other same brand router, you can try it also.
2. try to find a same MTK solution router to see if still same issue exists.
in my tests there has no such issues happened.
3. find clean environment to see if noise caused the problem.
4. check sniffer log to see if there existed a lot of re-transmissions in specific rate.
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
Problem also occurs with 43438 based boards.
I have reproduced the problem on:
- Raspberry Pi 3 (43438)
- Redbear Duo (43438)
- Murata Type 1LD (43438)
Have not seen any failures with:
- Raspberry Pi 3 B+ (43455)