Hi
(Adding Jouni to CC as he's the author of the commit in question)
On Sat, Jan 18, 2014 at 7:20 PM, Peer, Ilan <ilan.peer@xxxxxxxxx> wrote:
> Hi David,
>
> Sorry for the late response. Hope the below can help :)
>
> Regards,
>
> Ilan.
>
>> I tried again and masked the 5ghz channels (via "p2p_set", not "set" I
>> guess?), however, still almost exactly the same log but on a 2.4ghz
>> channel. I attached the full log to the email, I cut down all the
>> "p2p-scan" log messages and inlined most parts of the log below.
>>
>> Another thing that I noticed is that I don't get any "P2P-XY" status
>> messages to wpa_cli. I need to run "tail -f wpa.log | grep ^P2P-" in a
>> separate session to actually see messages like P2P-DEVICE-FOUND,
>> P2P-GO-NEG-SUCCESS, .. I only got "P2P-GROUP-" related messages
>> directly forwarded to my wpa_cli. I really think this is all somehow
>> related to the bunch of errors I get during p2p-dev-wlan0 setup, which
>> you said you cannot reproduce.
>>
>
> From the logs it looks like the wpa_supplicant tries to use the P2P Device interface for the GO instantiation (which is impossible since this is not a netdev but a P2P Device interface). Can you please try to invoke the wpa_supplicant with a global control interface and issue the P2P commands over the global control interface? Something like:
Yes, it definitely uses the wrong interface, that's why I get all the
"EINVAL/ENODEV" errors for the netdev ioctls/nl80211.
> wpa_supplicant -i wlan0 -c <conf> -p allow_p2p_device=1 -t -s -d -T -B -g /tmp/wpa_global -G <group>
> wpa_cli -g /tmp/wpa_global -G <group>
>
> See the following commit from Jouni: 78f79fe5fc251e3ababa2970956cc9a84f29f209
>
> P2P: Do not add ctrl interface for P2P_DEVICE (p2p-dev-*)
>
> Adding a new wpa_supplicant control interface for the dedicated
> P2P_DEVICE would be quite confusing for programs that manage P2P
> operations. Remove this control interface and require the global control
> interface to be used since it will provide consistent interface for both
> the new dedicated P2P_DEVICE (non-netdev) and old style P2P management
> through a netdev.
I tried that now, but it only got worse. I now cannot even attempt a
go-negotiation. Full wpa-log is attached to the mail. The important
part, I guess, is this:
1390301970.022517: nl80211: Set TX rates failed: ret=-100 (Network is down)
1390301970.022522: P2P: Created pending virtual interface p2p-wlan1-0
addr fc:f8:ae:69:8a:63
1390301970.022530: P2P: Request to start group negotiation -
peer=12:68:3f:4e:39:f2 GO Intent=7 Intended Interface
Address=fc:f8:ae:69:8a:63 wps_method=3 persistent_group=0
pd_before_go_neg=0
1390301970.022534: P2P: Prepare channel - force_freq=0 pref_freq=0 go=0
1390301970.022536: P2P: Prepare channel best
1390301970.023356: P2P: Select possible 5 GHz channel (op_class 124
channel 161) as operating channel preference
1390301970.023370: P2P: prepared channels: 81:1,2,3,4,5,6,7,8,9,10,11 124:161
1390301970.023381: P2P: after go/cli filter/add:
81:1,2,3,4,5,6,7,8,9,10,11 124:161
1390301970.023385: P2P: Own preference for operation channel:
Operating Class 124 Channel 161
1390301970.023389: P2P: Stopping find
1390301970.023393: P2P: Clear timeout (state=SEARCH)
1390301970.023396: P2P-FIND-STOPPED
1390301970.023409: CTRL_IFACE monitor sent successfully to
/tmp/wpa_ctrl_2844-2\x00
1390301970.023426: P2P: State SEARCH -> IDLE
1390301970.023438: P2P: p2p_scan running - delay connect send
1390301970.023483: RTM_NEWLINK: ifi_index=8 ifname=p2p-wlan1-0
operstate=2 linkmode=0 ifi_flags=0x1002 ()
1390301970.025753: Could not read interface p2p-dev-wlan1 flags: No such device
1390301970.025759: nl80211: Interface down
1390301970.025765: p2p-dev-wlan1: Event INTERFACE_DISABLED (29) received
1390301970.025771: p2p-dev-wlan1: Interface was disabled
1390301970.025781: p2p-dev-wlan1: State: DISCONNECTED -> DISCONNECTED
1390301970.025784: nl80211: Set p2p-dev-wlan1 operstate 0->0 (DORMANT)
1390301970.025786: netlink: Operstate: ifindex=0 linkmode=-1 (no
change), operstate=5 (IF_OPER_DORMANT)
1390301970.025806: EAPOL: External notification - portEnabled=0
1390301970.025810: EAPOL: External notification - portValid=0
1390301970.025812: p2p-dev-wlan1: State: DISCONNECTED -> INTERFACE_DISABLED
1390301970.025818: p2p-dev-wlan1: Event INTERFACE_STATUS (5) received
1390301970.095279: nl80211: Drv Event 34
(NL80211_CMD_NEW_SCAN_RESULTS) received for p2p-dev-wlan1
1390301970.095298: p2p-dev-wlan1: nl80211: New scan results available
1390301970.095307: nl80211: Scan probed for SSID 'DIRECT-'
1390301970.095310: nl80211: Scan included frequencies: 2412 2437 2462
1390301970.095314: p2p-dev-wlan1: Ignore event SCAN_RESULTS (3) while
interface is disabled
Again the device thinks the interface is down because it calls
linux_set_iface_flags() and linux_iface_up() on the p2p-dev-wlan1
device, instead of the p2p-wlan1-0 device. You can see that because
the ifindex is 0. And then it obviously gets an error because the
iface is down (non-existant).
However, I now checked out 78f79fe~ (the parent of the commit you
mentioned) and spawned wpa_cli on the p2p-dev-wlan1 interface. A
normal PBC connection works, now. But with HEAD it doesn't.
If there's anything I can do to debug this further, let me know. At
least I now have a working commit.
(sorry for the wlan0 <=> wlan1 confusion, but they change on each boot
according to USB probe-order)
Thanks
David
1390301954.372968: wpa_supplicant v2.1-devel
1390301954.373002: Global control interface '/tmp/wpa_global'
1390301954.373031: Using UNIX control socket '/tmp/wpa_global'
1390301954.373046: Successfully initialized wpa_supplicant
1390301954.373052: Initializing interface 'wlan1' conf '../wpa.conf' driver 'nl80211' ctrl_interface 'N/A' bridge 'N/A'
1390301954.373069: Configuration file '../wpa.conf' -> '/home/david/dev/openwfd/../wpa.conf'
1390301954.373075: Reading configuration file '/home/david/dev/openwfd/../wpa.conf'
1390301954.373110: ctrl_interface='/var/run/wpa_supplicant'
1390301954.373117: ap_scan=1
1390301954.373126: p2p_go_ht40=1
1390301954.373129: driver_param='p2p_device=1'
1390301954.373132: device_name='david-ub'
1390301954.373635: nl80211: Could not add multicast membership for vendor events: -2 (No such file or directory)
1390301954.373667: rfkill: initial event: idx=0 type=1 op=0 soft=0 hard=0
1390301954.373670: rfkill: initial event: idx=1 type=8 op=0 soft=0 hard=0
1390301954.373672: rfkill: initial event: idx=2 type=2 op=0 soft=0 hard=0
1390301954.373674: rfkill: initial event: idx=3 type=1 op=0 soft=0 hard=0
1390301954.373675: rfkill: initial event: idx=4 type=2 op=0 soft=0 hard=0
1390301954.373861: nl80211: Supported cipher 00-0f-ac:1
1390301954.373869: nl80211: Supported cipher 00-0f-ac:5
1390301954.373871: nl80211: Supported cipher 00-0f-ac:2
1390301954.373872: nl80211: Supported cipher 00-0f-ac:4
1390301954.373873: nl80211: Supported cipher 00-0f-ac:6
1390301954.373909: nl80211: Using driver-based off-channel TX
1390301954.373921: nl80211: Use separate P2P group interface (driver advertised support)
1390301954.373922: nl80211: interface wlan1 in phy phy1
1390301954.373945: nl80211: Set mode ifindex 3 iftype 2 (STATION)
1390301954.373965: nl80211: Subscribe to mgmt frames with non-AP handle 0x1caf4f0
1390301954.373976: nl80211: Register frame type=0xd0 nl_handle=0x1caf4f0 match=040a
1390301954.373990: nl80211: Register frame type=0xd0 nl_handle=0x1caf4f0 match=040b
1390301954.374001: nl80211: Register frame type=0xd0 nl_handle=0x1caf4f0 match=040c
1390301954.374011: nl80211: Register frame type=0xd0 nl_handle=0x1caf4f0 match=040d
1390301954.374022: nl80211: Register frame type=0xd0 nl_handle=0x1caf4f0 match=0409506f9a09
1390301954.374033: nl80211: Register frame type=0xd0 nl_handle=0x1caf4f0 match=7f506f9a09
1390301954.374043: nl80211: Register frame type=0xd0 nl_handle=0x1caf4f0 match=06
1390301954.374053: nl80211: Register frame type=0xd0 nl_handle=0x1caf4f0 match=0a07
1390301954.374063: nl80211: Register frame type=0xd0 nl_handle=0x1caf4f0 match=0a11
1390301954.389189: netlink: Operstate: ifindex=3 linkmode=1 (userspace-control), operstate=5 (IF_OPER_DORMANT)
1390301954.389240: nl80211: driver param='p2p_device=1'
1390301954.389253: Add interface wlan1 to a new radio phy1
1390301954.389528: nl80211: Regulatory information - country=00
1390301954.389533: nl80211: 2402-2472 @ 40 MHz 20 mBm
1390301954.389536: nl80211: 2457-2482 @ 40 MHz 20 mBm
1390301954.389539: nl80211: 2474-2494 @ 20 MHz 20 mBm
1390301954.389540: nl80211: 5170-5250 @ 80 MHz 20 mBm
1390301954.389542: nl80211: 5735-5835 @ 80 MHz 20 mBm
1390301954.389544: nl80211: 57240-63720 @ 2160 MHz 0 mBm
1390301954.389561: nl80211: Added 802.11b mode based on 802.11g information
1390301954.413649: wlan1: Own MAC address: fc:f8:ae:69:8a:61
1390301954.413695: wpa_driver_nl80211_set_key: ifindex=3 (wlan1) alg=0 addr=(nil) key_idx=0 set_tx=0 seq_len=0 key_len=0
1390301954.413754: wpa_driver_nl80211_set_key: ifindex=3 (wlan1) alg=0 addr=(nil) key_idx=1 set_tx=0 seq_len=0 key_len=0
1390301954.413781: wpa_driver_nl80211_set_key: ifindex=3 (wlan1) alg=0 addr=(nil) key_idx=2 set_tx=0 seq_len=0 key_len=0
1390301954.413808: wpa_driver_nl80211_set_key: ifindex=3 (wlan1) alg=0 addr=(nil) key_idx=3 set_tx=0 seq_len=0 key_len=0
1390301954.413827: wlan1: RSN: flushing PMKID list in the driver
1390301954.413830: nl80211: Flush PMKIDs
1390301954.413861: wlan1: State: DISCONNECTED -> INACTIVE
1390301954.413938: wlan1: WPS: UUID based on MAC address: 4a7cf8c2-3c3b-5238-b16f-7273f4bb4fda
1390301954.416739: EAPOL: SUPP_PAE entering state DISCONNECTED
1390301954.416745: EAPOL: Supplicant port status: Unauthorized
1390301954.416749: nl80211: Skip set_supp_port(unauthorized) while not associated
1390301954.416750: EAPOL: KEY_RX entering state NO_KEY_RECEIVE
1390301954.416752: EAPOL: SUPP_BE entering state INITIALIZE
1390301954.416755: EAP: EAP entering state DISABLED
1390301954.416831: wlan1: Added interface wlan1
1390301954.416836: wlan1: State: INACTIVE -> DISCONNECTED
1390301954.416838: nl80211: Set wlan1 operstate 0->0 (DORMANT)
1390301954.416841: netlink: Operstate: ifindex=3 linkmode=-1 (no change), operstate=5 (IF_OPER_DORMANT)
1390301954.416883: nl80211: Create interface iftype 10 (P2P_DEVICE)
1390301954.416957: nl80211: New P2P Device interface p2p-dev-wlan1 (0x10000000d) created
1390301954.416964: Initializing interface 'p2p-dev-wlan1' conf '/home/david/dev/openwfd/../wpa.conf' driver 'nl80211' ctrl_interface 'N/A' bridge 'N/A'
1390301954.416967: Configuration file '/home/david/dev/openwfd/../wpa.conf' -> '/home/david/dev/openwfd/../wpa.conf'
1390301954.416969: Reading configuration file '/home/david/dev/openwfd/../wpa.conf'
1390301954.417002: ctrl_interface='/var/run/wpa_supplicant'
1390301954.417006: ap_scan=1
1390301954.417011: p2p_go_ht40=1
1390301954.417013: driver_param='p2p_device=1'
1390301954.417016: device_name='david-ub'
1390301954.417049: rfkill: initial event: idx=0 type=1 op=0 soft=0 hard=0
1390301954.417052: rfkill: initial event: idx=1 type=8 op=0 soft=0 hard=0
1390301954.417054: rfkill: initial event: idx=2 type=2 op=0 soft=0 hard=0
1390301954.417055: rfkill: initial event: idx=3 type=1 op=0 soft=0 hard=0
1390301954.417057: rfkill: initial event: idx=4 type=2 op=0 soft=0 hard=0
1390301954.420088: Could not read interface p2p-dev-wlan1 flags: No such device
1390301954.422936: nl80211: Supported cipher 00-0f-ac:1
1390301954.422941: nl80211: Supported cipher 00-0f-ac:5
1390301954.422943: nl80211: Supported cipher 00-0f-ac:2
1390301954.422944: nl80211: Supported cipher 00-0f-ac:4
1390301954.422945: nl80211: Supported cipher 00-0f-ac:6
1390301954.422979: nl80211: Using driver-based off-channel TX
1390301954.422990: nl80211: Use separate P2P group interface (driver advertised support)
1390301954.422991: nl80211: interface p2p-dev-wlan1 in phy phy1
1390301954.423016: nl80211: Set mode ifindex 0 iftype 10 (P2P_DEVICE)
1390301954.423027: nl80211: Failed to set interface 0 to mode 10: -22 (Invalid argument)
1390301954.423052: nl80211: Subscribe to mgmt frames with non-AP handle 0x1ccc480
1390301954.423057: nl80211: Register frame type=0xd0 nl_handle=0x1ccc480 match=040a
1390301954.423069: nl80211: Register frame type=0xd0 nl_handle=0x1ccc480 match=040b
1390301954.423079: nl80211: Register frame type=0xd0 nl_handle=0x1ccc480 match=040c
1390301954.423088: nl80211: Register frame type=0xd0 nl_handle=0x1ccc480 match=040d
1390301954.423098: nl80211: Register frame type=0xd0 nl_handle=0x1ccc480 match=0409506f9a09
1390301954.423107: nl80211: Register frame type=0xd0 nl_handle=0x1ccc480 match=7f506f9a09
1390301954.423116: nl80211: Register frame type=0xd0 nl_handle=0x1ccc480 match=06
1390301954.423125: nl80211: Register frame type=0xd0 nl_handle=0x1ccc480 match=0a07
1390301954.423134: nl80211: Register frame type=0xd0 nl_handle=0x1ccc480 match=0a11
1390301954.424666: nl80211: Start P2P Device p2p-dev-wlan1 (0x10000000d): Success
1390301954.424701: nl80211: driver param='p2p_device=1'
1390301954.424704: Add interface p2p-dev-wlan1 to existing radio phy1
1390301954.424743: nl80211: Regulatory information - country=00
1390301954.424746: nl80211: 2402-2472 @ 40 MHz 20 mBm
1390301954.424747: nl80211: 2457-2482 @ 40 MHz 20 mBm
1390301954.424749: nl80211: 2474-2494 @ 20 MHz 20 mBm
1390301954.424750: nl80211: 5170-5250 @ 80 MHz 20 mBm
1390301954.424752: nl80211: 5735-5835 @ 80 MHz 20 mBm
1390301954.424753: nl80211: 57240-63720 @ 2160 MHz 0 mBm
1390301954.424766: p2p-dev-wlan1: Own MAC address: fc:f8:ae:69:8a:62
1390301954.424769: p2p-dev-wlan1: RSN: flushing PMKID list in the driver
1390301954.424770: nl80211: Flush PMKIDs
1390301954.427243: p2p-dev-wlan1: State: DISCONNECTED -> INACTIVE
1390301954.427254: p2p-dev-wlan1: WPS: UUID from the first interface: 4a7cf8c2-3c3b-5238-b16f-7273f4bb4fda
1390301954.427414: EAPOL: SUPP_PAE entering state DISCONNECTED
1390301954.427416: EAPOL: Supplicant port status: Unauthorized
1390301954.427418: nl80211: Skip set_supp_port(unauthorized) while not associated
1390301954.427419: EAPOL: KEY_RX entering state NO_KEY_RECEIVE
1390301954.427419: EAPOL: SUPP_BE entering state INITIALIZE
1390301954.427421: EAP: EAP entering state DISABLED
1390301954.428056: P2P: Own listen channel: 1
1390301954.428667: P2P: Random operating channel: 81:11
1390301954.428674: P2P: Driver did not support fetching of all supported channels; assume dualband support
1390301954.428676: P2P: Enable operating classes for 2.4 GHz band
1390301954.428677: P2P: Enable operating classes for lower 5 GHz band
1390301954.428678: P2P: Enable operating classes for higher 5 GHz band
1390301954.429298: P2P: initialized
1390301954.429313: P2P: channels: 81:1,2,3,4,5,6,7,8,9,10,11 115:36,40,44,48 124:149,153,157,161
1390301954.429316: P2P: cli_channels:
1390301954.429322: p2p-dev-wlan1: Added interface p2p-dev-wlan1
1390301954.429324: p2p-dev-wlan1: State: INACTIVE -> DISCONNECTED
1390301954.429326: nl80211: Set p2p-dev-wlan1 operstate 0->0 (DORMANT)
1390301954.429327: netlink: Operstate: ifindex=0 linkmode=-1 (no change), operstate=5 (IF_OPER_DORMANT)
1390301954.429366: RTM_NEWLINK: ifi_index=3 ifname=wlan1 operstate=2 linkmode=0 ifi_flags=0x1003 ([UP])
1390301955.417858: EAPOL: disable timer tick
1390301955.427587: EAPOL: disable timer tick
1390301956.951531: RX global ctrl_iface - hexdump_ascii(len=10):
49 4e 54 45 52 46 41 43 45 53 INTERFACES
1390301956.951640: CTRL_IFACE monitor attached /tmp/wpa_ctrl_2844-2\x00
1390301961.143319: p2p-dev-wlan1: Control interface command 'P2P_SET disallow_freq 5180-5800'
1390301961.143350: P2P: Disallowed frequency range 5180-5800
1390301961.143357: P2P: Driver did not support fetching of all supported channels; assume dualband support
1390301961.143358: P2P: Enable operating classes for 2.4 GHz band
1390301961.143359: P2P: Enable operating classes for lower 5 GHz band
1390301961.143359: P2P: Enable operating classes for higher 5 GHz band
1390301961.143373: P2P: Update channel list
1390301961.143384: P2P: channels: 81:1,2,3,4,5,6,7,8,9,10,11 124:161
1390301961.143388: P2P: cli_channels:
1390301963.124554: p2p-dev-wlan1: Control interface command 'P2P_FIND'
1390301963.124592: P2P: Starting find (type=0)
1390301963.124603: P2P: Clear timeout (state=IDLE)
1390301963.124608: P2P: State IDLE -> SEARCH
1390301963.124616: WPS: Building WPS IE for Probe Request
1390301963.124622: WPS: * Version (hardcoded 0x10)
1390301963.124624: WPS: * Request Type
1390301963.124626: WPS: * Config Methods (148)
1390301963.124627: WPS: * UUID-E
1390301963.124630: WPS: * Primary Device Type
1390301963.124634: WPS: * RF Bands (3)
1390301963.124635: WPS: * Association State
1390301963.124636: WPS: * Configuration Error (0)
1390301963.124637: WPS: * Device Password ID (0)
1390301963.124639: WPS: * Device Name
1390301963.124649: P2P: * P2P IE header
1390301963.124651: P2P: * Capability dev=25 group=00
1390301963.124653: P2P: * Listen Channel: Regulatory Class 81 Channel 1
1390301963.124659: p2p-dev-wlan1: Add radio work 'p2p-scan'@0x1cd2e00
1390301963.124664: p2p-dev-wlan1: First radio work item in the queue - schedule start immediately
1390301963.124668: P2P: Running p2p_scan
1390301963.124725: p2p-dev-wlan1: Starting radio work 'p2p-scan'@0x1cd2e00 after 0.000056 second wait
1390301963.124738: p2p-dev-wlan1: nl80211: scan request
1390301963.124765: nl80211: P2P probe - mask SuppRates
1390301963.127417: Scan requested (ret=0) - scan timeout 10 seconds
1390301963.127479: nl80211: Drv Event 33 (NL80211_CMD_TRIGGER_SCAN) received for p2p-dev-wlan1
1390301963.127489: p2p-dev-wlan1: nl80211: Scan trigger
1390301963.127498: p2p-dev-wlan1: Event SCAN_STARTED (49) received
1390301963.127540: p2p-dev-wlan1: Own scan request started a scan in 0.000095 seconds
1390301963.127543: p2p-dev-wlan1: CTRL-EVENT-SCAN-STARTED
1390301963.127576: CTRL_IFACE monitor sent successfully to /tmp/wpa_ctrl_2844-2\x00
1390301966.781574: nl80211: Drv Event 34 (NL80211_CMD_NEW_SCAN_RESULTS) received for p2p-dev-wlan1
1390301966.781596: p2p-dev-wlan1: nl80211: New scan results available
1390301966.781608: nl80211: Scan probed for SSID 'DIRECT-'
1390301966.781633: nl80211: Scan included frequencies: 2412 2417 2422 2427 2432 2437 2442 2447 2452 2457 2462 2467 2472 5180 5200 5220 5240 5260 5280 5300 5320 5500 5520 5540 5560 5580 5600 5620 5640 5660 5680 5700 5720 5745 5765 5785 5805 5825
1390301966.781639: p2p-dev-wlan1: Event SCAN_RESULTS (3) received
1390301966.781645: p2p-dev-wlan1: Scan completed in 3.654109 seconds
1390301966.781710: nl80211: Received scan results (0 BSSes)
1390301966.781746: p2p-dev-wlan1: BSS: Start scan result update 1
1390301966.781751: BSS: last_scan_res_used=0/0
1390301966.781756: p2p-dev-wlan1: Radio work 'p2p-scan'@0x1cd2e00 done in 3.657037 seconds
1390301966.781758: P2P: Scan results received (0 BSS)
1390301966.781774: P2P: State SEARCH -> SEARCH
1390301966.781781: P2P: Starting short listen state (state=SEARCH)
1390301966.782507: WPS: * Version (hardcoded 0x10)
1390301966.782511: WPS: * UUID-E
1390301966.782514: P2P: * P2P IE header
1390301966.782515: P2P: * Capability dev=25 group=00
1390301966.782518: P2P: * Device Info
1390301966.782522: p2p-dev-wlan1: Add radio work 'p2p-listen'@0x1cd23d0
1390301966.782527: p2p-dev-wlan1: First radio work item in the queue - schedule start immediately
1390301966.782551: p2p-dev-wlan1: Starting radio work 'p2p-listen'@0x1cd23d0 after 0.000021 second wait
1390301966.782579: nl80211: Enable Probe Request reporting nl_preq=0x1cd1ca0
1390301966.782584: nl80211: Register frame type=0x40 nl_handle=0x1cd1ca0 match=
1390301966.783260: nl80211: Remain-on-channel cookie 0xcb for freq=2412 MHz duration=102
1390301966.783300: nl80211: Drv Event 55 (NL80211_CMD_REMAIN_ON_CHANNEL) received for p2p-dev-wlan1
1390301966.783305: nl80211: Remain-on-channel event (cancel=0 freq=2412 channel_type=0 duration=102 cookie=0xcb (match))
1390301966.783313: p2p-dev-wlan1: Event REMAIN_ON_CHANNEL (21) received
1390301966.783327: Off-channel: Send Action callback (without_roc=0 pending_action_tx=(nil))
1390301966.783335: P2P: Starting Listen timeout(0,102400) on freq=2412 based on callback
1390301966.783339: P2P: Set timeout (state=SEARCH): 0.122400 sec
1390301966.884365: nl80211: Drv Event 56 (NL80211_CMD_CANCEL_REMAIN_ON_CHANNEL) received for p2p-dev-wlan1
1390301966.884376: nl80211: Remain-on-channel event (cancel=1 freq=2412 channel_type=0 duration=0 cookie=0xcb (match))
1390301966.884385: p2p-dev-wlan1: Event CANCEL_REMAIN_ON_CHANNEL (22) received
1390301966.884391: P2P: Cancel remain-on-channel callback (p2p_long_listen=0 ms pending_action_tx=(nil))
1390301966.884410: p2p-dev-wlan1: Radio work 'p2p-listen'@0x1cd23d0 done in 0.101859 seconds
1390301966.884416: P2P: Driver ended Listen state (freq=2412)
1390301966.884419: P2P: Skip stop_listen since not in listen_only state.
1390301966.905908: P2P: Timeout (state=SEARCH)
1390301966.905920: nl80211: Disable Probe Request reporting nl_preq=0x8888888889459429
1390301966.905976: P2P: Starting search
1390301966.905983: WPS: Building WPS IE for Probe Request
1390301966.905986: WPS: * Version (hardcoded 0x10)
1390301966.905988: WPS: * Request Type
1390301966.905989: WPS: * Config Methods (148)
1390301966.905990: WPS: * UUID-E
1390301966.905992: WPS: * Primary Device Type
1390301966.905993: WPS: * RF Bands (3)
1390301966.905994: WPS: * Association State
1390301966.905996: WPS: * Configuration Error (0)
1390301966.905997: WPS: * Device Password ID (0)
1390301966.905998: WPS: * Device Name
1390301966.906003: P2P: * P2P IE header
1390301966.906004: P2P: * Capability dev=25 group=00
1390301966.906007: P2P: * Listen Channel: Regulatory Class 81 Channel 1
1390301966.906013: p2p-dev-wlan1: Add radio work 'p2p-scan'@0x1cd1ed0
1390301966.906059: p2p-dev-wlan1: First radio work item in the queue - schedule start immediately
1390301966.906067: P2P: Running p2p_scan
1390301966.906082: p2p-dev-wlan1: Starting radio work 'p2p-scan'@0x1cd1ed0 after 0.000023 second wait
1390301966.906086: p2p-dev-wlan1: nl80211: scan request
1390301966.906099: nl80211: P2P probe - mask SuppRates
1390301966.908786: Scan requested (ret=0) - scan timeout 30 seconds
1390301966.908850: nl80211: Drv Event 33 (NL80211_CMD_TRIGGER_SCAN) received for p2p-dev-wlan1
1390301966.908859: p2p-dev-wlan1: nl80211: Scan trigger
1390301966.908865: p2p-dev-wlan1: Event SCAN_STARTED (49) received
1390301966.908870: p2p-dev-wlan1: Own scan request started a scan in 0.000065 seconds
1390301966.908873: p2p-dev-wlan1: CTRL-EVENT-SCAN-STARTED
1390301966.908904: CTRL_IFACE monitor sent successfully to /tmp/wpa_ctrl_2844-2\x00
1390301967.029552: nl80211: Drv Event 34 (NL80211_CMD_NEW_SCAN_RESULTS) received for p2p-dev-wlan1
1390301967.029569: p2p-dev-wlan1: nl80211: New scan results available
1390301967.029577: nl80211: Scan probed for SSID 'DIRECT-'
1390301967.029580: nl80211: Scan included frequencies: 2412 2437 2462
1390301967.029583: p2p-dev-wlan1: Event SCAN_RESULTS (3) received
1390301967.029600: p2p-dev-wlan1: Scan completed in 0.120719 seconds
1390301967.029638: nl80211: Received scan results (0 BSSes)
1390301967.029661: p2p-dev-wlan1: BSS: Start scan result update 2
1390301967.029665: BSS: last_scan_res_used=0/0
1390301967.029672: p2p-dev-wlan1: Radio work 'p2p-scan'@0x1cd1ed0 done in 0.123588 seconds
1390301967.029674: P2P: Scan results received (0 BSS)
1390301967.029680: P2P: State SEARCH -> SEARCH
1390301967.029683: P2P: Starting short listen state (state=SEARCH)
1390301967.030423: WPS: * Version (hardcoded 0x10)
1390301967.030428: WPS: * UUID-E
1390301967.030431: P2P: * P2P IE header
1390301967.030432: P2P: * Capability dev=25 group=00
1390301967.030434: P2P: * Device Info
1390301967.030439: p2p-dev-wlan1: Add radio work 'p2p-listen'@0x1cce4f0
1390301967.030443: p2p-dev-wlan1: First radio work item in the queue - schedule start immediately
1390301967.030465: p2p-dev-wlan1: Starting radio work 'p2p-listen'@0x1cce4f0 after 0.000019 second wait
1390301967.030490: nl80211: Enable Probe Request reporting nl_preq=0x1cd1ca0
1390301967.030495: nl80211: Register frame type=0x40 nl_handle=0x1cd1ca0 match=
1390301967.031142: nl80211: Remain-on-channel cookie 0xcc for freq=2412 MHz duration=307
1390301967.031181: nl80211: Drv Event 55 (NL80211_CMD_REMAIN_ON_CHANNEL) received for p2p-dev-wlan1
1390301967.031186: nl80211: Remain-on-channel event (cancel=0 freq=2412 channel_type=0 duration=307 cookie=0xcc (match))
1390301967.031194: p2p-dev-wlan1: Event REMAIN_ON_CHANNEL (21) received
1390301967.031198: Off-channel: Send Action callback (without_roc=0 pending_action_tx=(nil))
1390301967.031203: P2P: Starting Listen timeout(0,307200) on freq=2412 based on callback
1390301967.031207: P2P: Set timeout (state=SEARCH): 0.327200 sec
1390301967.337106: nl80211: Drv Event 56 (NL80211_CMD_CANCEL_REMAIN_ON_CHANNEL) received for p2p-dev-wlan1
1390301967.337118: nl80211: Remain-on-channel event (cancel=1 freq=2412 channel_type=0 duration=0 cookie=0xcc (match))
1390301967.337127: p2p-dev-wlan1: Event CANCEL_REMAIN_ON_CHANNEL (22) received
1390301967.337133: P2P: Cancel remain-on-channel callback (p2p_long_listen=0 ms pending_action_tx=(nil))
1390301967.337141: p2p-dev-wlan1: Radio work 'p2p-listen'@0x1cce4f0 done in 0.306677 seconds
1390301967.337146: P2P: Driver ended Listen state (freq=2412)
1390301967.337150: P2P: Skip stop_listen since not in listen_only state.
1390301967.358581: P2P: Timeout (state=SEARCH)
1390301967.358594: nl80211: Disable Probe Request reporting nl_preq=0x8888888889459429
1390301967.358671: P2P: Starting search
1390301967.358678: WPS: Building WPS IE for Probe Request
1390301967.358681: WPS: * Version (hardcoded 0x10)
1390301967.358682: WPS: * Request Type
1390301967.358693: WPS: * Config Methods (148)
1390301967.358695: WPS: * UUID-E
1390301967.358696: WPS: * Primary Device Type
1390301967.358735: WPS: * RF Bands (3)
1390301967.358737: WPS: * Association State
1390301967.358738: WPS: * Configuration Error (0)
1390301967.358739: WPS: * Device Password ID (0)
1390301967.358741: WPS: * Device Name
1390301967.358745: P2P: * P2P IE header
1390301967.358746: P2P: * Capability dev=25 group=00
1390301967.358749: P2P: * Listen Channel: Regulatory Class 81 Channel 1
1390301967.358755: p2p-dev-wlan1: Add radio work 'p2p-scan'@0x1cd1ed0
1390301967.358760: p2p-dev-wlan1: First radio work item in the queue - schedule start immediately
1390301967.358764: P2P: Running p2p_scan
1390301967.358779: p2p-dev-wlan1: Starting radio work 'p2p-scan'@0x1cd1ed0 after 0.000017 second wait
1390301967.358783: p2p-dev-wlan1: nl80211: scan request
1390301967.358794: nl80211: P2P probe - mask SuppRates
1390301967.361492: Scan requested (ret=0) - scan timeout 30 seconds
1390301967.361540: nl80211: Drv Event 33 (NL80211_CMD_TRIGGER_SCAN) received for p2p-dev-wlan1
1390301967.361548: p2p-dev-wlan1: nl80211: Scan trigger
1390301967.361554: p2p-dev-wlan1: Event SCAN_STARTED (49) received
1390301967.361559: p2p-dev-wlan1: Own scan request started a scan in 0.000049 seconds
1390301967.361562: p2p-dev-wlan1: CTRL-EVENT-SCAN-STARTED
1390301967.361593: CTRL_IFACE monitor sent successfully to /tmp/wpa_ctrl_2844-2\x00
1390301967.482264: nl80211: Drv Event 34 (NL80211_CMD_NEW_SCAN_RESULTS) received for p2p-dev-wlan1
1390301967.482278: p2p-dev-wlan1: nl80211: New scan results available
1390301967.482285: nl80211: Scan probed for SSID 'DIRECT-'
1390301967.482288: nl80211: Scan included frequencies: 2412 2437 2462
1390301967.482292: p2p-dev-wlan1: Event SCAN_RESULTS (3) received
1390301967.482296: p2p-dev-wlan1: Scan completed in 0.120738 seconds
1390301967.482358: nl80211: Received scan results (2 BSSes)
1390301967.482387: p2p-dev-wlan1: BSS: Start scan result update 3
1390301967.482406: p2p-dev-wlan1: BSS: Add new id 0 BSSID 9c:c7:a6:87:b0:f5 SSID 'Reichl&Vetter'
1390301967.482436: CTRL_IFACE monitor sent successfully to /tmp/wpa_ctrl_2844-2\x00
1390301967.482444: p2p-dev-wlan1: BSS: Add new id 1 BSSID 20:2b:c1:4b:8f:a4 SSID 'WLAN-8FA406'
1390301967.482454: CTRL_IFACE monitor sent successfully to /tmp/wpa_ctrl_2844-2\x00
1390301967.482457: BSS: last_scan_res_used=2/32
1390301967.482464: p2p-dev-wlan1: Radio work 'p2p-scan'@0x1cd1ed0 done in 0.123685 seconds
1390301967.482466: P2P: Scan results received (2 BSS)
1390301967.482477: P2P: Parsing WPS IE
1390301967.482483: P2P: Ignore scan data without P2P Device Info or P2P Device Id
1390301967.482488: P2P: Parsing WPS IE
1390301967.482491: P2P: Ignore scan data without P2P Device Info or P2P Device Id
1390301967.482496: P2P: State SEARCH -> SEARCH
1390301967.482499: P2P: Starting short listen state (state=SEARCH)
1390301967.483162: WPS: * Version (hardcoded 0x10)
1390301967.483166: WPS: * UUID-E
1390301967.483168: P2P: * P2P IE header
1390301967.483169: P2P: * Capability dev=25 group=00
1390301967.483171: P2P: * Device Info
1390301967.483176: p2p-dev-wlan1: Add radio work 'p2p-listen'@0x1cd6a80
1390301967.483181: p2p-dev-wlan1: First radio work item in the queue - schedule start immediately
1390301967.483204: p2p-dev-wlan1: Starting radio work 'p2p-listen'@0x1cd6a80 after 0.000020 second wait
1390301967.483229: nl80211: Enable Probe Request reporting nl_preq=0x1cd1ca0
1390301967.483235: nl80211: Register frame type=0x40 nl_handle=0x1cd1ca0 match=
1390301967.483850: nl80211: Remain-on-channel cookie 0xcd for freq=2412 MHz duration=204
1390301967.483889: nl80211: Drv Event 55 (NL80211_CMD_REMAIN_ON_CHANNEL) received for p2p-dev-wlan1
1390301967.483893: nl80211: Remain-on-channel event (cancel=0 freq=2412 channel_type=0 duration=204 cookie=0xcd (match))
1390301967.483901: p2p-dev-wlan1: Event REMAIN_ON_CHANNEL (21) received
1390301967.483906: Off-channel: Send Action callback (without_roc=0 pending_action_tx=(nil))
1390301967.483911: P2P: Starting Listen timeout(0,204800) on freq=2412 based on callback
1390301967.483915: P2P: Set timeout (state=SEARCH): 0.224800 sec
1390301967.687419: nl80211: Drv Event 56 (NL80211_CMD_CANCEL_REMAIN_ON_CHANNEL) received for p2p-dev-wlan1
1390301967.687464: nl80211: Remain-on-channel event (cancel=1 freq=2412 channel_type=0 duration=0 cookie=0xcd (match))
1390301967.687473: p2p-dev-wlan1: Event CANCEL_REMAIN_ON_CHANNEL (22) received
1390301967.687477: P2P: Cancel remain-on-channel callback (p2p_long_listen=0 ms pending_action_tx=(nil))
1390301967.687486: p2p-dev-wlan1: Radio work 'p2p-listen'@0x1cd6a80 done in 0.204283 seconds
1390301967.687490: P2P: Driver ended Listen state (freq=2412)
1390301967.687493: P2P: Skip stop_listen since not in listen_only state.
1390301967.708879: P2P: Timeout (state=SEARCH)
1390301967.708889: nl80211: Disable Probe Request reporting nl_preq=0x8888888889459429
1390301967.708942: P2P: Starting search
1390301967.708947: WPS: Building WPS IE for Probe Request
1390301967.708950: WPS: * Version (hardcoded 0x10)
1390301967.708951: WPS: * Request Type
1390301967.708952: WPS: * Config Methods (148)
1390301967.708953: WPS: * UUID-E
1390301967.708954: WPS: * Primary Device Type
1390301967.708955: WPS: * RF Bands (3)
1390301967.708957: WPS: * Association State
1390301967.708958: WPS: * Configuration Error (0)
1390301967.708959: WPS: * Device Password ID (0)
1390301967.708961: WPS: * Device Name
1390301967.708965: P2P: * P2P IE header
1390301967.708967: P2P: * Capability dev=25 group=00
1390301967.708969: P2P: * Listen Channel: Regulatory Class 81 Channel 1
1390301967.708974: p2p-dev-wlan1: Add radio work 'p2p-scan'@0x1cd1ca0
1390301967.708978: p2p-dev-wlan1: First radio work item in the queue - schedule start immediately
1390301967.708982: P2P: Running p2p_scan
1390301967.708995: p2p-dev-wlan1: Starting radio work 'p2p-scan'@0x1cd1ca0 after 0.000015 second wait
1390301967.708998: p2p-dev-wlan1: nl80211: scan request
1390301967.709007: nl80211: P2P probe - mask SuppRates
1390301967.711686: Scan requested (ret=0) - scan timeout 30 seconds
1390301967.711728: nl80211: Drv Event 33 (NL80211_CMD_TRIGGER_SCAN) received for p2p-dev-wlan1
1390301967.711736: p2p-dev-wlan1: nl80211: Scan trigger
1390301967.711741: p2p-dev-wlan1: Event SCAN_STARTED (49) received
1390301967.711747: p2p-dev-wlan1: Own scan request started a scan in 0.000045 seconds
1390301967.711749: p2p-dev-wlan1: CTRL-EVENT-SCAN-STARTED
1390301967.711775: CTRL_IFACE monitor sent successfully to /tmp/wpa_ctrl_2844-2\x00
1390301967.832456: nl80211: Drv Event 34 (NL80211_CMD_NEW_SCAN_RESULTS) received for p2p-dev-wlan1
1390301967.832472: p2p-dev-wlan1: nl80211: New scan results available
1390301967.832480: nl80211: Scan probed for SSID 'DIRECT-'
1390301967.832483: nl80211: Scan included frequencies: 2412 2437 2462
1390301967.832486: p2p-dev-wlan1: Event SCAN_RESULTS (3) received
1390301967.832491: p2p-dev-wlan1: Scan completed in 0.120744 seconds
1390301967.832574: nl80211: Received scan results (4 BSSes)
1390301967.832610: p2p-dev-wlan1: BSS: Start scan result update 4
1390301967.832624: p2p-dev-wlan1: BSS: Add new id 2 BSSID 84:1b:5e:7f:24:00 SSID 'PBG_Wlan_11ng'
1390301967.832657: CTRL_IFACE monitor sent successfully to /tmp/wpa_ctrl_2844-2\x00
1390301967.832665: p2p-dev-wlan1: BSS: Add new id 3 BSSID 10:fe:ed:56:76:9c SSID 'wlan-n'
1390301967.832675: CTRL_IFACE monitor sent successfully to /tmp/wpa_ctrl_2844-2\x00
1390301967.832678: BSS: last_scan_res_used=4/32
1390301967.832686: p2p-dev-wlan1: Radio work 'p2p-scan'@0x1cd1ca0 done in 0.123689 seconds
1390301967.832689: P2P: Scan results received (4 BSS)
1390301967.832695: P2P: Parsing WPS IE
1390301967.832704: P2P: Ignore scan data without P2P Device Info or P2P Device Id
1390301967.832710: P2P: Parsing WPS IE
1390301967.832713: P2P: Ignore scan data without P2P Device Info or P2P Device Id
1390301967.832717: P2P: Ignore scan data without P2P Device Info or P2P Device Id
1390301967.832720: P2P: Parsing WPS IE
1390301967.832723: P2P: Ignore scan data without P2P Device Info or P2P Device Id
1390301967.832728: P2P: State SEARCH -> SEARCH
1390301967.832730: P2P: Starting short listen state (state=SEARCH)
1390301967.833442: WPS: * Version (hardcoded 0x10)
1390301967.833474: WPS: * UUID-E
1390301967.833478: P2P: * P2P IE header
1390301967.833479: P2P: * Capability dev=25 group=00
1390301967.833481: P2P: * Device Info
1390301967.833486: p2p-dev-wlan1: Add radio work 'p2p-listen'@0x1cd6f50
1390301967.833491: p2p-dev-wlan1: First radio work item in the queue - schedule start immediately
1390301967.833564: p2p-dev-wlan1: Starting radio work 'p2p-listen'@0x1cd6f50 after 0.000057 second wait
1390301967.833590: nl80211: Enable Probe Request reporting nl_preq=0x1cd1ca0
1390301967.833596: nl80211: Register frame type=0x40 nl_handle=0x1cd1ca0 match=
1390301967.834204: nl80211: Remain-on-channel cookie 0xce for freq=2412 MHz duration=307
1390301967.834236: nl80211: Drv Event 55 (NL80211_CMD_REMAIN_ON_CHANNEL) received for p2p-dev-wlan1
1390301967.834241: nl80211: Remain-on-channel event (cancel=0 freq=2412 channel_type=0 duration=307 cookie=0xce (match))
1390301967.834248: p2p-dev-wlan1: Event REMAIN_ON_CHANNEL (21) received
1390301967.834252: Off-channel: Send Action callback (without_roc=0 pending_action_tx=(nil))
1390301967.834257: P2P: Starting Listen timeout(0,307200) on freq=2412 based on callback
1390301967.834261: P2P: Set timeout (state=SEARCH): 0.327200 sec
1390301968.110002: nl80211: BSS Event 59 (NL80211_CMD_FRAME) received for p2p-dev-wlan1
1390301968.110015: nl80211: RX frame freq=2412 ssi_signal=-24 stype=4 len=217
1390301968.110022: p2p-dev-wlan1: Event RX_MGMT (20) received
1390301968.110041: P2P: Parsing WPS IE
1390301968.110046: P2P: Config Methods (WPS): 0x4388
1390301968.110047: P2P: Device Password ID: 0
1390301968.110050: P2P: Primary Device Type (WPS): 10-0050F204-5
1390301968.110052: P2P: Parsing P2P IE
1390301968.110053: P2P: Attribute 2 length 2
1390301968.110054: P2P: * Device Capability 25 Group Capability 00
1390301968.110055: P2P: Attribute 6 length 5
1390301968.110056: P2P: * Listen Channel: Country DE(0x04) Regulatory Class 81 Channel Number 6
1390301968.110067: P2P: Created device entry based on Probe Req: 12:68:3f:4e:39:f2 dev_capab=0x25 group_capab=0x0 name='dvdhrm-nx' listen_freq=2437
1390301968.110071: P2P: Parsing WPS IE
1390301968.110072: P2P: Config Methods (WPS): 0x4388
1390301968.110073: P2P: Device Password ID: 0
1390301968.110075: P2P: Primary Device Type (WPS): 10-0050F204-5
1390301968.110076: P2P: Parsing P2P IE
1390301968.110077: P2P: Attribute 2 length 2
1390301968.110077: P2P: * Device Capability 25 Group Capability 00
1390301968.110078: P2P: Attribute 6 length 5
1390301968.110079: P2P: * Listen Channel: Country DE(0x04) Regulatory Class 81 Channel Number 6
1390301968.110082: P2P: Reply to P2P Probe Request in Listen state
1390301968.110085: WPS: * Version (hardcoded 0x10)
1390301968.110086: WPS: * UUID-E
1390301968.110088: P2P: * P2P IE header
1390301968.110089: P2P: * Capability dev=25 group=00
1390301968.110091: P2P: * Device Info
1390301968.110093: nl80211: send_mlme - noack=1 freq=0 no_cck=0 offchanok=0 wait_time=0 fc=0x50 nlmode=10
1390301968.110095: nl80211: Use last_mgmt_freq=2412
1390301968.110585: nl80211: BSS Event 59 (NL80211_CMD_FRAME) received for p2p-dev-wlan1
1390301968.110595: nl80211: RX frame freq=2412 ssi_signal=-25 stype=4 len=217
1390301968.110602: p2p-dev-wlan1: Event RX_MGMT (20) received
1390301968.110609: P2P: Parsing WPS IE
1390301968.110613: P2P: Config Methods (WPS): 0x4388
1390301968.110614: P2P: Device Password ID: 0
1390301968.110616: P2P: Primary Device Type (WPS): 10-0050F204-5
1390301968.110617: P2P: Parsing P2P IE
1390301968.110618: P2P: Attribute 2 length 2
1390301968.110619: P2P: * Device Capability 25 Group Capability 00
1390301968.110620: P2P: Attribute 6 length 5
1390301968.110621: P2P: * Listen Channel: Country DE(0x04) Regulatory Class 81 Channel Number 6
1390301968.110626: P2P: Parsing WPS IE
1390301968.110628: P2P: Config Methods (WPS): 0x4388
1390301968.110629: P2P: Device Password ID: 0
1390301968.110630: P2P: Primary Device Type (WPS): 10-0050F204-5
1390301968.110631: P2P: Parsing P2P IE
1390301968.110632: P2P: Attribute 2 length 2
1390301968.110632: P2P: * Device Capability 25 Group Capability 00
1390301968.110666: P2P: Attribute 6 length 5
1390301968.110667: P2P: * Listen Channel: Country DE(0x04) Regulatory Class 81 Channel Number 6
1390301968.110672: P2P: Reply to P2P Probe Request in Listen state
1390301968.110675: WPS: * Version (hardcoded 0x10)
1390301968.110676: WPS: * UUID-E
1390301968.110678: P2P: * P2P IE header
1390301968.110679: P2P: * Capability dev=25 group=00
1390301968.110680: P2P: * Device Info
1390301968.110682: nl80211: send_mlme - noack=1 freq=0 no_cck=0 offchanok=0 wait_time=0 fc=0x50 nlmode=10
1390301968.110685: nl80211: Use last_mgmt_freq=2412
1390301968.120666: nl80211: BSS Event 59 (NL80211_CMD_FRAME) received for p2p-dev-wlan1
1390301968.120678: nl80211: RX frame freq=2412 ssi_signal=-27 stype=4 len=217
1390301968.120685: p2p-dev-wlan1: Event RX_MGMT (20) received
1390301968.120694: P2P: Parsing WPS IE
1390301968.120698: P2P: Config Methods (WPS): 0x4388
1390301968.120699: P2P: Device Password ID: 0
1390301968.120702: P2P: Primary Device Type (WPS): 10-0050F204-5
1390301968.120703: P2P: Parsing P2P IE
1390301968.120704: P2P: Attribute 2 length 2
1390301968.120705: P2P: * Device Capability 25 Group Capability 00
1390301968.120706: P2P: Attribute 6 length 5
1390301968.120707: P2P: * Listen Channel: Country DE(0x04) Regulatory Class 81 Channel Number 6
1390301968.120714: P2P: Parsing WPS IE
1390301968.120715: P2P: Config Methods (WPS): 0x4388
1390301968.120716: P2P: Device Password ID: 0
1390301968.120718: P2P: Primary Device Type (WPS): 10-0050F204-5
1390301968.120719: P2P: Parsing P2P IE
1390301968.120719: P2P: Attribute 2 length 2
1390301968.120720: P2P: * Device Capability 25 Group Capability 00
1390301968.120721: P2P: Attribute 6 length 5
1390301968.120721: P2P: * Listen Channel: Country DE(0x04) Regulatory Class 81 Channel Number 6
1390301968.120726: P2P: Reply to P2P Probe Request in Listen state
1390301968.120729: WPS: * Version (hardcoded 0x10)
1390301968.120730: WPS: * UUID-E
1390301968.120732: P2P: * P2P IE header
1390301968.120733: P2P: * Capability dev=25 group=00
1390301968.120735: P2P: * Device Info
1390301968.120737: nl80211: send_mlme - noack=1 freq=0 no_cck=0 offchanok=0 wait_time=0 fc=0x50 nlmode=10
1390301968.120739: nl80211: Use last_mgmt_freq=2412
1390301968.130804: nl80211: BSS Event 59 (NL80211_CMD_FRAME) received for p2p-dev-wlan1
1390301968.130816: nl80211: RX frame freq=2412 ssi_signal=-28 stype=4 len=217
1390301968.130823: p2p-dev-wlan1: Event RX_MGMT (20) received
1390301968.130832: P2P: Parsing WPS IE
1390301968.130836: P2P: Config Methods (WPS): 0x4388
1390301968.130837: P2P: Device Password ID: 0
1390301968.130840: P2P: Primary Device Type (WPS): 10-0050F204-5
1390301968.130841: P2P: Parsing P2P IE
1390301968.130842: P2P: Attribute 2 length 2
1390301968.130843: P2P: * Device Capability 25 Group Capability 00
1390301968.130844: P2P: Attribute 6 length 5
1390301968.130845: P2P: * Listen Channel: Country DE(0x04) Regulatory Class 81 Channel Number 6
1390301968.130851: P2P: Parsing WPS IE
1390301968.130853: P2P: Config Methods (WPS): 0x4388
1390301968.130854: P2P: Device Password ID: 0
1390301968.130855: P2P: Primary Device Type (WPS): 10-0050F204-5
1390301968.130856: P2P: Parsing P2P IE
1390301968.130857: P2P: Attribute 2 length 2
1390301968.130857: P2P: * Device Capability 25 Group Capability 00
1390301968.130858: P2P: Attribute 6 length 5
1390301968.130859: P2P: * Listen Channel: Country DE(0x04) Regulatory Class 81 Channel Number 6
1390301968.130863: P2P: Reply to P2P Probe Request in Listen state
1390301968.130866: WPS: * Version (hardcoded 0x10)
1390301968.130867: WPS: * UUID-E
1390301968.130869: P2P: * P2P IE header
1390301968.130870: P2P: * Capability dev=25 group=00
1390301968.130872: P2P: * Device Info
1390301968.130874: nl80211: send_mlme - noack=1 freq=0 no_cck=0 offchanok=0 wait_time=0 fc=0x50 nlmode=10
1390301968.130876: nl80211: Use last_mgmt_freq=2412
1390301968.141776: nl80211: Drv Event 56 (NL80211_CMD_CANCEL_REMAIN_ON_CHANNEL) received for p2p-dev-wlan1
1390301968.141785: nl80211: Remain-on-channel event (cancel=1 freq=2412 channel_type=0 duration=0 cookie=0xce (match))
1390301968.141824: p2p-dev-wlan1: Event CANCEL_REMAIN_ON_CHANNEL (22) received
1390301968.141828: P2P: Cancel remain-on-channel callback (p2p_long_listen=0 ms pending_action_tx=(nil))
1390301968.141836: p2p-dev-wlan1: Radio work 'p2p-listen'@0x1cd6f50 done in 0.308286 seconds
1390301968.141841: P2P: Driver ended Listen state (freq=2412)
1390301968.141843: P2P: Skip stop_listen since not in listen_only state.
1390301968.161627: P2P: Timeout (state=SEARCH)
1390301968.161637: nl80211: Disable Probe Request reporting nl_preq=0x8888888889459429
1390301968.161696: P2P: Starting search
1390301968.161703: WPS: Building WPS IE for Probe Request
1390301968.161705: WPS: * Version (hardcoded 0x10)
1390301968.161706: WPS: * Request Type
1390301968.161707: WPS: * Config Methods (148)
1390301968.161708: WPS: * UUID-E
1390301968.161709: WPS: * Primary Device Type
1390301968.161710: WPS: * RF Bands (3)
1390301968.161711: WPS: * Association State
1390301968.161712: WPS: * Configuration Error (0)
1390301968.161713: WPS: * Device Password ID (0)
1390301968.161714: WPS: * Device Name
1390301968.161717: P2P: * P2P IE header
1390301968.161718: P2P: * Capability dev=25 group=00
1390301968.161720: P2P: * Listen Channel: Regulatory Class 81 Channel 1
1390301968.161726: p2p-dev-wlan1: Add radio work 'p2p-scan'@0x1cd6a90
1390301968.161730: p2p-dev-wlan1: First radio work item in the queue - schedule start immediately
1390301968.161733: P2P: Running p2p_scan
1390301968.161745: p2p-dev-wlan1: Starting radio work 'p2p-scan'@0x1cd6a90 after 0.000014 second wait
1390301968.161748: p2p-dev-wlan1: nl80211: scan request
1390301968.161758: nl80211: P2P probe - mask SuppRates
1390301968.164433: Scan requested (ret=0) - scan timeout 30 seconds
1390301968.164476: nl80211: Drv Event 33 (NL80211_CMD_TRIGGER_SCAN) received for p2p-dev-wlan1
1390301968.164484: p2p-dev-wlan1: nl80211: Scan trigger
1390301968.164489: p2p-dev-wlan1: Event SCAN_STARTED (49) received
1390301968.164493: p2p-dev-wlan1: Own scan request started a scan in 0.000044 seconds
1390301968.164495: p2p-dev-wlan1: CTRL-EVENT-SCAN-STARTED
1390301968.164523: CTRL_IFACE monitor sent successfully to /tmp/wpa_ctrl_2844-2\x00
1390301968.285246: nl80211: Drv Event 34 (NL80211_CMD_NEW_SCAN_RESULTS) received for p2p-dev-wlan1
1390301968.285261: p2p-dev-wlan1: nl80211: New scan results available
1390301968.285268: nl80211: Scan probed for SSID 'DIRECT-'
1390301968.285271: nl80211: Scan included frequencies: 2412 2437 2462
1390301968.285273: p2p-dev-wlan1: Event SCAN_RESULTS (3) received
1390301968.285278: p2p-dev-wlan1: Scan completed in 0.120786 seconds
1390301968.285340: nl80211: Received scan results (4 BSSes)
1390301968.285372: p2p-dev-wlan1: BSS: Start scan result update 5
1390301968.285398: BSS: last_scan_res_used=4/32
1390301968.285404: p2p-dev-wlan1: Radio work 'p2p-scan'@0x1cd6a90 done in 0.123658 seconds
1390301968.285407: P2P: Scan results received (4 BSS)
1390301968.285413: P2P: Parsing WPS IE
1390301968.285418: P2P: Ignore scan data without P2P Device Info or P2P Device Id
1390301968.285422: P2P: Parsing WPS IE
1390301968.285425: P2P: Ignore scan data without P2P Device Info or P2P Device Id
1390301968.285428: P2P: Ignore scan data without P2P Device Info or P2P Device Id
1390301968.285431: P2P: Parsing WPS IE
1390301968.285433: P2P: Ignore scan data without P2P Device Info or P2P Device Id
1390301968.285438: P2P: State SEARCH -> SEARCH
1390301968.285441: P2P: Starting short listen state (state=SEARCH)
1390301968.286105: WPS: * Version (hardcoded 0x10)
1390301968.286108: WPS: * UUID-E
1390301968.286111: P2P: * P2P IE header
1390301968.286111: P2P: * Capability dev=25 group=00
1390301968.286114: P2P: * Device Info
1390301968.286118: p2p-dev-wlan1: Add radio work 'p2p-listen'@0x1cd6f50
1390301968.286122: p2p-dev-wlan1: First radio work item in the queue - schedule start immediately
1390301968.286143: p2p-dev-wlan1: Starting radio work 'p2p-listen'@0x1cd6f50 after 0.000019 second wait
1390301968.286169: nl80211: Enable Probe Request reporting nl_preq=0x1cd1ca0
1390301968.286204: nl80211: Register frame type=0x40 nl_handle=0x1cd1ca0 match=
1390301968.286732: nl80211: Remain-on-channel cookie 0xcf for freq=2412 MHz duration=307
1390301968.286767: nl80211: Drv Event 55 (NL80211_CMD_REMAIN_ON_CHANNEL) received for p2p-dev-wlan1
1390301968.286772: nl80211: Remain-on-channel event (cancel=0 freq=2412 channel_type=0 duration=307 cookie=0xcf (match))
1390301968.286779: p2p-dev-wlan1: Event REMAIN_ON_CHANNEL (21) received
1390301968.286783: Off-channel: Send Action callback (without_roc=0 pending_action_tx=(nil))
1390301968.286789: P2P: Starting Listen timeout(0,307200) on freq=2412 based on callback
1390301968.286793: P2P: Set timeout (state=SEARCH): 0.327200 sec
1390301968.592766: nl80211: Drv Event 56 (NL80211_CMD_CANCEL_REMAIN_ON_CHANNEL) received for p2p-dev-wlan1
1390301968.592778: nl80211: Remain-on-channel event (cancel=1 freq=2412 channel_type=0 duration=0 cookie=0xcf (match))
1390301968.592786: p2p-dev-wlan1: Event CANCEL_REMAIN_ON_CHANNEL (22) received
1390301968.592792: P2P: Cancel remain-on-channel callback (p2p_long_listen=0 ms pending_action_tx=(nil))
1390301968.592800: p2p-dev-wlan1: Radio work 'p2p-listen'@0x1cd6f50 done in 0.306657 seconds
1390301968.592805: P2P: Driver ended Listen state (freq=2412)
1390301968.592808: P2P: Skip stop_listen since not in listen_only state.
1390301968.614142: P2P: Timeout (state=SEARCH)
1390301968.614153: nl80211: Disable Probe Request reporting nl_preq=0x8888888889459429
1390301968.614197: P2P: Starting search
1390301968.614203: WPS: Building WPS IE for Probe Request
1390301968.614205: WPS: * Version (hardcoded 0x10)
1390301968.614207: WPS: * Request Type
1390301968.614208: WPS: * Config Methods (148)
1390301968.614209: WPS: * UUID-E
1390301968.614210: WPS: * Primary Device Type
1390301968.614211: WPS: * RF Bands (3)
1390301968.614213: WPS: * Association State
1390301968.614214: WPS: * Configuration Error (0)
1390301968.614215: WPS: * Device Password ID (0)
1390301968.614217: WPS: * Device Name
1390301968.614220: P2P: * P2P IE header
1390301968.614221: P2P: * Capability dev=25 group=00
1390301968.614224: P2P: * Listen Channel: Regulatory Class 81 Channel 1
1390301968.614231: p2p-dev-wlan1: Add radio work 'p2p-scan'@0x1cd6a90
1390301968.614236: p2p-dev-wlan1: First radio work item in the queue - schedule start immediately
1390301968.614240: P2P: Running p2p_scan
1390301968.614254: p2p-dev-wlan1: Starting radio work 'p2p-scan'@0x1cd6a90 after 0.000017 second wait
1390301968.614257: p2p-dev-wlan1: nl80211: scan request
1390301968.614267: nl80211: P2P probe - mask SuppRates
1390301968.616813: Scan requested (ret=0) - scan timeout 30 seconds
1390301968.616893: nl80211: Drv Event 33 (NL80211_CMD_TRIGGER_SCAN) received for p2p-dev-wlan1
1390301968.616902: p2p-dev-wlan1: nl80211: Scan trigger
1390301968.616908: p2p-dev-wlan1: Event SCAN_STARTED (49) received
1390301968.616913: p2p-dev-wlan1: Own scan request started a scan in 0.000083 seconds
1390301968.616915: p2p-dev-wlan1: CTRL-EVENT-SCAN-STARTED
1390301968.616943: CTRL_IFACE monitor sent successfully to /tmp/wpa_ctrl_2844-2\x00
1390301968.737569: nl80211: Drv Event 34 (NL80211_CMD_NEW_SCAN_RESULTS) received for p2p-dev-wlan1
1390301968.737583: p2p-dev-wlan1: nl80211: New scan results available
1390301968.737589: nl80211: Scan probed for SSID 'DIRECT-'
1390301968.737592: nl80211: Scan included frequencies: 2412 2437 2462
1390301968.737594: p2p-dev-wlan1: Event SCAN_RESULTS (3) received
1390301968.737599: p2p-dev-wlan1: Scan completed in 0.120687 seconds
1390301968.737664: nl80211: Received scan results (5 BSSes)
1390301968.737694: p2p-dev-wlan1: BSS: Start scan result update 6
1390301968.737705: BSS: last_scan_res_used=4/32
1390301968.737711: p2p-dev-wlan1: Radio work 'p2p-scan'@0x1cd6a90 done in 0.123456 seconds
1390301968.737713: P2P: Scan results received (5 BSS)
1390301968.737719: P2P: Parsing WPS IE
1390301968.737724: P2P: Ignore scan data without P2P Device Info or P2P Device Id
1390301968.737727: P2P: Parsing WPS IE
1390301968.737729: P2P: Ignore scan data without P2P Device Info or P2P Device Id
1390301968.737769: P2P: Ignore scan data without P2P Device Info or P2P Device Id
1390301968.737772: P2P: Parsing WPS IE
1390301968.737774: P2P: Ignore scan data without P2P Device Info or P2P Device Id
1390301968.737776: P2P: Parsing WPS IE
1390301968.737778: P2P: Config Methods (WPS): 0x4388
1390301968.737780: P2P: Primary Device Type (WPS): 10-0050F204-5
1390301968.737782: P2P: Parsing P2P IE
1390301968.737782: P2P: Attribute 2 length 2
1390301968.737784: P2P: * Device Capability 25 Group Capability 00
1390301968.737785: P2P: Attribute 13 length 30
1390301968.737787: P2P: * Device Info: addr 12:68:3f:4e:39:f2 primary device type 10-0050F204-5 device name 'dvdhrm-nx' config methods 0x188
1390301968.737794: P2P: Update peer 12:68:3f:4e:39:f2 config_methods 0x0 -> 0x188
1390301968.737806: P2P: Peer found with Listen frequency 2437 MHz (rx_time=1978.707309)
1390301968.737812: P2P-DEVICE-FOUND 12:68:3f:4e:39:f2 p2p_dev_addr=12:68:3f:4e:39:f2 pri_dev_type=10-0050F204-5 name='dvdhrm-nx' config_methods=0x188 dev_capab=0x25 group_capab=0x0
1390301968.737838: CTRL_IFACE monitor sent successfully to /tmp/wpa_ctrl_2844-2\x00
1390301968.737850: P2P: State SEARCH -> SEARCH
1390301968.737853: P2P: Starting short listen state (state=SEARCH)
1390301968.738534: WPS: * Version (hardcoded 0x10)
1390301968.738539: WPS: * UUID-E
1390301968.738542: P2P: * P2P IE header
1390301968.738543: P2P: * Capability dev=25 group=00
1390301968.738545: P2P: * Device Info
1390301968.738552: p2p-dev-wlan1: Add radio work 'p2p-listen'@0x1cd6f30
1390301968.738557: p2p-dev-wlan1: First radio work item in the queue - schedule start immediately
1390301968.738584: p2p-dev-wlan1: Starting radio work 'p2p-listen'@0x1cd6f30 after 0.000024 second wait
1390301968.738609: nl80211: Enable Probe Request reporting nl_preq=0x1cd1ca0
1390301968.738613: nl80211: Register frame type=0x40 nl_handle=0x1cd1ca0 match=
1390301968.739136: nl80211: Remain-on-channel cookie 0xd0 for freq=2412 MHz duration=307
1390301968.739158: nl80211: Drv Event 55 (NL80211_CMD_REMAIN_ON_CHANNEL) received for p2p-dev-wlan1
1390301968.739161: nl80211: Remain-on-channel event (cancel=0 freq=2412 channel_type=0 duration=307 cookie=0xd0 (match))
1390301968.739167: p2p-dev-wlan1: Event REMAIN_ON_CHANNEL (21) received
1390301968.739170: Off-channel: Send Action callback (without_roc=0 pending_action_tx=(nil))
1390301968.739174: P2P: Starting Listen timeout(0,307200) on freq=2412 based on callback
1390301968.739177: P2P: Set timeout (state=SEARCH): 0.327200 sec
1390301969.045141: nl80211: Drv Event 56 (NL80211_CMD_CANCEL_REMAIN_ON_CHANNEL) received for p2p-dev-wlan1
1390301969.045151: nl80211: Remain-on-channel event (cancel=1 freq=2412 channel_type=0 duration=0 cookie=0xd0 (match))
1390301969.045159: p2p-dev-wlan1: Event CANCEL_REMAIN_ON_CHANNEL (22) received
1390301969.045164: P2P: Cancel remain-on-channel callback (p2p_long_listen=0 ms pending_action_tx=(nil))
1390301969.045170: p2p-dev-wlan1: Radio work 'p2p-listen'@0x1cd6f30 done in 0.306588 seconds
1390301969.045174: P2P: Driver ended Listen state (freq=2412)
1390301969.045177: P2P: Skip stop_listen since not in listen_only state.
1390301969.066542: P2P: Timeout (state=SEARCH)
1390301969.066553: nl80211: Disable Probe Request reporting nl_preq=0x8888888889459429
1390301969.066601: P2P: Starting search
1390301969.066613: WPS: Building WPS IE for Probe Request
1390301969.066616: WPS: * Version (hardcoded 0x10)
1390301969.066618: WPS: * Request Type
1390301969.066619: WPS: * Config Methods (148)
1390301969.066620: WPS: * UUID-E
1390301969.066620: WPS: * Primary Device Type
1390301969.066621: WPS: * RF Bands (3)
1390301969.066622: WPS: * Association State
1390301969.066623: WPS: * Configuration Error (0)
1390301969.066624: WPS: * Device Password ID (0)
1390301969.066625: WPS: * Device Name
1390301969.066628: P2P: * P2P IE header
1390301969.066629: P2P: * Capability dev=25 group=00
1390301969.066630: P2P: * Listen Channel: Regulatory Class 81 Channel 1
1390301969.066636: p2p-dev-wlan1: Add radio work 'p2p-scan'@0x1cd6a90
1390301969.066673: p2p-dev-wlan1: First radio work item in the queue - schedule start immediately
1390301969.066677: P2P: Running p2p_scan
1390301969.066690: p2p-dev-wlan1: Starting radio work 'p2p-scan'@0x1cd6a90 after 0.000017 second wait
1390301969.066692: p2p-dev-wlan1: nl80211: scan request
1390301969.066702: nl80211: P2P probe - mask SuppRates
1390301969.069354: Scan requested (ret=0) - scan timeout 30 seconds
1390301969.069396: nl80211: Drv Event 33 (NL80211_CMD_TRIGGER_SCAN) received for p2p-dev-wlan1
1390301969.069403: p2p-dev-wlan1: nl80211: Scan trigger
1390301969.069408: p2p-dev-wlan1: Event SCAN_STARTED (49) received
1390301969.069412: p2p-dev-wlan1: Own scan request started a scan in 0.000043 seconds
1390301969.069414: p2p-dev-wlan1: CTRL-EVENT-SCAN-STARTED
1390301969.069439: CTRL_IFACE monitor sent successfully to /tmp/wpa_ctrl_2844-2\x00
1390301969.190139: nl80211: Drv Event 34 (NL80211_CMD_NEW_SCAN_RESULTS) received for p2p-dev-wlan1
1390301969.190153: p2p-dev-wlan1: nl80211: New scan results available
1390301969.190159: nl80211: Scan probed for SSID 'DIRECT-'
1390301969.190162: nl80211: Scan included frequencies: 2412 2437 2462
1390301969.190165: p2p-dev-wlan1: Event SCAN_RESULTS (3) received
1390301969.190168: p2p-dev-wlan1: Scan completed in 0.120756 seconds
1390301969.190248: nl80211: Received scan results (5 BSSes)
1390301969.190278: p2p-dev-wlan1: BSS: Start scan result update 7
1390301969.190289: BSS: last_scan_res_used=4/32
1390301969.190294: p2p-dev-wlan1: Radio work 'p2p-scan'@0x1cd6a90 done in 0.123604 seconds
1390301969.190296: P2P: Scan results received (5 BSS)
1390301969.190302: P2P: Parsing WPS IE
1390301969.190307: P2P: Ignore scan data without P2P Device Info or P2P Device Id
1390301969.190310: P2P: Parsing WPS IE
1390301969.190312: P2P: Ignore scan data without P2P Device Info or P2P Device Id
1390301969.190315: P2P: Ignore scan data without P2P Device Info or P2P Device Id
1390301969.190317: P2P: Parsing WPS IE
1390301969.190319: P2P: Ignore scan data without P2P Device Info or P2P Device Id
1390301969.190321: P2P: Parsing WPS IE
1390301969.190323: P2P: Config Methods (WPS): 0x4388
1390301969.190325: P2P: Primary Device Type (WPS): 10-0050F204-5
1390301969.190326: P2P: Parsing P2P IE
1390301969.190327: P2P: Attribute 2 length 2
1390301969.190328: P2P: * Device Capability 25 Group Capability 00
1390301969.190329: P2P: Attribute 13 length 30
1390301969.190331: P2P: * Device Info: addr 12:68:3f:4e:39:f2 primary device type 10-0050F204-5 device name 'dvdhrm-nx' config methods 0x188
1390301969.190335: P2P: Do not update peer entry based on old frame (rx_time=1978.706893 last_seen=1978.707309)
1390301969.190340: P2P: State SEARCH -> SEARCH
1390301969.190342: P2P: Starting short listen state (state=SEARCH)
1390301969.190930: WPS: * Version (hardcoded 0x10)
1390301969.190933: WPS: * UUID-E
1390301969.190936: P2P: * P2P IE header
1390301969.190937: P2P: * Capability dev=25 group=00
1390301969.190938: P2P: * Device Info
1390301969.190942: p2p-dev-wlan1: Add radio work 'p2p-listen'@0x1cd6f30
1390301969.190945: p2p-dev-wlan1: First radio work item in the queue - schedule start immediately
1390301969.190964: p2p-dev-wlan1: Starting radio work 'p2p-listen'@0x1cd6f30 after 0.000017 second wait
1390301969.190987: nl80211: Enable Probe Request reporting nl_preq=0x1cd1ca0
1390301969.190991: nl80211: Register frame type=0x40 nl_handle=0x1cd1ca0 match=
1390301969.191538: nl80211: Remain-on-channel cookie 0xd1 for freq=2412 MHz duration=307
1390301969.191569: nl80211: Drv Event 55 (NL80211_CMD_REMAIN_ON_CHANNEL) received for p2p-dev-wlan1
1390301969.191573: nl80211: Remain-on-channel event (cancel=0 freq=2412 channel_type=0 duration=307 cookie=0xd1 (match))
1390301969.191581: p2p-dev-wlan1: Event REMAIN_ON_CHANNEL (21) received
1390301969.191585: Off-channel: Send Action callback (without_roc=0 pending_action_tx=(nil))
1390301969.191590: P2P: Starting Listen timeout(0,307200) on freq=2412 based on callback
1390301969.191593: P2P: Set timeout (state=SEARCH): 0.327200 sec
1390301969.331287: nl80211: BSS Event 59 (NL80211_CMD_FRAME) received for p2p-dev-wlan1
1390301969.331299: nl80211: RX frame freq=2412 ssi_signal=-22 stype=4 len=217
1390301969.331307: p2p-dev-wlan1: Event RX_MGMT (20) received
1390301969.331316: P2P: Parsing WPS IE
1390301969.331321: P2P: Config Methods (WPS): 0x4388
1390301969.331322: P2P: Device Password ID: 0
1390301969.331325: P2P: Primary Device Type (WPS): 10-0050F204-5
1390301969.331326: P2P: Parsing P2P IE
1390301969.331327: P2P: Attribute 2 length 2
1390301969.331328: P2P: * Device Capability 25 Group Capability 00
1390301969.331329: P2P: Attribute 6 length 5
1390301969.331330: P2P: * Listen Channel: Country DE(0x04) Regulatory Class 81 Channel Number 6
1390301969.331337: P2P: Parsing WPS IE
1390301969.331339: P2P: Config Methods (WPS): 0x4388
1390301969.331339: P2P: Device Password ID: 0
1390301969.331341: P2P: Primary Device Type (WPS): 10-0050F204-5
1390301969.331342: P2P: Parsing P2P IE
1390301969.331343: P2P: Attribute 2 length 2
1390301969.331343: P2P: * Device Capability 25 Group Capability 00
1390301969.331344: P2P: Attribute 6 length 5
1390301969.331345: P2P: * Listen Channel: Country DE(0x04) Regulatory Class 81 Channel Number 6
1390301969.331349: P2P: Reply to P2P Probe Request in Listen state
1390301969.331352: WPS: * Version (hardcoded 0x10)
1390301969.331353: WPS: * UUID-E
1390301969.331355: P2P: * P2P IE header
1390301969.331356: P2P: * Capability dev=25 group=00
1390301969.331358: P2P: * Device Info
1390301969.331360: nl80211: send_mlme - noack=1 freq=0 no_cck=0 offchanok=0 wait_time=0 fc=0x50 nlmode=10
1390301969.331363: nl80211: Use last_mgmt_freq=2412
1390301969.340660: nl80211: BSS Event 59 (NL80211_CMD_FRAME) received for p2p-dev-wlan1
1390301969.340672: nl80211: RX frame freq=2412 ssi_signal=-23 stype=4 len=217
1390301969.340680: p2p-dev-wlan1: Event RX_MGMT (20) received
1390301969.340688: P2P: Parsing WPS IE
1390301969.340693: P2P: Config Methods (WPS): 0x4388
1390301969.340694: P2P: Device Password ID: 0
1390301969.340697: P2P: Primary Device Type (WPS): 10-0050F204-5
1390301969.340698: P2P: Parsing P2P IE
1390301969.340699: P2P: Attribute 2 length 2
1390301969.340700: P2P: * Device Capability 25 Group Capability 00
1390301969.340702: P2P: Attribute 6 length 5
1390301969.340703: P2P: * Listen Channel: Country DE(0x04) Regulatory Class 81 Channel Number 6
1390301969.340709: P2P: Parsing WPS IE
1390301969.340711: P2P: Config Methods (WPS): 0x4388
1390301969.340712: P2P: Device Password ID: 0
1390301969.340713: P2P: Primary Device Type (WPS): 10-0050F204-5
1390301969.340714: P2P: Parsing P2P IE
1390301969.340715: P2P: Attribute 2 length 2
1390301969.340716: P2P: * Device Capability 25 Group Capability 00
1390301969.340717: P2P: Attribute 6 length 5
1390301969.340717: P2P: * Listen Channel: Country DE(0x04) Regulatory Class 81 Channel Number 6
1390301969.340722: P2P: Reply to P2P Probe Request in Listen state
1390301969.340725: WPS: * Version (hardcoded 0x10)
1390301969.340726: WPS: * UUID-E
1390301969.340728: P2P: * P2P IE header
1390301969.340729: P2P: * Capability dev=25 group=00
1390301969.340730: P2P: * Device Info
1390301969.340733: nl80211: send_mlme - noack=1 freq=0 no_cck=0 offchanok=0 wait_time=0 fc=0x50 nlmode=10
1390301969.340735: nl80211: Use last_mgmt_freq=2412
1390301969.360723: nl80211: BSS Event 59 (NL80211_CMD_FRAME) received for p2p-dev-wlan1
1390301969.360736: nl80211: RX frame freq=2412 ssi_signal=-24 stype=4 len=217
1390301969.360743: p2p-dev-wlan1: Event RX_MGMT (20) received
1390301969.360752: P2P: Parsing WPS IE
1390301969.360757: P2P: Config Methods (WPS): 0x4388
1390301969.360758: P2P: Device Password ID: 0
1390301969.360761: P2P: Primary Device Type (WPS): 10-0050F204-5
1390301969.360762: P2P: Parsing P2P IE
1390301969.360763: P2P: Attribute 2 length 2
1390301969.360764: P2P: * Device Capability 25 Group Capability 00
1390301969.360765: P2P: Attribute 6 length 5
1390301969.360766: P2P: * Listen Channel: Country DE(0x04) Regulatory Class 81 Channel Number 6
1390301969.360772: P2P: Parsing WPS IE
1390301969.360810: P2P: Config Methods (WPS): 0x4388
1390301969.360812: P2P: Device Password ID: 0
1390301969.360813: P2P: Primary Device Type (WPS): 10-0050F204-5
1390301969.360815: P2P: Parsing P2P IE
1390301969.360816: P2P: Attribute 2 length 2
1390301969.360816: P2P: * Device Capability 25 Group Capability 00
1390301969.360817: P2P: Attribute 6 length 5
1390301969.360818: P2P: * Listen Channel: Country DE(0x04) Regulatory Class 81 Channel Number 6
1390301969.360823: P2P: Reply to P2P Probe Request in Listen state
1390301969.360826: WPS: * Version (hardcoded 0x10)
1390301969.360827: WPS: * UUID-E
1390301969.360829: P2P: * P2P IE header
1390301969.360830: P2P: * Capability dev=25 group=00
1390301969.360832: P2P: * Device Info
1390301969.360834: nl80211: send_mlme - noack=1 freq=0 no_cck=0 offchanok=0 wait_time=0 fc=0x50 nlmode=10
1390301969.360837: nl80211: Use last_mgmt_freq=2412
1390301969.497527: nl80211: Drv Event 56 (NL80211_CMD_CANCEL_REMAIN_ON_CHANNEL) received for p2p-dev-wlan1
1390301969.497538: nl80211: Remain-on-channel event (cancel=1 freq=2412 channel_type=0 duration=0 cookie=0xd1 (match))
1390301969.497547: p2p-dev-wlan1: Event CANCEL_REMAIN_ON_CHANNEL (22) received
1390301969.497552: P2P: Cancel remain-on-channel callback (p2p_long_listen=0 ms pending_action_tx=(nil))
1390301969.497561: p2p-dev-wlan1: Radio work 'p2p-listen'@0x1cd6f30 done in 0.306595 seconds
1390301969.497565: P2P: Driver ended Listen state (freq=2412)
1390301969.497568: P2P: Skip stop_listen since not in listen_only state.
1390301969.518996: P2P: Timeout (state=SEARCH)
1390301969.519007: nl80211: Disable Probe Request reporting nl_preq=0x8888888889459429
1390301969.519063: P2P: Starting search
1390301969.519069: WPS: Building WPS IE for Probe Request
1390301969.519072: WPS: * Version (hardcoded 0x10)
1390301969.519073: WPS: * Request Type
1390301969.519074: WPS: * Config Methods (148)
1390301969.519076: WPS: * UUID-E
1390301969.519077: WPS: * Primary Device Type
1390301969.519079: WPS: * RF Bands (3)
1390301969.519081: WPS: * Association State
1390301969.519082: WPS: * Configuration Error (0)
1390301969.519083: WPS: * Device Password ID (0)
1390301969.519084: WPS: * Device Name
1390301969.519088: P2P: * P2P IE header
1390301969.519089: P2P: * Capability dev=25 group=00
1390301969.519092: P2P: * Listen Channel: Regulatory Class 81 Channel 1
1390301969.519097: p2p-dev-wlan1: Add radio work 'p2p-scan'@0x1cd6a90
1390301969.519102: p2p-dev-wlan1: First radio work item in the queue - schedule start immediately
1390301969.519106: P2P: Running p2p_scan
1390301969.519119: p2p-dev-wlan1: Starting radio work 'p2p-scan'@0x1cd6a90 after 0.000016 second wait
1390301969.519122: p2p-dev-wlan1: nl80211: scan request
1390301969.519132: nl80211: P2P probe - mask SuppRates
1390301969.521818: Scan requested (ret=0) - scan timeout 30 seconds
1390301969.521864: nl80211: Drv Event 33 (NL80211_CMD_TRIGGER_SCAN) received for p2p-dev-wlan1
1390301969.521871: p2p-dev-wlan1: nl80211: Scan trigger
1390301969.521876: p2p-dev-wlan1: Event SCAN_STARTED (49) received
1390301969.521882: p2p-dev-wlan1: Own scan request started a scan in 0.000045 seconds
1390301969.521884: p2p-dev-wlan1: CTRL-EVENT-SCAN-STARTED
1390301969.521912: CTRL_IFACE monitor sent successfully to /tmp/wpa_ctrl_2844-2\x00
1390301969.642579: nl80211: Drv Event 34 (NL80211_CMD_NEW_SCAN_RESULTS) received for p2p-dev-wlan1
1390301969.642593: p2p-dev-wlan1: nl80211: New scan results available
1390301969.642600: nl80211: Scan probed for SSID 'DIRECT-'
1390301969.642603: nl80211: Scan included frequencies: 2412 2437 2462
1390301969.642606: p2p-dev-wlan1: Event SCAN_RESULTS (3) received
1390301969.642611: p2p-dev-wlan1: Scan completed in 0.120731 seconds
1390301969.642679: nl80211: Received scan results (5 BSSes)
1390301969.642709: p2p-dev-wlan1: BSS: Start scan result update 8
1390301969.642723: BSS: last_scan_res_used=4/32
1390301969.642730: p2p-dev-wlan1: Radio work 'p2p-scan'@0x1cd6a90 done in 0.123609 seconds
1390301969.642732: P2P: Scan results received (5 BSS)
1390301969.642738: P2P: Parsing WPS IE
1390301969.642780: P2P: Ignore scan data without P2P Device Info or P2P Device Id
1390301969.642786: P2P: Ignore scan data without P2P Device Info or P2P Device Id
1390301969.642789: P2P: Parsing WPS IE
1390301969.642791: P2P: Ignore scan data without P2P Device Info or P2P Device Id
1390301969.642794: P2P: Parsing WPS IE
1390301969.642796: P2P: Ignore scan data without P2P Device Info or P2P Device Id
1390301969.642799: P2P: Parsing WPS IE
1390301969.642801: P2P: Config Methods (WPS): 0x4388
1390301969.642804: P2P: Primary Device Type (WPS): 10-0050F204-5
1390301969.642805: P2P: Parsing P2P IE
1390301969.642806: P2P: Attribute 2 length 2
1390301969.642807: P2P: * Device Capability 25 Group Capability 00
1390301969.642809: P2P: Attribute 13 length 30
1390301969.642810: P2P: * Device Info: addr 12:68:3f:4e:39:f2 primary device type 10-0050F204-5 device name 'dvdhrm-nx' config methods 0x188
1390301969.642819: P2P: State SEARCH -> SEARCH
1390301969.642823: P2P: Starting short listen state (state=SEARCH)
1390301969.643488: WPS: * Version (hardcoded 0x10)
1390301969.643491: WPS: * UUID-E
1390301969.643494: P2P: * P2P IE header
1390301969.643494: P2P: * Capability dev=25 group=00
1390301969.643496: P2P: * Device Info
1390301969.643500: p2p-dev-wlan1: Add radio work 'p2p-listen'@0x1cd6f30
1390301969.643504: p2p-dev-wlan1: First radio work item in the queue - schedule start immediately
1390301969.643580: p2p-dev-wlan1: Starting radio work 'p2p-listen'@0x1cd6f30 after 0.000070 second wait
1390301969.643608: nl80211: Enable Probe Request reporting nl_preq=0x1cd1ca0
1390301969.643614: nl80211: Register frame type=0x40 nl_handle=0x1cd1ca0 match=
1390301969.644243: nl80211: Remain-on-channel cookie 0xd2 for freq=2412 MHz duration=307
1390301969.644280: nl80211: Drv Event 55 (NL80211_CMD_REMAIN_ON_CHANNEL) received for p2p-dev-wlan1
1390301969.644284: nl80211: Remain-on-channel event (cancel=0 freq=2412 channel_type=0 duration=307 cookie=0xd2 (match))
1390301969.644291: p2p-dev-wlan1: Event REMAIN_ON_CHANNEL (21) received
1390301969.644295: Off-channel: Send Action callback (without_roc=0 pending_action_tx=(nil))
1390301969.644300: P2P: Starting Listen timeout(0,307200) on freq=2412 based on callback
1390301969.644304: P2P: Set timeout (state=SEARCH): 0.327200 sec
1390301969.950232: nl80211: Drv Event 56 (NL80211_CMD_CANCEL_REMAIN_ON_CHANNEL) received for p2p-dev-wlan1
1390301969.950242: nl80211: Remain-on-channel event (cancel=1 freq=2412 channel_type=0 duration=0 cookie=0xd2 (match))
1390301969.950250: p2p-dev-wlan1: Event CANCEL_REMAIN_ON_CHANNEL (22) received
1390301969.950255: P2P: Cancel remain-on-channel callback (p2p_long_listen=0 ms pending_action_tx=(nil))
1390301969.950262: p2p-dev-wlan1: Radio work 'p2p-listen'@0x1cd6f30 done in 0.306686 seconds
1390301969.950266: P2P: Driver ended Listen state (freq=2412)
1390301969.950269: P2P: Skip stop_listen since not in listen_only state.
1390301969.971669: P2P: Timeout (state=SEARCH)
1390301969.971679: nl80211: Disable Probe Request reporting nl_preq=0x8888888889459429
1390301969.971740: P2P: Starting search
1390301969.971747: WPS: Building WPS IE for Probe Request
1390301969.971749: WPS: * Version (hardcoded 0x10)
1390301969.971750: WPS: * Request Type
1390301969.971751: WPS: * Config Methods (148)
1390301969.971752: WPS: * UUID-E
1390301969.971753: WPS: * Primary Device Type
1390301969.971754: WPS: * RF Bands (3)
1390301969.971755: WPS: * Association State
1390301969.971755: WPS: * Configuration Error (0)
1390301969.971756: WPS: * Device Password ID (0)
1390301969.971757: WPS: * Device Name
1390301969.971761: P2P: * P2P IE header
1390301969.971762: P2P: * Capability dev=25 group=00
1390301969.971764: P2P: * Listen Channel: Regulatory Class 81 Channel 1
1390301969.971769: p2p-dev-wlan1: Add radio work 'p2p-scan'@0x1cd6a90
1390301969.971773: p2p-dev-wlan1: First radio work item in the queue - schedule start immediately
1390301969.971777: P2P: Running p2p_scan
1390301969.971789: p2p-dev-wlan1: Starting radio work 'p2p-scan'@0x1cd6a90 after 0.000015 second wait
1390301969.971824: p2p-dev-wlan1: nl80211: scan request
1390301969.971835: nl80211: P2P probe - mask SuppRates
1390301969.974496: Scan requested (ret=0) - scan timeout 30 seconds
1390301969.974538: nl80211: Drv Event 33 (NL80211_CMD_TRIGGER_SCAN) received for p2p-dev-wlan1
1390301969.974546: p2p-dev-wlan1: nl80211: Scan trigger
1390301969.974551: p2p-dev-wlan1: Event SCAN_STARTED (49) received
1390301969.974555: p2p-dev-wlan1: Own scan request started a scan in 0.000042 seconds
1390301969.974557: p2p-dev-wlan1: CTRL-EVENT-SCAN-STARTED
1390301969.974583: CTRL_IFACE monitor sent successfully to /tmp/wpa_ctrl_2844-2\x00
1390301970.022076: p2p-dev-wlan1: Control interface command 'P2P_CONNECT 12:68:3f:4e:39:f2 pbc'
1390301970.022110: p2p-dev-wlan1: Determining shared radio frequencies (max len 1)
1390301970.022123: p2p-dev-wlan1: Shared frequencies (len=0): completed iteration
1390301970.022125: P2P: Setup freqs: freq=0 num_MCC=1 shared_freqs=0
1390301970.022128: P2P: No current operating channels - try to use a new channel
1390301970.022133: P2P: Own frequency preference: 0 MHz
1390301970.022140: P2P: Create a new interface p2p-wlan1-0 for the group
1390301970.022143: nl80211: Create interface iftype 8 (P2P_CLIENT)
1390301970.022489: nl80211: New interface p2p-wlan1-0 created: ifindex=8
1390301970.022493: nl80211: Add own interface ifindex 8
1390301970.022517: nl80211: Set TX rates failed: ret=-100 (Network is down)
1390301970.022522: P2P: Created pending virtual interface p2p-wlan1-0 addr fc:f8:ae:69:8a:63
1390301970.022530: P2P: Request to start group negotiation - peer=12:68:3f:4e:39:f2 GO Intent=7 Intended Interface Address=fc:f8:ae:69:8a:63 wps_method=3 persistent_group=0 pd_before_go_neg=0
1390301970.022534: P2P: Prepare channel - force_freq=0 pref_freq=0 go=0
1390301970.022536: P2P: Prepare channel best
1390301970.023356: P2P: Select possible 5 GHz channel (op_class 124 channel 161) as operating channel preference
1390301970.023370: P2P: prepared channels: 81:1,2,3,4,5,6,7,8,9,10,11 124:161
1390301970.023381: P2P: after go/cli filter/add: 81:1,2,3,4,5,6,7,8,9,10,11 124:161
1390301970.023385: P2P: Own preference for operation channel: Operating Class 124 Channel 161
1390301970.023389: P2P: Stopping find
1390301970.023393: P2P: Clear timeout (state=SEARCH)
1390301970.023396: P2P-FIND-STOPPED
1390301970.023409: CTRL_IFACE monitor sent successfully to /tmp/wpa_ctrl_2844-2\x00
1390301970.023426: P2P: State SEARCH -> IDLE
1390301970.023438: P2P: p2p_scan running - delay connect send
1390301970.023483: RTM_NEWLINK: ifi_index=8 ifname=p2p-wlan1-0 operstate=2 linkmode=0 ifi_flags=0x1002 ()
1390301970.025753: Could not read interface p2p-dev-wlan1 flags: No such device
1390301970.025759: nl80211: Interface down
1390301970.025765: p2p-dev-wlan1: Event INTERFACE_DISABLED (29) received
1390301970.025771: p2p-dev-wlan1: Interface was disabled
1390301970.025781: p2p-dev-wlan1: State: DISCONNECTED -> DISCONNECTED
1390301970.025784: nl80211: Set p2p-dev-wlan1 operstate 0->0 (DORMANT)
1390301970.025786: netlink: Operstate: ifindex=0 linkmode=-1 (no change), operstate=5 (IF_OPER_DORMANT)
1390301970.025806: EAPOL: External notification - portEnabled=0
1390301970.025810: EAPOL: External notification - portValid=0
1390301970.025812: p2p-dev-wlan1: State: DISCONNECTED -> INTERFACE_DISABLED
1390301970.025818: p2p-dev-wlan1: Event INTERFACE_STATUS (5) received
1390301970.095279: nl80211: Drv Event 34 (NL80211_CMD_NEW_SCAN_RESULTS) received for p2p-dev-wlan1
1390301970.095298: p2p-dev-wlan1: nl80211: New scan results available
1390301970.095307: nl80211: Scan probed for SSID 'DIRECT-'
1390301970.095310: nl80211: Scan included frequencies: 2412 2437 2462
1390301970.095314: p2p-dev-wlan1: Ignore event SCAN_RESULTS (3) while interface is disabled
1390302004.972394: P2P: p2p_scan timeout (running=1)
1390302004.972406: P2P: Start previously requested connect with 12:68:3f:4e:39:f2
1390302004.972422: P2P: * Dialog Token: 1
1390302004.972423: P2P: * P2P IE header
1390302004.972424: P2P: * Capability dev=25 group=08
1390302004.972426: P2P: * GO Intent: Intent 7 Tie breaker 0
1390302004.972462: P2P: * Configuration Timeout: GO 255 (*10ms) client 20 (*10ms)
1390302004.972466: P2P: * Listen Channel: Regulatory Class 81 Channel 1
1390302004.972467: P2P: * Intended P2P Interface Address fc:f8:ae:69:8a:63
1390302004.972470: P2P: * Channel List - hexdump(len=19): 58 58 04 51 0b 01 02 03 04 05 06 07 08 09 0a 0b 7c 01 a1
1390302004.972477: P2P: * Device Info
1390302004.972478: P2P: * Operating Channel: Regulatory Class 124 Channel 161
1390302004.972481: WPS: * Version (hardcoded 0x10)
1390302004.972482: P2P: WPS IE Device Password ID: 4
1390302004.972485: P2P: Sending GO Negotiation Request
1390302004.972489: P2P: State IDLE -> CONNECT
1390302004.972491: P2P: Schedule new radio work for Action frame TX (listen_freq=-1 send_freq=-1)
1390302004.972496: p2p-dev-wlan1: Add radio work 'p2p-send-action'@0x1cd1ca0
1390302016.807240: p2p-dev-wlan1: Removing interface p2p-dev-wlan1
1390302016.807250: p2p-dev-wlan1: Request to deauthenticate - bssid=00:00:00:00:00:00 pending_bssid=00:00:00:00:00:00 reason=3 state=INTERFACE_DISABLED
1390302016.807306: p2p-dev-wlan1: BSS: Remove id 0 BSSID 9c:c7:a6:87:b0:f5 SSID 'Reichl&Vetter' due to wpa_bss_flush
1390302016.807332: CTRL_IFACE monitor sent successfully to /tmp/wpa_ctrl_2844-2\x00
1390302016.807341: p2p-dev-wlan1: BSS: Remove id 2 BSSID 84:1b:5e:7f:24:00 SSID 'PBG_Wlan_11ng' due to wpa_bss_flush
1390302016.807347: CTRL_IFACE monitor sent successfully to /tmp/wpa_ctrl_2844-2\x00
1390302016.807350: p2p-dev-wlan1: BSS: Remove id 3 BSSID 10:fe:ed:56:76:9c SSID 'wlan-n' due to wpa_bss_flush
1390302016.807354: CTRL_IFACE monitor sent successfully to /tmp/wpa_ctrl_2844-2\x00
1390302016.807356: p2p-dev-wlan1: BSS: Remove id 1 BSSID 20:2b:c1:4b:8f:a4 SSID 'WLAN-8FA406' due to wpa_bss_flush
1390302016.807361: CTRL_IFACE monitor sent successfully to /tmp/wpa_ctrl_2844-2\x00
1390302016.807363: p2p-dev-wlan1: Cancelling scan request
1390302016.807365: p2p-dev-wlan1: Cancelling authentication timeout
1390302016.807372: P2P: Removing pending group interface p2p-wlan1-0
1390302016.807393: nl80211: wpa_driver_nl80211_if_remove(type=5 ifname=p2p-wlan1-0) ifindex=8 added_if=0
1390302016.807395: nl80211: Remove interface ifindex=8
1390302016.893751: p2p-dev-wlan1: P2P: Disable P2P since removing the management interface is being removed
1390302016.893781: P2P: Stopping find
1390302016.893786: P2P: Clear timeout (state=CONNECT)
1390302016.893790: P2P: State CONNECT -> IDLE
1390302016.893796: P2P-DEVICE-LOST p2p_dev_addr=12:68:3f:4e:39:f2
1390302016.893830: CTRL_IFACE monitor sent successfully to /tmp/wpa_ctrl_2844-2\x00
1390302016.893838: Remove interface p2p-dev-wlan1 from radio phy1
1390302016.913679: nl80211: Remove monitor interface: refcount=0
1390302016.913687: netlink: Operstate: ifindex=0 linkmode=0 (kernel-control), operstate=6 (IF_OPER_UP)
1390302016.934618: nl80211: Stop P2P Device p2p-dev-wlan1 (0x10000000d): Success
1390302016.934631: nl80211: Unsubscribe mgmt frames handle 0x8888888889444c09 (deinit)
1390302016.947065: nl80211: Delete P2P Device p2p-dev-wlan1 (0x10000000d): Success
1390302016.947083: p2p-dev-wlan1: CTRL-EVENT-TERMINATING
1390302016.947110: CTRL_IFACE monitor sent successfully to /tmp/wpa_ctrl_2844-2\x00
1390302016.947122: wlan1: Removing interface wlan1
1390302016.947132: wlan1: Request to deauthenticate - bssid=00:00:00:00:00:00 pending_bssid=00:00:00:00:00:00 reason=3 state=DISCONNECTED
1390302016.947138: wlan1: State: DISCONNECTED -> DISCONNECTED
1390302016.947142: nl80211: Set wlan1 operstate 0->0 (DORMANT)
1390302016.947145: netlink: Operstate: ifindex=3 linkmode=-1 (no change), operstate=5 (IF_OPER_DORMANT)
1390302016.947225: EAPOL: External notification - portEnabled=0
1390302016.947236: EAPOL: External notification - portValid=0
1390302016.973857: wlan1: Cancelling scan request
1390302016.973866: wlan1: Cancelling authentication timeout
1390302016.973873: Remove interface wlan1 from radio phy1
1390302016.973875: Remove radio phy1
1390302016.973878: wlan1: Leaving started radio work 'p2p-scan'@0x1cd6a90 in the list
1390302016.973911: wlan1: Remove unstarted radio work 'p2p-send-action'@0x1cd1ca0
1390302016.993607: nl80211: Remove monitor interface: refcount=0
1390302016.993612: netlink: Operstate: ifindex=3 linkmode=0 (kernel-control), operstate=6 (IF_OPER_UP)
1390302017.028567: nl80211: Set mode ifindex 3 iftype 2 (STATION)
1390302017.028601: nl80211: Unsubscribe mgmt frames handle 0x8888888889427c79 (mode change)
1390302017.028634: wlan1: CTRL-EVENT-TERMINATING
1390302017.028651: CTRL_IFACE monitor sent successfully to /tmp/wpa_ctrl_2844-2\x00
