Please help with Registration issues on CME - Cisco 7841 SIP phones.

[Magnus Holsting]

Hi guys.

I'm in need of assistance.

I'm troubleshooting registration errors on a CUCME, the Cisco SIP 7841 phones, downloads the config, but reports "Error verifying config info".

-Load file has been present in config but removed to see if it helped.

-No create profile/create profile - done many times (after every conf change).

-Phone has been powercyled / reset / factory reset

-Phone cnf.xml has been deleted from flash:

-Ntp server has been added to phone cnf.xml

Essense of Config:

!
ip dhcp excluded-address 10.85.188.1 10.85.188.5
ip dhcp excluded-address 10.85.188.60
!
ip dhcp pool PABX
 network 10.85.188.0 255.255.255.192
 option 150 ip 10.85.188.2
 default-router 10.85.188.2
 option 42 ip 10.85.191.40
!
voice service voip
 no ip address trusted authenticate
 allow-connections h323 to sip
 allow-connections sip to h323
 allow-connections sip to sip
 no supplementary-service sip handle-replaces
 fax protocol t38 version 0 ls-redundancy 0 hs-redundancy 0 fallback none
 sip
  registrar server expires max 600 min 60
!
voice register global
 mode  cme
 source-address 10.85.188.2 port 5060
 max-dn 50
 max-pool 33
 timezone 23
 time-format 24
 date-format D/M/Y
 tftp-path flash:
 create profile sync 0321533874443521
 ntp-server 10.85.191.40 mode unicast
!
voice register dn  18
 number 23017
 name Foam & Sea. Room
 label 23017
!
voice register pool  18
 busy-trigger-per-button 2
 id mac 204C.9EB2.5678
 session-transport tcp
 type 7841
 number 1 dn 18
 dtmf-relay rtp-nte
 description Indoor
 codec g711ulaw
!
interface GigabitEthernet0/0
 description Remote-OSSCORESW01-Gi1/0/2
 ip address 10.85.188.3 255.255.255.192
 standby 1 ip 10.85.188.2
 standby 1 priority 110
 standby 1 preempt
 duplex auto
 speed auto
!
snmp-server community Read-Only RO
snmp-server community Read-Write RW
tftp-server flash:/kern78xx.10-1-1SR1-4.sbn
tftp-server flash:/rootfs78xx.10-1-1SR1-4.sbn
tftp-server flash:/sboot78xx.10-1-1SR1-4.sbn
tftp-server flash:/sip78xx.10-1-1SR1-4.loads
!

------------------------------------

Phone TFTP events:

*Jun 24 11:23:31.611: TFTP: Server request for port 51030, socket_id 0x234EFB70 for process 63
*Jun 24 11:23:31.611: TFTP: read request from host 10.85.188.21(51030) via GigabitEthernet0/0
*Jun 24 11:23:31.611: TFTP: Looking for CTLSEP204C9EB25678.tlv
*Jun 24 11:23:31.611: TFTP: Sending error 1 No such file
*Jun 24 11:23:31.771: TFTP: Server request for port 51000, socket_id 0x234EFB70 for process 63
*Jun 24 11:23:31.771: TFTP: read request from host 10.85.188.21(51000) via GigabitEthernet0/0
*Jun 24 11:23:31.771: TFTP: Looking for ITLSEP204C9EB25678.tlv
*Jun 24 11:23:31.771: TFTP: Sending error 1 No such file
*Jun 24 11:23:32.007: TFTP: Server request for port 49408, socket_id 0x234EFB70 for process 63
*Jun 24 11:23:32.007: TFTP: read request from host 10.85.188.21(49408) via GigabitEthernet0/0
*Jun 24 11:23:32.007: TFTP: Looking for SEP204C9EB25678.cnf.xml
*Jun 24 11:23:32.007: TFTP: Opened flash:/its/SEP204C9EB25678.cnf.xml, fd 4, size 3896 for pro                                     cess 63
*Jun 24 11:23:32.007: TFTP: Sending block 1 (retry 0), len 512, socket_id 0x234EFB70
*Jun 24 11:23:32.007: TFTP: Received ACK for block 1, socket_id 0x234EFB70
*Jun 24 11:23:32.007: TFTP: Sending block 2 (retry 0), len 512, socket_id 0x234EFB70
*Jun 24 11:23:32.007: TFTP: Received ACK for block 2, socket_id 0x234EFB70
*Jun 24 11:23:32.007: TFTP: Sending block 3 (retry 0), len 512, socket_id 0x234EFB70
*Jun 24 11:23:32.009: TFTP: Received ACK for block 3, socket_id 0x234EFB70
*Jun 24 11:23:32.009: TFTP: Sending block 4 (retry 0), len 512, socket_id 0x234EFB70
*Jun 24 11:23:32.009: TFTP: Received ACK for block 4, socket_id 0x234EFB70
*Jun 24 11:23:32.009: TFTP: Sending block 5 (retry 0), len 512, socket_id 0x234EFB70
*Jun 24 11:23:32.009: TFTP: Received ACK for block 5, socket_id 0x234EFB70
*Jun 24 11:23:32.009: TFTP: Sending block 6 (retry 0), len 512, socket_id 0x234EFB70
*Jun 24 11:23:32.009: TFTP: Received ACK for block 6, socket_id 0x234EFB70
*Jun 24 11:23:32.009: TFTP: Sending block 7 (retry 0), len 512, socket_id 0x234EFB70
*Jun 24 11:23:32.009: TFTP: Received ACK for block 7, socket_id 0x234EFB70
*Jun 24 11:23:32.009: TFTP: Sending block 8 (retry 0), len 312, socket_id 0x234EFB70
*Jun 24 11:23:32.009: TFTP: Received ACK for block 8, socket_id 0x234EFB70
*Jun 24 11:23:32.009: TFTP: Finished flash:/its/SEP204C9EB25678.cnf.xml, time 00:00:00 for pro                                     cess 63

