(PP_Mesh_POC_Local) #show ap mesh tech-support ap-name Point:ca:ef:a2 show ap mesh active Mesh Cluster Name: PeelPOC -------------------------- Name Group IP Address BSSID Band/Ch/EIRP/MaxEIRP MTU Enet Ports Mesh Role Parent #Children AP Type Uptime ---- ----- ---------- ----- -------------------- --- ---------- --------- ------ --------- ------- ------ Point:ca:ef:a2 PP_Mesh_POC_APGroup 10.2.52.21 94:b4:0f:2e:fa:31 802.11a/100E/12/28 Off/Off Point Portal:ca:cd:e0 0 275 1h:17m:29s Portal:ca:cd:e0 PP_Mesh_POC_APGroup 10.2.52.20 94:b4:0f:2c:de:11 802.11a/100E/9/29 1500 -/Off Portal - 1 277 4h:45m:50s Total APs :2 show ap mesh topology Mesh Cluster Name: PeelPOC -------------------------- Name Mesh Role Parent Path Cost Node Cost Link Cost Hop Count RSSI Rate Tx/Rx Last Update Uplink Age #Children ---- --------- ------ --------- --------- --------- --------- ---- ---------- ----------- ---------- --------- Point:ca:ef:a2 Point (AC) Portal:ca:cd:e0 1 0 0 1 54 1300/6 4m:53s 1h:16m:8s 0 Portal:ca:cd:e0 Portal (AC) - 0 1 0 0 0 - 4m:54s 4h:46m:13s 1 Total APs :2 (R): Recovery AP. (N): 11N Enabled. (AC): 11AC Enabled. For Portals 'Uplink Age' equals uptime. show ap mesh neighbors ap-name "Point:ca:ef:a2" Neighbor list ------------- MAC Portal Channel Age Hops Cost Relation Flags RSSI Rate Tx/Rx A-Req A-Resp A-Fail HT-Details Cluster ID --- ------ ------- --- ---- ---- ----------------- ----- ---- ---------- ----- ------ ------ ---------- ---------- 94:b4:0f:2c:de:11 Yes 100E 0 0 1.00 P 1h:16m:7s VLK 53 1300/1300 1 1 0 VHT-80MHz-3ss PeelPOC Total count: 1, Children: 0 Relation: P = Parent; C = Child; N = Neighbor; B = Blacklisted-neighbor Flags: R = Recovery-mode; S = Sub-threshold link; D = Reselection backoff; F = Auth-failure; H = High Throughput; V = Very High Throughput, L = Legacy allowed K = Connected; U = Upgrading; G = Descendant-upgrading; Z = Config pending; Y = Assoc-resp/Auth pending a = SAE Accepted; b = SAE Blacklisted-neighbour; e = SAE Enabled; u = portal-unreachable; o = opensystem show ap mesh debug current-cluster ap-name "Point:ca:ef:a2" Current Mesh Cluster Profile: MCP-001 ------------------------------------- Item Value ---- ----- Cluster Name PeelPOC RF Band a Encryption wpa2-psk-aes WPA Hexkey ******** WPA Passphrase ******** Priority 1 show ap mesh debug provisioned-clusters ap-name "Point:ca:ef:a2" Mesh Cluster Profile: Recovery Cluster Profile ---------------------------------------------- Item Value ---- ----- Cluster Name Recovery5SrEoQfhKVqnB/1b RF Band a Encryption wpa2-psk-aes WPA Hexkey ******** WPA Passphrase ******** Priority 16 Mesh Cluster Profile: MCP-001 ----------------------------- Item Value ---- ----- Cluster Name PeelPOC RF Band a Encryption wpa2-psk-aes WPA Hexkey ******** WPA Passphrase ******** Priority 1 show ap mesh debug counters ap-name "Point:ca:ef:a2" Mesh Packet Counters -------------------- Interface Echo Sent Echo Recv Probe Req Probe Resp Assoc Req Assoc Resp Assoc Fail Link up/down Resel. Switch Other Mgmt --------- --------- --------- --------- ---------- --------- ---------- ---------- ------------ ------ ------ ---------- Parent 0 0 0 0 0 0 0 0 - - 0 Child 4564 4555 6 0 1(1 HT) 1 (1 HT) 0 0 0 0 43586 Received Packet Statistics: Total 52751, Mgmt 43645 (dropped non-mesh 0), Data 9106 (dropped unassociated 0)HT: pns=0 ans=0 pnr=0 ars=1 arr=0 anr=1 Recovery Profile Usage Counters ------------------------------- Item Value ---- ----- Enter recovery mode 0 Exit recovery mode 0 Total connections to switch 0 Mesh loop-prevention Sequence No.:17093 Mesh timer ticks:4634 Change-record: first connection, linkdown:1h:17m:14s, linkup:1h:16m:7s, previous portal:00:00:00:00:00:00, previous parent: 00:00:00:00:00:00 Scan-summary:36:n 40:n 44:n 48:n 52:n 56:n 60:n 64:n 100:s 104:s 108:0 112:0 116:n 120:n 124:0 128:s 132:s 136:s 140:s scan-key: n:not-set,i:invalid,b:blacklisted,s:set,:probe-resp-cnt. show ap mesh debug forwarding-table ap-name "Point:ca:ef:a2" Datapath Bridge Devices ----------------------- Flags: F - source-filter, T - trusted, Q - tagged, I - IP S - split-tunnel, B - bridge, M - mesh, P - PPPoE w - Wired, b - blocked by STP Dev Name VLANs PVID ACLs FramesRx FramesTx Flags --- ------------ ----- ---- ------ -------- -------- ----- 11 br0 0 1 0/0 1 0 FIB 14 aruba001 4095 1 0/0 0 5 TQBM 15 aruba000 4095 1 0/0 13880 0 FTQBMw Datapath Bridge Table Entries ----------------------------- Flags: P - Permanent, D - Deny, R - Roamed Client, M - Mobile, X - Xsec, A - Auth, T - Trusted AP Flags: X - Awaiting 1X reply, B - Block all non-1X traffic, F - Force bridge role MAC VLAN Assigned VLAN Destination Flags Age AP Flags Bridge Role ACL ----------------- ---- ------------- ----------- ------- ---- -------- --------------- 00:0B:86:B7:3E:0F 1 1 dev15 0 0 94:B4:0F:CA:EF:A2 1 1 local P 0 0 show ap mesh debug meshd-log ap-name "Point:ca:ef:a2" [1607]1969-12-31 16:00:37.730 meshd_init: Enter, Calling DispatcherCreate [1607]1969-12-31 16:00:37.730 Calling meshd_papi_init [1607]1969-12-31 16:00:37.733 meshd_init: Exit [1607]1969-12-31 16:00:37.734 MESHD initialized [1607]1969-12-31 16:00:37.983 meshd_read_domain_profiles: profile parsed, len: 7 [1607]1969-12-31 16:00:38.357 meshd_read_domain_profiles: recovery-profile parsed, len: 24 [1607]1969-12-31 16:00:38.357 meshd_set_active_profile: using 8021X_PSK for profile PeelPOC [1607]1969-12-31 16:00:38.404 meshd_binary_wif_sysctl: programmed /proc/sys/dev/wifi0/mesh_id [1607]1969-12-31 16:00:38.404 meshd_binary_wif_sysctl: programmed /proc/sys/dev/wifi0/mesh_cmn_struct [1607]1969-12-31 16:00:38.404 meshd_config_radio: programmed tx_power 254 [1607]1969-12-31 16:00:38.405 meshd_config_radio: programmed country GB [1607]1969-12-31 16:00:38.471 meshd_config_radio: Set commit for Radio r=0 [1607]1969-12-31 16:00:38.471 meshd_config_radio: Radio 0: Programmed [1607]1969-12-31 16:00:38.720 meshd_scan_init: meshd_getchan_regtlb() gave 19 chans, mcc:16, ccode:4, cname:"GB" band:1 [1607]1969-12-31 16:00:38.720 meshd_create_vaps:1894 set channel, channel 36, offs: 0. [1607]1969-12-31 16:00:38.720 meshd_set_channel:189 change channel to 36/0 [1607]1969-12-31 16:00:38.784 meshd_dfs_channel: check DFS for channel 36 result 0 [1607]1969-12-31 16:00:38.864 meshd_create_vaps: Destroying VAP 0:1 [1607]1969-12-31 16:00:38.873 meshd_create_vaps: meshd is starting, hence no VAP existed: No such device [1607]1969-12-31 16:00:38.873 meshd_create_vaps: Creating VAP 0:1 [1607]1969-12-31 16:00:40.016 meshd_create_vaps: Destroying VAP 0:0 [1607]1969-12-31 16:00:40.026 meshd is starting, hence no VAP existed: No such device [1607]1969-12-31 16:00:40.026 Creating VAP 0:0 [1607]1969-12-31 16:00:40.030 using anul0 to capture........ [1607]1969-12-31 16:00:40.034 meshd_init_wlan_socket: M_p MAC=94:B4:0F:2E:FA:31 [1607]1969-12-31 16:00:40.034 meshd_init_wlan_socket: M_c MAC=94:B4:0F:2E:FA:30 [1607]1969-12-31 16:00:40.035 meshd_hostapd_ctrl_iface_init: Hostapd event sock /tmp/aruba001 [1607]1969-12-31 16:00:40.035 meshd_radio_init: Adding supplicant iface phy=0 [1607]1969-12-31 16:00:40.035 meshd_try_supplicantIF_add: attempt #0 [1607]1969-12-31 16:00:40.035 Cmd to supplicant: INTERFACE_ADD aruba000 /aruba/bin/mesh_psk_supplicant.conf broadcom "PeelPOC" - *** [1607]1969-12-31 16:00:40.035 meshd_supplicant_ctrl_request: Sending command: INTERFACE_ADD aruba000 /aruba/bi (len=95) [1607]1969-12-31 16:00:40.042 meshd_point_init:2983 [1607]1969-12-31 16:00:40.043 meshd_binary_wif_sysctl: programmed /proc/sys/dev/wifi0/mesh_cmn_struct [1607]1969-12-31 16:00:40.043 meshd_point_init:3010 ht capable 1 [1607]1969-12-31 16:00:40.043 meshd_point_init: m->ht.supported_mcs_set.bits: <0-23> [bits:ffffff00] [1607]1969-12-31 16:00:40.043 meshd_point_init:3050 vht capable 1 [1607]1969-12-31 16:00:40.044 meshd_sysctl_write_param: Error opening : No such file or directory [1607]1969-12-31 16:00:40.044 meshd_sysctl_write_param: Error opening : No such file or directory [1607]1969-12-31 16:00:40.044 meshd_wif_commit: commit=0 (val:<0 ¥ >) [1607]1969-12-31 16:00:40.148 meshd_wif_commit: Set commit for Radio r=0, node: /proc/sys/dev/wifi0/commit [1607]1969-12-31 16:00:40.148 meshd_wif_commit: commit=0 for node /proc/sys/dev/wifi0/commit (val:<0 ¥ >) [1607]1969-12-31 16:00:40.397 meshd_scan_init: meshd_getchan_regtlb() gave 19 chans, mcc:16, ccode:4, cname:"GB" band:1 [1607]1969-12-31 16:00:40.398 meshd_binary_wif_sysctl: programmed /proc/sys/dev/wifi0/mesh_cmn_struct [1607]1969-12-31 16:00:40.398 meshd_scan_all_channels: num_scan_channels: 19, scan_ch_index: 6, start-tick: 0. Scanning... [1607]1969-12-31 16:00:40.398 meshd_set_rssi_threshold: thresh: 12, delta: 1, max_rssi: 38 [1607]1969-12-31 16:00:40.900 meshd_binary_wif_sysctl: programmed /proc/sys/dev/wifi0/mesh_cmn_struct [1607]1969-12-31 16:00:40.900 meshd_init_ht_conf: HT=1 Band=a HT_CAP: 40MHz_allow=1 ext_off=0 sgi=1 mx_rx_mpdu=65535 mcs=0-23 chan=36, intol:0, legacy: 0 [1607]1969-12-31 16:00:40.900 meshd_init_ht_conf:1572 vht_cap 0x2 with mpdu size 0x2 [1607]1969-12-31 16:00:40.900 meshd_init_ht_conf:1588 vht_cap 0x2 with bandwidth type 80m [1607]1969-12-31 16:00:40.901 meshd_init_ht_conf:1595 vht_cap 0x12 with LDPC 0x10 [1607]1969-12-31 16:00:40.901 meshd_init_ht_conf:1615 vht_cap 0x32 with SIG_80 0x20 [1607]1969-12-31 16:00:40.901 meshd_init_ht_conf:1622 vht_cap 0x832 with SU_BEAMFMR 0x800 [1607]1969-12-31 16:00:40.901 meshd_init_ht_conf:1625 vht_cap 0x1832 with SU_BEAMFMEE 0x1000 [1607]1969-12-31 16:00:40.901 meshd_init_ht_conf:1654 vht_op supp_mcs 0xffea, vht_op_ch_freq_seg1 36 [1607]1969-12-31 16:00:40.902 meshd_set_mvap_ht_props: ht->supported_mcs_set.bits: ffffff00 [1607]1969-12-31 16:00:40.908 meshd_set_mvap_ht_props: Set VAP commit on node: /proc/sys/net/aruba000/commit [1607]1969-12-31 16:00:40.909 meshd_set_mvap_ht_props: ht->supported_mcs_set.bits: ffffff00 [1607]1969-12-31 16:00:40.911 meshd_set_mvap_ht_props: Set VAP commit on node: /proc/sys/net/aruba001/commit [1607]1969-12-31 16:00:40.911 Bringing up mesh_c VAP 0:0 ((flags:0x1002) [1607]1969-12-31 16:00:50.434 scan-summary: 36:s 40:s 44:s 48:s 52:s 56:s 60:s 64:s 100:s 104:s 108:s 112:s 116:s 120:s 124:s 128:s 132:s 136:s 140:s scan-key: n:not-set,i:invalid,b:blacklisted,s:set,:probe-resp-cnt. [1607]1969-12-31 16:00:50.435 meshd_scan_complete: candidates:0, profiles:1, recovery:FALSE, num_scans 1, disconnected-time: 10(secs) [1607]1969-12-31 16:00:51.045 meshd_timer_handler: rescan started, assoc 0, scan_active 0 [1607]1969-12-31 16:00:51.293 meshd_scan_init: meshd_getchan_regtlb() gave 19 chans, mcc:16, ccode:4, cname:"GB" band:1 [1607]1969-12-31 16:00:51.294 meshd_scan_all_channels: num_scan_channels: 19, scan_ch_index: 2, start-tick: 11. Scanning... [1607]1969-12-31 16:01:01.315 scan-summary: 36:s 40:s 44:s 48:s 52:s 56:s 60:s 64:s 100:s 104:s 108:s 112:s 116:s 120:s 124:s 128:s 132:s 136:s 140:s scan-key: n:not-set,i:invalid,b:blacklisted,s:set,:probe-resp-cnt. [1607]1969-12-31 16:01:01.315 meshd_scan_complete: candidates:0, profiles:1, recovery:FALSE, num_scans 2, disconnected-time: 10(secs) [1607]1969-12-31 16:01:02.300 meshd_timer_handler: rescan started, assoc 0, scan_active 0 [1607]1969-12-31 16:01:02.549 meshd_scan_init: meshd_getchan_regtlb() gave 19 chans, mcc:16, ccode:4, cname:"GB" band:1 [1607]1969-12-31 16:01:02.549 meshd_scan_all_channels: num_scan_channels: 19, scan_ch_index: 17, start-tick: 22. Scanning... [1607]1969-12-31 16:01:12.570 scan-summary: 36:s 40:s 44:s 48:s 52:s 56:s 60:s 64:s 100:s 104:s 108:s 112:s 116:s 120:s 124:s 128:s 132:s 136:s 140:s scan-key: n:not-set,i:invalid,b:blacklisted,s:set,:probe-resp-cnt. [1607]1969-12-31 16:01:12.570 meshd_scan_complete: candidates:0, profiles:1, recovery:FALSE, num_scans 3, disconnected-time: 21(secs) [1607]1969-12-31 16:01:13.556 meshd_timer_handler: rescan started, assoc 0, scan_active 0 [1607]1969-12-31 16:01:13.804 meshd_scan_init: meshd_getchan_regtlb() gave 19 chans, mcc:16, ccode:4, cname:"GB" band:1 [1607]1969-12-31 16:01:13.805 meshd_scan_all_channels: num_scan_channels: 19, scan_ch_index: 14, start-tick: 33. Scanning... [1607]1969-12-31 16:01:23.825 scan-summary: 36:s 40:s 44:s 48:s 52:s 56:s 60:s 64:s 100:s 104:s 108:s 112:s 116:s 120:s 124:s 128:s 132:s 136:s 140:s scan-key: n:not-set,i:invalid,b:blacklisted,s:set,:probe-resp-cnt. [1607]1969-12-31 16:01:23.825 meshd_scan_complete: candidates:0, profiles:1, recovery:FALSE, num_scans 4, disconnected-time: 32(secs) [1607]1969-12-31 16:01:24.811 meshd_timer_handler: rescan started, assoc 0, scan_active 0 [1607]1969-12-31 16:01:25.060 meshd_scan_init: meshd_getchan_regtlb() gave 19 chans, mcc:16, ccode:4, cname:"GB" band:1 [1607]1969-12-31 16:01:25.060 meshd_scan_all_channels: num_scan_channels: 19, scan_ch_index: 18, start-tick: 44. Scanning... [1607]1969-12-31 16:01:35.081 scan-summary: 36:s 40:s 44:s 48:s 52:s 56:s 60:s 64:s 100:s 104:s 108:s 112:s 116:s 120:s 124:s 128:s 132:s 136:s 140:s scan-key: n:not-set,i:invalid,b:blacklisted,s:set,:probe-resp-cnt. [1607]1969-12-31 16:01:35.081 meshd_scan_complete: candidates:0, profiles:1, recovery:FALSE, num_scans 5, disconnected-time: 43(secs) [1607]1969-12-31 16:01:36.067 meshd_timer_handler: rescan started, assoc 0, scan_active 0 [1607]1969-12-31 16:01:36.316 meshd_scan_init: meshd_getchan_regtlb() gave 19 chans, mcc:16, ccode:4, cname:"GB" band:1 [1607]1969-12-31 16:01:36.316 meshd_scan_all_channels: num_scan_channels: 19, scan_ch_index: 14, start-tick: 55. Scanning... [1607]1969-12-31 16:01:46.336 scan-summary: 36:s 40:s 44:s 48:s 52:s 56:s 60:s 64:s 100:s 104:s 108:s 112:s 116:0 120:0 124:s 128:s 132:s 136:s 140:s scan-key: n:not-set,i:invalid,b:blacklisted,s:set,:probe-resp-cnt. [1607]1969-12-31 16:01:46.336 meshd_set_link_cost: Using forward RSSI for mac: 94:b4:0f:2c:de:11, fwd-rssi: 52, rev-rssi: 0. (max_rssi: 38), link-cost(cH):0 [1607]1969-12-31 16:01:46.336 meshd_path_cost_compare: initialise first time to 94:b4:0f:2c:de:11, path-cost(cH): 100 [1607]1969-12-31 16:01:46.336 meshd_scan_complete:427 set channel, chan: 116, offs: 4. [1607]1969-12-31 16:01:46.337 meshd_set_channel:189 change channel to 116/4 [1607]1969-12-31 16:01:46.410 meshd_dfs_channel: check DFS for channel 116 result 1 [1607]1969-12-31 16:01:46.410 meshd_set_channel: set to dfs channel 116/4, start cac [1607]1969-12-31 16:01:46.410 meshd_scan_complete: selected potential parent 94:b4:0f:2c:de:11 in profile 0 on ch 116(offs=4), hop_count 0 [1607]1969-12-31 16:01:46.411 meshd_overlay_ht: ldpc:1, 20-sgi:1, 40-sgi:1, mcs:ffffff00, src-mcs:ffffff00 [1607]1969-12-31 16:01:46.411 meshd_overlay_vht vht aft overlay: ldpc:1, 80-sgi:1, 160-sgi:0, 160 allow:0, 8080 allow:0, txbf 1, mcs_map 0xffea [1607]1969-12-31 16:01:46.411 meshd_set_mvap_ht_props: ht->supported_mcs_set.bits: ffffff00 [1607]1969-12-31 16:01:46.414 meshd_set_mvap_ht_props: Set VAP commit on node: /proc/sys/net/aruba000/commit [1607]1969-12-31 16:01:46.414 meshd_scan_complete: Using Active profile PeelPOC [1607]1969-12-31 16:01:46.414 meshd_scan_complete: candidates:1, profiles:1, recovery:FALSE, num_scans 6, disconnected-time: 54(secs) [1607]1969-12-31 16:01:47.321 meshd_connection_check: authentication pending to 94:b4:0f:2c:de:11! [1607]1969-12-31 16:01:47.321 meshd_initiate_sae: SAE disabled, just try associating [1607]1969-12-31 16:01:48.322 meshd_binary_wif_sysctl: programmed /proc/sys/dev/wifi0/mesh_cmn_struct [1607]1969-12-31 16:01:48.323 meshd_dfs_channel: check DFS for channel 116 result 1 [1607]1969-12-31 16:01:48.323 meshd_send_assoc_request: Sent assoc req to 94:b4:0f:2c:de:11. HT=1 [1607]1969-12-31 16:01:48.393 Received assoc response from 94:b4:0f:2c:de:11 [1607]1969-12-31 16:01:48.393 meshd_handle_assoc_resp: received assoc_resp from 94:b4:0f:2c:de:11 with status SUCCESS [1607]1969-12-31 16:01:48.393 meshd_write_lms_ip: MP set LMS to that of parent: 10.100.41.2 [1607]1969-12-31 16:01:48.394 meshd_write_lms_ip: MP set master to LMS of parent: 10.100.41.2 [1607]1969-12-31 16:01:48.394 meshd_set_rmp_mpv_to_asap: programmed mpv 0 [1607]1969-12-31 16:01:48.394 meshd_handle_assoc_resp: success, turning off assoc_flag, lms 10.100.41.2 [1607]1969-12-31 16:01:48.394 meshd_overlay_ht: ldpc:1, 20-sgi:1, 40-sgi:1, mcs:ffffff00, src-mcs:ffffff00 [1607]1969-12-31 16:01:48.394 meshd_overlay_vht vht aft overlay: ldpc:1, 80-sgi:1, 160-sgi:0, 160 allow:0, 8080 allow:0, txbf 1, mcs_map 0xffea [1607]1969-12-31 16:01:48.395 meshd_set_mvap_ht_props: ht->supported_mcs_set.bits: ffffff00 [1607]1969-12-31 16:01:48.396 meshd_set_mvap_ht_props: Set VAP commit on node: /proc/sys/net/aruba000/commit [1607]1969-12-31 16:01:48.396 meshd_handle_assoc_resp:969 set channel, chan: 116, offs: 4. [1607]1969-12-31 16:01:48.397 meshd_set_channel:189 change channel to 116/4 [1607]1969-12-31 16:01:48.397 meshd_set_channel: cac running, stop cac [1607]1969-12-31 16:01:48.398 meshd_dfs_channel: check DFS for channel 116 result 1 [1607]1969-12-31 16:01:48.398 meshd_set_channel: set to dfs channel 116/4, start cac [1607]1969-12-31 16:01:48.398 meshd_supplicant_associate_inform: potential_parent.auth_pending set. [1607]1969-12-31 16:01:48.398 meshd_supplicant_ctrl_request: Sending command: ASSOCIATED 7 PeelPOC 94:b4:0f:2c (len=91) [1607]1969-12-31 16:01:48.409 meshd_read_syncsocket_cmd: MESHD_WPA_SUPPLICANT_SUCCESS [1607]1969-12-31 16:01:48.409 meshd_supplicant_auth_success: recv [1607]1969-12-31 16:01:48.409 meshd_set_parent: set parent <94:b4:0f:2c:de:11> [1607]1969-12-31 16:01:48.411 meshd_binary_wif_sysctl: programmed /proc/sys/dev/wifi0/mesh_portal_id [1607]1969-12-31 16:01:48.411 meshd_set_hop_count: pc-update, hop count changed: old: 0, new: 1, subtree_weight: 0 [1607]1969-12-31 16:01:48.412 meshd_set_node_cost: set node-cost to 255, hop_count 1, child_wt: 0, algo: 0, portal_reachability 0 [1607]1969-12-31 16:01:48.412 meshd_child_change: m->subtree_weight 0, subtree_delta 0 [1607]1969-12-31 16:01:48.412 meshd_binary_wif_sysctl: programmed /proc/sys/dev/wifi0/mesh_mbits [1607]1969-12-31 16:01:48.413 meshd_set_node_cost: set node-cost to 0, hop_count 1, child_wt: 0, algo: 0, portal_reachability 1 [1607]1969-12-31 16:01:48.413 meshd_set_link_cost: Using forward RSSI for mac: 94:b4:0f:2c:de:11, fwd-rssi: 51, rev-rssi: 0. (max_rssi: 38), link-cost(cH):0 [1607]1969-12-31 16:01:48.413 meshd_update_path_cost: updated path cost (cH) to 100, sysctl-pc to 1 (from 65535) [1607]1969-12-31 16:01:48.414 meshd_binary_wif_sysctl: programmed /proc/sys/dev/wifi0/mesh_cmn_struct [1607]1969-12-31 16:01:48.414 meshd_set_portal_reachability: Called from mesh_linkup():1320. Reachability set to 1 [1607]1969-12-31 16:01:48.414 meshd_binary_wif_sysctl: programmed /proc/sys/dev/wifi0/mesh_cmn_struct [1607]1969-12-31 16:01:48.415 meshd_send_notification_to_sapd: caller: mesh_linkup():1332, notif: 1, sapd-port: 8223 [1607]1969-12-31 16:01:48.415 meshd_send_notification_to_sapd: index=0, channel=1140 [1607]1969-12-31 16:01:48.415 Sending meshd parent linkup notice to sapd (parent: 94:b4:0f:2c:de:11) [1607]1969-12-31 16:02:20.249 meshd_handle_sap_goodparent: Connected 1, mstate:5 (Resp-pending:67) [1607]1969-12-31 16:02:20.249 meshd_mesh_p_vap_up: Role: Mesh Point, Radio: 0 [1607]1969-12-31 16:02:20.250 meshd_init_ht_conf: HT=1 Band=a HT_CAP: 40MHz_allow=1 ext_off=4 sgi=1 mx_rx_mpdu=65535 mcs=0-23 chan=116, intol:0, legacy: 0 [1607]1969-12-31 16:02:20.250 meshd_init_ht_conf:1572 vht_cap 0x2 with mpdu size 0x2 [1607]1969-12-31 16:02:20.250 meshd_init_ht_conf:1588 vht_cap 0x2 with bandwidth type 80m [1607]1969-12-31 16:02:20.250 meshd_init_ht_conf:1595 vht_cap 0x12 with LDPC 0x10 [1607]1969-12-31 16:02:20.250 meshd_init_ht_conf:1615 vht_cap 0x32 with SIG_80 0x20 [1607]1969-12-31 16:02:20.250 meshd_init_ht_conf:1622 vht_cap 0x832 with SU_BEAMFMR 0x800 [1607]1969-12-31 16:02:20.250 meshd_init_ht_conf:1625 vht_cap 0x1832 with SU_BEAMFMEE 0x1000 [1607]1969-12-31 16:02:20.250 meshd_init_ht_conf:1654 vht_op supp_mcs 0xffea, vht_op_ch_freq_seg1 116 [1607]1969-12-31 16:02:20.251 meshd_set_mvap_ht_props: ht->supported_mcs_set.bits: ffffff00 [1607]2015-09-25 11:47:16.859 meshd_set_mvap_ht_props: Set VAP commit on node: /proc/sys/net/aruba000/commit [1607]2015-09-25 11:47:16.860 meshd_set_mvap_ht_props: ht->supported_mcs_set.bits: ffffff00 [1607]2015-09-25 11:47:16.861 meshd_set_mvap_ht_props: Set VAP commit on node: /proc/sys/net/aruba001/commit [1607]2015-09-25 11:47:16.862 meshd_binary_wif_sysctl: programmed /proc/sys/dev/wifi0/mesh_portal_id [1607]2015-09-25 11:47:16.864 meshd_set_link_cost: Using forward RSSI for mac: 94:b4:0f:2c:de:11, fwd-rssi: 51, rev-rssi: 0. (max_rssi: 38), link-cost(cH):0 [1607]2015-09-25 11:47:16.864 Bringing up mesh_p VAP 0:1 [1607]2015-09-25 11:47:16.864 Syncing up with hostapd [1607]2015-09-25 11:47:16.864 Sending cmd to hostapd:CONFIG /- - - Recovery5SrEoQfhKVqnB/1b *** *** [1607]2015-09-25 11:47:16.865 meshd_hostapd_recv: recv-err:Success [1607]2015-09-25 11:47:16.866 meshd_binary_wif_sysctl: programmed /proc/sys/dev/wifi0/mesh_cmn_struct [1607]2015-09-25 11:47:16.866 meshd_start_interface: MP switch on bond0 interface as MP got the configuration [1607]2015-09-25 11:47:16.866 meshd_start_interface: MP switch on eth1 interface as MP got the configuration [1607]2015-09-25 11:47:16.867 meshd_state_transition: set shortest_uplink_hc, old: 0, new: 1 [1607]2015-09-25 11:47:16.867 meshd_cac_handler: clr timer of CAC [1607]2015-09-25 11:47:17.757 Received config for logging 1 [1607]2015-09-25 11:47:17.758 Received config for logging 2 [1607]2015-09-25 11:47:19.868 meshd_send_topology_update: parent 94:b4:0f:2c:de:11, portal 94:b4:0f:2c:de:11, chan 116, offset 4, tx_rate 1300, rx_rate 1300, uptime 35 [1607]2015-09-25 11:47:21.451 Received signal from sapd meshd_handle_config_ht_params 679 [1607]2015-09-25 11:47:21.451 meshd_handle_config_ht_params:755 HT-params enb=1 40m=1 sgi40=1 sgi20=1, mpdu=1 max_rx=65536 max_tx=65535, min_start_spc 5 mcs_str=0-23 legacy=1, ext_off=4 [1607]2015-09-25 11:47:21.451 meshd_handle_config_ht_params:755 txbf 0 compressed_steering 0, noncompressed_steering 0, delayed_feedback 0, immediate_feedback 0, sounding_intvl 0 [1607]2015-09-25 11:47:21.451 meshd_handle_config_ht_params:755 VHT-params enb=1 80m=1 sgi80=1 txbf=1 txbf_sounding=25 mcs_map=0xffea mpdu_size=2, amsdu_count=2,2,2,0 [1607]2015-09-25 11:47:21.452 meshd_binary_wif_sysctl: programmed /proc/sys/dev/wifi0/mesh_cmn_struct [1607]2015-09-25 11:47:21.452 meshd_init_ht_conf: HT=1 Band=a HT_CAP: 40MHz_allow=1 ext_off=4 sgi=1 mx_rx_mpdu=65536 mcs=0-23 chan=116, intol:0, legacy: 1 [1607]2015-09-25 11:47:21.453 meshd_init_ht_conf:1572 vht_cap 0x2 with mpdu size 0x2 [1607]2015-09-25 11:47:21.453 meshd_init_ht_conf:1588 vht_cap 0x2 with bandwidth type 80m [1607]2015-09-25 11:47:21.453 meshd_init_ht_conf:1595 vht_cap 0x12 with LDPC 0x10 [1607]2015-09-25 11:47:21.453 meshd_init_ht_conf:1615 vht_cap 0x32 with SIG_80 0x20 [1607]2015-09-25 11:47:21.453 meshd_init_ht_conf:1622 vht_cap 0x832 with SU_BEAMFMR 0x800 [1607]2015-09-25 11:47:21.453 meshd_init_ht_conf:1625 vht_cap 0x1832 with SU_BEAMFMEE 0x1000 [1607]2015-09-25 11:47:21.453 meshd_init_ht_conf:1654 vht_op supp_mcs 0xffea, vht_op_ch_freq_seg1 116 [1607]2015-09-25 11:47:21.454 meshd_set_mvap_ht_props: ht->supported_mcs_set.bits: ffffff00 [1607]2015-09-25 11:47:21.456 meshd_set_mvap_ht_props: Set VAP commit on node: /proc/sys/net/aruba001/commit [1607]2015-09-25 11:47:21.466 meshd_set_cfg_params: Setting max_children 64, max_hop_count 8, heartbeat_threshold: 10 MPV: 0 vlans=1-4094 [1607]2015-09-25 11:47:21.466 Received signal from sapd meshd_handle_config_rcvd 1016 [1607]2015-09-25 11:47:21.466 meshd_mesh_p_vap_up: meshp-vap already up - no-op. [1607]2015-09-25 11:47:21.466 meshd_metric_cfg: thresh: 12, mode: 2, algorithm: 0 [1607]2015-09-25 11:47:21.784 Received signal from sapd meshd_handle_config_rcvd 1016 [1607]2015-09-25 11:47:21.784 meshd_mesh_p_vap_up: meshp-vap already up - no-op. [1607]2015-09-25 11:47:22.969 Receive update cninfo [1607]2015-09-25 11:47:22.969 meshd_handle_config_cninfo, A band, get 11 outdoor channel 100 104 108 112 116 120 124 128 132 136 140 [1607]2015-09-25 11:47:22.969 meshd_handle_config_cninfo, G band, get 13 outdoor channel 1 2 3 4 5 6 7 8 9 10 11 12 13 [1607]2015-09-25 11:47:25.851 meshd_send_topology_update: parent 94:b4:0f:2c:de:11, portal 94:b4:0f:2c:de:11, chan 116, offset 4, tx_rate 6, rx_rate 6, uptime 40 [1607]2015-09-25 11:47:47.854 meshd_metric_start_reselect: found ZERO reselection candidates for domain PeelPOC, channel 116 [1607]2015-09-25 11:47:47.854 meshd_metric_cancel_reselect: cancelled [1607]2015-09-25 11:48:18.860 meshd_metric_start_reselect: found ZERO reselection candidates for domain PeelPOC, channel 116 [1607]2015-09-25 11:48:18.860 meshd_metric_cancel_reselect: cancelled [1607]2015-09-25 11:52:42.898 meshd_timer_handler: topo_adjust_scan, uplink-age: 357, tick: 424, scan-ival: 230 [1607]2015-09-25 11:52:43.148 meshd_scan_init: meshd_getchan_regtlb() gave 19 chans, mcc:16, ccode:4, cname:"GB" band:1 [1607]2015-09-25 11:52:43.149 meshd_binary_wif_sysctl: programmed /proc/sys/dev/wifi0/mesh_cmn_struct [1607]2015-09-25 11:52:43.149 meshd_scan_all_channels: num_scan_channels: 19, scan_ch_index: 10, start-tick: 424. Scanning... [1607]2015-09-25 11:52:43.149 meshd_timer_handler: echo not sent to parent 94:b4:0f:2c:de:11. Reach:1, scan:1, connect-pend:0 [1607]2015-09-25 11:52:43.840 meshd_scan_timer_handler: topo-scan, not scanning our parent's channel 116 [1607]2015-09-25 11:52:44.150 meshd_timer_handler: echo not sent to parent 94:b4:0f:2c:de:11. Reach:1, scan:1, connect-pend:0 [1607]2015-09-25 11:52:45.150 meshd_timer_handler: echo not sent to parent 94:b4:0f:2c:de:11. Reach:1, scan:1, connect-pend:0 [1607]2015-09-25 11:52:45.226 meshd_scan_timer_handler: not scanning as channel 36 is indoor [1607]2015-09-25 11:52:45.227 meshd_scan_timer_handler: not scanning as channel 40 is indoor [1607]2015-09-25 11:52:45.227 meshd_scan_timer_handler: not scanning as channel 44 is indoor [1607]2015-09-25 11:52:45.227 meshd_scan_timer_handler: not scanning as channel 48 is indoor [1607]2015-09-25 11:52:45.227 meshd_scan_timer_handler: not scanning as channel 52 is indoor [1607]2015-09-25 11:52:45.227 meshd_scan_timer_handler: not scanning as channel 56 is indoor [1607]2015-09-25 11:52:45.227 meshd_scan_timer_handler: not scanning as channel 60 is indoor [1607]2015-09-25 11:52:45.227 meshd_scan_timer_handler: not scanning as channel 64 is indoor [1607]2015-09-25 11:52:45.924 scan-summary: 36:n 40:n 44:n 48:n 52:n 56:n 60:n 64:n 100:s 104:s 108:0 112:0 116:n 120:n 124:0 128:s 132:s 136:s 140:s scan-key: n:not-set,i:invalid,b:blacklisted,s:set,:probe-resp-cnt. [1607]2015-09-25 11:52:45.924 meshd_set_link_cost: Using forward RSSI for mac: 94:b4:0f:2c:de:11, fwd-rssi: 51, rev-rssi: 0. (max_rssi: 38), link-cost(cH):0 [1607]2015-09-25 11:52:45.924 meshd_path_cost_compare: initialise first time to 94:b4:0f:2c:de:11, path-cost(cH): 100 [1607]2015-09-25 11:52:45.925 meshd_binary_wif_sysctl: programmed /proc/sys/dev/wifi0/mesh_cmn_struct [1607]2015-09-25 11:52:45.925 meshd_start_interface: MP switch on bond0 interface as MP got the configuration [1607]2015-09-25 11:52:45.925 meshd_start_interface: MP switch on eth1 interface as MP got the configuration [1607]2015-09-25 11:52:45.925 meshd_scan_complete: topo-scan retained current parent, channel 116, offset: 4, connected:1 [1607]2015-09-25 11:57:27.199 meshd_send_topology_update: parent 94:b4:0f:2c:de:11, portal 94:b4:0f:2c:de:11, chan 116, offset 4, tx_rate 6, rx_rate 1300, uptime 641 [1607]2015-09-25 12:07:15.048 meshd_set_link_cost: Using forward RSSI for mac: 94:b4:0f:2c:de:11, fwd-rssi: 51, rev-rssi: 0. (max_rssi: 38), link-cost(cH):0 [1607]2015-09-25 12:07:15.049 meshd_show_neighbors: skip parent 94:b4:0f:2c:de:11 in potential list [1607]2015-09-25 12:07:28.293 meshd_send_topology_update: parent 94:b4:0f:2c:de:11, portal 94:b4:0f:2c:de:11, chan 116, offset 4, tx_rate 6, rx_rate 1300, uptime 1242 [1607]2015-09-25 12:12:35.665 meshd_set_link_cost: Using forward RSSI for mac: 94:b4:0f:2c:de:11, fwd-rssi: 51, rev-rssi: 0. (max_rssi: 38), link-cost(cH):0 [1607]2015-09-25 12:12:35.666 meshd_show_neighbors: skip parent 94:b4:0f:2c:de:11 in potential list [1607]2015-09-25 12:17:29.394 meshd_send_topology_update: parent 94:b4:0f:2c:de:11, portal 94:b4:0f:2c:de:11, chan 116, offset 4, tx_rate 1300, rx_rate 6, uptime 1843 [1607]2015-09-25 12:27:30.499 meshd_send_topology_update: parent 94:b4:0f:2c:de:11, portal 94:b4:0f:2c:de:11, chan 116, offset 4, tx_rate 6, rx_rate 6, uptime 2444 [1607]2015-09-25 12:37:31.602 meshd_send_topology_update: parent 94:b4:0f:2c:de:11, portal 94:b4:0f:2c:de:11, chan 116, offset 4, tx_rate 780, rx_rate 975, uptime 3045 [1607]2015-09-25 12:37:54.148 Non-local action frame from 94:b4:0f:2c:de:11 (mc:94:b4:0f:2c:de:11)- ignored [1607]2015-09-25 12:37:54.390 meshd_find_aruba_mesh_elem:1207 beacon has csa ie: mode 0, chan 100, count 4 [1607]2015-09-25 12:37:54.390 meshd_find_aruba_mesh_elem:1221 beacon has ext csa ie: mode 0, chan 100, count 4 [1607]2015-09-25 12:37:54.390 meshd_find_aruba_mesh_elem:1213 beacon has sec choff ie: htoffs 1 [1607]2015-09-25 12:37:54.390 meshd_find_aruba_mesh_elem:1231 beacon has bw csa wrapper ie: chwidth 1 [1607]2015-09-25 12:37:54.391 meshd_read_wlan_packet: CSA from 94:b4:0f:2c:de:11, bssid: 94:b4:0f:2c:de:11. id:37, mode: 0, chan: 100, count: 4, offs: 4, delay: 1940 msecs [1607]2015-09-25 12:37:56.331 meshd_csa_handler: CSA timer expired - set to csa channel 100 (was 116), offset: 4 (was 4) [1607]2015-09-25 12:37:56.331 meshd_csa_handler:1942 set channel, chan: 100, offs: 4. [1607]2015-09-25 12:37:56.332 meshd_set_channel:189 change channel to 100/4 [1607]2015-09-25 12:37:56.334 meshd_dfs_channel: check DFS for channel 100 result 1 [1607]2015-09-25 12:37:56.334 meshd_set_channel: set to dfs channel 100/4, start cac [1607]2015-09-25 12:37:56.334 meshd_send_notification_to_sapd: caller: meshd_channel_notify_sap():1449, notif: 21318, sapd-port: 8223 [1607]2015-09-25 12:37:56.334 meshd_send_notification_to_sapd: channel-change 1124 [1607]2015-09-25 12:37:56.334 meshd_csa_handler: CSA dest. channel is DFS - set timer to wait for CAC done. [1607]2015-09-25 12:37:56.335 meshd_csa_handler: cac_running, stop it first [1607]2015-09-25 12:37:56.335 meshd_csa_handler: chg to dfs channel 100/4, start cac [1607]2015-09-25 12:37:59.611 meshd_send_topology_update: parent 94:b4:0f:2c:de:11, portal 94:b4:0f:2c:de:11, chan 100, offset 4, tx_rate 6, rx_rate 975, uptime 3073 [1607]2015-09-25 12:38:56.335 meshd_cac_handler: clr timer of CAC [1607]2015-09-25 12:48:00.750 meshd_send_topology_update: parent 94:b4:0f:2c:de:11, portal 94:b4:0f:2c:de:11, chan 100, offset 4, tx_rate 6, rx_rate 1300, uptime 3674 [1607]2015-09-25 12:58:01.852 meshd_send_topology_update: parent 94:b4:0f:2c:de:11, portal 94:b4:0f:2c:de:11, chan 100, offset 4, tx_rate 1300, rx_rate 6, uptime 4275 [1607]2015-09-25 13:02:54.200 meshd_set_link_cost: Using forward RSSI for mac: 94:b4:0f:2c:de:11, fwd-rssi: 53, rev-rssi: 0. (max_rssi: 38), link-cost(cH):0 [1607]2015-09-25 13:02:54.200 meshd_show_neighbors: skip parent 94:b4:0f:2c:de:11 in potential list show ap mesh debug hostapd-log ap-name "Point:ca:ef:a2" [1608]1969-12-31 16:00:37.921: wait_for_meshd [1608]2015-09-25 11:47:16.864: Got CONFIG : i=aruba001 s=PeelPOC [1608]2015-09-25 11:47:16.870: aruba001: IEEE 802.11 Fetching hardware channel/rate support not supported. [1608]2015-09-25 11:47:16.871: Flushing old station entries [1608]2015-09-25 11:47:16.871: Deauthenticate all stations [1608]2015-09-25 11:47:16.871: Preserving Recovery PSK.Generating PSK from Passphrase [1608]2015-09-25 11:47:16.871: SSID - hexdump_ascii(len=7): 50 65 65 6c 50 4f 43 PeelPOC [1608]2015-09-25 11:47:16.871: PSK (ASCII passphrase) - hexdump_ascii(len=13): 70 33 33 6c 70 30 72 74 35 6b 33 79 21 p33lp0rt5k3y! [1608]2015-09-25 11:47:17.080: PSK (from passphrase) - hexdump(len=32): 4c f5 ef e8 f9 d2 8e 06 82 aa c7 c6 98 2f 7c c6 10 2b e8 27 59 8d b8 b3 06 85 73 ba e3 28 85 b1 [1608]2015-09-25 11:47:17.081: WPA: group state machine entering state GTK_INIT (VLAN-ID 0) [1608]2015-09-25 11:47:17.081: GMK - hexdump(len=32): [REMOVED] [1608]2015-09-25 11:47:17.081: GTK - hexdump(len=16): [REMOVED] [1608]2015-09-25 11:47:17.081: WPA: group state machine entering state SETKEYSDONE (VLAN-ID 0) [1608]2015-09-25 11:47:17.081: Using existing control interface directory. [1608]2015-09-25 11:47:17.082: aruba001: Setup of interface done. [1608]2015-09-25 11:47:21.760: l2_packet_receive: anul0 [1608]2015-09-25 11:47:28.730: l2_packet_receive: anul0 [1608]2015-09-25 11:50:16.941: l2_packet_receive: anul0 [1608]2015-09-25 11:51:51.431: l2_packet_receive: anul0 [1608]2015-09-25 11:53:26.862: l2_packet_receive: anul0 [1608]2015-09-25 11:55:26.914: l2_packet_receive: anul0 [1608]2015-09-25 11:57:14.138: l2_packet_receive: anul0 [1608]2015-09-25 11:58:20.801: l2_packet_receive: anul0 [1608]2015-09-25 11:59:23.362: l2_packet_receive: anul0 [1608]2015-09-25 12:00:57.020: l2_packet_receive: anul0 [1608]2015-09-25 12:01:59.619: l2_packet_receive: anul0 [1608]2015-09-25 12:03:27.036: l2_packet_receive: anul0 [1608]2015-09-25 12:05:07.318: l2_packet_receive: anul0 [1608]2015-09-25 12:06:59.189: l2_packet_receive: anul0 [1608]2015-09-25 12:09:17.955: l2_packet_receive: anul0 [1608]2015-09-25 12:10:51.653: l2_packet_receive: anul0 [1608]2015-09-25 12:12:39.181: l2_packet_receive: anul0 [1608]2015-09-25 12:14:27.192: l2_packet_receive: anul0 [1608]2015-09-25 12:15:34.379: l2_packet_receive: anul0 [1608]2015-09-25 12:16:36.946: l2_packet_receive: anul0 [1608]2015-09-25 12:18:42.112: l2_packet_receive: anul0 [1608]2015-09-25 12:19:44.689: l2_packet_receive: anul0 [1608]2015-09-25 12:21:18.693: l2_packet_receive: anul0 [1608]2015-09-25 12:22:21.259: l2_packet_receive: anul0 [1608]2015-09-25 12:23:23.825: l2_packet_receive: anul0 [1608]2015-09-25 12:24:26.390: l2_packet_receive: anul0 [1608]2015-09-25 12:26:00.096: l2_packet_receive: anul0 [1608]2015-09-25 12:28:36.663: l2_packet_receive: anul0 [1608]2015-09-25 12:29:39.233: l2_packet_receive: anul0 [1608]2015-09-25 12:30:41.792: l2_packet_receive: anul0 [1608]2015-09-25 12:33:18.391: l2_packet_receive: anul0 [1608]2015-09-25 12:35:37.595: l2_packet_receive: anul0 [1608]2015-09-25 12:37:10.696: l2_packet_receive: anul0 [1608]2015-09-25 12:40:27.684: l2_packet_receive: anul0 [1608]2015-09-25 12:41:17.903: l2_packet_receive: anul0 [1608]2015-09-25 12:43:12.667: l2_packet_receive: anul0 [1608]2015-09-25 12:44:46.669: l2_packet_receive: anul0 [1608]2015-09-25 12:46:27.721: l2_packet_receive: anul0 [1608]2015-09-25 12:48:56.941: l2_packet_receive: anul0 [1608]2015-09-25 12:51:02.100: l2_packet_receive: anul0 [1608]2015-09-25 12:53:07.222: l2_packet_receive: anul0 [1608]2015-09-25 12:55:50.838: l2_packet_receive: anul0 [1608]2015-09-25 12:57:17.804: l2_packet_receive: anul0 [1608]2015-09-25 12:58:40.461: l2_packet_receive: anul0 [1608]2015-09-25 13:00:25.538: l2_packet_receive: anul0 [1608]2015-09-25 13:01:28.035: l2_packet_receive: anul0 (PP_Mesh_POC_Local) #