9840 Guest Access Disconnects and Goes to Webauth Redirect Every 5 Minutes

[phillip.vansickle]

I have a 9840 deployment with an Export Anchor setup to provide guest access. Webauth is provided via Cisco ISE portal. 

Guest Clients authenticate fine, but keep getting redirected to the login page every 5 minutes. I've set the idle timer to 1000 and the session timeout to 14400 on the Policies on both controllers (Anchor/Foreign). 

Running 16.12.3

Debug from radioactive trace:

2020/07/15 16:47:56.160 {mobilityd_R0-0}{2}: [mm-client] [21927]: (debug): MAC: 74d0.2bce.fb5e Received handoff_end, sub type: 0 of XID (5864) from (ipv4: 192.168.1.10 )
2020/07/15 16:47:56.161 {wncd_x_R0-0}{2}: [mm-client] [19771]: (debug): MAC: 74d0.2bce.fb5e Received handoff_end, sub type: 0 of XID (5864) from (MobilityD[0])
2020/07/15 16:47:56.161 {mobilityd_R0-0}{2}: [mm-transition] [21927]: (info): MAC: 74d0.2bce.fb5e MMFSM transition: S_MC_RUN -> S_MC_HANDOFF_END_RCVD_TR on E_MC_HANDOFF_END_RCVD from ipv4: 192.168.1.10
2020/07/15 16:47:56.161 {wncd_x_R0-0}{2}: [mm-transition] [19771]: (info): MAC: 74d0.2bce.fb5e MMIF FSM transition: S_MA_FOREIGN -> S_MA_HANDOFF_END_PROCESSED_TR on E_MA_HANDOFF_END_RCVD
2020/07/15 16:47:56.161 {mobilityd_R0-0}{2}: [mm-client] [21927]: (info): MAC: 74d0.2bce.fb5e Forwarding handoff_end, sub type: 0 of XID (5864) from (ipv4: 192.168.1.10 ) to (WNCD[0])
2020/07/15 16:47:56.161 {wncd_x_R0-0}{2}: [mm-client] [19771]: (debug): MAC: 74d0.2bce.fb5e Sending handoff_end_ack of XID (5864) to (MobilityD[0])
2020/07/15 16:47:56.161 {mobilityd_R0-0}{2}: [mm-client] [21927]: (debug): MAC: 74d0.2bce.fb5e Sending handoff_end of XID (5864) to (WNCD[0])
2020/07/15 16:47:56.161 {wncd_x_R0-0}{2}: [client-orch-sm] [19771]: (info): MAC: 74d0.2bce.fb5e Deleting the client, reason: 184, CO_CLIENT_DELETE_REASON_REMOTE_MOBILITY_DELETE, Client state S_CO_RUN
2020/07/15 16:47:56.161 {mobilityd_R0-0}{2}: [mm-client] [21927]: (debug): MAC: 74d0.2bce.fb5e Received handoff_end_ack, sub type: 0 of XID (5864) from (WNCD[0])
2020/07/15 16:47:56.161 {wncd_x_R0-0}{2}: [client-orch-sm] [19771]: (note): MAC: 74d0.2bce.fb5e Client delete initiated. Reason: CO_CLIENT_DELETE_REASON_REMOTE_MOBILITY_DELETE, fsm-state transition 0d|07|13|17|18|25|30|3f|40|42|43|48|53|6a|6b|6c|6d|13|17|18|25|30|3f|40|42|43|48|53|71|23|71|80|
2020/07/15 16:47:56.161 {mobilityd_R0-0}{2}: [mm-transition] [21927]: (info): MAC: 74d0.2bce.fb5e MMFSM transition: S_MC_WAIT_HANDOFF_END_ACK -> S_MC_HANDOFF_END_ACK_PROCESSED_TR on E_MC_HANDOFF_END_ACK_RCVD from WNCD[0]
2020/07/15 16:47:56.161 {mobilityd_R0-0}{2}: [mm-client] [21927]: (info): MAC: 74d0.2bce.fb5e Forwarding handoff_end_ack, sub type: 0 of XID (5864) from (WNCD[0]) to (ipv4: 192.168.1.10 )
2020/07/15 16:47:56.161 {mobilityd_R0-0}{2}: [mm-client] [21927]: (debug): MAC: 74d0.2bce.fb5e Sending handoff_end_ack of XID (5864) to (ipv4: 192.168.1.10 )
2020/07/15 16:47:56.162 {wncd_x_R0-0}{2}: [client-orch-state] [19771]: (note): MAC: 74d0.2bce.fb5e Client state transition: S_CO_RUN -> S_CO_DELETE_IN_PROGRESS
2020/07/15 16:47:56.162 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0xcc000078 client hdl 0 cur hdl 0x59000078 withclient name BM
2020/07/15 16:47:56.162 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0xcc000078 client hdl 2 cur hdl 0x4b000078 withclient name EPM
2020/07/15 16:47:56.162 {wncd_x_R0-0}{2}: [sanet-shim-translate] [19771]: (info): Anchor Vlan: 760
2020/07/15 16:47:56.162 {wncd_x_R0-0}{2}: [ewlc-qos-qosdb] [19771]: (info): Found Policy-map refcount record for pm_name: client-default
2020/07/15 16:47:56.162 {wncd_x_R0-0}{2}: [ewlc-qos-voice] [19771]: (info): MAC: 74d0.2bce.fb5e Successfully freed the bw for sip client
2020/07/15 16:47:56.162 {wncd_x_R0-0}{2}: [multicast-main] [19771]: (info): MAC: 74d0.2bce.fb5e No Flex/Fabric main record exists for client
2020/07/15 16:47:56.162 {wncd_x_R0-0}{2}: [rog-proxy-capwap] [19771]: (debug): Managed client state notification: client left run state: 74d0.2bce.fb5e
2020/07/15 16:47:56.162 {wncd_x_R0-0}{2}: [client-iplearn] [19771]: (info): MAC: 74d0.2bce.fb5e IP-learn state transition: S_IPLEARN_COMPLETE -> S_IPLEARN_DELETE_IN_PROGRESS
2020/07/15 16:47:56.162 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0xcc000078 client hdl 2 cur hdl 0x4b000078 withclient name EPM
2020/07/15 16:47:56.162 {wncd_x_R0-0}{2}: [dpath_svc] [19771]: (note): MAC: 74d0.2bce.fb5e Client datapath entry deleted for ifid 0xa0000010
2020/07/15 16:47:56.162 {wncd_x_R0-0}{2}: [mm-transition] [19771]: (info): MAC: 74d0.2bce.fb5e MMIF FSM transition: S_MA_WAIT_LOCAL_DELETE -> S_MA_LOCAL_DELETE_PROCESSED_TR on E_MA_CO_DELETE_RCVD
2020/07/15 16:47:56.162 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] Disconnect request from SANET-SHIM (14) for 74d0.2bce.fb5e / 0xcc000078 - term: user-roamed-out, abort: Unknown, disc: binding change
2020/07/15 16:47:56.162 {wncd_x_R0-0}{2}: [aaa-attr-inf] [19771]: (info): [ Applied attribute : username 0 "xyz@gmail.com" ]
2020/07/15 16:47:56.162 {wncd_x_R0-0}{2}: [aaa-attr-inf] [19771]: (info): [ Applied attribute : anchor-vlan 0 760 (0x2f8) ]
2020/07/15 16:47:56.162 {wncd_x_R0-0}{2}: [aaa-attr-inf] [19771]: (info): [ Applied attribute : class 0 43 41 43 53 3a 31 36 34 45 30 39 30 41 30 30 30 30 30 30 38 32 35 33 35 39 34 32 34 36 3a 64 68 77 69 73 65 33 2f 33 37 35 36 39 32 39 33 31 2f 38 31 38 32 35 38 ]
2020/07/15 16:47:56.162 {wncd_x_R0-0}{2}: [aaa-attr-inf] [19771]: (info): [ Applied attribute : url-redirect-acl 0 "ISE_Permit_Any" ]
2020/07/15 16:47:56.162 {wncd_x_R0-0}{2}: [aaa-attr-inf] [19771]: (info): [ Applied attribute : url-redirect 0 "https://192.168.1.12:8443/portal/gateway?sessionId=164E090A0000008253594246&portal=496304f2-d309-11e4-8349-0050568172ad&action=cwa&token=8ae20177887abaf30e656d9b0dc236b7" ]
2020/07/15 16:47:56.162 {wncd_x_R0-0}{2}: [aaa-attr-inf] [19771]: (info): [ Applied attribute : bsn-acl-name 0 "ISE_Permit_Any" ]
2020/07/15 16:47:56.162 {wncd_x_R0-0}{2}: [aaa-attr-inf] [19771]: (info): [ Applied attribute : timeout 0 65595 (0x1003b) ]
2020/07/15 16:47:56.162 {wncd_x_R0-0}{2}: [aaa-attr-inf] [19771]: (info): [ Applied attribute : Termination-Action 0 False ]
2020/07/15 16:47:56.162 {wncd_x_R0-0}{2}: [aaa-attr-inf] [19771]: (info): [ Applied attribute :bsn-vlan-interface-name 0 "WLC_9840_Mgmt" ]
2020/07/15 16:47:56.162 {wncd_x_R0-0}{2}: [client-auth] [19771]: (info): MAC: 74d0.2bce.fb5e Client auth-interface state transition: S_AUTHIF_WEBAUTH_DONE -> S_SANET_DELETE_IN_PROGRESS
2020/07/15 16:47:56.162 {wncd_x_R0-0}{2}: [dot11] [19771]: (info): MAC: 74d0.2bce.fb5e Sent disassoc to client, disassoc reason: 252, CLIENT_DEAUTH_REASON_ADMIN_RESET delete reason: 184, CO_CLIENT_DELETE_REASON_REMOTE_MOBILITY_DELETE.
2020/07/15 16:47:56.162 {wncd_x_R0-0}{2}: [dot11] [19771]: (info): MAC: 74d0.2bce.fb5e Sent deauth to client, deauth reason: 252, CLIENT_DEAUTH_REASON_ADMIN_RESET delete reason: 184, CO_CLIENT_DELETE_REASON_REMOTE_MOBILITY_DELETE.
2020/07/15 16:47:56.163 {wncd_x_R0-0}{2}: [apmgr-capwap-config] [19771]: (ERR): f40f.1b34.9220 Decremented client count for mewlc 13
2020/07/15 16:47:56.163 {wncd_x_R0-0}{2}: [dot11] [19771]: (info): MAC: 74d0.2bce.fb5e DOT11 state transition: S_DOT11_ASSOCIATED -> S_DOT11_DELETED
2020/07/15 16:47:56.163 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0xcc000078 client hdl 0 cur hdl 0x59000078 withclient name BM
2020/07/15 16:47:56.163 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0xcc000078 client hdl 1 cur hdl 0x3f00006d withclient name DTM
2020/07/15 16:47:56.163 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0xcc000078 client hdl 1 cur hdl 0x3f00006d withclient name DTM
2020/07/15 16:47:56.163 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0xcc000078 client hdl 1 cur hdl 0x3f00006d withclient name DTM
2020/07/15 16:47:56.163 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0xcc000078 client hdl 1 cur hdl 0x3f00006d withclient name DTM
2020/07/15 16:47:56.163 {wncd_x_R0-0}{2}: [caaa-acct] [19771]: (info): [CAAA:ACCT] Not a webauth call
2020/07/15 16:47:56.163 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0xcc000078 client hdl 0 cur hdl 0x59000078 withclient name BM
2020/07/15 16:47:56.163 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0xcc000078 client hdl 0 cur hdl 0x59000078 withclient name BM
2020/07/15 16:47:56.163 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0xcc000078 client hdl 1 cur hdl 0x3f00006d withclient name DTM
2020/07/15 16:47:56.164 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0xcc000078 client hdl 2 cur hdl 0x4b000078 withclient name EPM
2020/07/15 16:47:56.164 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0xcc000078 client hdl 0 cur hdl 0x59000078 withclient name BM
2020/07/15 16:47:56.164 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0xcc000078 client hdl 0 cur hdl 0x59000078 withclient name BM
2020/07/15 16:47:56.164 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0xcc000078 client hdl 1 cur hdl 0x3f00006d withclient name DTM
2020/07/15 16:47:56.164 {wncd_x_R0-0}{2}: [client-auth] [19771]: (info): MAC: 74d0.2bce.fb5e Client auth-interface state transition: S_SANET_DELETE_IN_PROGRESS -> S_AUTHIF_DELETED
2020/07/15 16:47:56.164 {wncd_x_R0-0}{2}: [mab] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] Received event 'MAB_DELETE' on handle 0x9A00001D
2020/07/15 16:47:56.164 {wncd_x_R0-0}{2}: [mab] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] Received ABORT event from Auth Mgr for 0x9A00001D (74d0.2bce.fb5e)
2020/07/15 16:47:56.164 {wncd_x_R0-0}{2}: [mab] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] MAB success: get auth state TERMINATE
2020/07/15 16:47:56.164 {wncd_x_R0-0}{2}: [mab] [19771]: (info): [0000.0000.0000:unknown] MAB deleted record
2020/07/15 16:47:56.164 {wncd_x_R0-0}{2}: [mab] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] Freed MAB client context
2020/07/15 16:47:56.164 {wncd_x_R0-0}{2}: [client-orch-state] [19771]: (note): MAC: 74d0.2bce.fb5e Client state transition: S_CO_DELETE_IN_PROGRESS -> S_CO_DELETED
2020/07/15 16:47:56.165 {wncd_x_R0-0}{2}: [rrm-client-chd] [19771]: (ERR): f40f.1b34.9220 (Radio: 802.11bg) xorRoam: Station: 74:D0:2B:CE:FB:5E station control block not present
2020/07/15 16:47:56.165 {wncd_x_R0-0}{2}: [rrm-client-chd] [19771]: (ERR): f40f.1b34.9220 (Radio: 802.11bg) xorRoam: Station: 74:D0:2B:CE:FB:5E station control block not present
2020/07/15 16:47:57.244 {wncd_x_R0-0}{2}: [dot11] [19771]: (info): Failed to dot11 map external to internal ie type. Unsupported IE received, skip decode . IE Type :150
2020/07/15 16:47:57.244 {wncd_x_R0-0}{2}: [client-orch-sm] [19771]: (note): MAC: 74d0.2bce.fb5e Re-Association received. BSSID f40f.1b34.9220, old BSSID 0000.0000.0000, WLAN ImAGuest, Slot 0 AP f40f.1b34.9220, CO-PTC_8FL_East
2020/07/15 16:47:57.244 {wncd_x_R0-0}{2}: [client-orch-sm] [19771]: (debug): MAC: 74d0.2bce.fb5e Received Dot11 association request. Processing started,SSID: ImAGuest, Policy profile: Im_A_Guest_Policy_Profile, AP Name: CO-PTC_8FL_East, Ap Mac Address: f40f.1b34.9220 BSSID MAC0000.0000.0000 wlan ID: 4RSSI: 0, SNR: 32
2020/07/15 16:47:57.244 {wncd_x_R0-0}{2}: [client-orch-state] [19771]: (note): MAC: 74d0.2bce.fb5e Client state transition: S_CO_INIT -> S_CO_ASSOCIATING
2020/07/15 16:47:57.245 {wncd_x_R0-0}{2}: [dot11] [19771]: (info): MAC: 74d0.2bce.fb5e DOT11 state transition: S_DOT11_INIT -> S_DOT11_MAB_PENDING
2020/07/15 16:47:57.245 {wncd_x_R0-0}{2}: [client-orch-state] [19771]: (note): MAC: 74d0.2bce.fb5e Client state transition: S_CO_ASSOCIATING -> S_CO_MACAUTH_IN_PROGRESS
2020/07/15 16:47:57.245 {wncd_x_R0-0}{2}: [client-auth] [19771]: (note): MAC: 74d0.2bce.fb5e MAB Authentication initiated. Policy VLAN 0, AAA override = 1, NAC = 1
2020/07/15 16:47:57.245 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] Session Start event called from SANET-SHIM with conn_hdl 14, vlan: 0
2020/07/15 16:47:57.245 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] Wireless session sequence, create context with method MAB
2020/07/15 16:47:57.245 {wncd_x_R0-0}{2}: [auth-mgr-feat_wireless] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] - authc_list: CWAguest
2020/07/15 16:47:57.245 {wncd_x_R0-0}{2}: [auth-mgr-feat_wireless] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] - authz_list: Not present under wlan configuration
2020/07/15 16:47:57.245 {wncd_x_R0-0}{2}: [client-auth] [19771]: (info): MAC: 74d0.2bce.fb5e Client auth-interface state transition: S_AUTHIF_INIT -> S_AUTHIF_AWAIT_MAB_AUTH_START_RESP
2020/07/15 16:47:57.245 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [74d0.2bce.fb5e:unknown] auth mgr attr change notification is received for attr (952)
2020/07/15 16:47:57.245 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] auth mgr attr change notification is received for attr (1263)
2020/07/15 16:47:57.245 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] auth mgr attr change notification is received for attr (220)
2020/07/15 16:47:57.245 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] auth mgr attr change notification is received for attr (952)
2020/07/15 16:47:57.245 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] Retrieved Client IIF ID 0x5f001e9d
2020/07/15 16:47:57.245 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] Allocated audit session id 164E090A0000008653602400
2020/07/15 16:47:57.245 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x0 withclient name EPM
2020/07/15 16:47:57.246 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] Device type found in cache Asus-Device
2020/07/15 16:47:57.246 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] Device type for the session is detected as Asus-Device and old device-type not classified earlier &Device name for the session is detected as ASUSTEK COMPUTER INC. and old device-name not classified earlier & Old protocol map 0 and new is 1
2020/07/15 16:47:57.246 {wncd_x_R0-0}{2}: [mm-client] [19771]: (debug): MAC: 0000.0000.0000 Sending device_cache_update of XID (0) to (MobilityD[0])
2020/07/15 16:47:57.246 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:47:57.246 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:47:57.246 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:47:57.246 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:47:57.246 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] SM Reauth Plugin: Received valid timeout = 14400
2020/07/15 16:47:57.246 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:47:57.246 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:47:57.246 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:47:57.246 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:47:57.246 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 1 cur hdl 0x0 withclient name DTM
2020/07/15 16:47:57.246 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:47:57.246 {wncd_x_R0-0}{2}: [mab] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] MAB authentication started for 74d0.2bce.fb5e
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [client-auth] [19771]: (info): MAC: 74d0.2bce.fb5e Client auth-interface state transition: S_AUTHIF_AWAIT_MAB_AUTH_START_RESP -> S_AUTHIF_MAB_AUTH_PENDING
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [ewlc-infra-evq] [19771]: (note): Authentication Success. Resolved Policy bitmap:11 for client 74d0.2bce.fb5e
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [client-auth] [19771]: (info): MAC: 74d0.2bce.fb5e Client auth-interface state transition: S_AUTHIF_MAB_AUTH_PENDING -> S_AUTHIF_MAB_AUTH_PENDING
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [mab] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] Received event 'MAB_CONTINUE' on handle 0xDC00001F
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] Device type for the session is detected as Asus-Device and old Asus-Device &Device name for the session is detected as ASUSTEK COMPUTER INC. and old ASUSTEK COMPUTER INC. & Old protocol map 1 and new is 1
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Auth filter spec is empty
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [caaa-author] [19771]: (info): [CAAA:AUTHOR:3500007c] DEBUG: mlist=CWAguest for type=1
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: Send Access-Request to 192.168.1.12:1812 id 0/172, len 369
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: authenticator 64 b9 65 dc de 4a 68 38 - 8c a0 58 0b 6e 14 1c 84
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: User-Name [1] 14 "74d02bcefb5e"
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: User-Password [2] 18 *
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: Cisco AVpair [1] 25 "service-type=Call Check"
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: Framed-MTU [12] 6 1485
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: Message-Authenticator[80] 18 ...
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: EAP-Key-Name [102] 2 *
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: Cisco AVpair [1] 43 "audit-session-id=164E090A0000008653602400"
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: Cisco AVpair [1] 12 "method=mab"
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: Cisco AVpair [1] 26 "client-iif-id=1593843357"
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: Cisco AVpair [1] 13 "vlan-id=301"
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: NAS-IP-Address [4] 6 10.9.78.22
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: NAS-Port-Id [87] 17 "capwap_90000003"
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: NAS-Port-Type [61] 6 802.11 wireless [19]
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: NAS-Port [5] 6 30116
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: Called-Station-Id [30] 28 "f4:0f:1b:34:92:20:ImAGuest"
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: Calling-Station-Id [31] 19 "74:d0:2b:ce:fb:5e"
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: Airespace-WLAN-ID [1] 6 4
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: Cisco AVpair [1] 26 "cisco-wlan-ssid=ImAGuest"
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: Nas-Identifier [32] 10 "ImAGuest"
2020/07/15 16:47:57.247 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: Started 5 sec timeout
2020/07/15 16:47:57.260 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: Received from id 1812/172 192.168.1.12:0, Access-Accept, len 403
2020/07/15 16:47:57.260 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: authenticator 63 e9 e1 37 a8 bd ee 5d - fc 88 87 da c8 d7 c0 3b
2020/07/15 16:47:57.260 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: User-Name [1] 19 "74-D0-2B-CE-FB-5E"
2020/07/15 16:47:57.260 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: Class [25] 56 ...
2020/07/15 16:47:57.260 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: Message-Authenticator[80] 18 ...
2020/07/15 16:47:57.260 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: Cisco AVpair [1] 37 "url-redirect-acl=ISE_Guest_Redirect"
2020/07/15 16:47:57.260 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: Cisco AVpair [1] 183 "url-redirect=https://192.168.1.12:8443/portal/gateway?sessionId=164E090A0000008653602400&portal=496304f2-d309-11e4-8349-0050568172ad&action=cwa&token=6524a85367ebf56759f60ecee22669c9"
2020/07/15 16:47:57.260 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: Cisco AVpair [1] 26 "profile-name=Asus-Device"
2020/07/15 16:47:57.260 {wncd_x_R0-0}{2}: [radius] [19771]: (info): RADIUS: Airespace-ACL-Name [6] 20 "ISE_Guest_Redirect"
2020/07/15 16:47:57.260 {wncd_x_R0-0}{2}: [eap-auth] [19771]: (info): SUCCESS for EAP method name: Identity on handle 0xFE000296
2020/07/15 16:47:57.260 {wncd_x_R0-0}{2}: [mab] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] MAB received an Access-Accept for 0xDC00001F
2020/07/15 16:47:57.260 {wncd_x_R0-0}{2}: [mab] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] Received event 'MAB_RESULT' on handle 0xDC00001F
2020/07/15 16:47:57.260 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] Authc success from MAB, Auth event success
2020/07/15 16:47:57.260 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:47:57.260 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] auth mgr attr change notification is received for attr (450)
2020/07/15 16:47:57.261 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] Received User-Name 74-D0-2B-CE-FB-5E for client 74d0.2bce.fb5e
2020/07/15 16:47:57.261 {wncd_x_R0-0}{2}: [auth-mgr-feat_wireless] [19771]: (info): [0000.0000.0000:unknown] AAA override is enabled under policy profile
2020/07/15 16:47:57.261 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] User profile is to be applied. Authz mlist is not present, Authc mlist CWAguest ,session push flag is unset
2020/07/15 16:47:57.261 {wncd_x_R0-0}{2}: [webauth-dev] [19771]: (info): [74d0.2bce.fb5e][ 0.0.0.0]Central Webauth URL Redirect, Received a request to create a CWA session for a mac [74:d0:2b:ce:fb:5e]
2020/07/15 16:47:57.261 {wncd_x_R0-0}{2}: [webauth-dev] [19771]: (info): [74d0.2bce.fb5e][ 0.0.0.0]No parameter map is associated with mac 74d0.2bce.fb5e
2020/07/15 16:47:57.261 {wncd_x_R0-0}{2}: [epm-redirect] [19771]: (info): [0000.0000.0000:unknown] URL-Redirect-ACL = ISE_Guest_Redirect
2020/07/15 16:47:57.261 {wncd_x_R0-0}{2}: [epm-redirect] [19771]: (info): [0000.0000.0000:unknown] URL-Redirect = https://192.168.1.12:8443/portal/gateway?sessionId=164E090A0000008653602400&portal=496304f2-d309-11e4-8349-0050568172ad&action=cwa&token=6524a85367ebf56759f60ecee22669c9
2020/07/15 16:47:57.261 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 1 cur hdl 0x0 withclient name DTM
2020/07/15 16:47:57.261 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:47:57.261 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 1 cur hdl 0x12000070 withclient name DTM
2020/07/15 16:47:57.261 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:47:57.261 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 1 cur hdl 0x12000070 withclient name DTM
2020/07/15 16:47:57.261 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:47:57.261 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:47:57.262 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:47:57.262 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:47:57.262 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:47:57.262 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:47:57.262 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:47:57.262 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] User Profile applied successfully for 0x3500007C - REPLACE
2020/07/15 16:47:57.262 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:47:57.262 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:47:57.262 {wncd_x_R0-0}{2}: [mm-client] [19771]: (debug): MAC: 0000.0000.0000 Sending pmk_update of XID (0) to (MobilityD[0])
2020/07/15 16:47:57.262 {wncd_x_R0-0}{2}: [client-auth] [19771]: (note): MAC: 74d0.2bce.fb5e MAB Authentication success.
2020/07/15 16:47:57.262 {wncd_x_R0-0}{2}: [client-auth] [19771]: (info): MAC: 74d0.2bce.fb5e Client auth-interface state transition: S_AUTHIF_MAB_AUTH_PENDING -> S_AUTHIF_MAB_AUTH_DONE
2020/07/15 16:47:57.262 {wncd_x_R0-0}{2}: [client-orch-sm] [19771]: (debug): MAC: 74d0.2bce.fb5e Processing MAB authentication result status: 0, CO_AUTH_STATUS_SUCCESS
2020/07/15 16:47:57.262 {wncd_x_R0-0}{2}: [client-orch-state] [19771]: (note): MAC: 74d0.2bce.fb5e Client state transition: S_CO_MACAUTH_IN_PROGRESS -> S_CO_ASSOCIATING
2020/07/15 16:47:57.262 {wncd_x_R0-0}{2}: [dot11] [19771]: (debug): MAC: 74d0.2bce.fb5e dot11 send association response. Sending association response with resp_status_code: 0
2020/07/15 16:47:57.262 {wncd_x_R0-0}{2}: [dot11] [19771]: (info): MAC: 74d0.2bce.fb5e dot11 send association response. Sending assoc response of length: 107 with resp_status_code: 0, DOT11_STATUS: DOT11_STATUS_SUCCESS
2020/07/15 16:47:57.262 {wncd_x_R0-0}{2}: [dot11] [19771]: (note): MAC: 74d0.2bce.fb5e Association success. AID 4, Roaming = False, WGB = False, 11r = False, 11w = False
2020/07/15 16:47:57.262 {wncd_x_R0-0}{2}: [dot11] [19771]: (info): MAC: 74d0.2bce.fb5e DOT11 state transition: S_DOT11_MAB_PENDING -> S_DOT11_ASSOCIATED
2020/07/15 16:47:57.262 {wncd_x_R0-0}{2}: [client-orch-sm] [19771]: (debug): MAC: 74d0.2bce.fb5e Station Dot11 association is successful.
2020/07/15 16:47:57.262 {wncd_x_R0-0}{2}: [client-orch-sm] [19771]: (debug): MAC: 74d0.2bce.fb5e Starting L2 authentication. Bssid in state machine:f40f.1b34.9220 Bssid in request is:f40f.1b34.9220
2020/07/15 16:47:57.262 {wncd_x_R0-0}{2}: [client-orch-state] [19771]: (note): MAC: 74d0.2bce.fb5e Client state transition: S_CO_ASSOCIATING -> S_CO_L2_AUTH_IN_PROGRESS
2020/07/15 16:47:57.262 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:47:57.262 {wncd_x_R0-0}{2}: [client-auth] [19771]: (info): MAC: 74d0.2bce.fb5e Client auth-interface state transition: S_AUTHIF_MAB_AUTH_DONE -> S_AUTHIF_WEBAUTH_DONE
2020/07/15 16:47:57.262 {wncd_x_R0-0}{2}: [client-orch-sm] [19771]: (debug): MAC: 74d0.2bce.fb5e L2 Authentication of station is successful., L3 Authentication : 0
2020/07/15 16:47:57.262 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:47:57.262 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:47:57.263 {mobilityd_R0-0}{2}: [mm-client] [21927]: (debug): MAC: 74d0.2bce.fb5e Received mobile_announce, sub type: 0 of XID (0) from (WNCD[0])
2020/07/15 16:47:57.263 {wncd_x_R0-0}{2}: [client-orch-sm] [19771]: (note): MAC: 74d0.2bce.fb5e Mobility discovery triggered. Client mode: Flex - Central Switching
2020/07/15 16:47:57.263 {mobilityd_R0-0}{2}: [mm-transition] [21927]: (info): MAC: 74d0.2bce.fb5e MMFSM transition: S_MC_INIT -> S_MC_ANNOUNCE_PROCESSED_NEW_CLIENT_TR on E_MC_ANNOUNCE_RCVD from WNCD[0]
2020/07/15 16:47:57.263 {wncd_x_R0-0}{2}: [client-orch-state] [19771]: (note): MAC: 74d0.2bce.fb5e Client state transition: S_CO_L2_AUTH_IN_PROGRESS -> S_CO_MOBILITY_DISCOVERY_IN_PROGRESS
2020/07/15 16:47:57.263 {mobilityd_R0-0}{2}: [mm-client] [21927]: (debug): MAC: 74d0.2bce.fb5e Sending mobile_announce of XID (371) to (ipv4: 192.168.1.10 )
2020/07/15 16:47:57.263 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:47:57.263 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:47:57.263 {wncd_x_R0-0}{2}: [mm-transition] [19771]: (info): MAC: 74d0.2bce.fb5e MMIF FSM transition: S_MA_INIT -> S_MA_MOBILITY_DISCOVERY_PROCESSED_TR on E_MA_MOBILITY_DISCOVERY
2020/07/15 16:47:57.263 {wncd_x_R0-0}{2}: [mm-client] [19771]: (info): MAC: 74d0.2bce.fb5e Roam type changed - None -> L3 Requested
2020/07/15 16:47:57.263 {wncd_x_R0-0}{2}: [mm-client] [19771]: (info): MAC: 74d0.2bce.fb5e Invalid transmitter ip in build client context
2020/07/15 16:47:57.263 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:47:57.263 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:47:57.263 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:47:57.263 {wncd_x_R0-0}{2}: [mm-client] [19771]: (debug): MAC: 74d0.2bce.fb5e Sending mobile_announce of XID (0) to (MobilityD[0])
2020/07/15 16:47:58.264 {mobilityd_R0-0}{2}: [mm-client] [21927]: (debug): MAC: 74d0.2bce.fb5e Sending mobile_announce of XID (371) to (ipv4: 192.168.1.10 )
2020/07/15 16:47:59.265 {mobilityd_R0-0}{2}: [mm-client] [21927]: (debug): MAC: 74d0.2bce.fb5e Sending mobile_announce of XID (371) to (ipv4: 192.168.1.10 )
2020/07/15 16:48:00.265 {wncd_x_R0-0}{2}: [mm-client] [19771]: (debug): MAC: 74d0.2bce.fb5e Received mobile_announce_nak, sub type: 2 of XID (372) from (MobilityD[0])
2020/07/15 16:48:00.265 {mobilityd_R0-0}{2}: [mm-transition] [21927]: (info): MAC: 74d0.2bce.fb5e MMFSM transition: S_MC_WAIT_ANNOUNCE_RSP -> S_MC_ANNOUNCE_TIMEDOUT_PROCESSED_TR on E_MC_REQUEST_TIMEDOUT from WNCD[0]
2020/07/15 16:48:00.265 {wncd_x_R0-0}{2}: [mm-transition] [19771]: (info): MAC: 74d0.2bce.fb5e MMIF FSM transition: S_MA_INIT_WAIT_ANNOUNCE_RSP -> S_MA_NAK_PROCESSED_TR on E_MA_NAK_RCVD
2020/07/15 16:48:00.265 {mobilityd_R0-0}{2}: [mm-client] [21927]: (debug): MAC: 74d0.2bce.fb5e Add MCC by tdl mac: client_ifid 0xa0000010 is assigned to client
2020/07/15 16:48:00.265 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:48:00.265 {mobilityd_R0-0}{2}: [mm-client] [21927]: (debug): MAC: 74d0.2bce.fb5e Sending capwap_msg_unknown (100) of XID (372) to (WNCD[0])
2020/07/15 16:48:00.265 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.265 {mobilityd_R0-0}{2}: [mm-client] [21927]: (debug): MAC: 0000.0000.0000 Sending mobile_announce_nak of XID (372) to (WNCD[0])
2020/07/15 16:48:00.265 {wncd_x_R0-0}{2}: [sanet-shim-miscellaneous] [19771]: (info): MAC: 74d0.2bce.fb5e policy payload: elapsed time: 14399 seconds
2020/07/15 16:48:00.265 {wncd_x_R0-0}{2}: [sanet-shim-miscellaneous] [19771]: (info): MAC: 74d0.2bce.fb5e policy payload: session timeout: 14400 seconds
2020/07/15 16:48:00.265 {wncd_x_R0-0}{2}: [sanet-shim-miscellaneous] [19771]: (info): MAC: 74d0.2bce.fb5e policy payload: terminate action not set
2020/07/15 16:48:00.265 {wncd_x_R0-0}{2}: [sanet-shim-miscellaneous] [19771]: (info): MAC: 74d0.2bce.fb5e policy payload: acl name
2020/07/15 16:48:00.265 {wncd_x_R0-0}{2}: [sanet-shim-miscellaneous] [19771]: (info): MAC: 74d0.2bce.fb5e setting wlan session timeout: 14400 seconds
2020/07/15 16:48:00.265 {wncd_x_R0-0}{2}: [sanet-shim-miscellaneous] [19771]: (info): MAC: 74d0.2bce.fb5e policy payload: qos level 5
2020/07/15 16:48:00.265 {wncd_x_R0-0}{2}: [sanet-shim-miscellaneous] [19771]: (info): MAC: 74d0.2bce.fb5e policy payload: avg data 0, avg rt 0, burst data 0, burst rt 0
2020/07/15 16:48:00.265 {wncd_x_R0-0}{2}: [sanet-shim-miscellaneous] [19771]: (info): MAC: 74d0.2bce.fb5e setting override bits 0x00000400
2020/07/15 16:48:00.265 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:48:00.265 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.265 {wncd_x_R0-0}{2}: [sanet-shim-miscellaneous] [19771]: (info): MAC: 74d0.2bce.fb5e setting Interface name : WLC_9840_Mgmt
2020/07/15 16:48:00.265 {wncd_x_R0-0}{2}: [sanet-shim-miscellaneous] [19771]: (info): MAC: 74d0.2bce.fb5e setting User name: 74-D0-2B-CE-FB-5E and Length: 17
2020/07/15 16:48:00.265 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.266 {mobilityd_R0-0}{2}: [mm-client] [21927]: (debug): MAC: 74d0.2bce.fb5e Received export_anchor_req, sub type: 0 of XID (0) from (WNCD[0])
2020/07/15 16:48:00.266 {wncd_x_R0-0}{2}: [mm-client] [19771]: (debug): MAC: 74d0.2bce.fb5e Sending export_anchor_req of XID (0) to (MobilityD[0])
2020/07/15 16:48:00.266 {mobilityd_R0-0}{2}: [mm-transition] [21927]: (info): MAC: 74d0.2bce.fb5e MMFSM transition: S_MC_WAIT_EXP_ANC_REQ -> S_MC_EXP_ANC_REQ_RCVD_TR on E_MC_EXP_ANC_REQ_RCVD from WNCD[0]
2020/07/15 16:48:00.266 {mobilityd_R0-0}{2}: [mm-client] [21927]: (debug): MAC: 74d0.2bce.fb5e Export Anchor Request successfully processed.
2020/07/15 16:48:00.266 {mobilityd_R0-0}{2}: [mm-client] [21927]: (debug): MAC: 74d0.2bce.fb5e Forwarding Export Anchor Request to Anchor.
2020/07/15 16:48:00.266 {mobilityd_R0-0}{2}: [mm-client] [21927]: (info): MAC: 74d0.2bce.fb5e Forwarding export_anchor_req, sub type: 0 of XID (373) from (WNCD[0]) to (ipv4: 192.168.1.10 )
2020/07/15 16:48:00.266 {mobilityd_R0-0}{2}: [mm-client] [21927]: (debug): MAC: 74d0.2bce.fb5e Sending export_anchor_req of XID (373) to (ipv4: 192.168.1.10 )
2020/07/15 16:48:00.272 {wncd_x_R0-0}{2}: [mm-client] [19771]: (debug): MAC: 74d0.2bce.fb5e Received export_anchor_rsp, sub type: 0 of XID (373) from (MobilityD[0])
2020/07/15 16:48:00.272 {mobilityd_R0-0}{2}: [mm-client] [21927]: (debug): MAC: 74d0.2bce.fb5e Received export_anchor_rsp, sub type: 0 of XID (373) from (ipv4: 192.168.1.10 )
2020/07/15 16:48:00.272 {wncd_x_R0-0}{2}: [mm-client] [19771]: (debug): MAC: 74d0.2bce.fb5e Export Anchor Response successfully handled.
2020/07/15 16:48:00.272 {mobilityd_R0-0}{2}: [mm-transition] [21927]: (info): MAC: 74d0.2bce.fb5e MMFSM transition: S_MC_WAIT_EXP_ANC_RSP -> S_MC_EXP_ANC_RSP_RCVD_TR on E_MC_EXP_ANC_RSP_RCVD from ipv4: 192.168.1.10
2020/07/15 16:48:00.272 {wncd_x_R0-0}{2}: [mm-transition] [19771]: (info): MAC: 74d0.2bce.fb5e MMIF FSM transition: S_MA_WAIT_ANCHORING_RSP -> S_MA_ANCHORING_RSP_PROCESSING_IN_PROGRESS_TR on E_MA_EXPORT_ANCHOR_RSP
2020/07/15 16:48:00.272 {mobilityd_R0-0}{2}: [mm-client] [21927]: (debug): MAC: 74d0.2bce.fb5e Export Anchor Response successfully processed.
2020/07/15 16:48:00.272 {wncd_x_R0-0}{2}: [sanet-shim-miscellaneous] [19771]: (info): MAC: 74d0.2bce.fb5e IPv6 Client payload is received in export anchor rsp
2020/07/15 16:48:00.272 {mobilityd_R0-0}{2}: [mm-client] [21927]: (info): MAC: 74d0.2bce.fb5e Forwarding export_anchor_rsp, sub type: 0 of XID (373) from (ipv4: 192.168.1.10 ) to (WNCD[0])
2020/07/15 16:48:00.272 {wncd_x_R0-0}{2}: [sanet-shim-miscellaneous] [19771]: (info): MAC: 74d0.2bce.fb5e Reset override bits for anchor vlan id 760
2020/07/15 16:48:00.272 {mobilityd_R0-0}{2}: [mm-client] [21927]: (debug): MAC: 74d0.2bce.fb5e Sending export_anchor_rsp of XID (373) to (WNCD[0])
2020/07/15 16:48:00.272 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:48:00.272 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:48:00.273 {mobilityd_R0-0}{2}: [mm-client] [21927]: (debug): MAC: 74d0.2bce.fb5e Received ipv4_address_update, sub type: 0 of XID (5865) from (ipv4: 192.168.1.10 )
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [epm-redirect] [19771]: (info): [0000.0000.0000:unknown] URL-Redirect-ACL = ISE_Guest_Redirect
2020/07/15 16:48:00.273 {mobilityd_R0-0}{2}: [mm-client] [21927]: (info): MAC: 74d0.2bce.fb5e Forwarding ipv4_address_update, sub type: 0 of XID (5865) from (ipv4: 192.168.1.10 ) to (WNCD[0])
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [epm-redirect] [19771]: (info): [0000.0000.0000:unknown] URL-Redirect = https://192.168.1.12:8443/portal/gateway?sessionId=164E090A0000008653602400&portal=496304f2-d309-11e4-8349-0050568172ad&action=cwa&token=6524a85367ebf56759f60ecee22669c9
2020/07/15 16:48:00.273 {mobilityd_R0-0}{2}: [mm-client] [21927]: (debug): MAC: 74d0.2bce.fb5e Sending ipv4_address_update of XID (5865) to (WNCD[0])
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 1 cur hdl 0x12000070 withclient name DTM
2020/07/15 16:48:00.273 {mobilityd_R0-0}{2}: [mm-client] [21927]: (debug): MAC: 0000.0000.0000 Sending ipv4_address_update_ack of XID (5865) to (ipv4: 192.168.1.10 )
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 1 cur hdl 0x12000070 withclient name DTM
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] Profile applied successfully for 0x3500007C
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 1 cur hdl 0x12000070 withclient name DTM
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [epm] [19771]: (info): Dynamic template update, template name [implicit_deny:ISE_Guest_Redirect:] is already updated in the record
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [mm-client] [19771]: (debug): MAC: 74d0.2bce.fb5e Processed Export Anchor Response.
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [mm-client] [19771]: (info): MAC: 74d0.2bce.fb5e Mobility role changed - Unassoc -> Export Foreign
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [sanet-shim-translate] [19771]: (info): Anchor Vlan: 760
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [mm-client] [19771]: (note): MAC: 74d0.2bce.fb5e Mobility Successful. Roam Type L3 Requested, Sub Roam Type MM_SUB_ROAM_TYPE_NONE, Previous BSSID MAC: 0000.0000.0000 Client IFID: 0xa0000010, Client Role: Export Foreign PoA: 0x90000003 PoP: 0xa0000001
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [ewlc-infra-evq] [19771]: (note): Authentication Success. Resolved Policy bitmap:4 for client 74d0.2bce.fb5e
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [client-auth] [19771]: (info): MAC: 74d0.2bce.fb5e Client auth-interface state transition: S_AUTHIF_WEBAUTH_DONE -> S_AUTHIF_WEBAUTH_DONE
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [client-orch-sm] [19771]: (debug): MAC: 74d0.2bce.fb5e Processing mobility response from MMIF. Client ifid: 0xa0000010, roam type: L3 Requested, client role: Export Foreign
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [sanet-shim-translate] [19771]: (info): Anchor Vlan: 760
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [ewlc-qos-client] [19771]: (info): MAC: 74d0.2bce.fb5e Client QoS add mobile cb
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [ewlc-qos-client] [19771]: (info): MAC: 74d0.2bce.fb5e No QoS PM Name or QoS Level received from SANet for pm_dir:0. Check client is fastlane, otherwise set pm name to none
2020/07/15 16:48:00.273 {wncd_x_R0-0}{2}: [ewlc-qos-client] [19771]: (info): MAC: 74d0.2bce.fb5e Local mode install client QoSpolicy:client-default pm_dir:input AP Mac: F4:0F:1B:34:92:20 slotId:0 vapId:4
2020/07/15 16:48:00.274 {wncd_x_R0-0}{2}: [ewlc-qos-qosdb] [19771]: (info): Found Policy-map refcount record for pm_name: client-default
2020/07/15 16:48:00.274 {wncd_x_R0-0}{2}: [ewlc-qos-qosdb] [19771]: (info): Found Policy-map refcount record for pm_name: client-default
2020/07/15 16:48:00.274 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:48:00.274 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.274 {wncd_x_R0-0}{2}: [ewlc-qos-client] [19771]: (info): MAC: 74d0.2bce.fb5e Build AAA QoS Params for addMobileaaa_avgdtus:0, aaa_avgrtdtus:0, aaa_bstdtus:0, aaa_bstrtdtus:0, aaa_avgdtds:0, aaa_avgrtdtds:0, aaa_bstdtds:0, aaa_bstrtdtds:0, aaa_sig:1431655765
2020/07/15 16:48:00.274 {wncd_x_R0-0}{2}: [ewlc-qos-client] [19771]: (info): MAC: 74d0.2bce.fb5e Qos rate-limit parameters encoded successfully in addMobile payload from qos addMobile callback
2020/07/15 16:48:00.274 {wncd_x_R0-0}{2}: [client-auth] [19771]: (note): MAC: 74d0.2bce.fb5e ADD MOBILE sent. Client state flags: 0x32 BSSID: MAC: f40f.1b34.9220 capwap IFID: 0x90000003
2020/07/15 16:48:00.274 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:48:00.274 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.274 {wncd_x_R0-0}{2}: [sanet-shim-translate] [19771]: (info): Anchor Vlan: 760
2020/07/15 16:48:00.274 {wncd_x_R0-0}{2}: [client-orch-state] [19771]: (note): MAC: 74d0.2bce.fb5e Client state transition: S_CO_MOBILITY_DISCOVERY_IN_PROGRESS -> S_CO_DPATH_PLUMB_IN_PROGRESS
2020/07/15 16:48:00.274 {wncd_x_R0-0}{2}: [dot11] [19771]: (note): MAC: 74d0.2bce.fb5e Client datapath entry params - ssid:ImAGuest,slot_id:0 bssid ifid: 0x0, radio_ifid: 0x90000002, wlan_ifid: 0xf0400004
2020/07/15 16:48:00.274 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:48:00.274 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.274 {wncd_x_R0-0}{2}: [sanet-shim-translate] [19771]: (info): Anchor Vlan: 760
2020/07/15 16:48:00.274 {wncd_x_R0-0}{2}: [ewlc-qos-client] [19771]: (info): MAC: 74d0.2bce.fb5e Client QoS dpath create params
2020/07/15 16:48:00.274 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:48:00.274 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.274 {wncd_x_R0-0}{2}: [ewlc-qos-client] [19771]: (info): MAC: 74d0.2bce.fb5e No QoS PM Name or QoS Level received from SANet for pm_dir:0. Check client is fastlane, otherwise set pm name to none
2020/07/15 16:48:00.274 {wncd_x_R0-0}{2}: [avc-afc] [19771]: (debug): AVC disabled for client 74d0.2bce.fb5e
2020/07/15 16:48:00.274 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.274 {wncd_x_R0-0}{2}: [dpath_svc] [19771]: (note): MAC: 74d0.2bce.fb5e Client datapath entry created for ifid 0xa0000010
2020/07/15 16:48:00.274 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:48:00.274 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.275 {wncd_x_R0-0}{2}: [sanet-shim-translate] [19771]: (info): Anchor Vlan: 760
2020/07/15 16:48:00.275 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:48:00.275 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.275 {wncd_x_R0-0}{2}: [sanet-shim-translate] [19771]: (info): Anchor Vlan: 760
2020/07/15 16:48:00.275 {wncd_x_R0-0}{2}: [client-orch-state] [19771]: (note): MAC: 74d0.2bce.fb5e Client state transition: S_CO_DPATH_PLUMB_IN_PROGRESS -> S_CO_IP_LEARN_IN_PROGRESS
2020/07/15 16:48:00.275 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:48:00.275 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.275 {wncd_x_R0-0}{2}: [sanet-shim-translate] [19771]: (info): Anchor Vlan: 760
2020/07/15 16:48:00.275 {wncd_x_R0-0}{2}: [client-orch-sm] [19771]: (debug): MAC: 74d0.2bce.fb5e Received ip learn response. method: IPLEARN_METHOD_ROAMING
2020/07/15 16:48:00.275 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:48:00.275 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.275 {wncd_x_R0-0}{2}: [sanet-shim-translate] [19771]: (info): Anchor Vlan: 760
2020/07/15 16:48:00.275 {wncd_x_R0-0}{2}: [aaa-attr-inf] [19771]: (info): [ Applied attribute : username 0 "74-D0-2B-CE-FB-5E" ]
2020/07/15 16:48:00.275 {wncd_x_R0-0}{2}: [aaa-attr-inf] [19771]: (info): [ Applied attribute : anchor-vlan 0 760 (0x2f8) ]
2020/07/15 16:48:00.275 {wncd_x_R0-0}{2}: [aaa-attr-inf] [19771]: (info): [ Applied attribute : class 0 43 41 43 53 3a 31 36 34 45 30 39 30 41 30 30 30 30 30 30 38 36 35 33 36 30 32 34 30 30 3a 64 68 77 69 73 65 33 2f 33 37 35 36 39 32 39 33 31 2f 38 31 38 32 37 30 ]
2020/07/15 16:48:00.275 {wncd_x_R0-0}{2}: [aaa-attr-inf] [19771]: (info): [ Applied attribute : url-redirect-acl 0 "ISE_Guest_Redirect" ]
2020/07/15 16:48:00.275 {wncd_x_R0-0}{2}: [aaa-attr-inf] [19771]: (info): [ Applied attribute : url-redirect 0 "https://192.168.1.12:8443/portal/gateway?sessionId=164E090A0000008653602400&portal=496304f2-d309-11e4-8349-0050568172ad&action=cwa&token=6524a85367ebf56759f60ecee22669c9" ]
2020/07/15 16:48:00.275 {wncd_x_R0-0}{2}: [aaa-attr-inf] [19771]: (info): [ Applied attribute : bsn-acl-name 0 "ISE_Guest_Redirect" ]
2020/07/15 16:48:00.275 {wncd_x_R0-0}{2}: [aaa-attr-inf] [19771]: (info): [ Applied attribute :bsn-vlan-interface-name 0 "WLC_9840_Mgmt" ]
2020/07/15 16:48:00.275 {wncd_x_R0-0}{2}: [aaa-attr-inf] [19771]: (info): [ Applied attribute : timeout 0 14400 (0x3840) ]
2020/07/15 16:48:00.275 {wncd_x_R0-0}{2}: [ewlc-qos-client] [19771]: (info): MAC: 74d0.2bce.fb5e Client QoS run state handler
2020/07/15 16:48:00.275 {wncd_x_R0-0}{2}: [rog-proxy-capwap] [19771]: (debug): Managed client RUN state notification: 74d0.2bce.fb5e
2020/07/15 16:48:00.275 {wncd_x_R0-0}{2}: [client-orch-state] [19771]: (note): MAC: 74d0.2bce.fb5e Client state transition: S_CO_IP_LEARN_IN_PROGRESS -> S_CO_RUN
2020/07/15 16:48:00.275 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:48:00.276 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.276 {wncd_x_R0-0}{2}: [sanet-shim-translate] [19771]: (info): Anchor Vlan: 760
2020/07/15 16:48:00.276 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:48:00.276 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.276 {wncd_x_R0-0}{2}: [sanet-shim-translate] [19771]: (info): Anchor Vlan: 760
2020/07/15 16:48:00.276 {wncd_x_R0-0}{2}: [ewlc-qos-client] [19771]: (info): MAC: 74d0.2bce.fb5e Client QoS dpath run params
2020/07/15 16:48:00.276 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:48:00.276 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.276 {wncd_x_R0-0}{2}: [ewlc-qos-client] [19771]: (info): MAC: 74d0.2bce.fb5e No QoS PM Name or QoS Level received from SANet for pm_dir:0. Check client is fastlane, otherwise set pm name to none
2020/07/15 16:48:00.276 {wncd_x_R0-0}{2}: [avc-afc] [19771]: (debug): AVC disabled for client 74d0.2bce.fb5e
2020/07/15 16:48:00.276 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.276 {wncd_x_R0-0}{2}: [mm-client] [19771]: (debug): MAC: 74d0.2bce.fb5e Received ipv4_address_update, sub type: 0 of XID (5865) from (MobilityD[0])
2020/07/15 16:48:00.276 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:48:00.276 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.276 {wncd_x_R0-0}{2}: [client-iplearn] [19771]: (note): MAC: 74d0.2bce.fb5e Client IP learn successful. Method: DHCP IP: 192.168.192.152
2020/07/15 16:48:00.276 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.277 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [74d0.2bce.fb5e:capwap_90000003] auth mgr attr change notification is received for attr (8)
2020/07/15 16:48:00.277 {wncd_x_R0-0}{2}: [client-iplearn] [19771]: (info): MAC: 74d0.2bce.fb5e IP-learn state transition: S_IPLEARN_INIT -> S_IPLEARN_COMPLETE
2020/07/15 16:48:00.277 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 0 cur hdl 0x8300007c withclient name BM
2020/07/15 16:48:00.277 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.277 {wncd_x_R0-0}{2}: [mm-transition] [19771]: (info): MAC: 74d0.2bce.fb5e MMIF FSM transition: S_MA_FOREIGN -> S_MA_IPV4_ADDRESS_UPDATE_PROCESSED_TR on E_MA_CO_IPV4_ADDRESS_UPDATE
2020/07/15 16:48:00.277 {wncd_x_R0-0}{2}: [mm-client] [19771]: (debug): MAC: 74d0.2bce.fb5e Mobile IPv4 address update event received.
2020/07/15 16:48:00.277 {wncd_x_R0-0}{2}: [auth-mgr] [19771]: (info): [0000.0000.0000:unknown] Session info 0x55ebed9a1130 hdl 0x3500007c client hdl 2 cur hdl 0x3d00007c withclient name EPM
2020/07/15 16:48:00.277 {wncd_x_R0-0}{2}: [client-auth] [19771]: (info): MAC: 74d0.2bce.fb5e Client auth-interface state transition: S_AUTHIF_WEBAUTH_DONE -> S_AUTHIF_WEBAUTH_DONE