Even though the phone recieves config, it still messages "error verifying config info"

Any suggestions? :)

Phone config attached

[Magnus Holsting]

Phone has IP*

OSSPBX01#sh ip dhcp bind
Bindings from all pools not associated with VRF:
IP address          Client-ID/              Lease expiration        Type
                    Hardware address/
                    User name
10.85.188.16        0050.c2fb.de39          Jun 25 2015 10:09 AM    Automatic
10.85.188.17        0050.c2fb.de29          Jun 25 2015 09:19 AM    Automatic
10.85.188.19        01c4.7295.a844.17       Jun 25 2015 11:19 AM    Automatic
10.85.188.21        0120.4c9e.b256.78       Jun 25 2015 12:53 PM    Automatic
OSSPBX01#

[Nadeem Ahmed]

Did you get anything in the debug ccsip messages?  Authenticate register not required if you want CHAP method to imply on the server. if not given even though phone will register with normail Register with 200ok messages.

Br,

Nadeem Ahmed

[Mohammed al Baqari]

Agreed with Nadeem. Authenticate register isn't needed since your phones are in the LAN of the CME. Also, the username and password isn't needed.

You need to configure bind source command under voice register service > sip.

Also, I noticed that you are using HSRP VIP as the source for your CME which isn't correct. You need to use the real IP of the interface because the packets initiated by CME will use real IP (not VIP).

Make these changes and if didn't work please share the output of debug ccsip message

[Magnus Holsting]

Made the following changes:

!
ip dhcp pool PABX
 network 10.85.188.0 255.255.255.192
 option 150 ip 10.85.188.3
 default-router 10.85.188.3
 option 42 ip 10.85.191.40
!

voice service voip
 no ip address trusted authenticate
 allow-connections h323 to sip
 allow-connections sip to h323
 allow-connections sip to sip
 no supplementary-service sip handle-replaces
 fax protocol t38 version 0 ls-redundancy 0 hs-redundancy 0 fallback none
 sip
  bind control source-interface GigabitEthernet0/0
  bind media source-interface GigabitEthernet0/0
  registrar server expires max 600 min 60

!

!
interface GigabitEthernet0/0
 description Remote-OSSCORESW01-Gi1/0/2
 ip address 10.85.188.3 255.255.255.192
 standby 1 ip 10.85.188.2
 standby 1 priority 110
 standby 1 preempt
 duplex auto
 speed auto
!

After this i did a no create profile/create profile.

Now Im awaiting test results to see if it helped, have turned on debug of ccsip and tftp - will post results here if its not working

Thank you again.

[Magnus Holsting]

Output after phone powercycling (after conf changes).

OSSPBX01#
*Jun 25 12:13:07.737: //-1/xxxxxxxxxxxx/SIP/Error/sipSPILineGetVersionStr:
 Failed to get supported header value
*Jun 25 12:13:07.737: //-1/xxxxxxxxxxxx/SIP/Error/ccsipCheckVoiceRegSupportedFeatures:
 Unable to access supported header values
*Jun 25 12:13:16.575: //-1/xxxxxxxxxxxx/SIP/Error/sipSPILineGetVersionStr:
 Failed to get supported header value
