WPA supplicant service failed when trying to reconnect p2p connection.

[sunxiaohuix]

Reproduce steps:
archermind@archermind-Z97X-UD7-TH:$ ssh root@192.168.2.15
Warning: Permanently added '192.168.2.15' (ECDSA) to the list of known hosts.
root@edison:# systemctl status wpa_supplicant
鈼?wpa_supplicant.service - WPA supplicant service
Loaded: loaded (/lib/systemd/system/wpa_supplicant.service; disabled)
Active: inactive (dead)
root@edison:# systemctl start wpa_supplicant
root@edison:# systemctl status wpa_supplicant
鈼?wpa_supplicant.service - WPA supplicant service
Loaded: loaded (/lib/systemd/system/wpa_supplicant.service; disabled)
Active: active (running) since Thu 2016-05-12 02:45:41 UTC; 1s ago
Process: 305 ExecStartPost=/bin/systemctl start wpa_supplicant_p2p_event (code=exited, status=0/SUCCESS)
Process: 302 ExecStartPost=/bin/systemctl start wpa_supplicant_wlan0_event (code=exited, status=0/SUCCESS)
Main PID: 301 (wpa_supplicant)
CGroup: /system.slice/wpa_supplicant.service
鈹斺攢301 /usr/sbin/wpa_supplicant -u -c/etc/wpa_supplicant/wpa_supplicant.conf -iwlan0 -Dnl80211 -puse_p2p_group_interface...
May 12 02:45:41 edison systemd[1]: Started WPA supplicant service.
root@edison:# wpa_cli -iwlan0 interface
Available interfaces:
p2p-dev-wlan0
wlan0
root@edison:# wpa_cli -ip2p-dev-wlan0 p2p_set listen_channel 11
OK
root@edison:# wpa_cli -ip2p-dev-wlan0 set persistent_reconnect 1
OK
root@edison:# wpa_cli -ip2p-dev-wlan0 p2p_set go_apsd 0
OK
root@edison:# wpa_cli -ip2p-dev-wlan0 p2p_find
OK
root@edison:# wpa_cli -ip2p-dev-wlan0 p2p_peers
0e:84:dc:be:cb:e0
7a:4b:87:a2:94:22
root@edison:# wpa_cli -ip2p-dev-wlan0 p2p_connect 7a:4b:87:a2:94:22 94094152 persistent join
OK
root@edison:# wpa_cli -iwlan0 interface
Available interfaces:
p2p-wlan0-0
p2p-dev-wlan0
wlan0

root@edison:# wpa_cli status -ip2p-wlan0-0
bssid=7a:4b:87:a2:14:22
ssid=DIRECT-0xabc
id=0
mode=station
pairwise_cipher=NONE
group_cipher=NONE
key_mgmt=UNKNOWN
wpa_state=ASSOCIATED
p2p_device_address=7a:4b:87:9e:9f:96
address=7a:4b:87:9e:1f:96
root@edison:#
root@edison:# wpa_cli -ip2p-dev-wlan0 p2p_group_remove p2p-wlan0-0
OK
root@edison:# wpa_cli -ip2p-dev-wlan0 p2p_connect 7a:4b:87:a2:94:22 94117226 persistent join
OK
root@edison:# wpa_cli -iwlan0 interface
Available interfaces:
p2p-wlan0-1
p2p-dev-wlan0
wlan0
root@edison:# wpa_cli status -ip2p-wlan0-1
wpa_state=SCANNING
p2p_device_address=7a:4b:87:9e:9f:96
address=7a:4b:87:9e:1f:96
root@edison:# wpa_cli -iwlan0 interface
Failed to connect to non-global ctrl_ifname: wlan0 error: Connection refused
root@edison:# wpa_cli status -ip2p-wlan0-1
Failed to connect to non-global ctrl_ifname: p2p-wlan0-1 error: Connection refused
root@edison:#
root@edison:# systemctl status wpa_supplicant
鈼?wpa_supplicant.service - WPA supplicant service
Loaded: loaded (/lib/systemd/system/wpa_supplicant.service; disabled)
Active: failed (Result: signal) since Thu 2016-05-12 02:48:21 UTC; 3min 33s ago
Process: 374 ExecStopPost=/bin/systemctl stop wpa_supplicant_p2p_event (code=exited, status=0/SUCCESS)
Process: 369 ExecStopPost=/bin/systemctl stop wpa_supplicant_wlan0_event (code=exited, status=0/SUCCESS)
Process: 305 ExecStartPost=/bin/systemctl start wpa_supplicant_p2p_event (code=exited, status=0/SUCCESS)
Process: 302 ExecStartPost=/bin/systemctl start wpa_supplicant_wlan0_event (code=exited, status=0/SUCCESS)
Process: 301 ExecStart=/usr/sbin/wpa_supplicant -u -c/etc/wpa_supplicant/wpa_supplicant.conf -iwlan0 -Dnl80211 -puse_p2p_group_interface=1p2p_device=1 -m/etc/wpa_supplicant/p2p_supplicant.conf -O /var/run/wpa_supplicant -e /etc/wpa_supplicant/entropy.bin (code=killed, signal=KILL)
Main PID: 301 (code=killed, signal=KILL)

