(Cisco Controller) >*apfOpenDtlSocket: Mar 06 15:42:14.687: b8:63:4d:1b:9f:05 Recevied management frame ASSOCIATION REQUEST on BSSID 40:01:7a:75:1e:6e destination addr 40:01:7a:75:1e:6e *apfMsConnTask_0: Mar 06 15:42:14.687: b8:63:4d:1b:9f:05 Updating 11r vendor IE *apfMsConnTask_0: Mar 06 15:42:14.688: b8:63:4d:1b:9f:05 Applying site-specific Local Bridging override for station b8:63:4d:1b:9f:05 - vapId 2, site 'LAB-INTERNAL', interface 'sn-int1' *apfMsConnTask_0: Mar 06 15:42:14.688: b8:63:4d:1b:9f:05 Applying Local Bridging Interface Policy for station b8:63:4d:1b:9f:05 - vlan 960, interface id 13, interface 'sn-int1' *apfMsConnTask_0: Mar 06 15:42:14.689: b8:63:4d:1b:9f:05 processSsidIE statusCode is 0 and status is 0 *apfMsConnTask_0: Mar 06 15:42:14.689: b8:63:4d:1b:9f:05 processSsidIE ssid_done_flag is 0 finish_flag is 0 *apfMsConnTask_0: Mar 06 15:42:14.689: b8:63:4d:1b:9f:05 STA - rates (8): 140 18 152 36 176 72 96 108 0 0 0 0 0 0 0 0 *apfMsConnTask_0: Mar 06 15:42:14.689: b8:63:4d:1b:9f:05 suppRates statusCode is 0 and gotSuppRatesElement is 1 *apfMsConnTask_0: Mar 06 15:42:14.689: b8:63:4d:1b:9f:05 Marking this mobile as TGr capable. *apfMsConnTask_0: Mar 06 15:42:14.689: RSNIE in Assoc. Req.: (20) *apfMsConnTask_0: Mar 06 15:42:14.689: [0000] 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f *apfMsConnTask_0: Mar 06 15:42:14.689: [0016] ac 04 0c 00 *apfMsConnTask_0: Mar 06 15:42:14.689: b8:63:4d:1b:9f:05 Processing RSN IE type 48, length 20 for mobile b8:63:4d:1b:9f:05 *apfMsConnTask_0: Mar 06 15:42:14.689: b8:63:4d:1b:9f:05 Selected Unicast cipher CCMP128 for client device *apfMsConnTask_0: Mar 06 15:42:14.689: b8:63:4d:1b:9f:05 RSN Capabilities: 12 *apfMsConnTask_0: Mar 06 15:42:14.689: b8:63:4d:1b:9f:05 Marking Mobile as non-11w Capable *apfMsConnTask_0: Mar 06 15:42:14.689: b8:63:4d:1b:9f:05 Validating FT AKM's on WLAN *apfMsConnTask_0: Mar 06 15:42:14.689: b8:63:4d:1b:9f:05 Setting adaptive AKM 4 into RSN Data at 19 *apfMsConnTask_0: Mar 06 15:42:14.689: b8:63:4d:1b:9f:05 Allocate AID 1 slot 1 on AP KZ-TEST-2800.80BC #clients on this slot 1 *apfMsConnTask_0: Mar 06 15:42:14.689: b8:63:4d:1b:9f:05 0.0.0.0 START (0) Initializing policy *apfMsConnTask_0: Mar 06 15:42:14.689: b8:63:4d:1b:9f:05 0.0.0.0 START (0) Change state to AUTHCHECK (2) last state START (0) *apfMsConnTask_0: Mar 06 15:42:14.689: b8:63:4d:1b:9f:05 apfVapSecurity=0x40004000 L2=16384 SkipWeb=0 *apfMsConnTask_0: Mar 06 15:42:14.689: b8:63:4d:1b:9f:05 AuthenticationRequired = 1 *apfMsConnTask_0: Mar 06 15:42:14.689: b8:63:4d:1b:9f:05 0.0.0.0 AUTHCHECK (2) Change state to 8021X_REQD (3) last state AUTHCHECK (2) *apfMsConnTask_0: Mar 06 15:42:14.689: b8:63:4d:1b:9f:05 Encryption policy is set to 0x80000001 *apfMsConnTask_0: Mar 06 15:42:14.689: b8:63:4d:1b:9f:05 Not Using WMM Compliance code qosCap 00 *apfMsConnTask_0: Mar 06 15:42:14.689: b8:63:4d:1b:9f:05 Vlan while overriding the policy = -1 *apfMsConnTask_0: Mar 06 15:42:14.689: b8:63:4d:1b:9f:05 0.0.0.0 8021X_REQD (3) Plumbed mobile LWAPP rule on AP 40:01:7a:75:1e:60 vapId 2 apVapId 2 flex-acl-name: *apfMsConnTask_0: Mar 06 15:42:14.689: b8:63:4d:1b:9f:05 apfMsAssoStateInc *apfMsConnTask_0: Mar 06 15:42:14.690: b8:63:4d:1b:9f:05 apfMsWepPskStateInc *apfMsConnTask_0: Mar 06 15:42:14.690: b8:63:4d:1b:9f:05 apfPemAddUser2 (apf_policy.c:416) Changing state for mobile b8:63:4d:1b:9f:05 on AP 40:01:7a:75:1e:60 from Idle to Associated *apfMsConnTask_0: Mar 06 15:42:14.690: b8:63:4d:1b:9f:05 apfPemAddUser2:session timeout forstation b8:63:4d:1b:9f:05 - Session Tout 25000, apfMsTimeOut '25000' and sessionTimerRunning flag is 0 *apfMsConnTask_0: Mar 06 15:42:14.690: b8:63:4d:1b:9f:05 Scheduling deletion of Mobile Station: (callerId: 49) in 25000 seconds *apfMsConnTask_0: Mar 06 15:42:14.690: b8:63:4d:1b:9f:05 Func: apfPemAddUser2, Ms Timeout = 25000, Session Timeout = 25000 *apfMsConnTask_0: Mar 06 15:42:14.690: b8:63:4d:1b:9f:05 Sending assoc-resp with status 0 station:b8:63:4d:1b:9f:05 AP:40:01:7a:75:1e:60-01 on apVapId 2 *apfMsConnTask_0: Mar 06 15:42:14.690: b8:63:4d:1b:9f:05 VHT Operation IE: width 20/0 ch 64 freq0 0 freq1 0 msc0 0x3f msc1 0x3f *apfMsConnTask_0: Mar 06 15:42:14.690: b8:63:4d:1b:9f:05 Including FT Mobility Domain IE (length 5) in Initial assoc Resp to mobile *apfMsConnTask_0: Mar 06 15:42:14.690: b8:63:4d:1b:9f:05 Sending R1KH-ID as e0:5f:b9:46:78:00 *apfMsConnTask_0: Mar 06 15:42:14.690: b8:63:4d:1b:9f:05 Sending R0KH-ID as:-84.28.20.4 *apfMsConnTask_0: Mar 06 15:42:14.690: b8:63:4d:1b:9f:05 Including FT IE (length 98) in Initial Assoc Resp to mobile *apfMsConnTask_0: Mar 06 15:42:14.690: b8:63:4d:1b:9f:05 Sending Assoc Response (status: '0') to station on AP KZ-TEST-2800.80BC on BSSID 40:01:7a:75:1e:6e ApVapId 2 Slot 1, mobility role 0 *apfMsConnTask_0: Mar 06 15:42:14.690: b8:63:4d:1b:9f:05 apfProcessAssocReq (apf_80211.c:11039) Changing state for mobile b8:63:4d:1b:9f:05 on AP 40:01:7a:75:1e:60 from Associated to Associated *spamApTask7: Mar 06 15:42:14.691: b8:63:4d:1b:9f:05 Successful transmission of LWAPP Add-Mobile to AP 40:01:7a:75:1e:60 *spamApTask7: Mar 06 15:42:14.739: b8:63:4d:1b:9f:05 Received ADD_MOBILE ack - Initiating 1x to STA b8:63:4d:1b:9f:05 (idx 89) *spamApTask7: Mar 06 15:42:14.739: b8:63:4d:1b:9f:05 Sent dot1x auth initiate message for mobile b8:63:4d:1b:9f:05 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.739: b8:63:4d:1b:9f:05 reauth_sm state transition 0 ---> 1 for mobile b8:63:4d:1b:9f:05 at 1x_reauth_sm.c:47 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.739: b8:63:4d:1b:9f:05 Creating a PKC PMKID Cache entry for station b8:63:4d:1b:9f:05 (RSN 2) *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.739: b8:63:4d:1b:9f:05 Resetting MSCB PMK Cache Entry @index 0 for station b8:63:4d:1b:9f:05 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.740: b8:63:4d:1b:9f:05 Setting active key cache index 8 ---> 8 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.740: b8:63:4d:1b:9f:05 Setting active key cache index 8 ---> 0 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.740: b8:63:4d:1b:9f:05 Created PMKID PMK Cache for BSSID 40:01:7a:75:1e:6e at index 0 for station b8:63:4d:1b:9f:05 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.740: New PMKID: (16) *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.740: [0000] e1 4a 46 7a 13 5e aa 51 bf 2a aa 26 e1 56 81 d2 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.740: b8:63:4d:1b:9f:05 Creating global PMK cache for this TGr client *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.740: b8:63:4d:1b:9f:05 Created PMK Cache Entry for TGr AKM:PSK b8:63:4d:1b:9f:05 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.740: b8:63:4d:1b:9f:05 R0KH-ID:172.28.20.4 R1KH-ID:e0:5f:b9:46:78:00 MSK Len:48 pmkValidTime:25027 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.740: b8:63:4d:1b:9f:05 apfCreatePmkCacheEntry: added a new pmk cache entry for b8:63:4d:1b:9f:05 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.740: b8:63:4d:1b:9f:05 Adding Audit session ID payload in Mobility handoff *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.740: b8:63:4d:1b:9f:05 0 PMK-update groupcast messages sent *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.740: b8:63:4d:1b:9f:05 Initiating RSN PSK to mobile b8:63:4d:1b:9f:05 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.740: b8:63:4d:1b:9f:05 EAP-PARAM Debug - eap-params for Wlan-Id :2 is disabled - applying Global eap timers and retries *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.740: b8:63:4d:1b:9f:05 Disable re-auth, use PMK lifetime. *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.740: b8:63:4d:1b:9f:05 dot1x - moving mobile b8:63:4d:1b:9f:05 into Force Auth state *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.740: b8:63:4d:1b:9f:05 Skipping EAP-Success to mobile b8:63:4d:1b:9f:05 (encryptBit:0) *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.740: b8:63:4d:1b:9f:05 Found an cache entry for BSSID 40:01:7a:75:1e:6e in PMKID cache at index 0 of station b8:63:4d:1b:9f:05 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.741: b8:63:4d:1b:9f:05 Found an cache entry for BSSID 40:01:7a:75:1e:6e in PMKID cache at index 0 of station b8:63:4d:1b:9f:05 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.741: Including PMKID in M1 (16) *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.741: [0000] e1 4a 46 7a 13 5e aa 51 bf 2a aa 26 e1 56 81 d2 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.741: M1 - Key Data: (22) *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.741: [0000] dd 14 00 0f ac 04 e1 4a 46 7a 13 5e aa 51 bf 2a *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.741: [0016] aa 26 e1 56 81 d2 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.741: b8:63:4d:1b:9f:05 Starting key exchange to mobile b8:63:4d:1b:9f:05, data packets will be dropped *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.741: b8:63:4d:1b:9f:05 Sending EAPOL-Key Message to mobile b8:63:4d:1b:9f:05 state INITPMK (message 1), replay counter 00.00.00.00.00.00.00.00 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.741: b8:63:4d:1b:9f:05 Allocating EAP Pkt for retransmission to mobile b8:63:4d:1b:9f:05 *dot1xSocketTask: Mar 06 15:42:14.772: b8:63:4d:1b:9f:05 validating eapol pkt: key version = 3 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.772: b8:63:4d:1b:9f:05 Received EAPOL-Key from mobile b8:63:4d:1b:9f:05 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.772: b8:63:4d:1b:9f:05 key Desc Version FT - 1 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.772: b8:63:4d:1b:9f:05 Received EAPOL-key in PTK_START state (message 2) from mobile b8:63:4d:1b:9f:05 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.772: b8:63:4d:1b:9f:05 Encryption Policy: 4, PTK Key Length: 48 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.772: R1KHID+S1KHID: (12) *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.772: [0000] e0 5f b9 46 78 00 b8 63 4d 1b 9f 05 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.773: b8:63:4d:1b:9f:05 Successfully computed PTK from PMK!!! *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.773: b8:63:4d:1b:9f:05 Received valid MIC in EAPOL Key Message M2!!!!! *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.773: b8:63:4d:1b:9f:05 Compare RSN IE in association and EAPOL-M2 frame(Skip pmkIdLen:16,and grpMgmtCipherLen:0) *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.773: b8:63:4d:1b:9f:05 Dumping RSNIE received in Association request: *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.773: 00000000: 30 14 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 0............... *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.773: 00000010: 00 0f ac 04 0c 00 ...... *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.773: b8:63:4d:1b:9f:05 Dumping RSNIE received in EAPOL M2 : *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.773: 00000000: 01 00 00 0f ac 04 01 00 00 0f ac 04 01 00 00 0f ................ *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.773: 00000010: ac 04 0c 00 01 00 ba 26 d1 f8 7a 14 c8 75 38 b6 .......&..z..u8. *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.773: 00000020: 9f 1b 76 8e bf a1 ..v... *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.773: b8:63:4d:1b:9f:05 11r-FT: Validate MDIE info in M2 message from mobile *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.773: b8:63:4d:1b:9f:05 Calculating PMKR0Name *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.773: b8:63:4d:1b:9f:05 Encrypt EAPOL packets = FALSE *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.773: b8:63:4d:1b:9f:05 Validate the 11r FTIE element received in the M2 against the assoc respnse FTIE *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.773: b8:63:4d:1b:9f:05 Received FTIE matches with what is being sent in Assoc Response frame *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.773: b8:63:4d:1b:9f:05 Successfully validated the FTIE in M2 with IE sent in association response *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.773: b8:63:4d:1b:9f:05 Not Flex client. Do not distribute dot11r Key cache. *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.773: b8:63:4d:1b:9f:05 Stopping retransmission timer for mobile b8:63:4d:1b:9f:05 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.773: b8:63:4d:1b:9f:05 key Desc Version FT - 1 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.774: b8:63:4d:1b:9f:05 key Desc Version FT - 1 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.774: b8:63:4d:1b:9f:05 Sending EAPOL-Key Message to mobile b8:63:4d:1b:9f:05 state PTKINITNEGOTIATING (message 3), replay counter 00.00.00.00.00.00.00.01 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.774: b8:63:4d:1b:9f:05 Reusing allocated memory for EAP Pkt for retransmission to mobile b8:63:4d:1b:9f:05 *dot1xSocketTask: Mar 06 15:42:14.802: b8:63:4d:1b:9f:05 validating eapol pkt: key version = 3 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.802: b8:63:4d:1b:9f:05 Received EAPOL-Key from mobile b8:63:4d:1b:9f:05 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.802: b8:63:4d:1b:9f:05 key Desc Version FT - 1 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.802: b8:63:4d:1b:9f:05 Received EAPOL-key in PTKINITNEGOTIATING state (message 4) from mobile b8:63:4d:1b:9f:05 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.802: b8:63:4d:1b:9f:05 Stopping retransmission timer for mobile b8:63:4d:1b:9f:05 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.802: b8:63:4d:1b:9f:05 Freeing EAP Retransmit Bufer for mobile b8:63:4d:1b:9f:05 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.802: b8:63:4d:1b:9f:05 apfMs1xStateInc *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.802: b8:63:4d:1b:9f:05 0.0.0.0 8021X_REQD (3) Change state to L2AUTHCOMPLETE (4) last state 8021X_REQD (3) *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.803: b8:63:4d:1b:9f:05 Mobility query, PEM State: L2AUTHCOMPLETE *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.803: b8:63:4d:1b:9f:05 0.0.0.0 L2AUTHCOMPLETE (4) NO release MSCB *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.803: b8:63:4d:1b:9f:05 Building Mobile Announce : *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.803: b8:63:4d:1b:9f:05 Building Client Payload: *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.803: b8:63:4d:1b:9f:05 Client Vlan Ip: 172.28.20.68, Vlan mask : 255.255.255.224 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.803: b8:63:4d:1b:9f:05 Client Vap Security: 1073758208 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.803: b8:63:4d:1b:9f:05 Virtual Ip: 1.1.1.1 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.803: b8:63:4d:1b:9f:05 ssid: TEST *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.803: b8:63:4d:1b:9f:05 Building VlanIpPayload. *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.803: b8:63:4d:1b:9f:05 Not Using WMM Compliance code qosCap 00 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.803: b8:63:4d:1b:9f:05 Vlan while overriding the policy = -1 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.803: b8:63:4d:1b:9f:05 sending to spamAddMobile vlanId -1 flex aclName = , flexAclId 65535 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.803: b8:63:4d:1b:9f:05 0.0.0.0 L2AUTHCOMPLETE (4) Plumbed mobile LWAPP rule on AP 40:01:7a:75:1e:60 vapId 2 apVapId 2 flex-acl-name: *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.803: b8:63:4d:1b:9f:05 0.0.0.0 L2AUTHCOMPLETE (4) Change state to DHCP_REQD (7) last state L2AUTHCOMPLETE (4) *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.803: b8:63:4d:1b:9f:05 0.0.0.0 DHCP_REQD (7) pemAdvanceState2 6757, Adding TMP rule *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.803: b8:63:4d:1b:9f:05 0.0.0.0 DHCP_REQD (7) Adding Fast Path rule type = Airespace AP - Learn IP address on AP 40:01:7a:75:1e:60, slot 1, interface = 13, QOS = 0 IPv4 ACL ID = 255, IP *spamApTask7: Mar 06 15:42:14.803: b8:63:4d:1b:9f:05 Successful transmission of LWAPP Add-Mobile to AP 40:01:7a:75:1e:60 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.803: b8:63:4d:1b:9f:05 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) 802.1P = 0, DSCP = 0, TokenID = 15206, IntfId = 13 Local Bridging Vlan = 960, Local Bridging intf id = 13 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.803: b8:63:4d:1b:9f:05 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 15206 AverageRate = 0, BurstRate = 0 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.803: b8:63:4d:1b:9f:05 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 15206 AverageRate = 0, BurstRate = 0 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.803: b8:63:4d:1b:9f:05 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 15206 AverageRate = 0, BurstRate = 0 *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.803: b8:63:4d:1b:9f:05 0.0.0.0 DHCP_REQD (7) Successfully plumbed mobile rule (IPv4 ACL ID 255, IPv6 ACL ID 255, L2 ACL ID 255,URL ACL ID 255) *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.804: b8:63:4d:1b:9f:05 0.0.0.0 DHCP_REQD (7) NO release MSCB *Dot1x_NW_MsgTask_5: Mar 06 15:42:14.804: b8:63:4d:1b:9f:05 Successfully Plumbed PTK session Keysfor mobile b8:63:4d:1b:9f:05 *pemReceiveTask: Mar 06 15:42:14.804: b8:63:4d:1b:9f:05 0.0.0.0 Added NPU entry of type 9, dtlFlags 0x0 *apfReceiveTask: Mar 06 15:42:14.804: b8:63:4d:1b:9f:05 0.0.0.0 DHCP_REQD (7) mobility role update request from Unassociated to Local Peer = 0.0.0.0, Old Anchor = 0.0.0.0, New Anchor = 172.28.20.4 *apfReceiveTask: Mar 06 15:42:14.804: b8:63:4d:1b:9f:05 0.0.0.0 DHCP_REQD (7) State Update from Mobility-Incomplete to Mobility-Complete, mobility role=Local, client state=APF_MS_STATE_ASSOCIATED *apfReceiveTask: Mar 06 15:42:14.804: b8:63:4d:1b:9f:05 0.0.0.0 DHCP_REQD (7) pemAdvanceState2 6395, Adding TMP rule *apfReceiveTask: Mar 06 15:42:14.804: b8:63:4d:1b:9f:05 0.0.0.0 DHCP_REQD (7) Replacing Fast Path rule type = Airespace AP - Learn IP address on AP 40:01:7a:75:1e:60, slot 1, interface = 13, QOS = 0 IPv4 ACL ID = 255, *apfReceiveTask: Mar 06 15:42:14.804: b8:63:4d:1b:9f:05 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) 802.1P = 0, DSCP = 0, TokenID = 15206, IntfId = 13 Local Bridging Vlan = 960, Local Bridging intf id = 13 *apfReceiveTask: Mar 06 15:42:14.804: b8:63:4d:1b:9f:05 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 15206 AverageRate = 0, BurstRate = 0 *apfReceiveTask: Mar 06 15:42:14.804: b8:63:4d:1b:9f:05 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 15206 AverageRate = 0, BurstRate = 0 *apfReceiveTask: Mar 06 15:42:14.804: b8:63:4d:1b:9f:05 0.0.0.0 DHCP_REQD (7) Fast Path rule (contd...) AVC Ratelimit: AppID = 0 ,AppAction = 0, AppToken = 15206 AverageRate = 0, BurstRate = 0 *apfReceiveTask: Mar 06 15:42:14.804: b8:63:4d:1b:9f:05 0.0.0.0 DHCP_REQD (7) Successfully plumbed mobile rule (IPv4 ACL ID 255, IPv6 ACL ID 255, L2 ACL ID 255,URL ACL ID 255) *apfReceiveTask: Mar 06 15:42:14.804: b8:63:4d:1b:9f:05 0.0.0.0 DHCP_REQD (7) NO release MSCB *pemReceiveTask: Mar 06 15:42:14.805: b8:63:4d:1b:9f:05 0.0.0.0 Added NPU entry of type 9, dtlFlags 0x0 *pemReceiveTask: Mar 06 15:42:14.805: b8:63:4d:1b:9f:05 Sent an XID frame *DHCP Socket Task: Mar 06 15:42:16.133: b8:63:4d:1b:9f:05 DHCP received op BOOTREQUEST (1) (len 308,vlan 920, port 13, encap 0xec03, xid 0xfc80a269) *DHCP Socket Task: Mar 06 15:42:16.133: b8:63:4d:1b:9f:05 DHCP option len (including the magic cookie) 72 *DHCP Socket Task: Mar 06 15:42:16.133: b8:63:4d:1b:9f:05 DHCP option: message type = DHCP DISCOVER *DHCP Socket Task: Mar 06 15:42:16.133: b8:63:4d:1b:9f:05 DHCP option: 55 (len 7) - skipping *DHCP Socket Task: Mar 06 15:42:16.133: b8:63:4d:1b:9f:05 DHCP option: 57 (len 2) - skipping *DHCP Socket Task: Mar 06 15:42:16.133: b8:63:4d:1b:9f:05 DHCP option: 61 (len 7) - skipping *DHCP Socket Task: Mar 06 15:42:16.133: b8:63:4d:1b:9f:05 DHCP option: lease time = 7776000 seconds *DHCP Socket Task: Mar 06 15:42:16.133: b8:63:4d:1b:9f:05 DHCP option: hostname = iPhone (len 6) *DHCP Socket Task: Mar 06 15:42:16.133: b8:63:4d:1b:9f:05 DHCP options end, len 72, actual 64 *DHCP Socket Task: Mar 06 15:42:16.134: b8:63:4d:1b:9f:05 DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff *DHCP Socket Task: Mar 06 15:42:16.134: b8:63:4d:1b:9f:05 DHCP intf:sn-int1 dhcp proxy mode disabled *DHCP Socket Task: Mar 06 15:42:16.134: b8:63:4d:1b:9f:05 DHCP intf:sn-int1 dhcp proxy mode disabled *DHCP Socket Task: Mar 06 15:42:16.134: b8:63:4d:1b:9f:05 DHCP processing DHCP DISCOVER (1) *DHCP Socket Task: Mar 06 15:42:16.134: b8:63:4d:1b:9f:05 DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 0 *DHCP Socket Task: Mar 06 15:42:16.134: b8:63:4d:1b:9f:05 DHCP xid: 0xfc80a269 (4236288617), secs: 2, flags: 0 *DHCP Socket Task: Mar 06 15:42:16.134: b8:63:4d:1b:9f:05 DHCP chaddr: b8:63:4d:1b:9f:05 *DHCP Socket Task: Mar 06 15:42:16.134: b8:63:4d:1b:9f:05 DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0 *DHCP Socket Task: Mar 06 15:42:16.134: b8:63:4d:1b:9f:05 DHCP siaddr: 0.0.0.0, giaddr: 0.0.0.0 *DHCP Socket Task: Mar 06 15:42:16.134: b8:63:4d:1b:9f:05 DHCP Opt82 bridge mode insertion enabled, inserts opt82 if opt82 is enabled vlan=960, datalen =18, optlen=64 *DHCP Socket Task: Mar 06 15:42:16.134: b8:63:4d:1b:9f:05 DHCP successfully bridged packet to DS *DHCP Socket Task: Mar 06 15:42:18.142: b8:63:4d:1b:9f:05 DHCP received op BOOTREQUEST (1) (len 308,vlan 920, port 13, encap 0xec03, xid 0xfc80a269) *DHCP Socket Task: Mar 06 15:42:18.142: b8:63:4d:1b:9f:05 DHCP option len (including the magic cookie) 72 *DHCP Socket Task: Mar 06 15:42:18.142: b8:63:4d:1b:9f:05 DHCP option: message type = DHCP DISCOVER *DHCP Socket Task: Mar 06 15:42:18.142: b8:63:4d:1b:9f:05 DHCP option: 55 (len 7) - skipping *DHCP Socket Task: Mar 06 15:42:18.142: b8:63:4d:1b:9f:05 DHCP option: 57 (len 2) - skipping *DHCP Socket Task: Mar 06 15:42:18.143: b8:63:4d:1b:9f:05 DHCP option: 61 (len 7) - skipping *DHCP Socket Task: Mar 06 15:42:18.143: b8:63:4d:1b:9f:05 DHCP option: lease time = 7776000 seconds *DHCP Socket Task: Mar 06 15:42:18.143: b8:63:4d:1b:9f:05 DHCP option: hostname = iPhone (len 6) *DHCP Socket Task: Mar 06 15:42:18.143: b8:63:4d:1b:9f:05 DHCP options end, len 72, actual 64 *DHCP Socket Task: Mar 06 15:42:18.143: b8:63:4d:1b:9f:05 DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff *DHCP Socket Task: Mar 06 15:42:18.143: b8:63:4d:1b:9f:05 DHCP intf:sn-int1 dhcp proxy mode disabled *DHCP Socket Task: Mar 06 15:42:18.143: b8:63:4d:1b:9f:05 DHCP intf:sn-int1 dhcp proxy mode disabled *DHCP Socket Task: Mar 06 15:42:18.143: b8:63:4d:1b:9f:05 DHCP processing DHCP DISCOVER (1) *DHCP Socket Task: Mar 06 15:42:18.143: b8:63:4d:1b:9f:05 DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 0 *DHCP Socket Task: Mar 06 15:42:18.143: b8:63:4d:1b:9f:05 DHCP xid: 0xfc80a269 (4236288617), secs: 4, flags: 0 *DHCP Socket Task: Mar 06 15:42:18.143: b8:63:4d:1b:9f:05 DHCP chaddr: b8:63:4d:1b:9f:05 *DHCP Socket Task: Mar 06 15:42:18.143: b8:63:4d:1b:9f:05 DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0 *DHCP Socket Task: Mar 06 15:42:18.143: b8:63:4d:1b:9f:05 DHCP siaddr: 0.0.0.0, giaddr: 0.0.0.0 *DHCP Socket Task: Mar 06 15:42:18.143: b8:63:4d:1b:9f:05 DHCP Opt82 bridge mode insertion enabled, inserts opt82 if opt82 is enabled vlan=960, datalen =18, optlen=64 *DHCP Socket Task: Mar 06 15:42:18.143: b8:63:4d:1b:9f:05 DHCP successfully bridged packet to DS *IPv6_Msg_Task: Mar 06 15:42:20.225: b8:63:4d:1b:9f:05 Link Local address fe80::1cd7:44c:f360:2f8f updated to mscb. Not Advancing pem state.Current state: mscb in apfMsMmInitial mobility state and client state APF_MS_STATE_AS *DHCP Socket Task: Mar 06 15:42:23.076: b8:63:4d:1b:9f:05 DHCP received op BOOTREQUEST (1) (len 308,vlan 920, port 13, encap 0xec03, xid 0xfc80a269) *DHCP Socket Task: Mar 06 15:42:23.076: b8:63:4d:1b:9f:05 DHCP option len (including the magic cookie) 72 *DHCP Socket Task: Mar 06 15:42:23.076: b8:63:4d:1b:9f:05 DHCP option: message type = DHCP DISCOVER *DHCP Socket Task: Mar 06 15:42:23.076: b8:63:4d:1b:9f:05 DHCP option: 55 (len 7) - skipping *DHCP Socket Task: Mar 06 15:42:23.076: b8:63:4d:1b:9f:05 DHCP option: 57 (len 2) - skipping *DHCP Socket Task: Mar 06 15:42:23.076: b8:63:4d:1b:9f:05 DHCP option: 61 (len 7) - skipping *DHCP Socket Task: Mar 06 15:42:23.076: b8:63:4d:1b:9f:05 DHCP option: lease time = 7776000 seconds *DHCP Socket Task: Mar 06 15:42:23.076: b8:63:4d:1b:9f:05 DHCP option: hostname = iPhone (len 6) *DHCP Socket Task: Mar 06 15:42:23.076: b8:63:4d:1b:9f:05 DHCP options end, len 72, actual 64 *DHCP Socket Task: Mar 06 15:42:23.076: b8:63:4d:1b:9f:05 DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff *DHCP Socket Task: Mar 06 15:42:23.077: b8:63:4d:1b:9f:05 DHCP intf:sn-int1 dhcp proxy mode disabled *DHCP Socket Task: Mar 06 15:42:23.077: b8:63:4d:1b:9f:05 DHCP intf:sn-int1 dhcp proxy mode disabled *DHCP Socket Task: Mar 06 15:42:23.077: b8:63:4d:1b:9f:05 DHCP processing DHCP DISCOVER (1) *DHCP Socket Task: Mar 06 15:42:23.077: b8:63:4d:1b:9f:05 DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 0 *DHCP Socket Task: Mar 06 15:42:23.077: b8:63:4d:1b:9f:05 DHCP xid: 0xfc80a269 (4236288617), secs: 9, flags: 0 *DHCP Socket Task: Mar 06 15:42:23.077: b8:63:4d:1b:9f:05 DHCP chaddr: b8:63:4d:1b:9f:05 *DHCP Socket Task: Mar 06 15:42:23.077: b8:63:4d:1b:9f:05 DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0 *DHCP Socket Task: Mar 06 15:42:23.077: b8:63:4d:1b:9f:05 DHCP siaddr: 0.0.0.0, giaddr: 0.0.0.0 *DHCP Socket Task: Mar 06 15:42:23.077: b8:63:4d:1b:9f:05 DHCP Opt82 bridge mode insertion enabled, inserts opt82 if opt82 is enabled vlan=960, datalen =18, optlen=64 *DHCP Socket Task: Mar 06 15:42:23.077: b8:63:4d:1b:9f:05 DHCP successfully bridged packet to DS *DHCP Socket Task: Mar 06 15:42:23.077: b8:63:4d:1b:9f:05 Interface Group was NULL.Number of DHCP Discovery 3 from client *DHCP Socket Task: Mar 06 15:42:31.307: b8:63:4d:1b:9f:05 DHCP received op BOOTREQUEST (1) (len 308,vlan 920, port 13, encap 0xec03, xid 0xfc80a269) *DHCP Socket Task: Mar 06 15:42:31.307: b8:63:4d:1b:9f:05 DHCP option len (including the magic cookie) 72 *DHCP Socket Task: Mar 06 15:42:31.307: b8:63:4d:1b:9f:05 DHCP option: message type = DHCP DISCOVER *DHCP Socket Task: Mar 06 15:42:31.307: b8:63:4d:1b:9f:05 DHCP option: 55 (len 7) - skipping *DHCP Socket Task: Mar 06 15:42:31.307: b8:63:4d:1b:9f:05 DHCP option: 57 (len 2) - skipping *DHCP Socket Task: Mar 06 15:42:31.307: b8:63:4d:1b:9f:05 DHCP option: 61 (len 7) - skipping *DHCP Socket Task: Mar 06 15:42:31.307: b8:63:4d:1b:9f:05 DHCP option: lease time = 7776000 seconds *DHCP Socket Task: Mar 06 15:42:31.307: b8:63:4d:1b:9f:05 DHCP option: hostname = iPhone (len 6) *DHCP Socket Task: Mar 06 15:42:31.307: b8:63:4d:1b:9f:05 DHCP options end, len 72, actual 64 *DHCP Socket Task: Mar 06 15:42:31.307: b8:63:4d:1b:9f:05 DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff *DHCP Socket Task: Mar 06 15:42:31.307: b8:63:4d:1b:9f:05 DHCP intf:sn-int1 dhcp proxy mode disabled *DHCP Socket Task: Mar 06 15:42:31.307: b8:63:4d:1b:9f:05 DHCP intf:sn-int1 dhcp proxy mode disabled *DHCP Socket Task: Mar 06 15:42:31.307: b8:63:4d:1b:9f:05 DHCP processing DHCP DISCOVER (1) *DHCP Socket Task: Mar 06 15:42:31.307: b8:63:4d:1b:9f:05 DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 0 *DHCP Socket Task: Mar 06 15:42:31.307: b8:63:4d:1b:9f:05 DHCP xid: 0xfc80a269 (4236288617), secs: 17, flags: 0 *DHCP Socket Task: Mar 06 15:42:31.307: b8:63:4d:1b:9f:05 DHCP chaddr: b8:63:4d:1b:9f:05 *DHCP Socket Task: Mar 06 15:42:31.307: b8:63:4d:1b:9f:05 DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0 *DHCP Socket Task: Mar 06 15:42:31.308: b8:63:4d:1b:9f:05 DHCP siaddr: 0.0.0.0, giaddr: 0.0.0.0 *DHCP Socket Task: Mar 06 15:42:31.308: b8:63:4d:1b:9f:05 DHCP Opt82 bridge mode insertion enabled, inserts opt82 if opt82 is enabled vlan=960, datalen =18, optlen=64 *DHCP Socket Task: Mar 06 15:42:31.308: b8:63:4d:1b:9f:05 DHCP successfully bridged packet to DS *DHCP Socket Task: Mar 06 15:42:39.804: b8:63:4d:1b:9f:05 DHCP received op BOOTREQUEST (1) (len 308,vlan 920, port 13, encap 0xec03, xid 0xfc80a269) *DHCP Socket Task: Mar 06 15:42:39.804: b8:63:4d:1b:9f:05 DHCP option len (including the magic cookie) 72 *DHCP Socket Task: Mar 06 15:42:39.804: b8:63:4d:1b:9f:05 DHCP option: message type = DHCP DISCOVER *DHCP Socket Task: Mar 06 15:42:39.804: b8:63:4d:1b:9f:05 DHCP option: 55 (len 7) - skipping *DHCP Socket Task: Mar 06 15:42:39.804: b8:63:4d:1b:9f:05 DHCP option: 57 (len 2) - skipping *DHCP Socket Task: Mar 06 15:42:39.804: b8:63:4d:1b:9f:05 DHCP option: 61 (len 7) - skipping *DHCP Socket Task: Mar 06 15:42:39.804: b8:63:4d:1b:9f:05 DHCP option: lease time = 7776000 seconds *DHCP Socket Task: Mar 06 15:42:39.804: b8:63:4d:1b:9f:05 DHCP option: hostname = iPhone (len 6) *DHCP Socket Task: Mar 06 15:42:39.804: b8:63:4d:1b:9f:05 DHCP options end, len 72, actual 64 *DHCP Socket Task: Mar 06 15:42:39.804: b8:63:4d:1b:9f:05 DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff *DHCP Socket Task: Mar 06 15:42:39.804: b8:63:4d:1b:9f:05 DHCP intf:sn-int1 dhcp proxy mode disabled *DHCP Socket Task: Mar 06 15:42:39.804: b8:63:4d:1b:9f:05 DHCP intf:sn-int1 dhcp proxy mode disabled *DHCP Socket Task: Mar 06 15:42:39.804: b8:63:4d:1b:9f:05 DHCP processing DHCP DISCOVER (1) *DHCP Socket Task: Mar 06 15:42:39.804: b8:63:4d:1b:9f:05 DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 0 *DHCP Socket Task: Mar 06 15:42:39.804: b8:63:4d:1b:9f:05 DHCP xid: 0xfc80a269 (4236288617), secs: 25, flags: 0 *DHCP Socket Task: Mar 06 15:42:39.804: b8:63:4d:1b:9f:05 DHCP chaddr: b8:63:4d:1b:9f:05 *DHCP Socket Task: Mar 06 15:42:39.804: b8:63:4d:1b:9f:05 DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0 *DHCP Socket Task: Mar 06 15:42:39.804: b8:63:4d:1b:9f:05 DHCP siaddr: 0.0.0.0, giaddr: 0.0.0.0 *DHCP Socket Task: Mar 06 15:42:39.804: b8:63:4d:1b:9f:05 DHCP Opt82 bridge mode insertion enabled, inserts opt82 if opt82 is enabled vlan=960, datalen =18, optlen=64 *DHCP Socket Task: Mar 06 15:42:39.804: b8:63:4d:1b:9f:05 DHCP successfully bridged packet to DS *DHCP Socket Task: Mar 06 15:42:47.949: b8:63:4d:1b:9f:05 DHCP received op BOOTREQUEST (1) (len 308,vlan 920, port 13, encap 0xec03, xid 0xfc80a269) *DHCP Socket Task: Mar 06 15:42:47.949: b8:63:4d:1b:9f:05 DHCP option len (including the magic cookie) 72 *DHCP Socket Task: Mar 06 15:42:47.949: b8:63:4d:1b:9f:05 DHCP option: message type = DHCP DISCOVER *DHCP Socket Task: Mar 06 15:42:47.949: b8:63:4d:1b:9f:05 DHCP option: 55 (len 7) - skipping *DHCP Socket Task: Mar 06 15:42:47.949: b8:63:4d:1b:9f:05 DHCP option: 57 (len 2) - skipping *DHCP Socket Task: Mar 06 15:42:47.949: b8:63:4d:1b:9f:05 DHCP option: 61 (len 7) - skipping *DHCP Socket Task: Mar 06 15:42:47.949: b8:63:4d:1b:9f:05 DHCP option: lease time = 7776000 seconds *DHCP Socket Task: Mar 06 15:42:47.949: b8:63:4d:1b:9f:05 DHCP option: hostname = iPhone (len 6) *DHCP Socket Task: Mar 06 15:42:47.950: b8:63:4d:1b:9f:05 DHCP options end, len 72, actual 64 *DHCP Socket Task: Mar 06 15:42:47.950: b8:63:4d:1b:9f:05 DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff *DHCP Socket Task: Mar 06 15:42:47.950: b8:63:4d:1b:9f:05 DHCP intf:sn-int1 dhcp proxy mode disabled *DHCP Socket Task: Mar 06 15:42:47.950: b8:63:4d:1b:9f:05 DHCP intf:sn-int1 dhcp proxy mode disabled *DHCP Socket Task: Mar 06 15:42:47.950: b8:63:4d:1b:9f:05 DHCP processing DHCP DISCOVER (1) *DHCP Socket Task: Mar 06 15:42:47.950: b8:63:4d:1b:9f:05 DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 0 *DHCP Socket Task: Mar 06 15:42:47.950: b8:63:4d:1b:9f:05 DHCP xid: 0xfc80a269 (4236288617), secs: 33, flags: 0 *DHCP Socket Task: Mar 06 15:42:47.950: b8:63:4d:1b:9f:05 DHCP chaddr: b8:63:4d:1b:9f:05 *DHCP Socket Task: Mar 06 15:42:47.950: b8:63:4d:1b:9f:05 DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0 *DHCP Socket Task: Mar 06 15:42:47.950: b8:63:4d:1b:9f:05 DHCP siaddr: 0.0.0.0, giaddr: 0.0.0.0 *DHCP Socket Task: Mar 06 15:42:47.950: b8:63:4d:1b:9f:05 DHCP Opt82 bridge mode insertion enabled, inserts opt82 if opt82 is enabled vlan=960, datalen =18, optlen=64 *DHCP Socket Task: Mar 06 15:42:47.950: b8:63:4d:1b:9f:05 DHCP successfully bridged packet to DS *DHCP Socket Task: Mar 06 15:42:55.970: b8:63:4d:1b:9f:05 DHCP received op BOOTREQUEST (1) (len 308,vlan 920, port 13, encap 0xec03, xid 0xfc80a269) *DHCP Socket Task: Mar 06 15:42:55.970: b8:63:4d:1b:9f:05 DHCP option len (including the magic cookie) 72 *DHCP Socket Task: Mar 06 15:42:55.970: b8:63:4d:1b:9f:05 DHCP option: message type = DHCP DISCOVER *DHCP Socket Task: Mar 06 15:42:55.970: b8:63:4d:1b:9f:05 DHCP option: 55 (len 7) - skipping *DHCP Socket Task: Mar 06 15:42:55.970: b8:63:4d:1b:9f:05 DHCP option: 57 (len 2) - skipping *DHCP Socket Task: Mar 06 15:42:55.970: b8:63:4d:1b:9f:05 DHCP option: 61 (len 7) - skipping *DHCP Socket Task: Mar 06 15:42:55.970: b8:63:4d:1b:9f:05 DHCP option: lease time = 7776000 seconds *DHCP Socket Task: Mar 06 15:42:55.970: b8:63:4d:1b:9f:05 DHCP option: hostname = iPhone (len 6) *DHCP Socket Task: Mar 06 15:42:55.970: b8:63:4d:1b:9f:05 DHCP options end, len 72, actual 64 *DHCP Socket Task: Mar 06 15:42:55.971: b8:63:4d:1b:9f:05 DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff *DHCP Socket Task: Mar 06 15:42:55.971: b8:63:4d:1b:9f:05 DHCP intf:sn-int1 dhcp proxy mode disabled *DHCP Socket Task: Mar 06 15:42:55.971: b8:63:4d:1b:9f:05 DHCP intf:sn-int1 dhcp proxy mode disabled *DHCP Socket Task: Mar 06 15:42:55.971: b8:63:4d:1b:9f:05 DHCP processing DHCP DISCOVER (1) *DHCP Socket Task: Mar 06 15:42:55.971: b8:63:4d:1b:9f:05 DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 0 *DHCP Socket Task: Mar 06 15:42:55.971: b8:63:4d:1b:9f:05 DHCP xid: 0xfc80a269 (4236288617), secs: 41, flags: 0 *DHCP Socket Task: Mar 06 15:42:55.971: b8:63:4d:1b:9f:05 DHCP chaddr: b8:63:4d:1b:9f:05 *DHCP Socket Task: Mar 06 15:42:55.971: b8:63:4d:1b:9f:05 DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0 *DHCP Socket Task: Mar 06 15:42:55.971: b8:63:4d:1b:9f:05 DHCP siaddr: 0.0.0.0, giaddr: 0.0.0.0 *DHCP Socket Task: Mar 06 15:42:55.971: b8:63:4d:1b:9f:05 DHCP Opt82 bridge mode insertion enabled, inserts opt82 if opt82 is enabled vlan=960, datalen =18, optlen=64 *DHCP Socket Task: Mar 06 15:42:55.971: b8:63:4d:1b:9f:05 DHCP successfully bridged packet to DS *DHCP Socket Task: Mar 06 15:43:04.958: b8:63:4d:1b:9f:05 DHCP received op BOOTREQUEST (1) (len 308,vlan 920, port 13, encap 0xec03, xid 0xfc80a269) *DHCP Socket Task: Mar 06 15:43:04.958: b8:63:4d:1b:9f:05 DHCP option len (including the magic cookie) 72 *DHCP Socket Task: Mar 06 15:43:04.958: b8:63:4d:1b:9f:05 DHCP option: message type = DHCP DISCOVER *DHCP Socket Task: Mar 06 15:43:04.958: b8:63:4d:1b:9f:05 DHCP option: 55 (len 7) - skipping *DHCP Socket Task: Mar 06 15:43:04.958: b8:63:4d:1b:9f:05 DHCP option: 57 (len 2) - skipping *DHCP Socket Task: Mar 06 15:43:04.958: b8:63:4d:1b:9f:05 DHCP option: 61 (len 7) - skipping *DHCP Socket Task: Mar 06 15:43:04.958: b8:63:4d:1b:9f:05 DHCP option: lease time = 7776000 seconds *DHCP Socket Task: Mar 06 15:43:04.958: b8:63:4d:1b:9f:05 DHCP option: hostname = iPhone (len 6) *DHCP Socket Task: Mar 06 15:43:04.958: b8:63:4d:1b:9f:05 DHCP options end, len 72, actual 64 *DHCP Socket Task: Mar 06 15:43:04.958: b8:63:4d:1b:9f:05 DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff *DHCP Socket Task: Mar 06 15:43:04.958: b8:63:4d:1b:9f:05 DHCP intf:sn-int1 dhcp proxy mode disabled *DHCP Socket Task: Mar 06 15:43:04.958: b8:63:4d:1b:9f:05 DHCP intf:sn-int1 dhcp proxy mode disabled *DHCP Socket Task: Mar 06 15:43:04.958: b8:63:4d:1b:9f:05 DHCP processing DHCP DISCOVER (1) *DHCP Socket Task: Mar 06 15:43:04.958: b8:63:4d:1b:9f:05 DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 0 *DHCP Socket Task: Mar 06 15:43:04.958: b8:63:4d:1b:9f:05 DHCP xid: 0xfc80a269 (4236288617), secs: 50, flags: 0 *DHCP Socket Task: Mar 06 15:43:04.958: b8:63:4d:1b:9f:05 DHCP chaddr: b8:63:4d:1b:9f:05 *DHCP Socket Task: Mar 06 15:43:04.958: b8:63:4d:1b:9f:05 DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0 *DHCP Socket Task: Mar 06 15:43:04.958: b8:63:4d:1b:9f:05 DHCP siaddr: 0.0.0.0, giaddr: 0.0.0.0 *DHCP Socket Task: Mar 06 15:43:04.959: b8:63:4d:1b:9f:05 DHCP Opt82 bridge mode insertion enabled, inserts opt82 if opt82 is enabled vlan=960, datalen =18, optlen=64 *DHCP Socket Task: Mar 06 15:43:04.959: b8:63:4d:1b:9f:05 DHCP successfully bridged packet to DS *DHCP Socket Task: Mar 06 15:43:13.809: b8:63:4d:1b:9f:05 DHCP received op BOOTREQUEST (1) (len 308,vlan 920, port 13, encap 0xec03, xid 0xfc80a269) *DHCP Socket Task: Mar 06 15:43:13.809: b8:63:4d:1b:9f:05 DHCP option len (including the magic cookie) 72 *DHCP Socket Task: Mar 06 15:43:13.809: b8:63:4d:1b:9f:05 DHCP option: message type = DHCP DISCOVER *DHCP Socket Task: Mar 06 15:43:13.809: b8:63:4d:1b:9f:05 DHCP option: 55 (len 7) - skipping *DHCP Socket Task: Mar 06 15:43:13.809: b8:63:4d:1b:9f:05 DHCP option: 57 (len 2) - skipping *DHCP Socket Task: Mar 06 15:43:13.809: b8:63:4d:1b:9f:05 DHCP option: 61 (len 7) - skipping *DHCP Socket Task: Mar 06 15:43:13.809: b8:63:4d:1b:9f:05 DHCP option: lease time = 7776000 seconds *DHCP Socket Task: Mar 06 15:43:13.809: b8:63:4d:1b:9f:05 DHCP option: hostname = iPhone (len 6) *DHCP Socket Task: Mar 06 15:43:13.809: b8:63:4d:1b:9f:05 DHCP options end, len 72, actual 64 *DHCP Socket Task: Mar 06 15:43:13.809: b8:63:4d:1b:9f:05 DHCP (encap type 0xec03) mstype 0ff:ff:ff:ff:ff:ff *DHCP Socket Task: Mar 06 15:43:13.809: b8:63:4d:1b:9f:05 DHCP intf:sn-int1 dhcp proxy mode disabled *DHCP Socket Task: Mar 06 15:43:13.809: b8:63:4d:1b:9f:05 DHCP intf:sn-int1 dhcp proxy mode disabled *DHCP Socket Task: Mar 06 15:43:13.809: b8:63:4d:1b:9f:05 DHCP processing DHCP DISCOVER (1) *DHCP Socket Task: Mar 06 15:43:13.809: b8:63:4d:1b:9f:05 DHCP op: BOOTREQUEST, htype: Ethernet, hlen: 6, hops: 0 *DHCP Socket Task: Mar 06 15:43:13.809: b8:63:4d:1b:9f:05 DHCP xid: 0xfc80a269 (4236288617), secs: 59, flags: 0 *DHCP Socket Task: Mar 06 15:43:13.809: b8:63:4d:1b:9f:05 DHCP chaddr: b8:63:4d:1b:9f:05 *DHCP Socket Task: Mar 06 15:43:13.809: b8:63:4d:1b:9f:05 DHCP ciaddr: 0.0.0.0, yiaddr: 0.0.0.0 *DHCP Socket Task: Mar 06 15:43:13.809: b8:63:4d:1b:9f:05 DHCP siaddr: 0.0.0.0, giaddr: 0.0.0.0 *DHCP Socket Task: Mar 06 15:43:13.809: b8:63:4d:1b:9f:05 DHCP Opt82 bridge mode insertion enabled, inserts opt82 if opt82 is enabled vlan=960, datalen =18, optlen=64 *DHCP Socket Task: Mar 06 15:43:13.809: b8:63:4d:1b:9f:05 DHCP successfully bridged packet to DS