cancel
Showing results for 
Search instead for 
Did you mean: 
cancel
1300
Views
0
Helpful
1
Replies

LSC phone and CME

Dear all,

 

I try to deploy LSC certificate on Cisco phone trough CME, but on the phone I can see “LSC : Not installed”.

 

 But the secure SCCP is working, but i just want to have LSC certificat eon my phone for EAP-TLS with LSC certificate.

Tested with CME v8.6 and v10 and the result is the same, no LSC on the phone :(

You can find the CME config bellow:

version 15.3

service timestamps debug datetime msec

service timestamps log datetime msec

no service password-encryption

!

hostname CME

!

boot-start-marker

boot system flash0:c2900-universalk9-mz.SPA.153-3.M7.bin

boot-end-marker

!

aqm-register-fnf

!

! card type command needed for slot/vwic-slot 0/0

!

no aaa new-model

!

!

!

!

!

!

!

ip domain name qar.local

ip cef

no ipv6 cef

!

multilink bundle-name authenticated

!

!

!

!

!

capf-server

 auth-mode LSC

 cert-enroll-trustpoint CAserver password 1 135445415F59527D737D

 trustpoint-label CME

 source-addr 10.57.37.130

!

ctl-client

 server cme 10.57.37.130 trustpoint CME

 server tftp 10.57.37.130 trustpoint CME

 server capf 10.57.37.130 trustpoint CME

 sast1 trustpoint CME

 sast2 trustpoint sast2

!

!

crypto pki server CAserver

 database level complete

 no database archive

 grant auto

!

crypto pki trustpoint CAserver

 enrollment url http://10.57.37.130:80

 revocation-check none

 rsakeypair CAserver 1024 1024

!

crypto pki trustpoint CME

 enrollment url http://10.57.37.130:80

 revocation-check none

 rsakeypair CME 1024 1024

 auto-enroll regenerate

!

crypto pki trustpoint sast2

 enrollment url http://10.57.37.130:80

 revocation-check crl

 rsakeypair sast2 1024 1024

!

!

crypto pki certificate chain CAserver

 certificate ca 01

  308201FF 30820168 A0030201 02020101 300D0609 2A864886 F70D0101 04050030

  13311130 0F060355 04031308 43417365 72766572 301E170D 31363039 31323135

  30313032 5A170D31 39303931 32313530 3130325A 30133111 300F0603 55040313

  08434173 65727665 7230819F 300D0609 2A864886 F70D0101 01050003 818D0030

  81890281 81008A4E AEB330F8 8811CD67 B702C9B1 C720BCA2 37A4906B FD725A7E

  4ECB8547 E19BEDBB F6953B95 AB45DB0D 311F62E3 55BDB5D1 5855AB16 E0B8ACDD

  C3F24FE3 CF3FAA54 FB8C4CAC C8164576 96283BC2 8BABE7FF 31FDC1B3 E7717459

  92D236AB DA77BAC6 48A5CCBC CCC755E0 A2EB89B7 D35D43AC 28133ACC 8396169A

  CBD0212E 37DD0203 010001A3 63306130 0F060355 1D130101 FF040530 030101FF

  300E0603 551D0F01 01FF0404 03020186 301F0603 551D2304 18301680 14ADF2F4

  E7F0DDA5 AC51C064 D915B752 447B0B8E D7301D06 03551D0E 04160414 ADF2F4E7

  F0DDA5AC 51C064D9 15B75244 7B0B8ED7 300D0609 2A864886 F70D0101 04050003

  8181007F 8703C9C4 9AE1B279 B5320B33 CBB5A1BD 274F949B 3BA0FB03 ECBBA82C

  28633555 8C86FC2C 97F75056 8CE96CA7 1D3DBC88 1ABA0B91 0E0E9EA5 68C38903

  1C13FD75 2CC4D150 042DB86A B3BDF394 D222B3A0 958EE9D4 7C907F59 6152E93C

  1C9FF878 4DA6E997 021B9273 03B84DC0 DC8EE44C B66B4D51 F42B3087 44736D65 373F30

  quit

crypto pki certificate chain CME

 certificate 02

  308201F6 3082015F A0030201 02020102 300D0609 2A864886 F70D0101 05050030

  13311130 0F060355 04031308 43417365 72766572 301E170D 31363039 31323135

  30323136 5A170D31 37303931 32313530 3231365A 301E311C 301A0609 2A864886

  F70D0109 02160D43 4D452E71 61722E6C 6F63616C 30819F30 0D06092A 864886F7

  0D010101 05000381 8D003081 89028181 009496B7 655A222F 784C2205 ABB782D2

  BC84B8C6 D88D05A0 3856B99C 897B9EE9 602BE107 F2729A29 7B8D2BB7 8F0FEA2F

  19D55B2C 3D83D994 8FF9981C 7CF44C72 26C7D23B DE82CD83 6862672E 8BF867B4

  347CDC99 0544D556 C3E34222 004CE762 595EEFAA 456F874A 16C51590 2942D11E

  2742F34D A59C9947 88FBD7A3 8495CE91 95020301 0001A34F 304D300B 0603551D

  0F040403 0205A030 1F060355 1D230418 30168014 ADF2F4E7 F0DDA5AC 51C064D9

  15B75244 7B0B8ED7 301D0603 551D0E04 160414F1 1B2C9A1E 1713F3C8 295CCD5C

  F59D78AC 3F5B0230 0D06092A 864886F7 0D010105 05000381 81008701 462DCBFC

  EDEFA053 BFC94C21 347AAAA5 B09D2C43 1B006FFA 16AE7A21 95A0EB0D 3F412755

  02269524 F85F08D3 5BD53EED BE615830 2708EE7F 61997872 89AE026B 2869EFCC

  ADC92BDC 4E33C821 89D3F3C3 8B92293F D31F4C9E CD5DA218 4A8B062A 05C385C1

  B72FB055 5748287A 4FCB7174 FCD1D1D0 C099559A 5C163D69 7041

  quit

 certificate ca 01

  308201FF 30820168 A0030201 02020101 300D0609 2A864886 F70D0101 04050030

  13311130 0F060355 04031308 43417365 72766572 301E170D 31363039 31323135

  30313032 5A170D31 39303931 32313530 3130325A 30133111 300F0603 55040313

  08434173 65727665 7230819F 300D0609 2A864886 F70D0101 01050003 818D0030

  81890281 81008A4E AEB330F8 8811CD67 B702C9B1 C720BCA2 37A4906B FD725A7E

  4ECB8547 E19BEDBB F6953B95 AB45DB0D 311F62E3 55BDB5D1 5855AB16 E0B8ACDD

  C3F24FE3 CF3FAA54 FB8C4CAC C8164576 96283BC2 8BABE7FF 31FDC1B3 E7717459

  92D236AB DA77BAC6 48A5CCBC CCC755E0 A2EB89B7 D35D43AC 28133ACC 8396169A

  CBD0212E 37DD0203 010001A3 63306130 0F060355 1D130101 FF040530 030101FF

  300E0603 551D0F01 01FF0404 03020186 301F0603 551D2304 18301680 14ADF2F4

  E7F0DDA5 AC51C064 D915B752 447B0B8E D7301D06 03551D0E 04160414 ADF2F4E7

  F0DDA5AC 51C064D9 15B75244 7B0B8ED7 300D0609 2A864886 F70D0101 04050003

  8181007F 8703C9C4 9AE1B279 B5320B33 CBB5A1BD 274F949B 3BA0FB03 ECBBA82C

  28633555 8C86FC2C 97F75056 8CE96CA7 1D3DBC88 1ABA0B91 0E0E9EA5 68C38903

  1C13FD75 2CC4D150 042DB86A B3BDF394 D222B3A0 958EE9D4 7C907F59 6152E93C

  1C9FF878 4DA6E997 021B9273 03B84DC0 DC8EE44C B66B4D51 F42B3087 44736D65 373F30

  quit

crypto pki certificate chain sast2

 certificate 03

  308201F6 3082015F A0030201 02020103 300D0609 2A864886 F70D0101 05050030

  13311130 0F060355 04031308 43417365 72766572 301E170D 31363039 31323135

  30323435 5A170D31 37303931 32313530 3234355A 301E311C 301A0609 2A864886

  F70D0109 02160D43 4D452E71 61722E6C 6F63616C 30819F30 0D06092A 864886F7

  0D010101 05000381 8D003081 89028181 00A27607 C677F703 FAD3FFEB 1FA6FB59

  F0AF83F4 106B77F5 B9359DD6 9DAF9B7C 2B067F98 BB2DDD22 D9C57937 0725B464

  09ACB29D 7968D99C 46A5E820 D69EFD06 BBF11EBE 10D898AD BB3F05F4 3C0AE5AE

  110E86DE 62755CB5 392E095C 0A1D1FED D496E1D5 06CD71D0 A8C4713A DF2BC217

  069FCAA2 619C744D 4231F541 B6A22095 F1020301 0001A34F 304D300B 0603551D

  0F040403 0205A030 1F060355 1D230418 30168014 ADF2F4E7 F0DDA5AC 51C064D9

  15B75244 7B0B8ED7 301D0603 551D0E04 160414B6 CA2539E7 12167BCA 0DEFDB89

  945C246F 85D89330 0D06092A 864886F7 0D010105 05000381 810007C3 89B9C2E6

  00DBE558 7CB6A53D 0211F656 DEEBFD47 B5BEA4BD AD6514D5 C417FEC2 B276B842

  ED2B5A21 211B09C1 8632F8BD 2B4AB7F2 D9E71A66 F02E1552 B7BFC888 E4C10793

  6E4C7958 205A8DDE 39A84344 09C07C31 63311C25 E0C42B33 A779B273 47EAEA5D

  40675254 D6886573 971C73EA 6787FD33 F378169B 62FE6EFA F389

  quit

 certificate ca 01

  308201FF 30820168 A0030201 02020101 300D0609 2A864886 F70D0101 04050030

  13311130 0F060355 04031308 43417365 72766572 301E170D 31363039 31323135

  30313032 5A170D31 39303931 32313530 3130325A 30133111 300F0603 55040313

  08434173 65727665 7230819F 300D0609 2A864886 F70D0101 01050003 818D0030

  81890281 81008A4E AEB330F8 8811CD67 B702C9B1 C720BCA2 37A4906B FD725A7E

  4ECB8547 E19BEDBB F6953B95 AB45DB0D 311F62E3 55BDB5D1 5855AB16 E0B8ACDD

  C3F24FE3 CF3FAA54 FB8C4CAC C8164576 96283BC2 8BABE7FF 31FDC1B3 E7717459

  92D236AB DA77BAC6 48A5CCBC CCC755E0 A2EB89B7 D35D43AC 28133ACC 8396169A

  CBD0212E 37DD0203 010001A3 63306130 0F060355 1D130101 FF040530 030101FF

  300E0603 551D0F01 01FF0404 03020186 301F0603 551D2304 18301680 14ADF2F4

  E7F0DDA5 AC51C064 D915B752 447B0B8E D7301D06 03551D0E 04160414 ADF2F4E7

  F0DDA5AC 51C064D9 15B75244 7B0B8ED7 300D0609 2A864886 F70D0101 04050003

  8181007F 8703C9C4 9AE1B279 B5320B33 CBB5A1BD 274F949B 3BA0FB03 ECBBA82C

  28633555 8C86FC2C 97F75056 8CE96CA7 1D3DBC88 1ABA0B91 0E0E9EA5 68C38903

  1C13FD75 2CC4D150 042DB86A B3BDF394 D222B3A0 958EE9D4 7C907F59 6152E93C

  1C9FF878 4DA6E997 021B9273 03B84DC0 DC8EE44C B66B4D51 F42B3087 44736D65 373F30

  quit

voice-card 0

!

!

!

voice service voip

 ip address trusted list

  ipv4 10.57.37.130

 qsig decode

 allow-connections h323 to h323

 allow-connections h323 to sip

 allow-connections sip to h323

 allow-connections sip to sip

 supplementary-service h450.12

 fax protocol t38 version 0 ls-redundancy 0 hs-redundancy 0 fallback none

!

!

!

!

!

!

license udi pid CISCO2921/K9 sn XXXXXXXX

license boot module c2900 technology-package securityk9

hw-module pvdm 0/0

!

!

!

vtp mode transparent

username admin privilege 15 password 0 T0ta1$

!

redundancy

!

!

!

!

!

ip ssh logging events

ip ssh version 2

!

!

!

!

!

!

!

!

!

interface Embedded-Service-Engine0/0

 no ip address

 shutdown

!

interface GigabitEthernet0/0

 ip address 10.57.37.130 255.255.255.224

 duplex auto

 speed auto

!

interface GigabitEthernet0/1

 no ip address

 shutdown

 duplex auto

 speed auto

!

interface GigabitEthernet0/2

 no ip address

 shutdown

 duplex auto

 speed auto

!

ip default-gateway 10.xxx.xxx.xxx

ip forward-protocol nd

!

ip http server

no ip http secure-server

!

ip route 0.0.0.0 0.0.0.0 10.xxx.xxx.xxx

!

!

!

tftp-server flash:/IP_Phones/7942-62/apps42.9-4-2ES22.sbn alias apps42.9-4-2ES22.sbn

tftp-server flash:/IP_Phones/7942-62/cnu42.9-4-2ES22.sbn alias cnu42.9-4-2ES22.sbn

tftp-server flash:/IP_Phones/7942-62/cvm42sccp.9-4-2ES22.sbn alias cvm42sccp.9-4-2ES22.sbn

tftp-server flash:/IP_Phones/7942-62/dsp42.9-4-2ES22.sbn alias dsp42.9-4-2ES22.sbn

tftp-server flash:/IP_Phones/7942-62/jar42sccp.9-4-2ES22.sbn alias jar42sccp.9-4-2ES22.sbn

tftp-server flash:/IP_Phones/7942-62/SCCP42.9-4-2SR2-2S.loads alias SCCP42.9-4-2SR2-2S.loads

tftp-server flash:/IP_Phones/7942-62/term42.default.loads alias term42.default.loads

tftp-server flash:/IP_Phones/7942-62/term62.default.loads alias term62.default.loads

tftp-server flash:/IP_Phones/7945-65/apps45.9-4-2ES22.sbn alias apps45.9-4-2ES22.sbn

tftp-server flash:/IP_Phones/7945-65/cnu45.9-4-2ES22.sbn alias cnu45.9-4-2ES22.sbn

tftp-server flash:/IP_Phones/7945-65/cvm45sccp.9-4-2ES22.sbn alias cvm45sccp.9-4-2ES22.sbn

tftp-server flash:/IP_Phones/7945-65/dsp45.9-4-2ES22.sbn alias dsp45.9-4-2ES22.sbn

tftp-server flash:/IP_Phones/7945-65/jar45sccp.9-4-2ES22.sbn alias jar45sccp.9-4-2ES22.sbn

tftp-server flash:/IP_Phones/7945-65/SCCP45.9-4-2SR2-2S.loads alias SCCP45.9-4-2SR2-2S.loads

tftp-server flash:/IP_Phones/7945-65/term45.default.loads alias term45.default.loads

tftp-server flash:/IP_Phones/7945-65/term65.default.loads alias term65.default.loads

!

control-plane

!

!

voice-port 0/1/0

!

voice-port 0/1/1

!

voice-port 0/1/2

!

voice-port 0/1/3

 !

 !

 !

 !

!

!

mgcp behavior rsip-range tgcp-only

mgcp behavior comedia-role none

mgcp behavior comedia-check-media-src disable

mgcp behavior comedia-sdp-force disable

!

mgcp profile default

!

!

!

!

!

gatekeeper

 shutdown

!

!

telephony-service

 secure-signaling trustpoint CME

 tftp-server-credentials trustpoint CME

 server-security-mode secure

 device-security-mode encrypted

 ssh userid cisco password cisco

 no auto-reg-ephone

 max-ephones 20

 max-dn 10

 ip source-address 10.57.37.130 port 2000

 service phone daysBacklightNotActive 1,2,3,4,5,6,7

 service phone backlightOnTime 07:30

 service phone backlightOnDuration 00:01

 service phone backlightIdleTimeout 00:01

 service phone daysDisplayNotActive 1,2,3,4,5,6,7

 service phone settingsAccess 1

 service phone displayOnWhenIncomingCall 1

 service phone webAccess 1

 service phone spanToPCPort 0

 service phone sshAccess 1

 system message TEST

 url services http://10.57.37.130/telephony_service.html

 url authentication http://10.57.37.130/CCMCIP/authenticate.asp 

 cnf-file location flash:

 cnf-file perphone

 load 7942 SCCP42.9-4-2SR2-2S

 load 7945 SCCP45.9-4-2SR2-2S

 load 7962 SCCP42.9-4-2SR2-2S

 load 7965 SCCP45.9-4-2SR2-2S

 time-zone 23

 time-format 24

 date-format dd-mm-yy

 max-conferences 8 gain -6

 multicast moh 239.1.1.1 port 2000 route 10.57.37.130

 transfer-system full-consult

 create cnf-files version-stamp Jan 01 2002 00:00:00

!

!

!

ephone-dn  2  dual-line

 number 456

 label 456

 name 456

!

!

ephone-dn  3  dual-line

 number 789

 label 789

 name 789

!

!

!

!

ephone  2

 device-security-mode encrypted

 cert-oper upgrade auth-mode LSC

 mac-address 0021.5502.E6B7

 type 7965

 button  1:2

!

!

!

ephone  4

 device-security-mode encrypted

 cert-oper upgrade auth-mode LSC

 mac-address 0025.84A2.6BFF

 type 7942

 button  1:3

!

!

!

!

line con 0

line aux 0

line 2

 no activation-character

 no exec

 transport preferred none

 transport output pad telnet rlogin lapb-ta mop udptn v120 ssh

 stopbits 1

line vty 0 4

 login local

 transport input ssh

line vty 5 15

 login local

 transport input ssh

!

scheduler allocate 20000 1000

ntp server 10.10.10.10 prefer

!

end

 

 

Debugs :

debug capf-server all

debug tftp events

debug ephone register

debug ephone detail

 

debug crypto pki server

debug crypto pki messages

debug crypto pki transactions

debug crypto pki validation

debug crypto pki api

 

debug ssl openssl errors

debug ssl openssl msg

debug ssl openssl states

 

 

You can find the result of the debug bellow:

Sep 13 12:03:36.245: CRYPTO_PKI: Initializing renewal timers

Sep 13 12:03:36.245: PKI:get_cert CME 0x10 (expired=0):

Sep 13 12:03:36.245: PKI:get_cert sast2 0x10 (expired=0):

Sep 13 12:04:02.105: ephone-3[2/2][SEP001D4595600A]:SkinnyCheckPendingCallBackPhone scan 1 lines

Sep 13 12:04:02.105: ephone-4[3/1][SEP002584A26BFF]:SkinnyCheckPendingCallBackPhone scan 2 lines

Sep 13 12:04:03.865: TFTP: Looking for CTLSEP00215502E6B7.tlv

Sep 13 12:04:03.869: TFTP: Opened flash:/CTLFile.tlv, fd 14, size 3837 for process 255

Sep 13 12:04:03.877: TFTP: Finished flash:/CTLFile.tlv, time 00:00:00 for process 255

Sep 13 12:04:04.029: TFTP: Looking for ITLSEP00215502E6B7.tlv

Sep 13 12:04:04.149: TFTP: Looking for ITLFile.tlv

Sep 13 12:04:04.637: TFTP: Looking for SEP00215502E6B7.cnf.xml.sgn

Sep 13 12:04:04.641: TFTP: Opened system:/its/vrf1/SEP00215502E6B7.cnf.xml.sgn, fd 14, size 2194 for process 255

Sep 13 12:04:04.645: TFTP: Finished system:/its/vrf1/SEP00215502E6B7.cnf.xml.sgn, time 00:00:00 for process 255

Sep 13 12:04:08.577: TFTP: Looking for English_United_States/be-sccp.jar.sgn

Sep 13 12:04:09.029: TFTP: Looking for United_States/g3-tones.xml.sgn

Sep 13 12:04:10.289: New Skinny socket accepted [2] from 1, sub 1 (2 active)

Sep 13 12:04:10.289: sin_family 2, sin_port 50708, in_addr 10.192.255.163

Sep 13 12:04:10.289: add_skinny_secure_socket: signal tunnel reserved for 2 10.192.255.163 50708

Sep 13 12:04:10.289: add_skinny_secure_socket: pid =255, new_sock=0, ip address = 10.192.255.163

Sep 13 12:04:10.289: skinny_secure_handshake: pid =255, sock=0, args->pid=255, ip address = 10.192.255.163

Sep 13 12:04:10.289: opssl_SetPKIInfo entry

Sep 13 12:04:10.289: CRYPTO_PKI: (A0036) Session started - identity selected (CME)

Sep 13 12:04:10.289: CRYPTO_OPSSL: Got router SIGNATURE private key

Sep 13 12:04:10.289:  No need to add ROOT cert.

 

Sep 13 12:04:10.289: CRYPTO_PKI: Rcvd request to end PKI session A0036.

Sep 13 12:04:10.289: CRYPTO_PKI: PKI session A0036 has ended. Freeing all resources.

Sep 13 12:04:10.289: CRYPTO_PKI: unlocked trustpoint CME, refcount is 0

Sep 13 12:04:10.289: opssl_SetPKIInfo done.

Sep 13 12:04:10.289: Start TLS Handshake 0 10.192.255.163 50708

Sep 13 12:04:10.289: Handshake start: before/accept initialization

Sep 13 12:04:10.289: SSL_accept:before/accept initialization

 

 

==========================

Sep 13 12:04:10.289: SSL_accept:would block on read in SSLv3 read client hello B

Sep 13 12:04:10.289: TLS Handshake retcode OPSSLReadWouldBlockErr

Sep 13 12:04:11.289: <<< TLS 1.0 Handshake [length 002F], ClientHello

Sep 13 12:04:11.289:     01 00 00 2B 03 01 57 51 B6 5D 3A 93 31 88 33 E9

Sep 13 12:04:11.289:     AF CA 87 1C 67 85 BA C1 3D 98 A3 C0 57 BC A4 0C

Sep 13 12:04:11.289:     7C 74 86 55 1F BA 00 00 04 00 35 00 2F 01 00

Sep 13 12:04:11.289:

 

==========================

Sep 13 12:04:11.289: SSL_accept:SSLv3 read client hello B

Sep 13 12:04:11.289: >>> TLS 1.0 Handshake [length 004A], ServerHello

Sep 13 12:04:11.289:     02 00 00 46 03 01 57 D7 EB 3B F7 6E 35 F7 9F 7C

Sep 13 12:04:11.289:     A2 E6 C0 98 D8 76 4C 96 12 7C 47 EE EF FB 7B 3E

Sep 13 12:04:11.289:     B8 F5 79 4A E0 74 20 9A E3 B4 46 EB 3E 64 3F B5

Sep 13 12:04:11.289:     22 0E A4 D7 84 B3 80 5A 61 B2 24 CD 39 3A 86 11

Sep 13 12:04:11.289:     2B 0A 14 0E 35 5F 23 00 2F 00

Sep 13 12:04:11.289:

 

==========================

Sep 13 12:04:11.289: SSL_accept:SSLv3 write server hello A

Sep 13 12:04:11.289: >>> TLS 1.0 Handshake [length 0204], Certificate

Sep 13 12:04:11.289:     0B 00 02 00 00 01 FD 00 01 FA 30 82 01 F6 30 82

Sep 13 12:04:11.289:     01 5F A0 03 02 01 02 02 01 02 30 0D 06 09 2A 86

Sep 13 12:04:11.289:     48 86 F7 0D 01 01 05 05 00 30 13 31 11 30 0F 06

Sep 13 12:04:11.289:     03 55 04 03 13 08 43 41 73 65 72 76 65 72 30 1E

Sep 13 12:04:11.289:     17 0D 31 36 30 39 31 32 31 35 30 32 31 36 5A 17

Sep 13 12:04:11.289:     0D 31 37 30 39 31 32 31 35 30 32 31 36 5A 30 1E

Sep 13 12:04:11.289:     31 1C 30 1A 06 09 2A 86 48 86 F7 0D 01 09 02 16

Sep 13 12:04:11.289:     0D 43 4D 45 2E 71 61 72 2E 6C 6F 63 61 6C 30 81

Sep 13 12:04:11.289:     9F 30 0D 06 09 2A 86 48 86 F7 0D 01 01 01 05 00

Sep 13 12:04:11.289:     03 81 8D 00 30 81 89 02 81 81 00 94 96 B7 65 5A

Sep 13 12:04:11.289:     22 2F 78 4C 22 05 AB B7 82 D2 BC 84 B8 C6 D8 8D

Sep 13 12:04:11.289:     05 A0 38 56 B9 9C 89 7B 9E E9 60 2B E1 07 F2 72

Sep 13 12:04:11.289:     9A 29 7B 8D 2B B7 8F 0F EA 2F 19 D5 5B 2C 3D 83

Sep 13 12:04:11.289:     D9 94 8F F9 98 1C 7C F4 4C 72 26 C7 D2 3B DE 82

Sep 13 12:04:11.289:     CD 83 68 62 67 2E 8B F8 67 B4 34 7C DC 99 05 44

Sep 13 12:04:11.289:     D5 56 C3 E3 42 22 00 4C E7 62 59 5E EF AA 45 6F

Sep 13 12:04:11.289:     87 4A 16 C5 15 90 29 42 D1 1E 27 42 F3 4D A5 9C

Sep 13 12:04:11.289:     99 47 88 FB D7 A3 84 95 CE 91 95 02 03 01 00 01

Sep 13 12:04:11.289:     A3 4F 30 4D 30 0B 06 03 55 1D 0F 04 04 03 02 05

Sep 13 12:04:11.289:     A0 30 1F 06 03 55 1D 23 04 18 30 16 80 14 AD F2

Sep 13 12:04:11.289:     F4 E7 F0 DD A5 AC 51 C0 64 D9 15 B7 52 44 7B 0B

Sep 13 12:04:11.289:     8E D7 30 1D 06 03 55 1D 0E 04 16 04 14 F1 1B 2C

Sep 13 12:04:11.289:     9A 1E 17 13 F3 C8 29 5C CD 5C F5 9D 78 AC 3F 5B

Sep 13 12:04:11.289:     02 30 0D 06 09 2A 86 48 86 F7 0D 01 01 05 05 00

Sep 13 12:04:11.293:     03 81 81 00 87 01 46 2D CB FC ED EF A0 53 BF C9

Sep 13 12:04:11.293:     4C 21 34 7A AA A5 B0 9D 2C 43 1B 00 6F FA 16 AE

Sep 13 12:04:11.293:     7A 21 95 A0 EB 0D 3F 41 27 55 02 26 95 24 F8 5F

Sep 13 12:04:11.293:     08 D3 5B D5 3E ED BE 61 58 30 27 08 EE 7F 61 99

Sep 13 12:04:11.293:     78 72 89 AE 02 6B 28 69 EF CC AD C9 2B DC 4E 33

Sep 13 12:04:11.293:     C8 21 89 D3 F3 C3 8B 92 29 3F D3 1F 4C 9E CD 5D

Sep 13 12:04:11.293:     A2 18 4A 8B 06 2A 05 C3 85 C1 B7 2F B0 55 57 48

Sep 13 12:04:11.293:     28 7A 4F CB 71 74 FC D1 D1 D0 C0 99 55 9A 5C 16

Sep 13 12:04:11.293:     3D 69 70 41

Sep 13 12:04:11.293:

 

==========================

Sep 13 12:04:11.293: SSL_accept:SSLv3 write certificate A

Sep 13 12:04:11.293: >>> TLS 1.0 Handshake [length 000C], CertificateRequest

Sep 13 12:04:11.293:     0D 00 00 04 01 01 00 00 0E 00 00 00

Sep 13 12:04:11.293:

Sep 13 12:04:11.293: SSL_accept:SSLv3 write certificate request A

Sep 13 12:04:11.293: SSL_accept:would block on write in SSLv3 flush data

 

==========================

Sep 13 12:04:11.293: TLS Handshake retcode OPSSLReadWouldBlockErr

Sep 13 12:04:12.293: SSL_accept:SSLv3 flush data

Sep 13 12:04:12.293: SSL_accept:would block on read in SSLv3 read client certificate A

Sep 13 12:04:12.293: TLS Handshake retcode OPSSLReadWouldBlockErr

Sep 13 12:04:13.293: SSL_accept:would block on read in SSLv3 read client certificate A

Sep 13 12:04:13.293: TLS Handshake retcode OPSSLReadWouldBlockErr

Sep 13 12:04:14.293: <<< TLS 1.0 Handshake [length 0487], Certificate

Sep 13 12:04:14.293:     0B 00 04 83 00 04 80 00 04 7D 30 82 04 79 30 82

Sep 13 12:04:14.293:     03 61 A0 03 02 01 02 02 0A 77 1E C4 95 00 00 00

Sep 13 12:04:14.293:     11 CD DE 30 0D 06 09 2A 86 48 86 F7 0D 01 01 05

Sep 13 12:04:14.293:     05 00 30 39 31 16 30 14 06 03 55 04 0A 13 0D 43

Sep 13 12:04:14.293:     69 73 63 6F 20 53 79 73 74 65 6D 73 31 1F 30 1D

Sep 13 12:04:14.293:     06 03 55 04 03 13 16 43 69 73 63 6F 20 4D 61 6E

Sep 13 12:04:14.293:     75 66 61 63 74 75 72 69 6E 67 20 43 41 30 1E 17

Sep 13 12:04:14.293:     0D 30 38 30 34 30 38 30 34 32 38 35 30 5A 17 0D

Sep 13 12:04:14.293:     31 38 30 34 30 38 30 34 33 38 35 30 5A 30 50 31

Sep 13 12:04:14.293:     1B 30 19 06 03 55 04 0A 13 12 43 69 73 63 6F 20

Sep 13 12:04:14.293:     53 79 73 74 65 6D 73 20 49 6E 63 2E 31 0E 30 0C

Sep 13 12:04:14.293:     06 03 55 04 0B 13 05 45 56 56 42 55 31 21 30 1F

Sep 13 12:04:14.293:     06 03 55 04 03 13 18 43 50 2D 37 39 36 35 47 2D

Sep 13 12:04:14.293:     53 45 50 30 30 32 31 35 35 30 32 45 36 42 37 30

Sep 13 12:04:14.293:     82 01 22 30 0D 06 09 2A 86 48 86 F7 0D 01 01 01

Sep 13 12:04:14.293:     05 00 03 82 01 0F 00 30 82 01 0A 02 82 01 01 00

Sep 13 12:04:14.293:     B7 85 EF E3 EB 12 C4 92 39 F3 F5 5B 2A 1C DE B8

Sep 13 12:04:14.293:     50 BC AD E8 84 53 CB 31 5D 74 8F 05 1B B8 90 8F

Sep 13 12:04:14.293:     C8 8F 47 D3 5E 6E CC 00 FE A6 B6 CF 67 4A FA EC

Sep 13 12:04:14.293:     28 B6 CC 51 FA 70 45 3F 66 56 DC DC FD 6B C4 3D

Sep 13 12:04:14.293:     F8 0A ED D1 65 AC 4E D0 13 5C A3 2A AB D5 04 E7

Sep 13 12:04:14.293:     5A 62 2E DD 9A 9A A7 9B 41 55 FF 5E C6 CD 96 2F

Sep 13 12:04:14.293:     0C DC CD 90 B2 EE 8C F0 F8 3D 18 4C 12 66 30 71

Sep 13 12:04:14.293:     2C D3 B2 BB E0 40 13 E2 85 7A 28 82 AA 22 D9 6C

Sep 13 12:04:14.293:     91 81 7B D1 B8 42 19 9B E3 17 B5 B8 44 A4 AB C2

Sep 13 12:04:14.293:     D2 A3 C2 68 50 A8 13 47 FE 65 EE 6D 25 1A 51 58

Sep 13 12:04:14.293:     70 44 34 FC D0 DD 9F 01 64 7D 1D 7B 6B 34 DA 69

Sep 13 12:04:14.293:     14 5A 3F 4B D3 6E 9D 62 95 7B 52 1A 3E 14 7E E1

Sep 13 12:04:14.293:     0A 33 61 DD 7C 2D CC 67 25 CF 99 77 5B 98 2C 9F

Sep 13 12:04:14.293:     66 35 14 C4 39 27 02 7C 50 5A E3 5A 27 DC 7F 74

Sep 13 12:04:14.293:     06 52 66 2B 6F 35 17 8D 13 F2 33 90 D5 5A F2 40

Sep 13 12:04:14.293:     54 74 50 70 E5 C8 D9 15 72 0F DF E1 9B FD 4D EB

Sep 13 12:04:14.297:     02 03 01 00 01 A3 82 01 6A 30 82 01 66 30 0B 06

Sep 13 12:04:14.297:     03 55 1D 0F 04 04 03 02 04 F0 30 2A 06 03 55 1D

Sep 13 12:04:14.297:     25 01 01 FF 04 20 30 1E 06 08 2B 06 01 05 05 07

Sep 13 12:04:14.297:     03 01 06 08 2B 06 01 05 05 07 03 02 06 08 2B 06

Sep 13 12:04:14.297:     01 05 05 07 03 05 30 23 06 03 55 1D 11 04 1C 30

Sep 13 12:04:14.297:     1A 86 18 43 50 2D 37 39 36 35 47 2D 53 45 50 30

Sep 13 12:04:14.297:     30 32 31 35 35 30 32 45 36 42 37 30 1D 06 03 55

Sep 13 12:04:14.297:     1D 0E 04 16 04 14 43 CC E3 E7 53 DF 93 CE 01 B4

Sep 13 12:04:14.297:     34 07 31 D5 07 B4 97 5E A2 7D 30 1F 06 03 55 1D

Sep 13 12:04:14.297:     23 04 18 30 16 80 14 D0 C5 22 26 AB 4F 46 60 EC

Sep 13 12:04:14.297:     AE 05 91 C7 DC 5A D1 B0 47 F7 6C 30 3B 06 03 55

Sep 13 12:04:14.297:     1D 1F 04 34 30 32 30 30 A0 2E A0 2C 86 2A 68 74

Sep 13 12:04:14.297:     74 70 3A 2F 2F 77 77 77 2E 63 69 73 63 6F 2E 63

Sep 13 12:04:14.297:     6F 6D 2F 73 65 63 75 72 69 74 79 2F 63 72 6C 2F

Sep 13 12:04:14.297:     63 6D 63 61 2E 63 72 6C 30 48 06 08 2B 06 01 05

Sep 13 12:04:14.297:     05 07 01 01 04 3C 30 3A 30 38 06 08 2B 06 01 05

Sep 13 12:04:14.297:     05 07 30 02 86 2C 68 74 74 70 3A 2F 2F 77 77 77

Sep 13 12:04:14.297:     2E 63 69 73 63 6F 2E 63 6F 6D 2F 73 65 63 75 72

Sep 13 12:04:14.297:     69 74 79 2F 63 65 72 74 73 2F 63 6D 63 61 2E 63

Sep 13 12:04:14.297:     65 72 30 3F 06 09 2B 06 01 04 01 82 37 14 02 04

Sep 13 12:04:14.297:     32 1E 30 00 49 00 50 00 53 00 45 00 43 00 49 00

Sep 13 12:04:14.297:     6E 00 74 00 65 00 72 00 6D 00 65 00 64 00 69 00

Sep 13 12:04:14.297:     61 00 74 00 65 00 4F 00 66 00 66 00 6C 00 69 00

Sep 13 12:04:14.297:     6E 00 65 30 0D 06 09 2A 86 48 86 F7 0D 01 01 05

Sep 13 12:04:14.297:     05 00 03 82 01 01 00 65 5C C0 B3 1F 94 C1 69 1C

Sep 13 12:04:14.297:     8F 02 EE A9 57 9F FC CC 4C 02 C1 00 97 D2 68 CA

Sep 13 12:04:14.297:     F8 00 D7 0F D6 D0 C6 9A 8B 78 9C D4 A5 DC 02 EF

Sep 13 12:04:14.297:     B7 4E 15 E7 35 6C 04 2A FE 45 00 27 59 88 F3 9D

Sep 13 12:04:14.297:     89 BC 84 2A B6 65 05 34 66 91 1F AE 5D AF CF 27

Sep 13 12:04:14.297:     A1 FD B4 75 7B 6C 72 96 DD DA 05 01 BC CA D3 E2

Sep 13 12:04:14.297:     45 EA 48 1F 74 2B 2B E7 23 22 64 DD 77 50 F0 0C

Sep 13 12:04:14.297:     A0 E7 D8 C8 07 D9 83 12 C5 CD 0E 9F 3B E0 AF 0E

Sep 13 12:04:14.297:     81 86 50 91 33 07 CD AE 62 39 AF 8C 07 2C C4 F6

Sep 13 12:04:14.297:     AF 3D AA B2 59 B9 5F E9 02 9F 49 3A 49 DA C4 CC

Sep 13 12:04:14.297:     15 59 70 99 FE 0B DA 07 54 9D 0F CC 0E 72 F2 86

Sep 13 12:04:14.297:     A5 8C F5 7E E3 94 8D F0 4F C5 6E D0 47 65 C4 A1

Sep 13 12:04:14.297:     3A 9D 28 FF 36 71 05 D4 48 65 D3 5B D9 50 C7 B1

Sep 13 12:04:14.297:     B8 45 63 E2 50 21 5B 72 65 21 57 40 84 5D 2D 25

Sep 13 12:04:14.297:     92 49 7F 1B 7B 5D D1 B4 92 E9 81 D4 DB 78 22 BD

Sep 13 12:04:14.297:     55 B2 CE E4 BF 41 8A 2F 48 5D 34 D6 D2 AB 4C B1

Sep 13 12:04:14.297:     DA 99 8F 1D 6A FD B0

Sep 13 12:04:14.297:

 

==========================

Sep 13 12:04:14.301: CRYPTO_PKI: (A0037) Session started - identity not specified

Sep 13 12:04:14.301: CRYPTO_PKI: (A0037) Adding peer certificate

Sep 13 12:04:14.301: CRYPTO_PKI: Added x509 peer certificate - (1149) bytes

Sep 13 12:04:14.301: CRYPTO_PKI: ip-ext-val: IP extension validation not required

Sep 13 12:04:14.301: CRYPTO_PKI: create new ca_req_context type PKI_VERIFY_CHAIN_CONTEXT,ident 6

Sep 13 12:04:14.301: CRYPTO_PKI: (A0037)validation path has 1 certs

 

Sep 13 12:04:14.301: CRYPTO_PKI: (A0037) Check for identical certs

Sep 13 12:04:14.301: CRYPTO_PKI : (A0037) Validating non-trusted cert

Sep 13 12:04:14.301: CRYPTO_PKI: (A0037) Create a list of suitable trustpoints

Sep 13 12:04:14.301: CRYPTO_PKI: Unable to locate cert record by issuername

Sep 13 12:04:14.301: CRYPTO_PKI: No trust point for cert issuer, looking up cert chain

 

Sep 13 12:04:14.301: CRYPTO_PKI: Found a issuer match

Sep 13 12:04:14.301: CRYPTO_PKI: (A0037) Suitable trustpoints are: Trustpool2,

Sep 13 12:04:14.301: CRYPTO_PKI: (A0037) Attempting to validate certificate using Trustpool2 policy

Sep 13 12:04:14.301: CRYPTO_PKI: (A0037) Using Trustpool2 to validate certificate

Sep 13 12:04:14.301: CRYPTO_PKI: Added 1 certs to trusted chain.

Sep 13 12:04:14.301: CRYPTO_PKI: Prepare session revocation service providers

Sep 13 12:04:14.301:  CRYPTO_PKI: Deleting cached key having key id 5

Sep 13 12:04:14.301:  CRYPTO_PKI: Attempting to insert the peer's public key into cache

Sep 13 12:04:14.301:  CRYPTO_PKI:Peer's public inserted successfully with key id 6

Sep 13 12:04:14.305:  CRYPTO_PKI: Expiring peer's cached key with key id 6

Sep 13 12:04:14.305: CRYPTO_PKI: (A0037) Certificate is verified

Sep 13 12:04:14.305: CRYPTO_PKI: Remove session revocation service providers

Sep 13 12:04:14.305: CRYPTO_PKI: Remove session revocation service providers

Sep 13 12:04:14.305: CRYPTO_PKI: (A0037) Certificate validated without revocation check

Sep 13 12:04:14.305: CRYPTO_PKI: Populate AAA auth data

Sep 13 12:04:14.305: CRYPTO_PKI: Unable to get configured attribute for primary AAA list authorization.

Sep 13 12:04:14.305: CRYPTO_PKI: (A0037)chain cert was anchored to trustpoint Trustpool2, and chain validation result was: CRYPTO_VALID_CERT_WITH_WARNING

Sep 13 12:04:14.305: CRYPTO_PKI: locked trustpoint Trustpool2, refcount is 1

Sep 13 12:04:14.305: CRYPTO_PKI: (A0037) Validation TP is Trustpool2

Sep 13 12:04:14.305: CRYPTO_PKI: (A0037) Certificate validation succeeded

Sep 13 12:04:14.305: CRYPTO_PKI: Rcvd request to end PKI session A0037.

Sep 13 12:04:14.305: CRYPTO_PKI: PKI session A0037 has ended. Freeing all resources.

Sep 13 12:04:14.305: CRYPTO_PKI: unlocked trustpoint Trustpool2, refcount is 0

Sep 13 12:04:14.305: SSL_accept:SSLv3 read client certificate A

Sep 13 12:04:14.305: <<< TLS 1.0 Handshake [length 0086], ClientKeyExchange

Sep 13 12:04:14.305:     10 00 00 82 00 80 59 44 59 FB C1 89 32 11 CF AA

Sep 13 12:04:14.305:     70 2E C6 CE 9F 92 72 4D 08 59 46 C9 56 CA 94 3E

Sep 13 12:04:14.305:     69 B5 5B F9 21 0E 07 0A C3 E6 AF C2 AF 23 36 1C

Sep 13 12:04:14.305:     C5 36 5A 5A D0 14 05 26 E7 8F 1F 77 C3 51 3E 30

Sep 13 12:04:14.305:     29 D1 D2 76 13 2A C8 20 3B E4 63 AB 8E E7 EB D6

Sep 13 12:04:14.305:     A4 89 03 1D 28 89 19 2F 53 49 B6 D6 86 FF D6 5F

Sep 13 12:04:14.305:     07 A0 7D CA 50 7A BA DD 4B E9 AF 1D 31 74 07 5E

Sep 13 12:04:14.305:     9E C9 F0 ED 43 7F DF 7F 41 D3 D3 30 A7 11 36 95

Sep 13 12:04:14.305:     34 E5 7D A9 2E 7A

Sep 13 12:04:14.305:

Sep 13 12:04:14.341: SSL_accept:SSLv3 read client key exchange A

Sep 13 12:04:14.341: <<< TLS 1.0 Handshake [length 0106], CertificateVerify

Sep 13 12:04:14.341:     0F 00 01 02 01 00 14 89 17 0D 00 42 26 E4 71 7C

Sep 13 12:04:14.341:     23 50 21 28 09 21 4F 12 EE 89 EF AD EB D3 7E 79

Sep 13 12:04:14.341:     50 78 55 19 84 C6 44 94 CF 26 A9 29 F6 A0 BF A2

Sep 13 12:04:14.341:     31 76 CB 79 8F 17 08 C9 75 7D 20 B9 23 CE BC 63

Sep 13 12:04:14.345:     87 26 57 72 62 20 8E B1 9A F2 DB 37 FE C7 42 2E

Sep 13 12:04:14.345:     66 5B CB 2B C0 C8 E2 41 83 04 F4 61 E6 6E 0A A4

Sep 13 12:04:14.345:     70 D1 3E BE DD 4A A8 D8 2A ED 38 73 E2 25 FA 80

Sep 13 12:04:14.345:     AB 68 D0 DE B1 0F A2 F7 C0 63 6B E0 35 55 30 78

Sep 13 12:04:14.345:     5C 1F 28 4F 9D E2 D2 D1 9C AD 73 2A 17 85 19 91

Sep 13 12:04:14.345:     9A 96 77 45 62 99 27 CC CD E1 7D AF 73 FD D9 EF

Sep 13 12:04:14.345:     9D 5D 99 F9 9A 32 CC 32 25 DB 93 B3 A4 07 B9 EE

Sep 13 12:04:14.345:     A4 19 1D 7E 31 C1 FE F3 30 CE 5E F1 DA CB C7 49

Sep 13 12:04:14.345:     6A F1 A2 B0 BE 4C D9 70 F5 60 76 4D 62 30 4A BA

Sep 13 12:04:14.345:     3F 80 1C 28 EC E7 AA 2B E6 77 82 86 B9 03 00 CB

Sep 13 12:04:14.345:     78 D9 48 1E B0 3B F7 61 54 D9 6E 65 3C C3 A7 02

Sep 13 12:04:14.345:     DE 9E 73 7D 19 F0 FA 31 C2 10 AE E9 9A 07 A6 BF

Sep 13 12:04:14.345:     5B 54 E2 CC AD 4A

Sep 13 12:04:14.345:

Sep 13 12:04:14.345:  CRYPTO_PKI: Attempting to insert the peer's public key into cache

Sep 13 12:04:14.345:  CRYPTO_PKI:Peer's public inserted successfully with key id 6

Sep 13 12:04:14.349: SSL_accept:SSLv3 read certificate verify A

Sep 13 12:04:14.349: <<< TLS 1.0 ChangeCipherSpec [length 0001]

Sep 13 12:04:14.349:     01

Sep 13 12:04:14.349:

Sep 13 12:04:14.353: <<< TLS 1.0 Handshake [length 0010], Finished

Sep 13 12:04:14.353:     14 00 00 0C 52 F2 BB 67 BF 83 B2 39 96 6C 01 78

Sep 13 12:04:14.353:

Sep 13 12:04:14.353: SSL_accept:SSLv3 read finished A

Sep 13 12:04:14.353: >>> TLS 1.0 ChangeCipherSpec [length 0001]

Sep 13 12:04:14.353:     01

Sep 13 12:04:14.353:

Sep 13 12:04:14.353: SSL_accept:SSLv3 write change cipher spec A

Sep 13 12:04:14.353: >>> TLS 1.0 Handshake [length 0010], Finished

Sep 13 12:04:14.353:     14 00 00 0C FD A5 87 A8 DA 79 10 28 E3 9D 2D D6

Sep 13 12:04:14.353:

Sep 13 12:04:14.353: SSL_accept:SSLv3 write finished A

Sep 13 12:04:14.353: SSL_accept:SSLv3 flush data

Sep 13 12:04:14.353: Handshake done: SSL negotiation finished successfully

Sep 13 12:04:14.353: TLS Handshake completes

Sep 13 12:04:14.353: add_skinny_secure_socket 0 10.192.255.163 50708

Sep 13 12:04:15.109: UNSUPPORTED message 0x15A on socket 3

Sep 13 12:04:15.185: ephone-(2)[3] StationRegisterMessage (2/4/21) from 10.192.255.163

Sep 13 12:04:15.185: ephone-(2)[3] Register StationIdentifier DeviceName SEP00215502E6B7

Sep 13 12:04:15.185: ephone-(2)[3] StationIdentifier Instance 0    deviceType 436

Sep 13 12:04:15.185: fSkinnyStationRegister deviceType 436 protocolVer = 0xAD720016

Sep 13 12:04:15.185: StationJoinAndDirectTransferFeatureSupportMask set disable

Sep 13 12:04:15.185: StationDisableJoinOnTheSameLineFeatureMask set enable

Sep 13 12:04:15.185: StationDisableJoinAcrossLineFeatureMask set enable

Sep 13 12:04:15.185: StationDisableDirectTransferOnTheSameLineFeatureMask set enable

Sep 13 12:04:15.185: StationDisableDirectTransferAcrossLineFeatureMask set enable

Sep 13 12:04:15.185: ephone-2[1/-1][SEP00215502E6B7]:stationIpAddr 10.192.255.163

Sep 13 12:04:15.185: ephone-2[1/-1][SEP00215502E6B7]:stationIpv6Addr ::

Sep 13 12:04:15.185: ephone-2[1/-1][SEP00215502E6B7]:maxStreams 5

Sep 13 12:04:15.185: ephone-2[1/-1][SEP00215502E6B7]:From Phone raw protocol Ver 0xAD720016

Sep 13 12:04:15.185: ephone-2[1/-1][SEP00215502E6B7]:protocol Ver 0xAD720016

Sep 13 12:04:15.185: ephone-2[1/-1][SEP00215502E6B7]:phone-size 36136 dn-size 1048

Sep 13 12:04:15.185: ephone-(2) Allow any Skinny Server IP address 10.57.37.130

Sep 13 12:04:15.185: ephone-2[1/-1][SEP00215502E6B7]:Found entry 1 for 00215502E6B7

Sep 13 12:04:15.185: ephone-2[1/-1][SEP00215502E6B7]:socket change -1 to 3

Sep 13 12:04:15.185: ephone-2[1/-1][SEP00215502E6B7]:FAILED: CLOSED old socket -1

Sep 13 12:04:15.185: ephone-2[1/-1][SEP00215502E6B7]:

Sep 13 12:04:15.185: bulk_speeddial_init_ephone: 1

Sep 13 12:04:15.185: ephone-2[1/-1]:SkinnyVideoParmsUpdate: phone: 1, action: 2, dn_index: -1

Sep 13 12:04:15.185: ephone-2[1/3][SEP00215502E6B7]:phone SEP00215502E6B7 re-associate OK on socket [3]

Sep 13 12:04:15.185: %IPPHONE-6-REGISTER: ephone-2:SEP00215502E6B7 IP:10.192.255.163 Socket:3 DeviceType:Phone has registered.

Sep 13 12:04:15.185: Phone 1 socket 3

Sep 13 12:04:15.185: Skinny Local IP address = 10.57.37.130 on port 2000

 

Sep 13 12:04:15.185: Skinny Phone IP address = 10.192.255.163 50708

Sep 13 12:04:15.185: ephone-2[1/3]:SkinnyVideoParmsUpdate: phone: 1, action: 2, dn_index: -1

Sep 13 12:04:15.185: ephone-2[1/3][SEP00215502E6B7]:Signal protocol ver 17 to phone with ver 22

Sep 13 12:04:15.185: ephone-2[1/3][SEP00215502E6B7]:Date Format D/M/Y

Sep 13 12:04:15.185: ephone-2[1/3]:RegisterAck sent to sockettype ephone socket 3: keepalive period 30 use sccp-version 17

Sep 13 12:04:15.185: ephone-2[1/3]:CapabilitiesReq sent

Sep 13 12:04:15.221: ephone-2[1/3][SEP00215502E6B7]:Skinny IP port 3500 set for socket [3]

Sep 13 12:04:15.225: ephone-2[1/3]:ButtonTemplateReqMessage

Sep 13 12:04:15.225: ephone-2[1/3][SEP00215502E6B7]:ButtonTemplateReqMessage get maxNumberOfLines 54

Sep 13 12:04:15.225: ephone-2[1/3]:ButtonTemplateReqMessage waiting for Caps

Sep 13 12:04:15.225: ephone-2[1/3]:StationSoftKeyTemplateReqMessage

Sep 13 12:04:15.225: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 1 Redial

Sep 13 12:04:15.225: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 2 NewCall

Sep 13 12:04:15.225: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 3 Hold

Sep 13 12:04:15.225: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 4 Trnsfer

Sep 13 12:04:15.225: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 5 CFwdAll

Sep 13 12:04:15.225: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 6 CW Off

Sep 13 12:04:15.225: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 7 CFwdNoAnswer

Sep 13 12:04:15.225: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 8 <<

Sep 13 12:04:15.225: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 9 EndCall

Sep 13 12:04:15.225: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 10 Resume

Sep 13 12:04:15.225: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 11 Answer

Sep 13 12:04:15.225: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 12 Info

Sep 13 12:04:15.225: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 13 Confrn

Sep 13 12:04:15.229: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 14 Park

Sep 13 12:04:15.229: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 15 Join

Sep 13 12:04:15.229: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 16 MeetMe

Sep 13 12:04:15.229: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 17 PickUp

Sep 13 12:04:15.229: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 18 GPickUp

Sep 13 12:04:15.229: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 19 RmLstC

Sep 13 12:04:15.229: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 20 CallBack

Sep 13 12:04:15.229: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 21 Barge

Sep 13 12:04:15.229: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 22 DnD

Sep 13 12:04:15.229: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 23 Acct

Sep 13 12:04:15.229: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 24 Flash

Sep 13 12:04:15.229: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 25 Login

Sep 13 12:04:15.229: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 26 HLog

Sep 13 12:04:15.229: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 27 ConfList

Sep 13 12:04:15.229: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 28 Select

Sep 13 12:04:15.229: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 29 TrnsfVM

Sep 13 12:04:15.229: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 30 CBarge

Sep 13 12:04:15.229: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 31 LiveRcd

Sep 13 12:04:15.229: ephone-2[1/3][SEP00215502E6B7]:SoftKeys: 32 Mobility

Sep 13 12:04:15.229: ephone-2[1/3]:StationSoftKeyTemplateResMessage

Sep 13 12:04:15.229: ephone-2[1/3]:StationSoftKeySetReqMessage

Sep 13 12:04:15.229: ephone-2[1/3]:GetSoftkeysetIdle: Default Template

 

Sep 13 12:04:15.229: ephone-2[1/3]:GetSoftkeysetConnected:Default Template

 

Sep 13 12:04:15.229: ephone-2[1/3]:GetSoftkeysetHold: Default Template

 

Sep 13 12:04:15.229: ephone-2[1/3]:GetSoftkeysetRinging: Default Template

 

Sep 13 12:04:15.229: ephone-2[1/3]:GetSoftkeysetSeized:Default Template

 

Sep 13 12:04:15.229: ephone-2[1/3]:GetSoftkeysetAlerting:Default Template

 

Sep 13 12:04:15.229: ephone-2[1/3]:GetSoftkeysetRemote_in_use:Default Template

 

Sep 13 12:04:15.229: ephone-2[1/3]:StationSoftKeySetResMessage

Sep 13 12:04:15.229: skinny_tls_write block error=11 returnCode=-6982, len=792 buf_len=0

Sep 13 12:04:15.233: ephone-2[1/3]:StationConfigStatReqMessage

Sep 13 12:04:15.233: ephone-2[1/3]:waiting for Caps

Sep 13 12:04:15.241: ephone-2[1/3]:CapabilitiesRes received

Sep 13 12:04:15.241: ephone-2[1/3][SEP00215502E6B7]:Caps list 9

WideBand_256K  40 ms, is_mtp 0

G711Ulaw64k  40 ms, is_mtp 0

G711Alaw64k  40 ms, is_mtp 0

ILBC  60 ms, is_mtp 0

G729AnnexB  60 ms, is_mtp 0

G729AnnexAwAnnexB  60 ms, is_mtp 0

G729  60 ms, is_mtp 0

G729AnnexA  60 ms, is_mtp 0

RFC2833 Dynamic Payload 1 ms, is_mtp 0

 

Sep 13 12:04:15.241: ephone-2[1/3]:Process pending button template

Sep 13 12:04:15.245: ephone-2[1/3]:ButtonTemplateReqMessage

Sep 13 12:04:15.245: ephone-2[1/3][SEP00215502E6B7]:StationButtonTemplateReqMessage set max presentation to 6

Sep 13 12:04:15.245: ephone-2[1/3]:CheckAutoReg

Sep 13 12:04:15.245: ephone-2[1/3]:AutoReg is disabled

Sep 13 12:04:15.245: ephone-2[1/3][SEP00215502E6B7]:Setting 6 lines 0 speed-dials on phone (max_line 6)

Sep 13 12:04:15.245: ephone-2[1/3][SEP00215502E6B7]:First Speed Dial Button location is 0 (0)

Sep 13 12:04:15.245: ephone-2[1/3]:ButtonTemplate lines=6 speed=0 buttons=6 offset=0

Sep 13 12:04:15.245: ephone-2[1/3][SEP00215502E6B7]:ButtonTemplate buttonCount=6 totalButtonCount=6 buttonOffset=0

Sep 13 12:04:15.245: ephone-2[1/3][SEP00215502E6B7]:Configured 0 speed dial buttons

Sep 13 12:04:15.245: ephone-2[1/3]:Process pending ConfigStat

Sep 13 12:04:15.245: ephone-2[1/3]:StationConfigStatReqMessage

Sep 13 12:04:15.245: ephone-2[1/3][SEP00215502E6B7]:StationConfigStatMessage sent for device SEP00215502E6B7 (40/280)

Sep 13 12:04:15.301: ephone-2[1/3][SEP00215502E6B7]:StationLineStatReqMessage from ephone line 1

Sep 13 12:04:15.301: ephone-2[1/3]:StationLineStatReqMessage ephone line 1 DN 2 = 456 desc = 456 label = 456

Sep 13 12:04:15.301: ephone-2[1/3][SEP00215502E6B7]:StationLineStatResMessage sent to ephone (1 of 6)

Sep 13 12:04:15.325: ephone-2[1/3][SEP00215502E6B7]:StationForwardStatReqMessage line 1 from ephone

Sep 13 12:04:15.325: Skinny StationForwardStatMessage line 1 sent on ephone socket [3] for ephone-2

Sep 13 12:04:15.325: activeForward 0 AllActive 0 BusyActive 0 NoAnswerActive 0

Sep 13 12:04:15.325: ephone-2[1/3][SEP00215502E6B7]:StationLineStatReqMessage from ephone line 2

Sep 13 12:04:15.325: ephone-2[1/3][SEP00215502E6B7]:StationLineStatReqMessage from ephone line 2 Invalid DN -1

Sep 13 12:04:15.325: ephone-2[1/3][SEP00215502E6B7]:StationLineStatResMessage sent to ephone (2 of 6)

Sep 13 12:04:15.325: ephone-2[1/3][SEP00215502E6B7]:StationForwardStatReqMessage line 2 from ephone

Sep 13 12:04:15.325: Skinny StationForwardStatMessage line 2 sent on ephone socket [3] for ephone-2

Sep 13 12:04:15.325: activeForward 0 AllActive 0 BusyActive 0 NoAnswerActive 0

Sep 13 12:04:15.325: ephone-2[1/3][SEP00215502E6B7]:StationLineStatReqMessage from ephone line 3

Sep 13 12:04:15.325: ephone-2[1/3][SEP00215502E6B7]:StationLineStatReqMessage from ephone line 3 Invalid DN -1

Sep 13 12:04:15.325: ephone-2[1/3][SEP00215502E6B7]:StationLineStatResMessage sent to ephone (3 of 6)

Sep 13 12:04:15.325: ephone-2[1/3][SEP00215502E6B7]:StationForwardStatReqMessage line 3 from ephone

Sep 13 12:04:15.325: Skinny StationForwardStatMessage line 3 sent on ephone socket [3] for ephone-2

Sep 13 12:04:15.325: activeForward 0 AllActive 0 BusyActive 0 NoAnswerActive 0

Sep 13 12:04:15.325: ephone-2[1/3][SEP00215502E6B7]:StationLineStatReqMessage from ephone line 4

Sep 13 12:04:15.325: ephone-2[1/3][SEP00215502E6B7]:StationLineStatReqMessage from ephone line 4 Invalid DN -1

Sep 13 12:04:15.325: ephone-2[1/3][SEP00215502E6B7]:StationLineStatResMessage sent to ephone (4 of 6)

Sep 13 12:04:15.325: ephone-2[1/3][SEP00215502E6B7]:StationForwardStatReqMessage line 4 from ephone

Sep 13 12:04:15.325: Skinny StationForwardStatMessage line 4 sent on ephone socket [3] for ephone-2

Sep 13 12:04:15.325: activeForward 0 AllActive 0 BusyActive 0 NoAnswerActive 0

Sep 13 12:04:15.325: ephone-2[1/3][SEP00215502E6B7]:StationLineStatReqMessage from ephone line 5

Sep 13 12:04:15.325: ephone-2[1/3][SEP00215502E6B7]:StationLineStatReqMessage from ephone line 5 Invalid DN -1

Sep 13 12:04:15.325: ephone-2[1/3][SEP00215502E6B7]:StationLineStatResMessage sent to ephone (5 of 6)

Sep 13 12:04:15.325: ephone-2[1/3][SEP00215502E6B7]:StationForwardStatReqMessage line 5 from ephone

Sep 13 12:04:15.325: Skinny StationForwardStatMessage line 5 sent on ephone socket [3] for ephone-2

Sep 13 12:04:15.325: activeForward 0 AllActive 0 BusyActive 0 NoAnswerActive 0

Sep 13 12:04:15.325: ephone-2[1/3][SEP00215502E6B7]:StationLineStatReqMessage from ephone line 6

Sep 13 12:04:15.325: ephone-2[1/3][SEP00215502E6B7]:StationLineStatReqMessage from ephone line 6 Invalid DN -1

Sep 13 12:04:15.325: ephone-2[1/3][SEP00215502E6B7]:StationLineStatResMessage sent to ephone (6 of 6)

Sep 13 12:04:15.325: ephone-2[1/3]:SkinnyCompleteRegistration

Sep 13 12:04:15.325: ephone-2[1/3]:SelectPhoneSoftKeys set 0 mask FFBE for line 0 ref 0

Sep 13 12:04:15.325: ephone-2[1/3][SEP00215502E6B7]:SkinnyCheckPendingCallBackPhone scan 6 lines

Sep 13 12:04:15.325: ephone-2[1/3][SEP00215502E6B7]: DN in-service for DN 2 chan 1

Sep 13 12:04:15.325: SkinnyGetCallState for DN 2 chan 1 IDLE

Sep 13 12:04:15.325: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0

Sep 13 12:04:15.325: ephone-2[1/3][SEP00215502E6B7]: DN in-service for DN 2 chan 2

Sep 13 12:04:15.325: SkinnyGetCallState for DN 2 chan 2 IDLE

Sep 13 12:04:15.325: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0

Sep 13 12:04:15.325: Skinny DN 2 chan 1 state change to UP

Sep 13 12:04:15.325: Skinny DN 2 chan 2 state change to UP

Sep 13 12:04:15.325: ephone-2[1/3][SEP00215502E6B7]:SkinnyCleanupOverlapInfo: Obtained phone index(1) from DN

 

Sep 13 12:04:15.325: SkinnySetCTILineStatus: phone 1 dn 2 line status 1 line_removed 0

Sep 13 12:04:15.325: ephone-2[1/3][SEP00215502E6B7]:StationForwardStatReqMessage line 6 from ephone

Sep 13 12:04:15.325: Skinny StationForwardStatMessage line 6 sent on ephone socket [3] for ephone-2

Sep 13 12:04:15.325: activeForward 0 AllActive 0 BusyActive 0 NoAnswerActive 0

Sep 13 12:04:15.601: ephone-2[1/3]:TimeDateReqMessage

Sep 13 12:04:15.601: year=2016 month=9 day=13

Sep 13 12:04:15.601: hour=12 minute=4 second=15

Sep 13 12:04:15.601: day=2 dayofyear=257 tzoffset=0

Sep 13 12:04:15.601: ephone-2[1/3]:DefineTimeDate sent

Sep 13 12:04:15.989: ephone-2[1/3][SEP00215502E6B7]:Check Hot-Sync for line from 1 to 6 out of 1 lines

Sep 13 12:04:15.989: ephone-2[1/3][SEP00215502E6B7]:SkinnySyncDnCFA DN 2 line 1 to []

Sep 13 12:04:15.989: SkinnySyncDnCFA for DN 2 for 1 phones

Sep 13 12:04:15.989: SkinnyGetCallState for DN 2 chan 1 IDLE

Sep 13 12:04:15.989: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0

Sep 13 12:04:15.989: SkinnyGetCallState for DN 2 chan 1 IDLE

Sep 13 12:04:15.989: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0

Sep 13 12:04:15.989: SkinnyGetCallState for DN 2 chan 2 IDLE

Sep 13 12:04:15.989: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0

Sep 13 12:04:15.989: ephone-2[3]:SetCallState line 1 DN 2(-1) chan 1 ref 0 TsOnHook

Sep 13 12:04:15.989: ephone-2[1/3]:SkinnyTrackActiveCall for line 1 ref 0 state 2 (slot 0)

Sep 13 12:04:15.989: ephone-2[1/3]:SelectPhoneSoftKeys set 0 mask FFBE for line 1 ref 0

Sep 13 12:04:15.989: SkinnyGetCallState for DN 2 chan 2 IDLE

Sep 13 12:04:15.989: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0

Sep 13 12:04:15.989: SkinnyGetCallState for DN 2 chan 1 IDLE

Sep 13 12:04:15.989: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0

Sep 13 12:04:15.989: SkinnyGetCallState for DN 2 chan 2 IDLE

Sep 13 12:04:15.989: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0

Sep 13 12:04:15.989: ephone-2[3]:SetCallState line 1 DN 2(-1) chan 2 ref 0 TsOnHook

Sep 13 12:04:15.989: ephone-2[1/3]:SkinnyTrackActiveCall for line 1 ref 0 state 2 (slot 0)

Sep 13 12:04:15.989: ephone-2[1/3]:SelectPhoneSoftKeys set 0 mask FFBE for line 1 ref 0

Sep 13 12:04:15.989: ephone-2[1/3][SEP00215502E6B7]:SkinnyCleanupOverlapInfo: Obtained phone index(1) from DN

 

Sep 13 12:04:15.989: ephone-2[3]:Set MWI line 1 to OFF

Sep 13 12:04:15.989: SkinnyNotifyCTIMWI: phone 1 dn 2 mwi OFF mwi count 0

Sep 13 12:04:15.989: ephone-2[3]:Set MWI line 0 to OFF

Sep 13 12:04:15.989: ephone-2[1/3][SEP00215502E6B7]:SkinnyCheckPendingCallBackPhone scan 6 lines

Sep 13 12:04:15.989: ephone-2[1/3][SEP00215502E6B7]:Skinny Available Lines 6 set for socket [3]

Sep 13 12:04:15.989: ephone-2[1/3]:Already done SkinnyCompleteRegistration

Sep 13 12:04:16.013: ephone-2[1/3][SEP00215502E6B7]:MediaPathEventMessage Headset OFF

Sep 13 12:04:16.013: ephone-2[1/3]:MediaPathEventMessage

Sep 13 12:04:16.013: ephone-2[1/3][SEP00215502E6B7]:MediaPathEventMessage Handset OFF

Sep 13 12:04:16.013: ephone-2[1/3]:MediaPathEventMessage

Sep 13 12:04:16.017: ephone-2[1/3][SEP00215502E6B7]:MediaPathCapabilitiesMessage Speaker Enable

Sep 13 12:04:16.017: ephone-2[1/3]:MediaPathCapabilitiesMessage

Sep 13 12:04:16.113: ephone-2[1/3][SEP00215502E6B7]:Skinny Available Lines 6 set for socket [3]

Sep 13 12:04:16.113: ephone-2[1/3]:Already done SkinnyCompleteRegistration

 

Documentation :

http://www.firewall.cx/cisco-technical-knowledgebase/cisco-voice/956-cisco-voice-cme-secure-voip.html

https://supportforums.cisco.com/blog/9913611/chalk-talk-understanding-and-setting-secure-cme

 

 

1 Reply 1

capf-ip-in-cnf was missing on my ephone config.

Now all is ok.