May 12 02:45:41 edison systemd[1]: Started WPA supplicant service.
May 12 02:48:17 edison systemd[1]: wpa_supplicant.service: main process exited, code=killed, status=9/KILL
May 12 02:48:21 edison systemd[1]: Unit wpa_supplicant.service entered failed state.

And dmesg log:
[ 247.180584] dhd_wlfc_init(): successfully enabled bdcv2 tlv signaling, 79
[ 247.181581] dhd_wlfc_init(): wlfc_mode=0x0, ret=-23
[ 247.193454] Register interface [p2p-wlan0-1] MAC: 7a:4b:87:9e:1f:96
[ 247.193454]
[ 247.195011] CFG80211-ERROR) wl_cfg80211_add_virtual_iface : virtual interface(p2p-wlan0-1) is created net attach done
[ 247.195039] CFG80211-ERROR) dhd_cfg80211_set_p2p_info : Set : op_mode=0x0035
[ 247.291233] CFG80211-ERROR) wl_escan_handler : escan is not ready ndev f5beb800 drv_status 0x0 e_type 69 e_states 8
[ 247.318376] CFG80211-ERROR) wl_escan_handler : escan is not ready ndev f5beb800 drv_status 0x0 e_type 69 e_states 8
[ 247.400666] CFG80211-ERROR) wl_escan_handler : escan is not ready ndev f5beb800 drv_status 0x0 e_type 69 e_states 8
[ 247.401943] CFG80211-ERROR) wl_escan_handler : escan is not ready ndev f5beb800 drv_status 0x0 e_type 69 e_states 8
[ 247.402051] CFG80211-ERROR) wl_escan_handler : escan is not ready ndev f5beb800 drv_status 0x0 e_type 69 e_states 8
[ 247.413353] CFG80211-ERROR) wl_escan_handler : escan is not ready ndev f5beb800 drv_status 0x0 e_type 69 e_states 8
[ 247.433906] CFG80211-ERROR) wl_escan_handler : escan is not ready ndev f5beb800 drv_status 0x0 e_type 69 e_states 8
[ 247.454578] CFG80211-ERROR) wl_escan_handler : escan is not ready ndev f5beb800 drv_status 0x0 e_type 69 e_states 8
[ 247.473793] CFG80211-ERROR) wl_escan_handler : escan is not ready ndev f5beb800 drv_status 0x0 e_type 69 e_states 0
[ 257.258616] CFG80211-ERROR) wl_scan_timeout : timer expired
[ 257.258841] CFG80211-ERROR) wl_escan_handler : escan is not ready ndev f59ee800 drv_status 0x0 e_type 69 e_states 2
[ 257.277419] BUG: unable to handle kernel NULL pointer dereference at (null)
[ 257.277521] IP: [] wl_cfg80211_connect+0x486/0x1bf0 [bcm4334x]
[ 257.277671] *pdpt = 00000000351f2001 *pde = 0000000000000000
[ 257.277734] Oops: 0002 [#1] PREEMPT SMP
[ 257.277789] Modules linked in: usb_f_acm u_serial usb_f_ecm g_multi usb_f_rndis usb_f_mass_storage u_ether libcomposite bcm_bt_lpm bcm4334x(O)
[ 257.277961] CPU: 1 PID: 301 Comm: wpa_supplicant Tainted: G W O 3.19.5-yocto-standard+ #1
[ 257.278029] Hardware name: Intel Corporation Merrifield/BODEGA BAY, BIOS 542 2015.01.21:18.19.48
[ 257.278096] task: f5bb2d10 ti: f5bda000 task.ti: f5bda000
[ 257.278146] EIP: 0060:[] EFLAGS: 00210246 CPU: 1
[ 257.278321] EAX: 00000000 EBX: 00000001 ECX: f5bdb9d0 EDX: 00000000
[ 257.278372] ESI: f5beb800 EDI: f5bdba50 EBP: f5bdba10 ESP: f5bdb974
[ 257.278423] DS: 007b ES: 007b FS: 00d8 GS: 0033 SS: 0068
[ 257.278470] CR0: 8005003b CR2: 00000000 CR3: 35125000 CR4: 001007f0
[ 257.278518] Stack:
[ 257.278542] 00000002 f5270444 00000043 00000001 00000000 c1d6d540 f5bdba1c c1320782
[ 257.278656] c1d6d540 00000001 00000141 c1d6cac0 f8db3e08 f5160420 f5bdba50 f5160664
[ 257.278767] 00000032 f5160420 f5160180 00000002 00000000 0000b9d4 00000000 00000002
[ 257.278878] Call Trace:
[ 257.278930] [] ? __alloc_pages_nodemask+0x122/0x890
[ 257.278995] [] ? preempt_count_sub+0xaf/0x110
[ 257.279053] [] ? __mutex_lock_slowpath+0x208/0x3a0
[ 257.279112] [] ? __mutex_lock_slowpath+0x208/0x3a0
[ 257.279170] [] ? __might_sleep+0x3a/0xb0
[ 257.279294] [] ? wl_cfg80211_stop_ap+0x3c0/0x3c0 [bcm4334x]
[ 257.279357] [] cfg80211_connect+0xc7/0x4b0
[ 257.279412] [] nl80211_connect+0x2eb/0x3c0
[ 257.279479] [] genl_rcv_msg+0x219/0x380
[ 257.279535] [] ? ctrl_dumpfamily+0xf0/0xf0
[ 257.279588] [] netlink_rcv_skb+0x8e/0xb0
[ 257.279639] [] genl_rcv+0x21/0x30
[ 257.279687] [] netlink_unicast+0x131/0x1b0
[ 257.279741] [] ? memcpy_fromiovec+0x47/0x80
[ 257.279796] [] netlink_sendmsg+0x240/0x3e0
[ 257.279855] [] do_sock_sendmsg+0xbd/0xe0
[ 257.279914] [] ? copy_msghdr_from_user+0x145/0x1d0
[ 257.279973] [] ___sys_sendmsg+0x20f/0x250
[ 257.280027] [] ? ___sys_recvmsg+0xd4/0x140
[ 257.280081] [] ? sock_recvmsg_nosec+0xa0/0xa0
[ 257.280138] [] ? __might_sleep+0x3a/0xb0
[ 257.280194] [] ? move_addr_to_user+0xa2/0xc0
[ 257.280250] [] ? SYSC_getsockname+0xb3/0xc0
[ 257.280303] [] ? preempt_count_sub+0xaf/0x110
[ 257.280356] [] ? get_parent_ip+0xb/0x40
[ 257.280408] [] ? __fdget+0x12/0x20
[ 257.280457] [] ? sockfd_lookup_light+0x14/0x70
[ 257.280511] [] __sys_sendmsg+0x38/0x70
[ 257.280565] [] SYSC_socketcall+0x816/0x9f0
[ 257.280621] [] ? __slab_free+0x2cc/0x390
[ 257.280675] [] ? __local_bh_enable_ip+0x61/0xe0
[ 257.280730] [] ? preempt_count_sub+0xaf/0x110
[ 257.280784] [] ? preempt_count_sub+0xaf/0x110
[ 257.280839] [] ? kmem_cache_free+0x79/0x1b0
[ 257.280893] [] ? sock_destroy_inode+0x28/0x30
[ 257.280946] [] ? get_parent_ip+0xb/0x40
[ 257.280996] [] ? preempt_count_sub+0xaf/0x110
[ 257.281052] [] ? dentry_free+0x4c/0x90
[ 257.281104] [] ? dentry_free+0x4c/0x90
[ 257.281155] [] ? __dentry_kill+0x10b/0x1b0
[ 257.281210] [] ? mntput_no_expire+0x25/0x120
[ 257.281264] [] ? mntput+0x20/0x40
[ 257.281312] [] ? __fput+0x164/0x1e0
[ 257.281365] [] SyS_socketcall+0x13/0x20
[ 257.281415] [] syscall_call+0x7/0x7
[ 257.281469] [] ? __ww_mutex_lock_interruptible_slowpath+0x640/0x700
[ 257.281523] Code: 04 24 89 f0 e8 ac 6a 01 00 85 c0 89 c7 0f 85 a2 0b 00 00 8b 45 a8 b9 02 00 00 00 89 f2 e8 f3 59 ff ff 8b 7d 9c 8d 4d c0 8b 57 2c <89> 10 a1 a0 6e db f8 89 f2 89 45 a8 e8 b9 12 01 00 85 c0 74 45
[ 257.282109] EIP: [] wl_cfg80211_connect+0x486/0x1bf0 [bcm4334x] SS:ESP 0068:f5bdb974
[ 257.282265] CR2: 0000000000000000
[ 257.670439] ---[ end trace 1be12dbab29b7072 ]---
[ 257.713436] wpa_supplicant (301) used greatest stack depth: 4208 bytes left

[andy-shev]

Can you reproduce this on latest (vanilla) kernel? You may try to use https://github.com/edison-fw/meta-intel-edison

Also it seems you opened quite a few questions here. Perhaps it would make sense to test all and close them here, and open ones that have been reproduced against new meta-intel-edison layer.

[htot]

Also, why are you calling supplicant directly? Is p2p not supported from connmanctl?