*Jun 25 12:13:16.575: //-1/xxxxxxxxxxxx/SIP/Error/ccsipCheckVoiceRegSupportedFeatures:
 Unable to access supported header values
*Jun 25 12:13:39.737: //12638/5F98D2B9B293/SIP/Error/sipSPIFlushDeferredQueue:
 Invalid deferredQueue
*Jun 25 12:13:48.575: //12639/64DD6553B294/SIP/Error/sipSPIFlushDeferredQueue:
 Invalid deferredQueue
*Jun 25 12:15:04.703: //-1/xxxxxxxxxxxx/SIP/Error/sipSPILineGetVersionStr:
 Failed to get supported header value
*Jun 25 12:15:04.703: //-1/xxxxxxxxxxxx/SIP/Error/ccsipCheckVoiceRegSupportedFeatures:
 Unable to access supported header values
*Jun 25 12:15:13.289: //-1/xxxxxxxxxxxx/SIP/Error/sipSPILineGetVersionStr:
 Failed to get supported header value
*Jun 25 12:15:13.289: //-1/xxxxxxxxxxxx/SIP/Error/ccsipCheckVoiceRegSupportedFeatures:
 Unable to access supported header values
*Jun 25 12:15:36.703: //12640/A5506AB4B295/SIP/Error/sipSPIFlushDeferredQueue:
 Invalid deferredQueue
*Jun 25 12:15:45.289: //12641/AA6E8A1BB296/SIP/Error/sipSPIFlushDeferredQueue:
 Invalid deferredQueue
*Jun 25 12:16:35.285: //12642/DB4E225BB297/SIP/Error/sipSPIFlushDeferredQueue:
 Invalid deferredQueue
*Jun 25 12:17:01.669: //-1/xxxxxxxxxxxx/SIP/Error/sipSPILineGetVersionStr:
 Failed to get supported header value
*Jun 25 12:17:01.669: //-1/xxxxxxxxxxxx/SIP/Error/ccsipCheckVoiceRegSupportedFeatures:
 Unable to access supported header values
*Jun 25 12:17:10.003: //-1/xxxxxxxxxxxx/SIP/Error/sipSPILineGetVersionStr:
 Failed to get supported header value
*Jun 25 12:17:10.003: //-1/xxxxxxxxxxxx/SIP/Error/ccsipCheckVoiceRegSupportedFeatures:
 Unable to access supported header values
*Jun 25 12:17:33.669: //12643/EB0802AFB298/SIP/Error/sipSPIFlushDeferredQueue:
 Invalid deferredQueue
*Jun 25 12:17:42.003: //12644/EFFFAEE4B299/SIP/Error/sipSPIFlushDeferredQueue:
 Invalid deferredQueue
*Jun 25 12:18:34.421: TFTP: Server request for port 50948, socket_id 0x213036E0 for process 63
*Jun 25 12:18:34.423: TFTP: read request from host 10.85.188.21(50948) via GigabitEthernet0/0
*Jun 25 12:18:34.423: TFTP: Looking for CTLSEP204C9EB25678.tlv
*Jun 25 12:18:34.423: TFTP: Sending error 1 No such file
*Jun 25 12:18:34.587: TFTP: Server request for port 49628, socket_id 0x213036E0 for process 63
*Jun 25 12:18:34.587: TFTP: read request from host 10.85.188.21(49628) via GigabitEthernet0/0
*Jun 25 12:18:34.587: TFTP: Looking for ITLSEP204C9EB25678.tlv
*Jun 25 12:18:34.587: TFTP: Sending error 1 No such file
*Jun 25 12:18:34.835: TFTP: Server request for port 52677, socket_id 0x213036E0 for process 63
*Jun 25 12:18:34.835: TFTP: read request from host 10.85.188.21(52677) via GigabitEthernet0/0
*Jun 25 12:18:34.835: TFTP: Looking for SEP204C9EB25678.cnf.xml
*Jun 25 12:18:34.835: TFTP: Opened flash:/its/SEP204C9EB25678.cnf.xml, fd 4, size 3901 for process 63
*Jun 25 12:18:34.837: TFTP: Sending block 1 (retry 0), len 512, socket_id 0x213036E0
*Jun 25 12:18:34.837: TFTP: Received ACK for block 1, socket_id 0x213036E0
*Jun 25 12:18:34.837: TFTP: Sending block 2 (retry 0), len 512, socket_id 0x213036E0
*Jun 25 12:18:34.837: TFTP: Received ACK for block 2, socket_id 0x213036E0
*Jun 25 12:18:34.837: TFTP: Sending block 3 (retry 0), len 512, socket_id 0x213036E0
*Jun 25 12:18:34.839: TFTP: Received ACK for block 3, socket_id 0x213036E0
*Jun 25 12:18:34.839: TFTP: Sending block 4 (retry 0), len 512, socket_id 0x213036E0
*Jun 25 12:18:34.839: TFTP: Received ACK for block 4, socket_id 0x213036E0
*Jun 25 12:18:34.839: TFTP: Sending block 5 (retry 0), len 512, socket_id 0x213036E0
*Jun 25 12:18:34.839: TFTP: Received ACK for block 5, socket_id 0x213036E0
*Jun 25 12:18:34.839: TFTP: Sending block 6 (retry 0), len 512, socket_id 0x213036E0
*Jun 25 12:18:34.839: TFTP: Received ACK for block 6, socket_id 0x213036E0
*Jun 25 12:18:34.839: TFTP: Sending block 7 (retry 0), len 512, socket_id 0x213036E0
*Jun 25 12:18:34.839: TFTP: Received ACK for block 7, socket_id 0x213036E0
*Jun 25 12:18:34.839: TFTP: Sending block 8 (retry 0), len 317, socket_id 0x213036E0
*Jun 25 12:18:34.839: TFTP: Received ACK for block 8, socket_id 0x213036E0
*Jun 25 12:18:34.839: TFTP: Finished flash:/its/SEP204C9EB25678.cnf.xml, time 00:00:00 for process 63
*Jun 25 12:18:58.635: //-1/xxxxxxxxxxxx/SIP/Error/sipSPILineGetVersionStr:
 Failed to get supported header value
