(Cisco Controller) >debug client a4:4e:31:95:8c:c0 (Cisco Controller) >*emWeb: Nov 13 11:23:34.560: a4:4e:31:95:8c:c0 Central Switch = TRUE *DHCP Socket Task: Nov 13 11:24:54.207: a4:4e:31:95:8c:c0 DHCP received op BOOTREQUEST (1) (len 308,vlan 0, port 1, encap 0xec03) *DHCP Socket Task: Nov 13 11:24:54.207: a4:4e:31:95:8c:c0 DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff *DHCP Socket Task: Nov 13 11:24:54.207: a4:4e:31:95:8c:c0 DHCP selecting relay 1 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:24:54.207: a4:4e:31:95:8c:c0 DHCP selected relay 1 - 10.201.205.1 (local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:24:54.207: a4:4e:31:95:8c:c0 DHCP selecting relay 2 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:24:54.207: a4:4e:31:95:8c:c0 DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:24:54.208: a4:4e:31:95:8c:c0 DHCP selecting relay 1 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:24:54.208: a4:4e:31:95:8c:c0 DHCP selected relay 1 - 10.201.205.1 (local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:24:54.208: a4:4e:31:95:8c:c0 DHCP transmitting DHCP DISCOVER (1) *DHCP Socket Task: Nov 13 11:24:54.208: a4:4e:31:95:8c:c0 DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 1 *DHCP Socket Task: Nov 13 11:24:54.208: a4:4e:31:95:8c:c0 DHCP xid: 0x7aacb529 (2058138921), secs: 0, flags: 0 *DHCP Socket Task: Nov 13 11:24:54.208: a4:4e:31:95:8c:c0 DHCP chaddr: a4:4e:31:95:8c:c0 *DHCP Socket Task: Nov 13 11:24:54.208: a4:4e:31:95:8c:c0 DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0 *DHCP Socket Task: Nov 13 11:24:54.208: a4:4e:31:95:8c:c0 DHCP siaddr: 0.0.0.0, giaddr: 10.201.209.2 *DHCP Socket Task: Nov 13 11:24:54.208: a4:4e:31:95:8c:c0 DHCP sending REQUEST to 10.201.209.1 (len 350, port 2, vlan 209) *DHCP Socket Task: Nov 13 11:24:54.208: a4:4e:31:95:8c:c0 DHCP selecting relay 2 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:24:54.208: a4:4e:31:95:8c:c0 DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 0.0.0.0, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:24:58.205: a4:4e:31:95:8c:c0 DHCP received op BOOTREQUEST (1) (len 308,vlan 0, port 1, encap 0xec03) *DHCP Socket Task: Nov 13 11:24:58.205: a4:4e:31:95:8c:c0 DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff *DHCP Socket Task: Nov 13 11:24:58.205: a4:4e:31:95:8c:c0 DHCP selecting relay 1 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:24:58.205: a4:4e:31:95:8c:c0 DHCP selected relay 1 - 10.201.205.1 (local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:24:58.205: a4:4e:31:95:8c:c0 DHCP selecting relay 2 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:24:58.205: a4:4e:31:95:8c:c0 DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:24:58.205: a4:4e:31:95:8c:c0 DHCP selecting relay 1 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:24:58.205: a4:4e:31:95:8c:c0 DHCP selected relay 1 - 10.201.205.1 (local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:24:58.205: a4:4e:31:95:8c:c0 DHCP transmitting DHCP DISCOVER (1) *DHCP Socket Task: Nov 13 11:24:58.205: a4:4e:31:95:8c:c0 DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 1 *DHCP Socket Task: Nov 13 11:24:58.205: a4:4e:31:95:8c:c0 DHCP xid: 0x7aacb529 (2058138921), secs: 1024, flags: 0 *DHCP Socket Task: Nov 13 11:24:58.206: a4:4e:31:95:8c:c0 DHCP chaddr: a4:4e:31:95:8c:c0 *DHCP Socket Task: Nov 13 11:24:58.206: a4:4e:31:95:8c:c0 DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0 *DHCP Socket Task: Nov 13 11:24:58.206: a4:4e:31:95:8c:c0 DHCP siaddr: 0.0.0.0, giaddr: 10.201.209.2 *DHCP Socket Task: Nov 13 11:24:58.206: a4:4e:31:95:8c:c0 DHCP sending REQUEST to 10.201.209.1 (len 350, port 2, vlan 209) *DHCP Socket Task: Nov 13 11:24:58.206: a4:4e:31:95:8c:c0 DHCP selecting relay 2 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:24:58.206: a4:4e:31:95:8c:c0 DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 0.0.0.0, gateway 10.201.209.1, VLAN 209, port 2) *emWeb: Nov 13 11:25:05.449: a4:4e:31:95:8c:c0 Central Switch = TRUE *DHCP Socket Task: Nov 13 11:25:06.212: a4:4e:31:95:8c:c0 DHCP received op BOOTREQUEST (1) (len 308,vlan 0, port 1, encap 0xec03) *DHCP Socket Task: Nov 13 11:25:06.212: a4:4e:31:95:8c:c0 DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff *DHCP Socket Task: Nov 13 11:25:06.212: a4:4e:31:95:8c:c0 DHCP selecting relay 1 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:25:06.212: a4:4e:31:95:8c:c0 DHCP selected relay 1 - 10.201.205.1 (local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:25:06.212: a4:4e:31:95:8c:c0 DHCP selecting relay 2 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:25:06.212: a4:4e:31:95:8c:c0 DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:25:06.212: a4:4e:31:95:8c:c0 DHCP selecting relay 1 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:25:06.213: a4:4e:31:95:8c:c0 DHCP selected relay 1 - 10.201.205.1 (local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:25:06.213: a4:4e:31:95:8c:c0 DHCP transmitting DHCP DISCOVER (1) *DHCP Socket Task: Nov 13 11:25:06.213: a4:4e:31:95:8c:c0 DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 1 *DHCP Socket Task: Nov 13 11:25:06.213: a4:4e:31:95:8c:c0 DHCP xid: 0x7aacb529 (2058138921), secs: 3072, flags: 0 *DHCP Socket Task: Nov 13 11:25:06.213: a4:4e:31:95:8c:c0 DHCP chaddr: a4:4e:31:95:8c:c0 *DHCP Socket Task: Nov 13 11:25:06.213: a4:4e:31:95:8c:c0 DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0 *DHCP Socket Task: Nov 13 11:25:06.213: a4:4e:31:95:8c:c0 DHCP siaddr: 0.0.0.0, giaddr: 10.201.209.2 *DHCP Socket Task: Nov 13 11:25:06.213: a4:4e:31:95:8c:c0 DHCP sending REQUEST to 10.201.209.1 (len 350, port 2, vlan 209) *DHCP Socket Task: Nov 13 11:25:06.213: a4:4e:31:95:8c:c0 DHCP selecting relay 2 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:25:06.213: a4:4e:31:95:8c:c0 DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 0.0.0.0, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:25:21.210: a4:4e:31:95:8c:c0 DHCP received op BOOTREQUEST (1) (len 308,vlan 0, port 1, encap 0xec03) *DHCP Socket Task: Nov 13 11:25:21.210: a4:4e:31:95:8c:c0 DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff *DHCP Socket Task: Nov 13 11:25:21.210: a4:4e:31:95:8c:c0 DHCP selecting relay 1 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:25:21.210: a4:4e:31:95:8c:c0 DHCP selected relay 1 - 10.201.205.1 (local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:25:21.210: a4:4e:31:95:8c:c0 DHCP selecting relay 2 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:25:21.210: a4:4e:31:95:8c:c0 DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:25:21.210: a4:4e:31:95:8c:c0 DHCP selecting relay 1 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:25:21.210: a4:4e:31:95:8c:c0 DHCP selected relay 1 - 10.201.205.1 (local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:25:21.210: a4:4e:31:95:8c:c0 DHCP transmitting DHCP DISCOVER (1) *DHCP Socket Task: Nov 13 11:25:21.210: a4:4e:31:95:8c:c0 DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 1 *DHCP Socket Task: Nov 13 11:25:21.210: a4:4e:31:95:8c:c0 DHCP xid: 0x7aacb529 (2058138921), secs: 6912, flags: 0 *DHCP Socket Task: Nov 13 11:25:21.210: a4:4e:31:95:8c:c0 DHCP chaddr: a4:4e:31:95:8c:c0 *DHCP Socket Task: Nov 13 11:25:21.210: a4:4e:31:95:8c:c0 DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0 *DHCP Socket Task: Nov 13 11:25:21.210: a4:4e:31:95:8c:c0 DHCP siaddr: 0.0.0.0, giaddr: 10.201.209.2 *DHCP Socket Task: Nov 13 11:25:21.210: a4:4e:31:95:8c:c0 DHCP sending REQUEST to 10.201.209.1 (len 350, port 2, vlan 209) *DHCP Socket Task: Nov 13 11:25:21.210: a4:4e:31:95:8c:c0 DHCP selecting relay 2 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:25:21.210: a4:4e:31:95:8c:c0 DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 0.0.0.0, gateway 10.201.209.1, VLAN 209, port 2) *apfPmkCacheTimer: Nov 13 11:25:22.217: a4:4e:31:95:8c:c0 Removing expired PMK cache entry for station a4:4e:31:95:8c:c0 AKM was:APF_KEY_MGMT_80211i *apfPmkCacheTimer: Nov 13 11:25:22.217: a4:4e:31:95:8c:c0 Removing expired PTK entry for station a4:4e:31:95:8c:c0 *apfReceiveTask: Nov 13 11:25:22.217: a4:4e:31:95:8c:c0 Initiating 802.1x due to PMK Timeout Event for STA *apfReceiveTask: Nov 13 11:25:22.217: a4:4e:31:95:8c:c0 Found an cache entry for BSSID 7c:0e:ce:3f:67:7f in PMKID cache at index 0 of station a4:4e:31:95:8c:c0 *apfReceiveTask: Nov 13 11:25:22.217: a4:4e:31:95:8c:c0 Removing BSSID 7c:0e:ce:3f:67:7f from PMKID cache of station a4:4e:31:95:8c:c0 *apfReceiveTask: Nov 13 11:25:22.217: a4:4e:31:95:8c:c0 Resetting MSCB PMK Cache Entry 0 for station a4:4e:31:95:8c:c0 *dot1xMsgTask: Nov 13 11:25:22.218: a4:4e:31:95:8c:c0 EAP-PARAM Debug - eap-params for Wlan-Id :1 is disabled - applying Global eap timers and retries *dot1xMsgTask: Nov 13 11:25:22.218: a4:4e:31:95:8c:c0 dot1x - moving mobile a4:4e:31:95:8c:c0 into Connecting state *dot1xMsgTask: Nov 13 11:25:22.218: a4:4e:31:95:8c:c0 Sending EAP-Request/Identity to mobile a4:4e:31:95:8c:c0 (EAP Id 1) *dot1xMsgTask: Nov 13 11:25:22.218: a4:4e:31:95:8c:c0 mscb->apfMsLwappLradNhMac = 7c:0e:ce:19:e2:0c mscb->apfMsLradSlotId = 1 mscb->apfMsLradJumbo = 0 mscb->apfMsintIfNum = 1 *dot1xMsgTask: Nov 13 11:25:22.218: a4:4e:31:95:8c:c0 mscb->apfMsBssid = 7c:0e:ce:3f:67:70 mscb->apfMsAddress = a4:4e:31:95:8c:c0 mscb->apfMsApVapId = 1 *dot1xMsgTask: Nov 13 11:25:22.218: a4:4e:31:95:8c:c0 dot1xcb->snapOrg = 00 00 00 dot1xcb->eapolWepBit = 1 mscb->apfMsLwappLradVlanId = 0 mscb->apfMsLwappMwarInet.ipv4.addr = 180997605 *dot1xMsgTask: Nov 13 11:25:22.218: a4:4e:31:95:8c:c0 mscb->apfMsLwappMwarPort = 5246 mscb->apfMsLwappLradInet.ipv4.addr = 180997392 mscb->apfMsLwappLradPort = 40482 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.224: a4:4e:31:95:8c:c0 Received EAPOL EAPPKT from mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.224: a4:4e:31:95:8c:c0 Received Identity Response (count=1) from mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.224: a4:4e:31:95:8c:c0 Resetting reauth count 1 to 0 for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.224: a4:4e:31:95:8c:c0 EAP State update from Connecting to Authenticating for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.224: a4:4e:31:95:8c:c0 dot1x - moving mobile a4:4e:31:95:8c:c0 into Authenticating state *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.224: a4:4e:31:95:8c:c0 Entering Backend Auth Response state for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.226: a4:4e:31:95:8c:c0 Processing Access-Challenge for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.226: a4:4e:31:95:8c:c0 Entering Backend Auth Req state (id=235) for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.226: a4:4e:31:95:8c:c0 WARNING: updated EAP-Identifier 1 ===> 235 for STA a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.226: a4:4e:31:95:8c:c0 Sending EAP Request from AAA to mobile a4:4e:31:95:8c:c0 (EAP Id 235) *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.226: a4:4e:31:95:8c:c0 Allocating EAP Pkt for retransmission to mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.226: a4:4e:31:95:8c:c0 mscb->apfMsLwappLradNhMac = 7c:0e:ce:19:e2:0c mscb->apfMsLradSlotId = 1 mscb->apfMsLradJumbo = 0 mscb->apfMsintIfNum = 1 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.226: a4:4e:31:95:8c:c0 mscb->apfMsBssid = 7c:0e:ce:3f:67:70 mscb->apfMsAddress = a4:4e:31:95:8c:c0 mscb->apfMsApVapId = 1 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.226: a4:4e:31:95:8c:c0 dot1xcb->snapOrg = 00 00 00 dot1xcb->eapolWepBit = 1 mscb->apfMsLwappLradVlanId = 0 mscb->apfMsLwappMwarInet.ipv4.addr = 180997605 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.226: a4:4e:31:95:8c:c0 mscb->apfMsLwappMwarPort = 5246 mscb->apfMsLwappLradInet.ipv4.addr = 180997392 mscb->apfMsLwappLradPort = 40482 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.228: a4:4e:31:95:8c:c0 Received EAPOL EAPPKT from mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.228: a4:4e:31:95:8c:c0 Received EAP Response from mobile a4:4e:31:95:8c:c0 (EAP Id 235, EAP Type 3) *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.228: a4:4e:31:95:8c:c0 Resetting reauth count 0 to 0 for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.228: a4:4e:31:95:8c:c0 Entering Backend Auth Response state for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.230: a4:4e:31:95:8c:c0 Processing Access-Challenge for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.230: a4:4e:31:95:8c:c0 Entering Backend Auth Req state (id=236) for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.230: a4:4e:31:95:8c:c0 Sending EAP Request from AAA to mobile a4:4e:31:95:8c:c0 (EAP Id 236) *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.230: a4:4e:31:95:8c:c0 Reusing allocated memory for EAP Pkt for retransmission to mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.230: a4:4e:31:95:8c:c0 mscb->apfMsLwappLradNhMac = 7c:0e:ce:19:e2:0c mscb->apfMsLradSlotId = 1 mscb->apfMsLradJumbo = 0 mscb->apfMsintIfNum = 1 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.230: a4:4e:31:95:8c:c0 mscb->apfMsBssid = 7c:0e:ce:3f:67:70 mscb->apfMsAddress = a4:4e:31:95:8c:c0 mscb->apfMsApVapId = 1 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.230: a4:4e:31:95:8c:c0 dot1xcb->snapOrg = 00 00 00 dot1xcb->eapolWepBit = 1 mscb->apfMsLwappLradVlanId = 0 mscb->apfMsLwappMwarInet.ipv4.addr = 180997605 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.230: a4:4e:31:95:8c:c0 mscb->apfMsLwappMwarPort = 5246 mscb->apfMsLwappLradInet.ipv4.addr = 180997392 mscb->apfMsLwappLradPort = 40482 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.231: a4:4e:31:95:8c:c0 Received EAPOL EAPPKT from mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.231: a4:4e:31:95:8c:c0 Received EAP Response from mobile a4:4e:31:95:8c:c0 (EAP Id 236, EAP Type 25) *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.231: a4:4e:31:95:8c:c0 Resetting reauth count 0 to 0 for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.231: a4:4e:31:95:8c:c0 Entering Backend Auth Response state for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.233: a4:4e:31:95:8c:c0 Processing Access-Challenge for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.233: a4:4e:31:95:8c:c0 Entering Backend Auth Req state (id=237) for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.233: a4:4e:31:95:8c:c0 Sending EAP Request from AAA to mobile a4:4e:31:95:8c:c0 (EAP Id 237) *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.233: a4:4e:31:95:8c:c0 Reusing allocated memory for EAP Pkt for retransmission to mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.233: a4:4e:31:95:8c:c0 mscb->apfMsLwappLradNhMac = 7c:0e:ce:19:e2:0c mscb->apfMsLradSlotId = 1 mscb->apfMsLradJumbo = 0 mscb->apfMsintIfNum = 1 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.233: a4:4e:31:95:8c:c0 mscb->apfMsBssid = 7c:0e:ce:3f:67:70 mscb->apfMsAddress = a4:4e:31:95:8c:c0 mscb->apfMsApVapId = 1 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.233: a4:4e:31:95:8c:c0 dot1xcb->snapOrg = 00 00 00 dot1xcb->eapolWepBit = 1 mscb->apfMsLwappLradVlanId = 0 mscb->apfMsLwappMwarInet.ipv4.addr = 180997605 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.233: a4:4e:31:95:8c:c0 mscb->apfMsLwappMwarPort = 5246 mscb->apfMsLwappLradInet.ipv4.addr = 180997392 mscb->apfMsLwappLradPort = 40482 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.236: a4:4e:31:95:8c:c0 Received EAPOL EAPPKT from mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.236: a4:4e:31:95:8c:c0 Received EAP Response from mobile a4:4e:31:95:8c:c0 (EAP Id 237, EAP Type 25) *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.236: a4:4e:31:95:8c:c0 Resetting reauth count 0 to 0 for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.236: a4:4e:31:95:8c:c0 Entering Backend Auth Response state for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.254: a4:4e:31:95:8c:c0 Processing Access-Challenge for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.254: a4:4e:31:95:8c:c0 Entering Backend Auth Req state (id=238) for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.254: a4:4e:31:95:8c:c0 Sending EAP Request from AAA to mobile a4:4e:31:95:8c:c0 (EAP Id 238) *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.254: a4:4e:31:95:8c:c0 Reusing allocated memory for EAP Pkt for retransmission to mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.254: a4:4e:31:95:8c:c0 mscb->apfMsLwappLradNhMac = 7c:0e:ce:19:e2:0c mscb->apfMsLradSlotId = 1 mscb->apfMsLradJumbo = 0 mscb->apfMsintIfNum = 1 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.254: a4:4e:31:95:8c:c0 mscb->apfMsBssid = 7c:0e:ce:3f:67:70 mscb->apfMsAddress = a4:4e:31:95:8c:c0 mscb->apfMsApVapId = 1 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.254: a4:4e:31:95:8c:c0 dot1xcb->snapOrg = 00 00 00 dot1xcb->eapolWepBit = 1 mscb->apfMsLwappLradVlanId = 0 mscb->apfMsLwappMwarInet.ipv4.addr = 180997605 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.254: a4:4e:31:95:8c:c0 mscb->apfMsLwappMwarPort = 5246 mscb->apfMsLwappLradInet.ipv4.addr = 180997392 mscb->apfMsLwappLradPort = 40482 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.256: a4:4e:31:95:8c:c0 Received EAPOL EAPPKT from mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.256: a4:4e:31:95:8c:c0 Received EAP Response from mobile a4:4e:31:95:8c:c0 (EAP Id 238, EAP Type 25) *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.256: a4:4e:31:95:8c:c0 Resetting reauth count 0 to 0 for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.256: a4:4e:31:95:8c:c0 Entering Backend Auth Response state for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.259: a4:4e:31:95:8c:c0 Processing Access-Accept for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.259: a4:4e:31:95:8c:c0 Resetting web IPv4 acl from 255 to 255 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.259: a4:4e:31:95:8c:c0 Resetting web IPv4 Flex acl from 65535 to 65535 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.259: a4:4e:31:95:8c:c0 interface lookup failed, removing intf group from mscb *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.259: a4:4e:31:95:8c:c0 override for default ap group, marking intgrp NULL *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.259: a4:4e:31:95:8c:c0 Applying Interface policy on Mobile, role Local. Ms NAC State 2 Quarantine Vlan 0 Access Vlan 209 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.259: a4:4e:31:95:8c:c0 Re-applying interface policy for client *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.259: a4:4e:31:95:8c:c0 0.0.0.0 RUN (20) Changing IPv4 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2219) *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.259: a4:4e:31:95:8c:c0 0.0.0.0 RUN (20) Changing IPv6 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2240) *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.259: a4:4e:31:95:8c:c0 apfApplyWlanPolicy: Apply WLAN Policy over PMIPv6 Client Mobility Type *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.259: a4:4e:31:95:8c:c0 Inserting AAA Override struct for mobile MAC: a4:4e:31:95:8c:c0, source 4 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.259: a4:4e:31:95:8c:c0 interface lookup failed, removing intf group from mscb *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.259: a4:4e:31:95:8c:c0 Applying Interface policy on Mobile, role Local. Ms NAC State 2 Quarantine Vlan 0 Access Vlan 0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.259: a4:4e:31:95:8c:c0 Re-applying interface policy for client *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.260: a4:4e:31:95:8c:c0 0.0.0.0 RUN (20) Changing IPv4 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2219) *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.260: a4:4e:31:95:8c:c0 0.0.0.0 RUN (20) Changing IPv6 ACL 'none' (ACL ID 255) ===> 'none' (ACL ID 255) --- (caller apf_policy.c:2240) *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.260: a4:4e:31:95:8c:c0 Applying Local Bridging Interface Policy for station a4:4e:31:95:8c:c0 - vlan 209, interface id 25, interface 'vodacom38' *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.260: a4:4e:31:95:8c:c0 Setting re-auth timeout to 1800 seconds, got from WLAN config. *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.260: a4:4e:31:95:8c:c0 Station a4:4e:31:95:8c:c0 setting dot1x reauth timeout = 1800 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.260: a4:4e:31:95:8c:c0 Creating a PKC PMKID Cache entry for station a4:4e:31:95:8c:c0 (RSN 2) *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.260: a4:4e:31:95:8c:c0 Resetting MSCB PMK Cache Entry 0 for station a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.260: a4:4e:31:95:8c:c0 Setting active key cache index 0 ---> 8 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.260: a4:4e:31:95:8c:c0 Setting active key cache index 8 ---> 0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.260: a4:4e:31:95:8c:c0 Adding BSSID 7c:0e:ce:3f:67:7f to PMKID cache at index 0 for station a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.260: New PMKID: (16) *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.260: [0000] 0a 49 55 bd 12 7e 1c 8e 72 27 d4 b7 20 66 0f 2d *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.260: a4:4e:31:95:8c:c0 Disabling re-auth since PMK lifetime can take care of same. *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.260: a4:4e:31:95:8c:c0 unsetting PmkIdValidatedByAp *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.261: a4:4e:31:95:8c:c0 PMK sent to mobility group *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.261: a4:4e:31:95:8c:c0 Sending EAP-Success to mobile a4:4e:31:95:8c:c0 (EAP Id 238) *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.261: a4:4e:31:95:8c:c0 mscb->apfMsLwappLradNhMac = 7c:0e:ce:19:e2:0c mscb->apfMsLradSlotId = 1 mscb->apfMsLradJumbo = 0 mscb->apfMsintIfNum = 1 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.261: a4:4e:31:95:8c:c0 mscb->apfMsBssid = 7c:0e:ce:3f:67:70 mscb->apfMsAddress = a4:4e:31:95:8c:c0 mscb->apfMsApVapId = 1 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.261: a4:4e:31:95:8c:c0 dot1xcb->snapOrg = 00 00 00 dot1xcb->eapolWepBit = 1 mscb->apfMsLwappLradVlanId = 0 mscb->apfMsLwappMwarInet.ipv4.addr = 180997605 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.261: a4:4e:31:95:8c:c0 mscb->apfMsLwappMwarPort = 5246 mscb->apfMsLwappLradInet.ipv4.addr = 180997392 mscb->apfMsLwappLradPort = 40482 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.261: a4:4e:31:95:8c:c0 Freeing AAACB from Dot1xCB as AAA auth is done for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.261: a4:4e:31:95:8c:c0 EAPOL Header: *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.261: 00000000: 02 03 00 5f ..._ *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.261: a4:4e:31:95:8c:c0 Found an cache entry for BSSID 7c:0e:ce:3f:67:7f in PMKID cache at index 0 of station a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.261: a4:4e:31:95:8c:c0 Found an cache entry for BSSID 7c:0e:ce:3f:67:7f in PMKID cache at index 0 of station a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.261: Including PMKID in M1 (16) *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.261: [0000] 0a 49 55 bd 12 7e 1c 8e 72 27 d4 b7 20 66 0f 2d *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.261: a4:4e:31:95:8c:c0 Starting key exchange to mobile a4:4e:31:95:8c:c0, data packets will be dropped *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.261: a4:4e:31:95:8c:c0 Sending EAPOL-Key Message to mobile a4:4e:31:95:8c:c0 state INITPMK (message 1), replay counter 00.00.00.00.00.00.00.03 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.261: a4:4e:31:95:8c:c0 Sending EAPOL-Key Message to mobile a4:4e:31:95:8c:c0 state INITPMK (message 1), replay counter 00.00.00.00.00.00.00.03 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.261: a4:4e:31:95:8c:c0 Reusing allocated memory for EAP Pkt for retransmission to mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.261: a4:4e:31:95:8c:c0 mscb->apfMsLwappLradNhMac = 7c:0e:ce:19:e2:0c mscb->apfMsLradSlotId = 1 mscb->apfMsLradJumbo = 0 mscb->apfMsintIfNum = 1 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.261: a4:4e:31:95:8c:c0 mscb->apfMsBssid = 7c:0e:ce:3f:67:70 mscb->apfMsAddress = a4:4e:31:95:8c:c0 mscb->apfMsApVapId = 1 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.261: a4:4e:31:95:8c:c0 dot1xcb->snapOrg = 00 00 00 dot1xcb->eapolWepBit = 1 mscb->apfMsLwappLradVlanId = 0 mscb->apfMsLwappMwarInet.ipv4.addr = 180997605 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.262: a4:4e:31:95:8c:c0 mscb->apfMsLwappMwarPort = 5246 mscb->apfMsLwappLradInet.ipv4.addr = 180997392 mscb->apfMsLwappLradPort = 40482 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.262: a4:4e:31:95:8c:c0 Entering Backend Auth Success state (id=238) for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.262: a4:4e:31:95:8c:c0 Received Auth Success while in Authenticating state for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.262: a4:4e:31:95:8c:c0 dot1x - moving mobile a4:4e:31:95:8c:c0 into Authenticated state *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.265: a4:4e:31:95:8c:c0 Received EAPOL-Key from mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.265: a4:4e:31:95:8c:c0 Ignoring invalid EAPOL version (1) in EAPOL-key message from mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.265: a4:4e:31:95:8c:c0 Received EAPOL-key in PTK_START state (message 2) from mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.265: a4:4e:31:95:8c:c0 EAPOL-key M2 with invalid secure bit (set) received from mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:22.270: a4:4e:31:95:8c:c0 Received EAPOL-key M2 with invalid MIC from mobile a4:4e:31:95:8c:c0 version 2 *osapiBsnTimer: Nov 13 11:25:23.309: a4:4e:31:95:8c:c0 802.1x 'timeoutEvt' Timer expired for station a4:4e:31:95:8c:c0 and for message = M2 *dot1xMsgTask: Nov 13 11:25:23.309: a4:4e:31:95:8c:c0 Retransmit 1 of EAPOL-Key M1 (length 121) for mobile a4:4e:31:95:8c:c0 *dot1xMsgTask: Nov 13 11:25:23.309: a4:4e:31:95:8c:c0 mscb->apfMsLwappLradNhMac = 7c:0e:ce:19:e2:0c mscb->apfMsLradSlotId = 1 mscb->apfMsLradJumbo = 0 mscb->apfMsintIfNum = 1 *dot1xMsgTask: Nov 13 11:25:23.309: a4:4e:31:95:8c:c0 mscb->apfMsBssid = 7c:0e:ce:3f:67:70 mscb->apfMsAddress = a4:4e:31:95:8c:c0 mscb->apfMsApVapId = 1 *dot1xMsgTask: Nov 13 11:25:23.309: a4:4e:31:95:8c:c0 dot1xcb->snapOrg = 00 00 00 dot1xcb->eapolWepBit = 1 mscb->apfMsLwappLradVlanId = 0 mscb->apfMsLwappMwarInet.ipv4.addr = 180997605 *dot1xMsgTask: Nov 13 11:25:23.309: a4:4e:31:95:8c:c0 mscb->apfMsLwappMwarPort = 5246 mscb->apfMsLwappLradInet.ipv4.addr = 180997392 mscb->apfMsLwappLradPort = 40482 *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.311: a4:4e:31:95:8c:c0 Received EAPOL-Key from mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.311: a4:4e:31:95:8c:c0 Ignoring invalid EAPOL version (1) in EAPOL-key message from mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.311: a4:4e:31:95:8c:c0 Received EAPOL-key in PTK_START state (message 2) from mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.311: a4:4e:31:95:8c:c0 EAPOL-key M2 with invalid secure bit (set) received from mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.311: a4:4e:31:95:8c:c0 PMK: Sending cache add *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.311: a4:4e:31:95:8c:c0 Stopping retransmission timer for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.311: a4:4e:31:95:8c:c0 EAPOL Header: *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.311: 00000000: 02 03 00 5f ..._ *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.311: a4:4e:31:95:8c:c0 Sending EAPOL-Key Message to mobile a4:4e:31:95:8c:c0 state PTKINITNEGOTIATING (message 3), replay counter 00.00.00.00.00.00.00.05 *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.311: a4:4e:31:95:8c:c0 Sending EAPOL-Key Message to mobile a4:4e:31:95:8c:c0 state PTKINITNEGOTIATING (message 3), replay counter 00.00.00.00.00.00.00.05 *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.311: a4:4e:31:95:8c:c0 Reusing allocated memory for EAP Pkt for retransmission to mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.311: a4:4e:31:95:8c:c0 mscb->apfMsLwappLradNhMac = 7c:0e:ce:19:e2:0c mscb->apfMsLradSlotId = 1 mscb->apfMsLradJumbo = 0 mscb->apfMsintIfNum = 1 *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.311: a4:4e:31:95:8c:c0 mscb->apfMsBssid = 7c:0e:ce:3f:67:70 mscb->apfMsAddress = a4:4e:31:95:8c:c0 mscb->apfMsApVapId = 1 *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.311: a4:4e:31:95:8c:c0 dot1xcb->snapOrg = 00 00 00 dot1xcb->eapolWepBit = 1 mscb->apfMsLwappLradVlanId = 0 mscb->apfMsLwappMwarInet.ipv4.addr = 180997605 *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.311: a4:4e:31:95:8c:c0 mscb->apfMsLwappMwarPort = 5246 mscb->apfMsLwappLradInet.ipv4.addr = 180997392 mscb->apfMsLwappLradPort = 40482 *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.313: a4:4e:31:95:8c:c0 Received EAPOL-Key from mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.313: a4:4e:31:95:8c:c0 Ignoring invalid EAPOL version (1) in EAPOL-key message from mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.313: a4:4e:31:95:8c:c0 Received EAPOL-key in PTKINITNEGOTIATING state (message 4) from mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.313: a4:4e:31:95:8c:c0 Stopping retransmission timer for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.313: a4:4e:31:95:8c:c0 Freeing EAP Retransmit Bufer for mobile a4:4e:31:95:8c:c0 *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.313: a4:4e:31:95:8c:c0 STA [a4:4e:31:95:8c:c0, 0.0.0.0] Deleting Fast Path Rule (8021X_AUTH) *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.313: a4:4e:31:95:8c:c0 apfMsRunStateDec *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.313: a4:4e:31:95:8c:c0 apfMs1xStateDec *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.313: a4:4e:31:95:8c:c0 0.0.0.0 RUN (20) Change state to 8021X_REQD (3) last state RUN (20) *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.313: a4:4e:31:95:8c:c0 apfMs1xStateInc *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.313: a4:4e:31:95:8c:c0 0.0.0.0 8021X_REQD (3) Change state to L2AUTHCOMPLETE (4) last state 8021X_REQD (3) *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.313: a4:4e:31:95:8c:c0 Central switch is TRUE *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.313: a4:4e:31:95:8c:c0 Not Using WMM Compliance code qosCap 00 *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.313: a4:4e:31:95:8c:c0 0.0.0.0 L2AUTHCOMPLETE (4) Plumbed mobile LWAPP rule on AP 7c:0e:ce:3f:67:70 vapId 1 apVapId 1 flex-acl-name: *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.313: a4:4e:31:95:8c:c0 apfMsRunStateInc *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.313: a4:4e:31:95:8c:c0 0.0.0.0 L2AUTHCOMPLETE (4) Change state to RUN (20) last state L2AUTHCOMPLETE (4) *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.313: a4:4e:31:95:8c:c0 0.0.0.0 RUN (20) Reached PLUMBFASTPATH: from line 6321 *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.313: a4:4e:31:95:8c:c0 0.0.0.0 RUN (20) Adding Fast Path rule type = Airespace AP Client on AP 7c:0e:ce:3f:67:70, slot 1, interface = 1, QOS = 1 IPv4 ACL ID = 255, IPv6 ACL ID = 255, L *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.313: a4:4e:31:95:8c:c0 0.0.0.0 RUN (20) Fast Path rule (contd...) 802.1P = 0, DSCP = 0, TokenID = 15206 Local Bridging Vlan = 209, Local Bridging intf id = 25 *Dot1x_NW_MsgTask_0: Nov 13 11:25:23.314: a4:4e:31:95:8c:c0 0.0.0.0 RUN (20) Successfully plumbed mobile rule (IPv4 ACL ID 255, IPv6 ACL ID 255, L2 ACL ID 255) *pemReceiveTask: Nov 13 11:25:23.314: a4:4e:31:95:8c:c0 0.0.0.0 Removed NPU entry. *pemReceiveTask: Nov 13 11:25:23.314: a4:4e:31:95:8c:c0 0.0.0.0 Added NPU entry of type 1, dtlFlags 0x0 *pemReceiveTask: Nov 13 11:25:23.314: a4:4e:31:95:8c:c0 Pushing IPv6: fe80:0000:0000:0000:1d25:aed7:f606:9a86 , and MAC: A4:4E:31:95:8C:C0 , Binding to Data Plane. SUCCESS !! *DHCP Socket Task: Nov 13 11:25:23.319: a4:4e:31:95:8c:c0 DHCP received op BOOTREQUEST (1) (len 308,vlan 0, port 1, encap 0xec03) *DHCP Socket Task: Nov 13 11:25:23.319: a4:4e:31:95:8c:c0 DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff *DHCP Socket Task: Nov 13 11:25:23.319: a4:4e:31:95:8c:c0 DHCP selecting relay 1 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:25:23.319: a4:4e:31:95:8c:c0 DHCP selected relay 1 - 10.201.205.1 (local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:25:23.319: a4:4e:31:95:8c:c0 DHCP selecting relay 2 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:25:23.319: a4:4e:31:95:8c:c0 DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:25:23.319: a4:4e:31:95:8c:c0 DHCP selecting relay 1 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:25:23.319: a4:4e:31:95:8c:c0 DHCP selected relay 1 - 10.201.205.1 (local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:25:23.319: a4:4e:31:95:8c:c0 DHCP transmitting DHCP DISCOVER (1) *DHCP Socket Task: Nov 13 11:25:23.319: a4:4e:31:95:8c:c0 DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 1 *DHCP Socket Task: Nov 13 11:25:23.319: a4:4e:31:95:8c:c0 DHCP xid: 0x796afe20 (2037055008), secs: 0, flags: 0 *DHCP Socket Task: Nov 13 11:25:23.319: a4:4e:31:95:8c:c0 DHCP chaddr: a4:4e:31:95:8c:c0 *DHCP Socket Task: Nov 13 11:25:23.319: a4:4e:31:95:8c:c0 DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0 *DHCP Socket Task: Nov 13 11:25:23.319: a4:4e:31:95:8c:c0 DHCP siaddr: 0.0.0.0, giaddr: 10.201.209.2 *DHCP Socket Task: Nov 13 11:25:23.319: a4:4e:31:95:8c:c0 DHCP sending REQUEST to 10.201.209.1 (len 350, port 2, vlan 209) *DHCP Socket Task: Nov 13 11:25:23.319: a4:4e:31:95:8c:c0 DHCP selecting relay 2 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:25:23.319: a4:4e:31:95:8c:c0 DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 0.0.0.0, gateway 10.201.209.1, VLAN 209, port 2) *apfOrphanSocketTask: Nov 13 11:25:23.610: a4:4e:31:95:8c:c0 Orphan Packet from STA - IP 169.254.154.134 *apfOrphanSocketTask: Nov 13 11:25:23.611: a4:4e:31:95:8c:c0 In apfRegisterIpAddrOnMscb_debug: regType=2 Invalid src IP address, 169.254.154.134 is part of reserved ip address range (caller apf_broff.c:230) *apfOrphanSocketTask: Nov 13 11:25:23.611: a4:4e:31:95:8c:c0 IPv4 Addr: 169:254:154:134 *IPv6_Msg_Task: Nov 13 11:25:23.612: a4:4e:31:95:8c:c0 Link Local address fe80::1d25:aed7:f606:9a86 updated to mscb. Not Advancing pem state.Current state: mscb in apfMsMmInitial mobility state and client state APF_MS_STATE_A *DHCP Socket Task: Nov 13 11:25:27.311: a4:4e:31:95:8c:c0 DHCP received op BOOTREQUEST (1) (len 308,vlan 0, port 1, encap 0xec03) *DHCP Socket Task: Nov 13 11:25:27.311: a4:4e:31:95:8c:c0 DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff *DHCP Socket Task: Nov 13 11:25:27.311: a4:4e:31:95:8c:c0 DHCP selecting relay 1 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 0.0.0.0 VLAN: 0 *DHCP Socket Task: Nov 13 11:25:27.311: a4:4e:31:95:8c:c0 DHCP selected relay 1 - 10.201.205.1 (local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:25:27.311: a4:4e:31:95:8c:c0 DHCP selecting relay 2 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:25:27.311: a4:4e:31:95:8c:c0 DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:25:27.311: a4:4e:31:95:8c:c0 DHCP selecting relay 1 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:25:27.311: a4:4e:31:95:8c:c0 DHCP selected relay 1 - 10.201.205.1 (local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:25:27.312: a4:4e:31:95:8c:c0 DHCP transmitting DHCP DISCOVER (1) *DHCP Socket Task: Nov 13 11:25:27.312: a4:4e:31:95:8c:c0 DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 1 *DHCP Socket Task: Nov 13 11:25:27.312: a4:4e:31:95:8c:c0 DHCP xid: 0x796afe20 (2037055008), secs: 1024, flags: 0 *DHCP Socket Task: Nov 13 11:25:27.312: a4:4e:31:95:8c:c0 DHCP chaddr: a4:4e:31:95:8c:c0 *DHCP Socket Task: Nov 13 11:25:27.312: a4:4e:31:95:8c:c0 DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0 *DHCP Socket Task: Nov 13 11:25:27.312: a4:4e:31:95:8c:c0 DHCP siaddr: 0.0.0.0, giaddr: 10.201.209.2 *DHCP Socket Task: Nov 13 11:25:27.312: a4:4e:31:95:8c:c0 DHCP sending REQUEST to 10.201.209.1 (len 350, port 2, vlan 209) *DHCP Socket Task: Nov 13 11:25:27.312: a4:4e:31:95:8c:c0 DHCP selecting relay 2 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:25:27.312: a4:4e:31:95:8c:c0 DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 0.0.0.0, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:25:34.319: a4:4e:31:95:8c:c0 DHCP received op BOOTREQUEST (1) (len 308,vlan 0, port 1, encap 0xec03) *DHCP Socket Task: Nov 13 11:25:34.319: a4:4e:31:95:8c:c0 DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff *DHCP Socket Task: Nov 13 11:25:34.320: a4:4e:31:95:8c:c0 DHCP selecting relay 1 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:25:34.320: a4:4e:31:95:8c:c0 DHCP selected relay 1 - 10.201.205.1 (local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:25:34.320: a4:4e:31:95:8c:c0 DHCP selecting relay 2 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:25:34.320: a4:4e:31:95:8c:c0 DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:25:34.320: a4:4e:31:95:8c:c0 DHCP selecting relay 1 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:25:34.320: a4:4e:31:95:8c:c0 DHCP selected relay 1 - 10.201.205.1 (local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:25:34.320: a4:4e:31:95:8c:c0 DHCP transmitting DHCP DISCOVER (1) *DHCP Socket Task: Nov 13 11:25:34.320: a4:4e:31:95:8c:c0 DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 1 *DHCP Socket Task: Nov 13 11:25:34.320: a4:4e:31:95:8c:c0 DHCP xid: 0x796afe20 (2037055008), secs: 2816, flags: 0 *DHCP Socket Task: Nov 13 11:25:34.320: a4:4e:31:95:8c:c0 DHCP chaddr: a4:4e:31:95:8c:c0 *DHCP Socket Task: Nov 13 11:25:34.320: a4:4e:31:95:8c:c0 DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0 *DHCP Socket Task: Nov 13 11:25:34.320: a4:4e:31:95:8c:c0 DHCP siaddr: 0.0.0.0, giaddr: 10.201.209.2 *DHCP Socket Task: Nov 13 11:25:34.320: a4:4e:31:95:8c:c0 DHCP sending REQUEST to 10.201.209.1 (len 350, port 2, vlan 209) *DHCP Socket Task: Nov 13 11:25:34.320: a4:4e:31:95:8c:c0 DHCP selecting relay 2 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:25:34.320: a4:4e:31:95:8c:c0 DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 0.0.0.0, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:25:49.435: a4:4e:31:95:8c:c0 DHCP received op BOOTREQUEST (1) (len 308,vlan 0, port 1, encap 0xec03) *DHCP Socket Task: Nov 13 11:25:49.435: a4:4e:31:95:8c:c0 DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff *DHCP Socket Task: Nov 13 11:25:49.436: a4:4e:31:95:8c:c0 DHCP selecting relay 1 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:25:49.436: a4:4e:31:95:8c:c0 DHCP selected relay 1 - 10.201.205.1 (local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:25:49.436: a4:4e:31:95:8c:c0 DHCP selecting relay 2 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:25:49.436: a4:4e:31:95:8c:c0 DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:25:49.436: a4:4e:31:95:8c:c0 DHCP selecting relay 1 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:25:49.436: a4:4e:31:95:8c:c0 DHCP selected relay 1 - 10.201.205.1 (local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:25:49.436: a4:4e:31:95:8c:c0 DHCP transmitting DHCP DISCOVER (1) *DHCP Socket Task: Nov 13 11:25:49.436: a4:4e:31:95:8c:c0 DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 1 *DHCP Socket Task: Nov 13 11:25:49.436: a4:4e:31:95:8c:c0 DHCP xid: 0x796afe20 (2037055008), secs: 6656, flags: 0 *DHCP Socket Task: Nov 13 11:25:49.436: a4:4e:31:95:8c:c0 DHCP chaddr: a4:4e:31:95:8c:c0 *DHCP Socket Task: Nov 13 11:25:49.436: a4:4e:31:95:8c:c0 DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0 *DHCP Socket Task: Nov 13 11:25:49.436: a4:4e:31:95:8c:c0 DHCP siaddr: 0.0.0.0, giaddr: 10.201.209.2 *DHCP Socket Task: Nov 13 11:25:49.436: a4:4e:31:95:8c:c0 DHCP sending REQUEST to 10.201.209.1 (len 350, port 2, vlan 209) *DHCP Socket Task: Nov 13 11:25:49.436: a4:4e:31:95:8c:c0 DHCP selecting relay 2 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:25:49.436: a4:4e:31:95:8c:c0 DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 0.0.0.0, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:25:49.436: a4:4e:31:95:8c:c0 Interface Group was NULL.Number of DHCP Discovery 3 from client *DHCP Socket Task: Nov 13 11:26:22.433: a4:4e:31:95:8c:c0 DHCP received op BOOTREQUEST (1) (len 308,vlan 0, port 1, encap 0xec03) *DHCP Socket Task: Nov 13 11:26:22.433: a4:4e:31:95:8c:c0 DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff *DHCP Socket Task: Nov 13 11:26:22.433: a4:4e:31:95:8c:c0 DHCP selecting relay 1 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:26:22.433: a4:4e:31:95:8c:c0 DHCP selected relay 1 - 10.201.205.1 (local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:26:22.433: a4:4e:31:95:8c:c0 DHCP selecting relay 2 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:26:22.433: a4:4e:31:95:8c:c0 DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:26:22.433: a4:4e:31:95:8c:c0 DHCP selecting relay 1 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:26:22.433: a4:4e:31:95:8c:c0 DHCP selected relay 1 - 10.201.205.1 (local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:26:22.433: a4:4e:31:95:8c:c0 DHCP transmitting DHCP DISCOVER (1) *DHCP Socket Task: Nov 13 11:26:22.433: a4:4e:31:95:8c:c0 DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 1 *DHCP Socket Task: Nov 13 11:26:22.433: a4:4e:31:95:8c:c0 DHCP xid: 0xbc3729fa (3157731834), secs: 0, flags: 8000 *DHCP Socket Task: Nov 13 11:26:22.433: a4:4e:31:95:8c:c0 DHCP chaddr: a4:4e:31:95:8c:c0 *DHCP Socket Task: Nov 13 11:26:22.433: a4:4e:31:95:8c:c0 DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0 *DHCP Socket Task: Nov 13 11:26:22.433: a4:4e:31:95:8c:c0 DHCP siaddr: 0.0.0.0, giaddr: 10.201.209.2 *DHCP Socket Task: Nov 13 11:26:22.434: a4:4e:31:95:8c:c0 DHCP sending REQUEST to 10.201.209.1 (len 350, port 2, vlan 209) *DHCP Socket Task: Nov 13 11:26:22.434: a4:4e:31:95:8c:c0 DHCP selecting relay 2 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:26:22.434: a4:4e:31:95:8c:c0 DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 0.0.0.0, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:26:26.433: a4:4e:31:95:8c:c0 DHCP received op BOOTREQUEST (1) (len 308,vlan 0, port 1, encap 0xec03) *DHCP Socket Task: Nov 13 11:26:26.433: a4:4e:31:95:8c:c0 DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff *DHCP Socket Task: Nov 13 11:26:26.433: a4:4e:31:95:8c:c0 DHCP selecting relay 1 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:26:26.434: a4:4e:31:95:8c:c0 DHCP selected relay 1 - 10.201.205.1 (local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:26:26.434: a4:4e:31:95:8c:c0 DHCP selecting relay 2 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:26:26.434: a4:4e:31:95:8c:c0 DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:26:26.434: a4:4e:31:95:8c:c0 DHCP selecting relay 1 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:26:26.434: a4:4e:31:95:8c:c0 DHCP selected relay 1 - 10.201.205.1 (local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:26:26.434: a4:4e:31:95:8c:c0 DHCP transmitting DHCP DISCOVER (1) *DHCP Socket Task: Nov 13 11:26:26.434: a4:4e:31:95:8c:c0 DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 1 *DHCP Socket Task: Nov 13 11:26:26.434: a4:4e:31:95:8c:c0 DHCP xid: 0xbc3729fa (3157731834), secs: 1024, flags: 8000 *DHCP Socket Task: Nov 13 11:26:26.434: a4:4e:31:95:8c:c0 DHCP chaddr: a4:4e:31:95:8c:c0 *DHCP Socket Task: Nov 13 11:26:26.434: a4:4e:31:95:8c:c0 DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0 *DHCP Socket Task: Nov 13 11:26:26.434: a4:4e:31:95:8c:c0 DHCP siaddr: 0.0.0.0, giaddr: 10.201.209.2 *DHCP Socket Task: Nov 13 11:26:26.434: a4:4e:31:95:8c:c0 DHCP sending REQUEST to 10.201.209.1 (len 350, port 2, vlan 209) *DHCP Socket Task: Nov 13 11:26:26.434: a4:4e:31:95:8c:c0 DHCP selecting relay 2 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:26:26.434: a4:4e:31:95:8c:c0 DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 0.0.0.0, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:26:34.438: a4:4e:31:95:8c:c0 DHCP received op BOOTREQUEST (1) (len 308,vlan 0, port 1, encap 0xec03) *DHCP Socket Task: Nov 13 11:26:34.438: a4:4e:31:95:8c:c0 DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff *DHCP Socket Task: Nov 13 11:26:34.438: a4:4e:31:95:8c:c0 DHCP selecting relay 1 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:26:34.438: a4:4e:31:95:8c:c0 DHCP selected relay 1 - 10.201.205.1 (local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:26:34.438: a4:4e:31:95:8c:c0 DHCP selecting relay 2 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:26:34.438: a4:4e:31:95:8c:c0 DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:26:34.438: a4:4e:31:95:8c:c0 DHCP selecting relay 1 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:26:34.438: a4:4e:31:95:8c:c0 DHCP selected relay 1 - 10.201.205.1 (local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:26:34.438: a4:4e:31:95:8c:c0 DHCP transmitting DHCP DISCOVER (1) *DHCP Socket Task: Nov 13 11:26:34.438: a4:4e:31:95:8c:c0 DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 1 *DHCP Socket Task: Nov 13 11:26:34.438: a4:4e:31:95:8c:c0 DHCP xid: 0xbc3729fa (3157731834), secs: 3072, flags: 8000 *DHCP Socket Task: Nov 13 11:26:34.438: a4:4e:31:95:8c:c0 DHCP chaddr: a4:4e:31:95:8c:c0 *DHCP Socket Task: Nov 13 11:26:34.438: a4:4e:31:95:8c:c0 DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0 *DHCP Socket Task: Nov 13 11:26:34.438: a4:4e:31:95:8c:c0 DHCP siaddr: 0.0.0.0, giaddr: 10.201.209.2 *DHCP Socket Task: Nov 13 11:26:34.438: a4:4e:31:95:8c:c0 DHCP sending REQUEST to 10.201.209.1 (len 350, port 2, vlan 209) *DHCP Socket Task: Nov 13 11:26:34.438: a4:4e:31:95:8c:c0 DHCP selecting relay 2 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:26:34.438: a4:4e:31:95:8c:c0 DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 0.0.0.0, gateway 10.201.209.1, VLAN 209, port 2) *emWeb: Nov 13 11:26:36.220: a4:4e:31:95:8c:c0 Central Switch = TRUE *DHCP Socket Task: Nov 13 11:26:49.444: a4:4e:31:95:8c:c0 DHCP received op BOOTREQUEST (1) (len 308,vlan 0, port 1, encap 0xec03) *DHCP Socket Task: Nov 13 11:26:49.445: a4:4e:31:95:8c:c0 DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff *DHCP Socket Task: Nov 13 11:26:49.445: a4:4e:31:95:8c:c0 DHCP selecting relay 1 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:26:49.445: a4:4e:31:95:8c:c0 DHCP selected relay 1 - 10.201.205.1 (local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:26:49.445: a4:4e:31:95:8c:c0 DHCP selecting relay 2 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:26:49.445: a4:4e:31:95:8c:c0 DHCP selected relay 2 - NONE (server address 0.0.0.0,local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:26:49.445: a4:4e:31:95:8c:c0 DHCP selecting relay 1 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209 *DHCP Socket Task: Nov 13 11:26:49.445: a4:4e:31:95:8c:c0 DHCP selected relay 1 - 10.201.205.1 (local address 10.201.209.2, gateway 10.201.209.1, VLAN 209, port 2) *DHCP Socket Task: Nov 13 11:26:49.445: a4:4e:31:95:8c:c0 DHCP transmitting DHCP DISCOVER (1) *DHCP Socket Task: Nov 13 11:26:49.445: a4:4e:31:95:8c:c0 DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 1 *DHCP Socket Task: Nov 13 11:26:49.445: a4:4e:31:95:8c:c0 DHCP xid: 0xbc3729fa (3157731834), secs: 6912, flags: 8000 *DHCP Socket Task: Nov 13 11:26:49.445: a4:4e:31:95:8c:c0 DHCP chaddr: a4:4e:31:95:8c:c0 *DHCP Socket Task: Nov 13 11:26:49.445: a4:4e:31:95:8c:c0 DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0 *DHCP Socket Task: Nov 13 11:26:49.445: a4:4e:31:95:8c:c0 DHCP siaddr: 0.0.0.0, giaddr: 10.201.209.2 *DHCP Socket Task: Nov 13 11:26:49.445: a4:4e:31:95:8c:c0 DHCP sending REQUEST to 10.201.209.1 (len 350, port 2, vlan 209) *DHCP Socket Task: Nov 13 11:26:49.445: a4:4e:31:95:8c:c0 DHCP selecting relay 2 - control block settings: dhcpServer: 0.0.0.0, dhcpNetmask: 0.0.0.0, dhcpGateway: 0.0.0.0, dhcpRelay: 10.201.209.2 VLAN: 209