msm8916 + wcn3620 mainline support?

Sun Jan 18 17:53:10 PST 2015

On 12 January 2015 at 17:58, Andy Green <andy.green at linaro.org> wrote:
> On 12 January 2015 at 17:22, Eugene Krasnikov <k.eugene.e at gmail.com> wrote:

> It does not always(?) mean death, maybe wpa_supplicant is retrying at
> a high level in the background.  For example here is what getting big
> buck bunny actually looked like (with iwconfig power off), he is doing
> it every 40s exactly.  But when idle, it happens much less often.
>
> ies/BigBuckBunny_320x180.mp4t http://download.blender.org/peach/bigbuckbunny_mov
> --1970-01-01 00:33:54--
> http://download.blender.org/peach/bigbuckbunny_movies/BigBuckBunny_320x180.mp4
> Resolving download.blender.org (download.blender.org)... 82.94.213.221
> Connecting to download.blender.org
> (download.blender.org)|82.94.213.221|:80... connected.
> HTTP request sent, awaiting response... 200 OK
> Length: 64657027 (62M) [application/octet-stream]
> Saving to: ‘BigBuckBunny_320x180.mp4’
>
> 21% [=======>                               ] 14,212,181  --.-K/s  eta
> 1m 55s  [ 2069.555799] wcn36xx: ERROR hal_remove_bsskey response
> failed err=16
> 31% [===========>                           ] 20,584,181  --.-K/s  eta
> 2m 35s  [ 2109.575756] wcn36xx: ERROR hal_remove_bsskey response
> failed err=16

These problems coming at 40s intervals appear to be directly related
to wpa_supplicant asking for SCAN.