[cwedwards]

Has there been any resolution to this?

[phillip.vansickle]

Yes, it turned out that the issue was the ISE configuration.

The first issue I had (causing redirection every 5 minutes) was having the redirection URL in the final authorization profile in ISE.

However, the second, more concerning issue that I had was that guest access did not seem to work consistently at all.

Turns out that I was pushing Airspace ACLs in the authorization profiles.It worked, but only intermittently.

These authorization profiles were setup for the legacy Airspace controllers (5508/8510) that I am transitioning off of.

Rewrote the authorization profiles and guest access now works consistently.

Redirection Authorization Profile:

Final Authorization Profile (pushed out AFTER the client has successfully authenticated via web auth):

Stumbled across this document that lead to the fix...

https://community.cisco.com/t5/security-documents/ise-and-catalyst-9800-series-integration-guide/ta-p/3753060#toc-hId--1620733215

[phillip.vansickle]

Also, keep in mind that the redirection ACL must be written in reverse and be fully present on the export anchor controller.

The internal  controllers (Foreign) only need the name of the ACL as a reference.

The DACL in the final authorization profile is written as a normal ACL. This ACL does not need to be present on any of the controllers, only in ISE.

Additionally, the export anchor controller can be a 9800CL running in a VM (working great so far). 

[cwedwards]

Thanks for getting back to me.  I am not using ISE but have seemingly the same issue.  TAC is looking into it but nobody seems to be extremely knowledgeable on these controllers yet.  I am also running the 9800CL. 

[net-MG]

Im in the same situation @cwedwards - no ISE, running 9800CL. Did you resolve your issue?