*Jun 25 12:18:58.635: //-1/xxxxxxxxxxxx/SIP/Error/ccsipCheckVoiceRegSupportedFeatures:
 Unable to access supported header values
*Jun 25 12:19:06.717: //-1/xxxxxxxxxxxx/SIP/Error/sipSPILineGetVersionStr:
 Failed to get supported header value
*Jun 25 12:19:06.717: //-1/xxxxxxxxxxxx/SIP/Error/ccsipCheckVoiceRegSupportedFeatures:
 Unable to access supported header values
*Jun 25 12:19:30.637: //12645/30BF9AAAB29A/SIP/Error/sipSPIFlushDeferredQueue:
 Invalid deferredQueue
*Jun 25 12:19:38.717: //12646/3590D1A7B29B/SIP/Error/sipSPIFlushDeferredQueue:
 Invalid deferredQueue
OSSPBX01#

No ccsip errors regarding the registration of the phone :(

[Nadeem Ahmed]

What is the IOS version and  Phone load?

Br,

Nadeem

[Magnus Holsting]

Hi Nadeem

ROM: System Bootstrap, Version 15.1(1r)T5, RELEASE SOFTWARE (fc1)

load 7841 sip78xx.10-1-1SR1-4

/Magnus

[Rejohn Cuares]

Has this phone registered to CUCM before?

[Magnus Holsting]

Hello.

No the phones are brand new.

Only third party phones are registrered to cucme..

/Magnus

[manojpillai]

Hi All,

Does any one was able to figure out the issue

Many Thanks

[Magnus Holsting]

Phone cnf attached here:

[radhesh13]

Hi,

Couple of suggestions,

voice service voip

sip

<bind control and media to voice register global source-interface>

shut and no shut sip.

voice register global

authenticate register

voice register pool

username <userid> password <pwd>

and of course no create pr, create pr after the above changes are done.

Hope this helps.

Regards

[Wilson Samuel]

Just adding to what Radhesh13 has said

enter the username whatever you want but the password has  to be what the Phone DNs are.

HTH

voice register pool

username <userid> password <pwd>

- See more at: https://supportforums.cisco.com/discussion/12541601/please-help-registration-issues-cme-cisco-7841-sip-phones#sthash.zXBUUauK.dpuf

voice register pool

username <userid> password <pwd>

- See more at: https://supportforums.cisco.com/discussion/12541601/please-help-registration-issues-cme-cisco-7841-sip-phones#sthash.zXBUUauK.dpuf

voice register pool

username <userid> password <pwd>

- See more at: https://supportforums.cisco.com/discussion/12541601/please-help-registration-issues-cme-cisco-7841-sip-phones#sthash.zXBUUauK.dpuf

[Magnus Holsting]

Hey guys.

Thank you for all the replies.

I will run several tests, ending with auth - since it shouldn't be nessesary.

Will let you know what the outcome is.

*btw I get no output from debug ccsip - only from 3rd party devices *some header info messages.

Again - thank you very much for taking the time to reply!

Best regards

Magnus