root at linaro-developer:~# ping reddit.com
PING reddit.com (198.41.208.139) 56(84) bytes of data.
64 bytes from 198.41.208.139: icmp_seq=1 ttl=50 time=32.1 ms
64 bytes from 198.41.208.139: icmp_seq=2 ttl=50 time=30.1 ms
64 bytes from 198.41.208.139: icmp_seq=3 ttl=50 time=39.1 ms
64 bytes from 198.41.208.139: icmp_seq=4 ttl=50 time=32.4 ms
64 bytes from 198.41.208.139: icmp_seq=5 ttl=50 time=30.7 ms
64 bytes from 198.41.208.139: icmp_seq=6 ttl=50 time=30.3 ms
64 bytes from 198.41.208.139: icmp_seq=7 ttl=50 time=30.1 ms
64 bytes from 198.41.208.139: icmp_seq=8 ttl=50 time=46.2 ms
64 bytes from 198.41.208.139: icmp_seq=9 ttl=50 time=32.2 ms
64 bytes from 198.41.208.139: icmp_seq=10 ttl=50 time=37.5 ms
64 bytes from 198.41.208.139: icmp_seq=11 ttl=50 time=30.2 ms
64 bytes from 198.41.208.139: icmp_seq=12 ttl=50 time=30.4 ms
64 bytes from 198.41.208.139: icmp_seq=13 ttl=50 time=33.4 ms
[   44.235622] wcn36xx: hal init scan mode 2
[   44.238111] wcn36xx: hal start scan channel 11
[   54.031504] wcn36xx: hal end scan channel 11
[   54.032768] wcn36xx: hal finish scan mode 2
64 bytes from 198.41.208.139: icmp_seq=14 ttl=50 time=9100 ms
64 bytes from 198.41.208.139: icmp_seq=15 ttl=50 time=8097 ms
64 bytes from 198.41.208.139: icmp_seq=16 ttl=50 time=7097 ms
64 bytes from 198.41.208.139: icmp_seq=17 ttl=50 time=6102 ms
64 bytes from 198.41.208.139: icmp_seq=18 ttl=50 time=5102 ms
64 bytes from 198.41.208.139: icmp_seq=19 ttl=50 time=4102 ms
64 bytes from 198.41.208.139: icmp_seq=20 ttl=50 time=3103 ms
64 bytes from 198.41.208.139: icmp_seq=21 ttl=50 time=2107 ms
64 bytes from 198.41.208.139: icmp_seq=22 ttl=50 time=1107 ms
64 bytes from 198.41.208.139: icmp_seq=23 ttl=50 time=108 ms
64 bytes from 198.41.208.139: icmp_seq=24 ttl=50 time=30.0 ms
64 bytes from 198.41.208.139: icmp_seq=25 ttl=50 time=30.1 ms
...
64 bytes from 198.41.208.139: icmp_seq=53 ttl=50 time=29.9 ms
[   84.028186] wcn36xx: hal init scan mode 2
[   84.031935] wcn36xx: hal start scan channel 11
[   93.521482] wcn36xx: hal end scan channel 11
[   93.522714] wcn36xx: hal finish scan mode 2
64 bytes from 198.41.208.139: icmp_seq=54 ttl=50 time=8619 ms
64 bytes from 198.41.208.139: icmp_seq=55 ttl=50 time=7625 ms
64 bytes from 198.41.208.139: icmp_seq=56 ttl=50 time=6627 ms
64 bytes from 198.41.208.139: icmp_seq=57 ttl=50 time=5630 ms
64 bytes from 198.41.208.139: icmp_seq=58 ttl=50 time=4630 ms
64 bytes from 198.41.208.139: icmp_seq=59 ttl=50 time=3630 ms
64 bytes from 198.41.208.139: icmp_seq=60 ttl=50 time=2631 ms
64 bytes from 198.41.208.139: icmp_seq=61 ttl=50 time=1635 ms
64 bytes from 198.41.208.139: icmp_seq=62 ttl=50 time=635 ms
64 bytes from 198.41.208.139: icmp_seq=63 ttl=50 time=30.4 ms
64 bytes from 198.41.208.139: icmp_seq=64 ttl=50 time=30.4 ms
...
eventually he does not survive coming back from it
---
64 bytes from 198.41.208.139: icmp_seq=170 ttl=50 time=30.3 ms
64 bytes from 198.41.208.139: icmp_seq=171 ttl=50 time=30.2 ms
[  203.125019] wcn36xx: hal init scan mode 2
[  203.127556] wcn36xx: hal start scan channel 11
[  212.921332] wcn36xx: hal end scan channel 11
[  212.922602] wcn36xx: hal finish scan mode 2
64 bytes from 198.41.208.139: icmp_seq=173 ttl=50 time=8846 ms
64 bytes from 198.41.208.139: icmp_seq=174 ttl=50 time=7851 ms
64 bytes from 198.41.208.139: icmp_seq=175 ttl=50 time=6853 ms
64 bytes from 198.41.208.139: icmp_seq=176 ttl=50 time=5875 ms
64 bytes from 198.41.208.139: icmp_seq=177 ttl=50 time=4896 ms
64 bytes from 198.41.208.139: icmp_seq=178 ttl=50 time=3916 ms
64 bytes from 198.41.208.139: icmp_seq=179 ttl=50 time=2924 ms
64 bytes from 198.41.208.139: icmp_seq=180 ttl=50 time=1948 ms
64 bytes from 198.41.208.139: icmp_seq=181 ttl=50 time=964 ms
64 bytes from 198.41.208.139: icmp_seq=182 ttl=50 time=31.1 ms
64 bytes from 198.41.208.139: icmp_seq=183 ttl=50 time=30.3 ms
[  242.924487] wcn36xx: hal init scan mode 2
[  242.926965] wcn36xx: hal start scan channel 11
[  252.721275] wcn36xx: hal end scan channel 11
[  252.722951] wcn36xx: hal finish scan mode 2
[  282.724649] wcn36xx: hal init scan mode 2
[  282.727116] wcn36xx: hal start scan channel 11
[  292.521231] wcn36xx: hal end scan channel 11
[  292.522499] wcn36xx: hal finish scan mode 2
[  322.523902] wcn36xx: hal init scan mode 2
[  322.526438] wcn36xx: hal start scan channel 11
[  332.321209] wcn36xx: hal end scan channel 11
[  332.322481] wcn36xx: hal finish scan mode 2
(link is still logically up, but not working)

I'll try to understand the difference between Prima SCAN action and
wcn36xx action since this looks like it might be the root of all the
remaining evil.

-Andy