Solved: 9800-CL Sonos can't associate

Tenere · ‎09-07-2022

Hello out there,

after setting up a 9800-CL with 9120AXI in my homelab I stumbled across some problems: Sonos devices can't associate with the APs.

The Radioactive Trace shows the following messages:

2022/09/07 09:11:07.556506341 {wncd_x_R0-0}{1}: [client-orch-sm] [14949]: (note): MAC: 949f.0fe3.3c64 HREAP Fault tolerance payload received BSSID 5ce1.76d7.0be2, WLAN Homeoffice, slot 0 AP 5ce1.7d67.0be0 AP6C41.BCE0.AF00, AID 4WlanId: 5
2022/09/07 09:11:07.556513168 {wncd_x_R0-0}{1}: [client-orch-state] [14949]: (note): MAC: 949f.0fe3.3c64 Client state transition: S_CO_INIT -> S_CO_ASSOCIATING
2022/09/07 09:11:07.556655613 {wncd_x_R0-0}{1}: [client-orch-state] [14949]: (note): MAC: 949f.0fe3.3c64 Client state transition: S_CO_ASSOCIATING -> S_CO_CREATE_SM_SESSION_IN_PROGRESS
2022/09/07 09:11:07.557453829 {wncd_x_R0-0}{1}: [ewlc-infra-evq] [14949]: (note): Authentication Success. Resolved Policy bitmap:11 for client 949f.0fe3.3c64 
2022/09/07 09:11:07.557570753 {wncd_x_R0-0}{1}: [client-orch-sm] [14949]: (note): MAC: 949f.0fe3.3c64 Mobility discovery triggered. Client mode: Flex - Local Switching
2022/09/07 09:11:07.557573798 {wncd_x_R0-0}{1}: [client-orch-state] [14949]: (note): MAC: 949f.0fe3.3c64 Client state transition: S_CO_CREATE_SM_SESSION_IN_PROGRESS -> S_CO_MOBILITY_DISCOVERY_IN_PROGRESS
2022/09/07 09:11:07.590779526 {wncd_x_R0-0}{1}: [mm-client] [14949]: (note): MAC: 949f.0fe3.3c64 Mobility Successful. Roam Type None, Sub Roam Type MM_SUB_ROAM_TYPE_NONE, Client IFID: 0xa0000004, Client Role: Local PoA: 0x90000004 PoP: 0x0
2022/09/07 09:11:07.590803670 {wncd_x_R0-0}{1}: [client-orch-state] [14949]: (note): MAC: 949f.0fe3.3c64 Client state transition: S_CO_MOBILITY_DISCOVERY_IN_PROGRESS -> S_CO_DPATH_PLUMB_IN_PROGRESS
2022/09/07 09:11:07.590810042 {wncd_x_R0-0}{1}: [dot11] [14949]: (note): MAC: 949f.0fe3.3c64 Client datapath entry params - ssid:homeoffice,slot_id:0 bssid ifid: 0x0, radio_ifid: 0x90000003, wlan_ifid: 0xf0400005
2022/09/07 09:11:07.590883878 {wncd_x_R0-0}{1}: [dpath_svc] [14949]: (note): MAC: 949f.0fe3.3c64 Client datapath entry created for ifid 0xa0000004
2022/09/07 09:11:07.590995531 {wncd_x_R0-0}{1}: [client-iplearn] [14949]: (note): MAC: 949f.0fe3.3c64 Client IP learn successful. Method: IP Snooping IP: 192.168.178.90
2022/09/07 09:11:07.591098449 {wncd_x_R0-0}{1}: [client-orch-state] [14949]: (note): MAC: 949f.0fe3.3c64 Client state transition: S_CO_DPATH_PLUMB_IN_PROGRESS -> S_CO_IP_LEARN_IN_PROGRESS
2022/09/07 09:11:07.591320018 {wncd_x_R0-0}{1}: [client-orch-state] [14949]: (note): MAC: 949f.0fe3.3c64 Client state transition: S_CO_IP_LEARN_IN_PROGRESS -> S_CO_RUN
2022/09/07 09:11:11.526635247 {wncd_x_R0-0}{1}: [client-orch-sm] [14949]: (note): MAC: 949f.0fe3.3c64 Association received. BSSID 5ce1.76d7.0be2, old BSSID 5ce1.76d7.0be2, WLAN Homeoffice, Slot 0 AP 5ce1.76d7.0be0, AP6C41.BCE0.AF00
2022/09/07 09:11:11.526836363 {wncd_x_R0-0}{1}: [dot11-validate] [14949]: (ERR): MAC: 949f.0fe3.3c64 Failed to dot11 ie validate aironet ipaddr. Aironet ipaddr IE is not present in Assoc Request
2022/09/07 09:11:11.526837620 {wncd_x_R0-0}{1}: [dot11-validate] [14949]: (ERR): MAC: 949f.0fe3.3c64 dot11 ie validate vendor wme. WME required set on WLAN, WME IE not present in assoc
2022/09/07 09:11:11.526851132 {wncd_x_R0-0}{1}: [ewlc-infra-evq] [14949]: (ERR): 949f.0fe3.3c64CLIENT_ASSOC_FAIL Failure = IE_VALIDATION_FAILURE Validation Failure Type = 35, WLAN profile = Homeoffice, Policy profile = VLAN-1-Policy-Profile 
2022/09/07 09:11:11.526852041 {wncd_x_R0-0}{1}: [dot11] [14949]: (ERR): MAC: 949f.0fe3.3c64 Failed to assoc failure tr state entry. Incorrect validation status value :35
2022/09/07 09:11:11.526982282 {wncd_x_R0-0}{1}: [dot11] [14949]: (ERR): MAC: 949f.0fe3.3c64 Dot11 update co assoc fail. Sent assoc failure to CO. delete reason: 322, CO_CLIENT_DELETE_REASON_DOT11_UNSPEC_QOS_RELATED_REASON
2022/09/07 09:11:11.527052346 {wncd_x_R0-0}{1}: [client-orch-sm] [14949]: (note): MAC: 949f.0fe3.3c64 Client delete initiated. Reason: CO_CLIENT_DELETE_REASON_DOT11_UNSPEC_QOS_RELATED_REASON, details: , fsm-state transition 00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|b4|b7|ba|bb|37|46|48|4a|4c|51|60|62|83|86|8d|12|
2022/09/07 09:11:11.527100113 {wncd_x_R0-0}{1}: [client-orch-state] [14949]: (note): MAC: 949f.0fe3.3c64 Client state transition: S_CO_RUN -> S_CO_DELETE_IN_PROGRESS
2022/09/07 09:11:11.529904745 {wncd_x_R0-0}{1}: [dpath_svc] [14949]: (note): MAC: 949f.0fe3.3c64 Client datapath entry deleted for ifid 0xa0000004
2022/09/07 09:11:11.530060862 {wncd_x_R0-0}{1}: [sanet-shim-translate] [14949]: (note): MAC: 949f.0fe3.3c64 Session manager disconnect event called, session label: 0x3d000004
2022/09/07 09:11:11.531135767 {wncd_x_R0-0}{1}: [client-orch-state] [14949]: (note): MAC: 949f.0fe3.3c64 Client state transition: S_CO_DELETE_IN_PROGRESS -> S_CO_DELETED
2022/09/07 09:11:13.825481532 {wncd_x_R0-0}{1}: [client-orch-sm] [14949]: (note): MAC: 949f.0fe3.3c64 Association received. BSSID 5ce1.76d7.0bed, WLAN Homeoffice, Slot 1 AP 5ce1.76d7.0be0, AP6C41.BCE0.AF00
2022/09/07 09:11:13.825688309 {wncd_x_R0-0}{1}: [client-orch-state] [14949]: (note): MAC: 949f.0fe3.3c64 Client state transition: S_CO_INIT -> S_CO_ASSOCIATING
2022/09/07 09:11:13.825925447 {wncd_x_R0-0}{1}: [dot11-validate] [14949]: (ERR): MAC: 949f.0fe3.3c64 Failed to dot11 ie validate aironet ipaddr. Aironet ipaddr IE is not present in Assoc Request
2022/09/07 09:11:13.825927412 {wncd_x_R0-0}{1}: [dot11-validate] [14949]: (ERR): MAC: 949f.0fe3.3c64 dot11 ie validate vendor wme. WME required set on WLAN, WME IE not present in assoc
2022/09/07 09:11:13.825947700 {wncd_x_R0-0}{1}: [ewlc-infra-evq] [14949]: (ERR): 949f.0fe3.3c64CLIENT_ASSOC_FAIL Failure = IE_VALIDATION_FAILURE Validation Failure Type = 35, WLAN profile = Homeoffice, Policy profile = VLAN-1-Policy-Profile 
2022/09/07 09:11:13.825949674 {wncd_x_R0-0}{1}: [dot11] [14949]: (ERR): MAC: 949f.0fe3.3c64 Failed to assoc failure tr state entry. Incorrect validation status value :35
2022/09/07 09:11:13.826198457 {wncd_x_R0-0}{1}: [dot11] [14949]: (ERR): MAC: 949f.0fe3.3c64 Dot11 update co assoc fail. Sent assoc failure to CO. delete reason: 322, CO_CLIENT_DELETE_REASON_DOT11_UNSPEC_QOS_RELATED_REASON
2022/09/07 09:11:13.826263145 {wncd_x_R0-0}{1}: [client-orch-sm] [14949]: (note): MAC: 949f.0fe3.3c64 Client delete initiated. Reason: CO_CLIENT_DELETE_REASON_DOT11_UNSPEC_QOS_RELATED_REASON, details: , fsm-state transition 00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|00|01|08|12|
2022/09/07 09:11:13.826332496 {wncd_x_R0-0}{1}: [client-orch-state] [14949]: (note): MAC: 949f.0fe3.3c64 Client state transition: S_CO_ASSOCIATING -> S_CO_DELETE_IN_PROGRESS
2022/09/07 09:11:13.826832611 {wncd_x_R0-0}{1}: [client-orch-state] [14949]: (note): MAC: 949f.0fe3.3c64 Client state transition: S_CO_DELETE_IN_PROGRESS -> S_CO_DELETED

