Send connman mailing list submissions to
[email protected]
To subscribe or unsubscribe via the World Wide Web, visit
https://lists.01.org/mailman/listinfo/connman
or, via email, send a message with subject or body 'help' to
[email protected]
You can reach the person managing the list at
[email protected]
When replying, please edit your Subject line so it is more specific
than "Re: Contents of connman digest..."
Today's Topics:
1. Re: intermittent failures (Daniel Wagner)
2. Re: Connman Error wifi: Operation not permitted [HELP please]
(Jared Harvey)
----------------------------------------------------------------------
Message: 1
Date: Sun, 12 Mar 2017 21:03:38 +0100
From: Daniel Wagner <[email protected]>
To: Fred Ollinger <[email protected]>, "[email protected]"
<[email protected]>
Subject: Re: intermittent failures
Message-ID: <[email protected]>
Content-Type: text/plain; charset=windows-1252; format=flowed
Hi Fred,
On 03/10/2017 02:01 AM, Fred Ollinger wrote:
> New Note 58
>
> Given i.MX6 hardware with ARMv7 processor, I'm having intermittent failures
> when connecting to access points.
>
> It's intermittent in that I can sometimes connect to an access point
> then other times, connecting fails. From what I can see, we authenticate
> properly, but then fail to get a password via dhcp.
Do you mean you don't get a lease instead of a password?
> I'm running connman 1.25 and I'm connecting by using the DBUS interface. This
> is built with Yocto.
>
> Is there any other information you need?
>
> Has this been fixed in a later release?
There are a lot of bug fixes between 1.25 and the current head. If
possible give the head a try first before starting to debug.
> Is there a bugzilla I can go to in order to search for similar problems?
We have a jira: https://01.org/jira/projects/CM/summary
> Here's the debug output from a failure.
>
> connmand[510]: Skipping disconnect of
> 43533635782d3136302d4368757061636162726173_managed_none, network is
> connecting.
> connmand[510]: wlan0 {add} route ff00:: gw :: scope 0 <UNIVERSE>
> connmand[510]: wlan0 {add} route fe80:: gw :: scope 0 <UNIVERSE>
> connmand[510]: wlan0 {RX} 32 packets 4991 bytes
> connmand[510]: wlan0 {TX} 299 packets 53708 bytes
> connmand[510]: wlan0 {update} flags 69699 <UP,RUNNING,LOWER_UP>
> connmand[510]: wlan0 {newlink} index 3 address E0:E5:CF:7C:60:FC mtu 1500
> connmand[510]: wlan0 {newlink} index 3 operstate 6 <UP>
> connmand[510]: wlan0 {RX} 32 packets 4991 bytes
> connmand[510]: wlan0 {TX} 299 packets 53708 bytes
> connmand[510]: wlan0 {update} flags 69635 <UP,LOWER_UP>
> connmand[510]: wlan0 {newlink} index 3 address E0:E5:CF:7C:60:FC mtu 1500
> connmand[510]: wlan0 {newlink} index 3 operstate 5 <DORMANT>
> connmand[510]: wlan0 {RX} 32 packets 4991 bytes
> connmand[510]: wlan0 {TX} 299 packets 53708 bytes
> connmand[510]: wlan0 {update} flags 69699 <UP,RUNNING,LOWER_UP>
> connmand[510]: wlan0 {newlink} index 3 address E0:E5:CF:7C:60:FC mtu 1500
> connmand[510]: wlan0 {newlink} index 3 operstate 6 <UP>
> connmand[510]: wlan0 {add} address 192.168.8.27/32 label wlan0 family 2
> connmand[510]: wlan0 {add} route 0.0.0.0 gw 0.0.0.0 scope 253 <LINK>
> connmand[510]: wlan0 {RX} 33 packets 5333 bytes
> connmand[510]: wlan0 {TX} 306 packets 55004 bytes
> connmand[510]: wlan0 {update} flags 4099 <UP>
> connmand[510]: wlan0 {newlink} index 3 address E0:E5:CF:7C:60:FC mtu 1500
> connmand[510]: wlan0 {newlink} index 3 operstate 2 <DOWN>
> connmand[510]: wlan0 {del} route fe80:: gw :: scope 0 <UNIVERSE>
> connmand[510]: wlan0 {del} route ff00:: gw :: scope 0 <UNIVERSE>
> connmand[510]: Probably roaming right now! Staying connected...
> connmand[510]: wlan0 {RX} 33 packets 5333 bytes
> connmand[510]: wlan0 {TX} 306 packets 55004 bytes
> connmand[510]: wlan0 {update} flags 69699 <UP,RUNNING,LOWER_UP>
> connmand[510]: wlan0 {newlink} index 3 address E0:E5:CF:7C:60:FC mtu 1500
> connmand[510]: wlan0 {newlink} index 3 operstate 6 <UP>
> connmand[510]: wlan0 {RX} 33 packets 5333 bytes
> connmand[510]: wlan0 {TX} 306 packets 55004 bytes
> connmand[510]: wlan0 {update} flags 69635 <UP,LOWER_UP>
> connmand[510]: wlan0 {newlink} index 3 address E0:E5:CF:7C:60:FC mtu 1500
> connmand[510]: wlan0 {newlink} index 3 operstate 5 <DORMANT>
> connmand[510]: wlan0 {RX} 33 packets 5333 bytes
> connmand[510]: wlan0 {TX} 306 packets 55004 bytes
> connmand[510]: wlan0 {update} flags 69699 <UP,RUNNING,LOWER_UP>
> connmand[510]: wlan0 {newlink} index 3 address E0:E5:CF:7C:60:FC mtu 1500
> connmand[510]: wlan0 {newlink} index 3 operstate 6 <UP>
> connmand[510]: Probably roaming right now! Staying connected...
>
>
> Case2:
> connmand[524]: wlan0 {RX} 2 packets 463 bytes
> connmand[524]: wlan0 {TX} 12 packets 1712 bytes
> connmand[524]: wlan0 {update} flags 4099 <UP>
> connmand[524]: wlan0 {newlink} index 3 address E0:E5:CF:7C:60:FC mtu 1500
> connmand[524]: wlan0 {newlink} index 3 operstate 2 <DOWN>
> connmand[524]: Skipping disconnect of
> 43533635782d3136302d4368757061636162726173_managed_none, network is
> connecting.
> connmand[524]: wlan0 {RX} 2 packets 463 bytes
> connmand[524]: wlan0 {TX} 12 packets 1712 bytes
> connmand[524]: wlan0 {update} flags 69699 <UP,RUNNING,LOWER_UP>
> connmand[524]: wlan0 {newlink} index 3 address E0:E5:CF:7C:60:FC mtu 1500
> connmand[524]: wlan0 {newlink} index 3 operstate 6 <UP>
> connmand[524]: wlan0 {RX} 2 packets 463 bytes
> connmand[524]: wlan0 {TX} 12 packets 1712 bytes
> connmand[524]: wlan0 {update} flags 69635 <UP,LOWER_UP>
> connmand[524]: wlan0 {newlink} index 3 address E0:E5:CF:7C:60:FC mtu 1500
> connmand[524]: wlan0 {newlink} index 3 operstate 5 <DORMANT>
> connmand[524]: wlan0 {RX} 2 packets 463 bytes
> connmand[524]: wlan0 {TX} 12 packets 1712 bytes
> connmand[524]: wlan0 {update} flags 69699 <UP,RUNNING,LOWER_UP>
> connmand[524]: wlan0 {newlink} index 3 address E0:E5:CF:7C:60:FC mtu 1500
> connmand[524]: wlan0 {newlink} index 3 operstate 6 <UP>
> connmand[524]: wlan0 {add} address 192.168.8.27/32 label wlan0 family 2
> connmand[524]: wlan0 {add} route 0.0.0.0 gw 0.0.0.0 scope 253 <LINK>
Not much what I can read from the log. You need to enable the debug log
for some additional information.
One thing which is different between the two logs, is that in the upper
one there is roaming involved. In the lower one the client stays on one
AP. At least during this snippet. Not sure if that means anything.
In short: give the current head a try :)
Thanks,
Daniel
------------------------------
Message: 2
Date: Sun, 12 Mar 2017 16:56:20 -0400
From: Jared Harvey <[email protected]>
To: Daniel Wagner <[email protected]>
Cc: [email protected]
Subject: Re: Connman Error wifi: Operation not permitted [HELP please]
Message-ID:
<CAA1dXcXoytz8e=+fa809bw22sw9ozwx-rxxnsia7mycmtb3...@mail.gmail.com>
Content-Type: text/plain; charset="utf-8"
I did a fresh boot. then did the below commands. Is the stuff around [
341.732127] the stack trace you are looking for?
machinekit@beaglebone:~$ sudo connmanctl enable wifi
Error wifi: Operation not permitted
machinekit@beaglebone:~$ cat /var/log/messages | grep 7601
Feb 12 15:13:34 beaglebone kernel: [ 1.972568] usb 1-1: New USB device
found, idVendor=148f, idProduct=7601
Mar 5 14:06:22 beaglebone kernel: [ 2.078731] usb 1-1: New USB device
found, idVendor=148f, idProduct=7601
Mar 5 14:08:39 beaglebone kernel: [ 2.081168] usb 1-1: New USB device
found, idVendor=148f, idProduct=7601
Mar 5 14:10:04 beaglebone kernel: [ 2.171234] usb 1-1: New USB device
found, idVendor=148f, idProduct=7601
Mar 5 14:56:19 beaglebone kernel: [ 1932.411996] Modules linked in:
mt7601Usta(O) omap_rng 8021q garp stp llc g_ether libcomposite
Mar 5 14:56:19 beaglebone kernel: [ 1932.412689] [<c032b6a3>]
(usb_submit_urb+0x1cb/0x398) from [<bf86b7ab>] (BulkInCmdRspEvent+0x42/0x68
[mt7601Usta])
Mar 5 14:56:19 beaglebone kernel: [ 1932.413109] [<bf86b7ab>]
(BulkInCmdRspEvent+0x42/0x68 [mt7601Usta]) from [<bf86b8cd>]
(RTUSBBulkCmdRspEventReceive+0x38/0x58 [mt7601Usta])
Mar 5 14:56:19 beaglebone kernel: [ 1932.413481] [<bf86b8cd>]
(RTUSBBulkCmdRspEventReceive+0x38/0x58 [mt7601Usta]) from [<bf84dabf>]
(NICInitializeAsic+0xea/0x3c0 [mt7601Usta])
Mar 5 14:56:19 beaglebone kernel: [ 1932.413863] [<bf84dabf>]
(NICInitializeAsic+0xea/0x3c0 [mt7601Usta]) from [<e0d8a000>] (0xe0d8a000)
Mar 5 15:43:10 beaglebone kernel: [ 2.078803] usb 1-1: New USB device
found, idVendor=148f, idProduct=7601
Mar 5 15:48:56 beaglebone kernel: [ 330.263310] Modules linked in:
mt7601Usta(O) omap_rng 8021q garp stp llc g_ether libcomposite
Mar 5 15:48:56 beaglebone kernel: [ 330.264005] [<c032b6a3>]
(usb_submit_urb+0x1cb/0x398) from [<bf86b7ab>] (BulkInCmdRspEvent+0x42/0x68
[mt7601Usta])
Mar 5 15:48:56 beaglebone kernel: [ 330.264424] [<bf86b7ab>]
(BulkInCmdRspEvent+0x42/0x68 [mt7601Usta]) from [<bf86b8cd>]
(RTUSBBulkCmdRspEventReceive+0x38/0x58 [mt7601Usta])
Mar 5 15:48:56 beaglebone kernel: [ 330.264795] [<bf86b8cd>]
(RTUSBBulkCmdRspEventReceive+0x38/0x58 [mt7601Usta]) from [<bf84dabf>]
(NICInitializeAsic+0xea/0x3c0 [mt7601Usta])
Mar 5 15:48:56 beaglebone kernel: [ 330.265162] [<bf84dabf>]
(NICInitializeAsic+0xea/0x3c0 [mt7601Usta]) from [<e0d8a000>] (0xe0d8a000)
Mar 8 11:24:00 beaglebone kernel: [ 1.176010] usbcore: registered new
interface driver cdc_ncm
Mar 8 11:24:00 beaglebone kernel: [ 2.081250] usb 1-1: New USB device
found, idVendor=148f, idProduct=7601
Mar 9 10:59:50 beaglebone kernel: [84932.378008] Modules linked in:
mt7601Usta(O) omap_rng 8021q garp stp llc g_ether libcomposite
Mar 9 10:59:50 beaglebone kernel: [84932.378703] [<c032b6a3>]
(usb_submit_urb+0x1cb/0x398) from [<bf86b7ab>] (BulkInCmdRspEvent+0x42/0x68
[mt7601Usta])
Mar 9 10:59:50 beaglebone kernel: [84932.379294] [<bf86b7ab>]
(BulkInCmdRspEvent+0x42/0x68 [mt7601Usta]) from [<bf86b8cd>]
(RTUSBBulkCmdRspEventReceive+0x38/0x58 [mt7601Usta])
Mar 9 10:59:50 beaglebone kernel: [84932.379670] [<bf86b8cd>]
(RTUSBBulkCmdRspEventReceive+0x38/0x58 [mt7601Usta]) from [<bf84dabf>]
(NICInitializeAsic+0xea/0x3c0 [mt7601Usta])
Mar 9 10:59:50 beaglebone kernel: [84932.379870] [<bf84dabf>]
(NICInitializeAsic+0xea/0x3c0 [mt7601Usta]) from [<e0d8a000>] (0xe0d8a000)
Mar 9 13:43:23 beaglebone kernel: [ 2.081163] usb 1-1: New USB device
found, idVendor=148f, idProduct=7601
Mar 12 01:45:37 beaglebone kernel: [ 2.081482] usb 1-1: New USB device
found, idVendor=148f, idProduct=7601
Mar 12 20:45:55 beaglebone kernel: [ 341.732270] Modules linked in:
mt7601Usta(O) omap_rng 8021q garp stp llc g_ether libcomposite
Mar 12 20:45:55 beaglebone kernel: [ 341.732964] [<c032b6a3>]
(usb_submit_urb+0x1cb/0x398) from [<bf86b7ab>] (BulkInCmdRspEvent+0x42/0x68
[mt7601Usta])
Mar 12 20:45:55 beaglebone kernel: [ 341.733377] [<bf86b7ab>]
(BulkInCmdRspEvent+0x42/0x68 [mt7601Usta]) from [<bf86b8cd>]
(RTUSBBulkCmdRspEventReceive+0x38/0x58 [mt7601Usta])
Mar 12 20:45:55 beaglebone kernel: [ 341.733930] [<bf86b8cd>]
(RTUSBBulkCmdRspEventReceive+0x38/0x58 [mt7601Usta]) from [<bf84dabf>]
(NICInitializeAsic+0xea/0x3c0 [mt7601Usta])
Mar 12 20:45:55 beaglebone kernel: [ 341.734137] [<bf84dabf>]
(NICInitializeAsic+0xea/0x3c0 [mt7601Usta]) from [<e0d8a000>] (0xe0d8a000)
machinekit@beaglebone:~$ cat /var/log/messages | grep rt2
Mar 5 14:07:46 beaglebone kernel: [ 63.587405] usbcore: registered new
interface driver rt2870
Mar 5 14:08:52 beaglebone kernel: [ 22.810446] usbcore: registered new
interface driver rt2870
Mar 5 14:10:13 beaglebone kernel: [ 19.282070] usbcore: registered new
interface driver rt2870
Mar 5 15:43:22 beaglebone kernel: [ 22.099443] usbcore: registered new
interface driver rt2870
Mar 8 11:24:14 beaglebone kernel: [ 24.063742] usbcore: registered new
interface driver rt2870
Mar 9 13:43:30 beaglebone kernel: [ 30.529642] usbcore: registered new
interface driver rt2870
Mar 12 01:45:49 beaglebone kernel: [ 23.058410] usbcore: registered new
interface driver rt2870
machinekit@beaglebone:~$ cat /var/log/messages | grep wifi
machinekit@beaglebone:~$ cat /var/log/messages | grep WiFi
machinekit@beaglebone:~$ cat /var/log/messages | grep connman
machinekit@beaglebone:~$ cat /var/log/messages
snip below.
Mar 12 01:45:39 beaglebone kernel: [ 13.080520] hub 2-0:1.0: USB hub found
Mar 12 01:45:39 beaglebone kernel: [ 13.080543] hub 2-0:1.0: 1 port
detected
Mar 12 01:45:40 beaglebone kernel: [ 13.513587] libphy: 4a101000.mdio:00
- Link is Up - 100/Full
Mar 12 01:45:40 beaglebone kernel: [ 13.513647] IPv6:
ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
Mar 12 01:45:40 beaglebone kernel: [ 13.543282] IPv6:
ADDRCONF(NETDEV_UP): usb0: link is not ready
Mar 12 01:45:40 beaglebone kernel: [ 13.593966] 8021q: 802.1Q VLAN
Support v1.8
Mar 12 01:45:40 beaglebone rsyslogd-2007: action 'action 18' suspended,
next retry is Sun Mar 12 01:46:10 2017 [try http://www.rsyslog.com/e/2007 ]
Mar 12 01:45:46 beaglebone kernel: [ 19.256839] omap_rng 48310000.rng:
base address of priv is -97452032
Mar 12 01:45:46 beaglebone kernel: [ 19.258941] omap_rng 48310000.rng:
OMAP Random Number Generator ver. 20
Mar 12 01:45:49 beaglebone mtp-probe: checking bus 1, device 2:
"/sys/devices/ocp.3/47400000.usb/musb-hdrc.1.auto/usb1/1-1"
Mar 12 01:45:49 beaglebone mtp-probe: bus: 1, device: 2 was not an MTP
device
Mar 12 01:45:49 beaglebone kernel: [ 23.058410] usbcore: registered new
interface driver rt2870
Mar 12 01:45:50 beaglebone ifupdown-hotplug[1602]: Bad ifupdown udev helper
invocation: $INTERFACE is not set
Mar 12 20:40:51 beaglebone rsyslogd-2007: action 'action 18' suspended,
next retry is Sun Mar 12 20:41:21 2017 [try http://www.rsyslog.com/e/2007 ]
Mar 12 20:41:17 beaglebone org.gtk.Private.AfcVolumeMonitor[1861]: Volume
monitor alive
Mar 12 20:41:22 beaglebone kernel: [ 68.247107] EXT4-fs (mmcblk1p2):
mounted filesystem with ordered data mode. Opts: (null)
Mar 12 20:41:22 beaglebone rsyslogd-2007: action 'action 18' suspended,
next retry is Sun Mar 12 20:41:52 2017 [try http://www.rsyslog.com/e/2007 ]
Mar 12 20:41:22 beaglebone org.gtk.Private.UDisks2VolumeMonitor[1861]:
index_parse.c:191: indx_parse(): error opening
/media/machinekit/Angstrom/BDMV/index.bdmv
Mar 12 20:41:22 beaglebone org.gtk.Private.UDisks2VolumeMonitor[1861]:
index_parse.c:191: indx_parse(): error opening
/media/machinekit/Angstrom/BDMV/BACKUP/index.bdmv
Mar 12 20:41:22 beaglebone org.gtk.Private.UDisks2VolumeMonitor[1861]:
index_parse.c:191: indx_parse(): error opening
/media/machinekit/BEAGLEBONE/BDMV/index.bdmv
Mar 12 20:41:22 beaglebone org.gtk.Private.UDisks2VolumeMonitor[1861]:
index_parse.c:191: indx_parse(): error opening
/media/machinekit/BEAGLEBONE/BDMV/BACKUP/index.bdmv
Mar 12 20:42:49 beaglebone rsyslogd-2007: action 'action 18' suspended,
next retry is Sun Mar 12 20:43:19 2017 [try http://www.rsyslog.com/e/2007 ]
Mar 12 20:45:55 beaglebone rsyslogd-2007: action 'action 18' suspended,
next retry is Sun Mar 12 20:46:25 2017 [try http://www.rsyslog.com/e/2007 ]
Mar 12 20:45:55 beaglebone kernel: [ 341.732127] ------------[ cut here
]------------
Mar 12 20:45:55 beaglebone kernel: [ 341.732225] WARNING: at
drivers/usb/core/urb.c:327 usb_submit_urb+0x1cb/0x398()
Mar 12 20:45:55 beaglebone kernel: [ 341.732250] URB df796940 submitted
while active
Mar 12 20:45:55 beaglebone kernel: [ 341.732270] Modules linked in:
mt7601Usta(O) omap_rng 8021q garp stp llc g_ether libcomposite
Mar 12 20:45:55 beaglebone kernel: [ 341.732433] [<c0011611>]
(unwind_backtrace+0x1/0x90) from [<c003086b>]
(warn_slowpath_common+0x3f/0x4c)
Mar 12 20:45:55 beaglebone kernel: [ 341.732483] [<c003086b>]
(warn_slowpath_common+0x3f/0x4c) from [<c0030895>]
(warn_slowpath_fmt+0x1d/0x28)
Mar 12 20:45:55 beaglebone kernel: [ 341.732533] [<c0030895>]
(warn_slowpath_fmt+0x1d/0x28) from [<c032b6a3>] (usb_submit_urb+0x1cb/0x398)
Mar 12 20:45:55 beaglebone kernel: [ 341.732964] [<c032b6a3>]
(usb_submit_urb+0x1cb/0x398) from [<bf86b7ab>] (BulkInCmdRspEvent+0x42/0x68
[mt7601Usta])
Mar 12 20:45:55 beaglebone kernel: [ 341.733377] [<bf86b7ab>]
(BulkInCmdRspEvent+0x42/0x68 [mt7601Usta]) from [<bf86b8cd>]
(RTUSBBulkCmdRspEventReceive+0x38/0x58 [mt7601Usta])
Mar 12 20:45:55 beaglebone kernel: [ 341.733930] [<bf86b8cd>]
(RTUSBBulkCmdRspEventReceive+0x38/0x58 [mt7601Usta]) from [<bf84dabf>]
(NICInitializeAsic+0xea/0x3c0 [mt7601Usta])
Mar 12 20:45:55 beaglebone kernel: [ 341.734137] [<bf84dabf>]
(NICInitializeAsic+0xea/0x3c0 [mt7601Usta]) from [<e0d8a000>] (0xe0d8a000)
Mar 12 20:45:55 beaglebone kernel: [ 341.734166] ---[ end trace
ca65cef3a8e7dd7f ]---
machinekit@beaglebone:~$
Best regards.
.. ..-. / -.-- --- ..- / .-. . .- -.. / - .... .. ...
.-.. . - ... / .... .- ...- . / .- / -... . . .-.
Jared Harvey Operator KB1GTT
e-mail [email protected]
Web page http://jaredharvey.com
On Sun, Mar 12, 2017 at 3:51 PM, Daniel Wagner <[email protected]> wrote:
> Hi Jared,
>
> On 03/09/2017 01:01 PM, Jared Harvey wrote:
>
>> machinekit@beaglebone:~$ dmesg | grep 7601
>> [ 1.176010] usbcore: registered new interface driver cdc_ncm
>> [ 2.081250] usb 1-1: New USB device found, idVendor=148f,
>> idProduct=7601
>> [84932.378008] Modules linked in: mt7601Usta(O) omap_rng 8021q garp stp
>> llc g_ether libcomposite
>> [84932.378703] [<c032b6a3>] (usb_submit_urb+0x1cb/0x398) from
>> [<bf86b7ab>] (BulkInCmdRspEvent+0x42/0x68 [mt7601Usta])
>> [84932.379294] [<bf86b7ab>] (BulkInCmdRspEvent+0x42/0x68 [mt7601Usta])
>> from [<bf86b8cd>] (RTUSBBulkCmdRspEventReceive+0x38/0x58 [mt7601Usta])
>> [84932.379670] [<bf86b8cd>] (RTUSBBulkCmdRspEventReceive+0x38/0x58
>> [mt7601Usta]) from [<bf84dabf>] (NICInitializeAsic+0xea/0x3c0
>> [mt7601Usta])
>> [84932.379870] [<bf84dabf>] (NICInitializeAsic+0xea/0x3c0 [mt7601Usta])
>> from [<e0d8a000>] (0xe0d8a000)
>>
>
> This looks like a stack trace from the kernel. And it looks like it
> contains USB function. Since your device is USB based it might just be the
> source of your problem. Can you look into the kernel log and see if there
> is a complete stack trace?
>
> Thanks,
> Daniel
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL:
<http://lists.01.org/pipermail/connman/attachments/20170312/812ec5f6/attachment.html>
------------------------------
Subject: Digest Footer
_______________________________________________
connman mailing list
[email protected]
https://lists.01.org/mailman/listinfo/connman
------------------------------
End of connman Digest, Vol 17, Issue 9
**************************************