I'm kind of lost as it worked "out of the box" with an old vWLC with 8.3.150 software.

Please advise and point me into the right direction...

Thanks in advance,

Jörg

ammahend · ‎09-07-2022

I think this is your problem

Aironet ipaddr IE is not present in Assoc Request

try this and see if it works

Step 1	Choose Configuration > Tags & Profiles > WLANs .
Step 2	In the WLANs window, click Add.
Step 3	In the Add WLAN window, under the Advanced tab, uncheck the Aironet IE check box to disable Aironet IE on the WLAN.
Step 4	Click Apply to Device.

-hope this helps-

Tenere · ‎09-07-2022

This checkbox is disabled...

marce1000 · ‎09-07-2022

- Note that you can have the Radioactive Trace analyzed with : https://cway.cisco.com/wireless-debug-analyzer/

M.

-- Each morning when I wake up and look into the mirror I always say ' Why am I so brilliant ? '
When the mirror will then always repond to me with ' The only thing that exceeds your brilliance is your beauty! '

Tenere · ‎09-07-2022

Thanks, wasn't aware of that!

Tenere · ‎09-07-2022

Thanks, that was helpful. WMM was on the 9800 required but Sonos don't support it.

TimeTaskTranslated

2022/09/07 07:46:39.577	client-orch-sm	Client made a new Association to an AP/BSSID: BSSID 5ce1.76d7.0bed, WLAN Homeoffice, Slot 1 AP 5ce1.76d7.0be0, AP6C41.0ECB.AF00
2022/09/07 07:46:39.577	dot11	Association failure, reason code sent: 35, interpretation: WLAN requires the use of WMM and client does not support it
2022/09/07 07:46:39.578	client-orch-sm	Controller initiated client deletion with code: CO_CLIENT_DELETE_REASON_DOT11_UNSPEC_QOS_RELATED_REASON

THANKS!