cancel
Showing results for 
Search instead for 
Did you mean: 
cancel
5305
Views
0
Helpful
21
Replies

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

Magnus Holsting
Level 1
Level 1

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

21 Replies 21

Magnus Holsting
Level 1
Level 1

Hi again all.

 

No-one has any other suggestions?

I will do any debug nessesary (ccsip doesn't get output).

 

Thanks in advance.

Ok. This looks to be strange problem.

 

Lets try this:

 

1. take off the command  "tftp-path flash:" and apply create profile command

2. Please share your current config

3. Share the output of "sh voice register tftp-bind"

4. Share the output of "more more flash:/its/SEPxxxxxxx.cnf.xml"

5. deb ccsip verbose

Running: (After TFTP-Path was removed)

 

Current configuration : 14779 bytes
!
! Last configuration change at 11:48:13 UTC Fri Jun 26 2015 by cisco
!
version 15.5
service timestamps debug datetime msec
service timestamps log datetime msec
no service password-encryption
!
hostname OSSPBX01
!
boot-start-marker
boot-end-marker
!
!
logging buffered 51200 warnings
enable secret 5 $1$nzT2$1d.ns1K5vBabEaHhpAEX41
!
no aaa new-model
ethernet lmi ce
bsd-client server url https://cloudsso.cisco.com/as/token.oauth2
!
!
!
!
!
!
!
!
!
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.3
 default-router 10.85.188.3
 option 42 ip 10.85.191.40
!
!
!
no ip domain lookup
ip cef
no ipv6 cef
!
multilink bundle-name authenticated
!
!
!
!
!
cts logging verbose
!
crypto pki trustpoint TP-self-signed-3043977732
 enrollment selfsigned
 subject-name cn=IOS-Self-Signed-Certificate-3043977732
 revocation-check none
 rsakeypair TP-self-signed-3043977732
!
!
crypto pki certificate chain TP-self-signed-3043977732
 certificate self-signed 01
  3082022B 30820194 A0030201 02020101 300D0609 2A864886 F70D0101 05050030
  31312F30 2D060355 04031326 494F532D 53656C66 2D536967 6E65642D 43657274
  69666963 6174652D 33303433 39373737 3332301E 170D3135 30343235 30333130
  33345A17 0D323030 31303130 30303030 305A3031 312F302D 06035504 03132649
  4F532D53 656C662D 5369676E 65642D43 65727469 66696361 74652D33 30343339
  37373733 3230819F 300D0609 2A864886 F70D0101 01050003 818D0030 81890281
  810094DF 2EA2FB66 4D30AC5C 36EBFF46 413D65B1 EAEAA721 A95798DC F1C54861
  52530792 FB7D997A C6A6B81D 6950647A 2CC6BB50 2325874F FF8CA5B9 703F6D4A
  E81DAB52 4A025F7D 7C334049 30A4B0F1 A900D324 A4C669E1 A859613F 46E7F50E
  E1094497 D175E2D4 6FE54484 9E83EF7F FC30D54D AAEF3957 13DA9236 5A2B7965
  28AD0203 010001A3 53305130 0F060355 1D130101 FF040530 030101FF 301F0603
  551D2304 18301680 14D025F0 2D104427 3CE338CF 1A627ABB F31F0C8D BA301D06
  03551D0E 04160414 D025F02D 1044273C E338CF1A 627ABBF3 1F0C8DBA 300D0609
  2A864886 F70D0101 05050003 8181004F 3735A6FE 484BC65F F6F4F213 D1DBB683
  417A9479 590681C6 6726A573 F7255915 A30A9C52 3A9CCDEF DA0A3EB2 E2F0D469
  80DE6D54 B66FDACF AF64617E 61BFD692 AB6DC4DB AB15068B E876C131 11D608D8
  B557E72B 24739EC0 B6EA95B3 18826F02 ABAFBB82 3EE44399 1271578B E72FCA7E
  8FEA32DD 267DA6AA 64BE87FA A4F3C4
        quit
voice-card 0
!
!
!
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
!
!
!
!
voice register global
 mode  cme
 source-address 10.85.188.2 port 5060
 max-dn 50
 max-pool 33
 load 7841 sip78xx.10-1-1SR1-4
 timezone 23
 time-format 24
 date-format D/M/Y
 create profile sync 0516020910063132
 ntp-server 10.85.191.40 mode unicast
!
voice register dn  1
 number 23000
 name Antenna Mast
 label 23000
!
voice register dn  2
 number 23001
 name Tennet Room
 label 23001
!
voice register dn  3
 number 23002
 name Tennet Room
 label 23002
!
voice register dn  4
 number 23003
 name Day Crew Emerg. Shelter Room
 label 23003
!
voice register dn  5
 number 23004
 name Air Lock - Locker Room
 label 23004
!
voice register dn  6
 number 23005
 name C&C Room 2
 label 23005
!
voice register dn  7
 number 23006
 name C&C Room 1
 label 23006
!
voice register dn  8
 number 23007
 name Fire Fighting Room
 label 23007
!
voice register dn  9
 number 23008
 name LV Room A
 label 23008
!
voice register dn  10
 number 23009
 name LV Room B
 label 23009
!
voice register dn  11
 number 23010
 name UPS Room A
 label 23010
!
voice register dn  12
 number 23011
 name UPS Room B
 label 23011
!
voice register dn  13
 number 23012
 name Batt. Room A
 label 23012
!
voice register dn  14
 number 23013
 name Batt. Room B
 label 23013
!
voice register dn  15
 number 23014
 name Shunt Reac. Room 1
 label 23014
!
voice register dn  16
 number 23015
 name Shunt Reac. Room 2
 label 23015
!
voice register dn  17
 number 23016
 name HWAC Room
 label 23016
!
voice register dn  18
 number 23017
 name Foam & Sea. Room
 label 23017
!
voice register dn  19
 number 23018
 name Earting Tr. Room 1
 label 23018
!
voice register dn  20
 number 23019
 name Earting Tr. Room 2
 label 23019
!
voice register dn  21
 number 23020
 name Compensation Room 1
 label 23020
!
voice register dn  22
 number 23021
 name Compensation Room 2
 label 23021
!
voice register dn  23
 number 23022
 name Aux. Power Room
 label 23022
!
voice register dn  24
 number 23023
 name Transformer Room 1
 label 23023
!
voice register dn  25
 number 23024
 name Transformer Room 2
 label 23024
!
voice register dn  26
 number 23025
 name MV Room 1
 label 23025
!
voice register dn  27
 number 23026
 name MV Room 2
 label 23026
!
voice register dn  28
 number 23027
 name GIS Room
 label 23027
!
voice register dn  29
 number 23028
 name Diesel Gen. Room A
 label 23028
!
voice register dn  30
 number 23029
 name Diesel Gen. Room B
 label 23029
!
voice register dn  31
 number 23030
 name Muster Area
 label 23030
!
voice register dn  32
 number 23031
 name Workshop & Storage Room
 label 23031
!
voice register dn  33
 number 23232
 name PAGA System Pager
 label 23232
!
voice register pool  1
 busy-trigger-per-button 1
 id mac 0050.C2FB.DE38
 session-transport tcp
 number 1 dn 1
 dtmf-relay rtp-nte
 username 23000 password 1234
 description Outdoor
 codec g711ulaw
!
voice register pool  2
 busy-trigger-per-button 2
 id mac C472.95A8.4452
 session-transport tcp
 type 7841
 number 1 dn 2
 dtmf-relay rtp-nte
 description Indoor
 codec g711ulaw
!
voice register pool  3
 busy-trigger-per-button 2
 id mac C472.95A8.4417
 session-transport tcp
 type 7841
 number 1 dn 3
 dtmf-relay rtp-nte
 description Indoor
 codec g711ulaw
!
voice register pool  4
 busy-trigger-per-button 2
 id mac C472.95A8.4466
 session-transport tcp
 type 7841
 number 1 dn 4
 dtmf-relay rtp-nte
 description Indoor
 codec g711ulaw
!
voice register pool  5
 busy-trigger-per-button 2
 id mac C472.95A8.444C
 session-transport tcp
 type 7841
 number 1 dn 5
 dtmf-relay rtp-nte
 description Indoor
 codec g711ulaw
!
voice register pool  6
 busy-trigger-per-button 2
 id mac C472.95A8.4FD1
 session-transport tcp
 type 7841
 number 1 dn 6
 dtmf-relay rtp-nte
 description Indoor
 codec g711ulaw
!
voice register pool  7
 busy-trigger-per-button 2
 id mac C472.95A8.4FF7
 session-transport tcp
 type 7841
 number 1 dn 7
 dtmf-relay rtp-nte
 description Indoor
 codec g711ulaw
!
voice register pool  8
 busy-trigger-per-button 2
 id mac C472.95A8.507A
 session-transport tcp
 type 7841
 number 1 dn 8
 dtmf-relay rtp-nte
 description Indoor
 codec g711ulaw
!
voice register pool  9
 busy-trigger-per-button 2
 id mac C472.95A8.4F79
 session-transport tcp
 type 7841
 number 1 dn 9
 dtmf-relay rtp-nte
 description Indoor
 codec g711ulaw
!
voice register pool  10
 busy-trigger-per-button 2
 id mac C472.95A8.500E
 session-transport tcp
 type 7841
 number 1 dn 10
 dtmf-relay rtp-nte
 description Indoor
 codec g711ulaw
!
voice register pool  11
 busy-trigger-per-button 2
 id mac C472.95A8.4FF5
 session-transport tcp
 type 7841
 number 1 dn 11
 dtmf-relay rtp-nte
 description Indoor
 codec g711ulaw
!
voice register pool  12
 busy-trigger-per-button 2
 id mac C472.95A8.502E
 session-transport tcp
 type 7841
 number 1 dn 12
 dtmf-relay rtp-nte
 description Indoor
 codec g711ulaw
!
voice register pool  13
 busy-trigger-per-button 1
 id mac 0050.C2FB.DE29
 session-transport tcp
 number 1 dn 13
 dtmf-relay rtp-nte
 username 23012 password 1234
 description Outdoor
 codec g711ulaw
!
voice register pool  14
 busy-trigger-per-button 1
 id mac 0050.C2FB.DE2A
 session-transport tcp
 number 1 dn 14
 dtmf-relay rtp-nte
 username 23013 password 1234
 description Outdoor
 codec g711ulaw
!
voice register pool  15
 busy-trigger-per-button 2
 id mac C472.95A8.5007
 session-transport tcp
 type 7841
 number 1 dn 15
 dtmf-relay rtp-nte
 description Indoor
 codec g711ulaw
!
voice register pool  16
 busy-trigger-per-button 2
 id mac C472.95A8.5044
 session-transport tcp
 type 7841
 number 1 dn 16
 dtmf-relay rtp-nte
 description Indoor
 codec g711ulaw
!
voice register pool  17
 busy-trigger-per-button 2
 id mac C472.95A8.4FDA
 session-transport tcp
 type 7841
 number 1 dn 17
 dtmf-relay rtp-nte
 description Indoor
 codec g711ulaw
!
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
!
voice register pool  19
 busy-trigger-per-button 1
 id mac 0050.C2FB.DE39
 session-transport tcp
 number 1 dn 19
 dtmf-relay rtp-nte
 username 23018 password 1234
 description Outdoor
 codec g711ulaw
!
voice register pool  20
 busy-trigger-per-button 1
 id mac 0050.C2FB.DE3D
 session-transport tcp
 number 1 dn 20
 dtmf-relay rtp-nte
 username 23019 password 1234
 description Outdoor
 codec g711ulaw
!
voice register pool  21
 busy-trigger-per-button 1
 id mac 0050.C2FB.DE3A
 session-transport tcp
 number 1 dn 21
 dtmf-relay rtp-nte
 username 23020 password 1234
 description Outdoor
 codec g711ulaw
!
voice register pool  22
 busy-trigger-per-button 1
 id mac 0050.C2FB.DE3F
 session-transport tcp
 number 1 dn 22
 dtmf-relay rtp-nte
 username 23021 password 1234
 description Outdoor
 codec g711ulaw
!
voice register pool  23
 busy-trigger-per-button 2
 id mac 204C.9EB2.5462
 session-transport tcp
 type 7841
 number 1 dn 23
 dtmf-relay rtp-nte
 description Indoor
 codec g711ulaw
!
voice register pool  24
 busy-trigger-per-button 1
 id mac 0050.C2FB.DE3E
 session-transport tcp
 number 1 dn 24
 dtmf-relay rtp-nte
 username 23023 password 1234
 description Outdoor
 codec g711ulaw
!
voice register pool  25
 busy-trigger-per-button 1
 id mac 0050.C2FB.DE40
 session-transport tcp
 number 1 dn 25
 dtmf-relay rtp-nte
 username 23024 password 1234
 description Outdoor
 codec g711ulaw
!
voice register pool  26
 busy-trigger-per-button 2
 id mac 204C.9EB2.54BB
 session-transport tcp
 type 7841
 number 1 dn 26
 dtmf-relay rtp-nte
 description Indoor
 codec g711ulaw
!
voice register pool  27
 busy-trigger-per-button 2
 id mac 204C.9EB2.53F9
 session-transport tcp
 type 7841
 number 1 dn 27
 dtmf-relay rtp-nte
 description Indoor
 codec g711ulaw
!
voice register pool  28
 busy-trigger-per-button 2
 id mac 204C.9EB2.5467
 session-transport tcp
 type 7841
 number 1 dn 28
 dtmf-relay rtp-nte
 description Indoor
 codec g711ulaw
!
voice register pool  29
 busy-trigger-per-button 1
 id mac 0050.C2FB.DE37
 session-transport tcp
 number 1 dn 29
 dtmf-relay rtp-nte
 username 23028 password 1234
 description Outdoor
 codec g711ulaw
!
voice register pool  30
 busy-trigger-per-button 1
 id mac 0050.C2FB.DE3B
 session-transport tcp
 number 1 dn 30
 dtmf-relay rtp-nte
 username 23029 password 1234
 description Outdoor
 codec g711ulaw
!
voice register pool  31
 busy-trigger-per-button 1
 id mac 0050.C2FB.DE3C
 session-transport tcp
 number 1 dn 31
 dtmf-relay rtp-nte
 username 23030 password 1234
 description Outdoor
 codec g711ulaw
!
voice register pool  32
 busy-trigger-per-button 2
 id mac 204C.9EB2.547B
 session-transport tcp
 type 7841
 number 1 dn 32
 dtmf-relay rtp-nte
 description Indoor
 codec g711ulaw
!
voice register pool  33
 id mac 00D0.5F01.423A
 session-transport tcp
 number 1 dn 33
 dtmf-relay rtp-nte
 username cisco password cisco
 no call-waiting
 description PAGER
 codec g711ulaw
!
voice hunt-group 1 parallel
 list 23028,23029
 pilot 23100
!
!
voice hunt-group 2 parallel
 list 23001,23002,23005,23006
 pilot 23101
!
!
voice hunt-group 3 parallel
 list 23003,23004
 pilot 23102
!
!
voice hunt-group 4 parallel
 list 23008,23009,23010,23011,23012,23013
 pilot 23103
!
!
voice hunt-group 5 parallel
 list 23014,23015,23023,23024
 pilot 23104
!
!
voice hunt-group 6 parallel
 list 23016,23022
 pilot 23105
!
!
voice hunt-group 7 parallel
 list 23018,23019,23020,23021
 pilot 23106
!
!
voice hunt-group 8 parallel
 list 23025,23026,23027
 pilot 23107
!
!
!
!
!
!
license udi pid C3900-SPE200/K9 sn FOC1912249U
!
!
hw-module pvdm 0/0
!
username cisco privilege 15 secret 5 $1$td7J$e3q3FoJbip7FQdyetr8rU1
!
redundancy
!
!
!
!
!
!
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
!
interface GigabitEthernet0/1
 no ip address
 shutdown
 duplex auto
 speed auto
!
interface GigabitEthernet0/2
 no ip address
 shutdown
 duplex auto
 speed auto
!
interface GigabitEthernet0/3
 ip address 192.168.10.1 255.255.255.0
 duplex auto
 speed auto
!
ip forward-protocol nd
!
ip http server
ip http secure-server
!
ip route 0.0.0.0 0.0.0.0 10.85.188.1
!
!
nls resp-timeout 1
cpd cr-id 1
!
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
!
control-plane
!
 !
 !
 !
 !
!
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
!
!
!
!
dial-peer voice 10 voip
 description Local & International Calls
 destination-pattern 0T
 session protocol sipv2
 session target ipv4:10.85.198.5
 codec g711ulaw
!
dial-peer voice 20 voip
 description Wind Turbines Sandbank
 destination-pattern 11...
 session protocol sipv2
 session target ipv4:10.85.198.5
 codec g711ulaw
!
dial-peer voice 21 voip
 description Wind Turbines Sandbank
 destination-pattern 12...
 session protocol sipv2
 session target ipv4:10.85.198.5
 codec g711ulaw
!
dial-peer voice 22 voip
 description Wind Turbines Sandbank
 destination-pattern 21...
 session protocol sipv2
 session target ipv4:10.85.198.5
 codec g711ulaw
!
dial-peer voice 23 voip
 description Wind Turbines Sandbank
 destination-pattern 22...
 session protocol sipv2
 session target ipv4:10.85.198.5
 codec g711ulaw
!
dial-peer voice 11 voip
 description Emergency Calls
 destination-pattern 11.
 session protocol sipv2
 session target ipv4:10.85.198.5
 codec g711ulaw
!
!
sip-ua
!
!
!
gatekeeper
 shutdown
!
!
!
line con 0
 login local
line aux 0
line vty 0 4
 privilege level 15
 login local
 transport input telnet ssh
line vty 5 15
 privilege level 15
 login local
 transport input telnet ssh
!
scheduler allocate 20000 1000
ntp server 10.85.191.40
!
end

OSSPBX01(config-register-global)#

 

OSSPBX01(config-register-global)# do sh voice register tftp-bind
tftp-server url system:/cme/sipphone/syncinfo.xml alias syncinfo.xml
tftp-server url system:/cme/sipphone/SIPDefault.cnf alias SIPDefault.cnf
tftp-server url system:/cme/sipphone/softkeyDefault_kpml.xml alias softkeyDefault_kpml.xml
tftp-server url system:/cme/sipphone/softkeyDefault.xml alias softkeyDefault.xml
tftp-server url system:/cme/sipphone/featurePolicyDefault.xml alias featurePolicyDefault.xml
tftp-server url system:/cme/sipphone/SEPC47295A84452.cnf.xml alias SEPC47295A84452.cnf.xml
tftp-server url system:/cme/sipphone/SEPC47295A84417.cnf.xml alias SEPC47295A84417.cnf.xml
tftp-server url system:/cme/sipphone/SEPC47295A84466.cnf.xml alias SEPC47295A84466.cnf.xml
tftp-server url system:/cme/sipphone/SEPC47295A8444C.cnf.xml alias SEPC47295A8444C.cnf.xml
tftp-server url system:/cme/sipphone/SEPC47295A84FD1.cnf.xml alias SEPC47295A84FD1.cnf.xml
tftp-server url system:/cme/sipphone/SEPC47295A84FF7.cnf.xml alias SEPC47295A84FF7.cnf.xml
tftp-server url system:/cme/sipphone/SEPC47295A8507A.cnf.xml alias SEPC47295A8507A.cnf.xml
tftp-server url system:/cme/sipphone/SEPC47295A84F79.cnf.xml alias SEPC47295A84F79.cnf.xml
tftp-server url system:/cme/sipphone/SEPC47295A8500E.cnf.xml alias SEPC47295A8500E.cnf.xml
tftp-server url system:/cme/sipphone/SEPC47295A84FF5.cnf.xml alias SEPC47295A84FF5.cnf.xml
tftp-server url system:/cme/sipphone/SEPC47295A8502E.cnf.xml alias SEPC47295A8502E.cnf.xml
tftp-server url system:/cme/sipphone/SEPC47295A85007.cnf.xml alias SEPC47295A85007.cnf.xml
tftp-server url system:/cme/sipphone/SEPC47295A85044.cnf.xml alias SEPC47295A85044.cnf.xml
tftp-server url system:/cme/sipphone/SEPC47295A84FDA.cnf.xml alias SEPC47295A84FDA.cnf.xml
tftp-server url system:/cme/sipphone/SEP204C9EB25678.cnf.xml alias SEP204C9EB25678.cnf.xml
tftp-server url system:/cme/sipphone/SEP204C9EB25462.cnf.xml alias SEP204C9EB25462.cnf.xml
tftp-server url system:/cme/sipphone/SEP204C9EB254BB.cnf.xml alias SEP204C9EB254BB.cnf.xml
tftp-server url system:/cme/sipphone/SEP204C9EB253F9.cnf.xml alias SEP204C9EB253F9.cnf.xml
tftp-server url system:/cme/sipphone/SEP204C9EB25467.cnf.xml alias SEP204C9EB25467.cnf.xml
tftp-server url system:/cme/sipphone/SEP204C9EB2547B.cnf.xml alias SEP204C9EB2547B.cnf.xml

 

OSSPBX01#more flash:its/SEP204C9EB25678.cnf.xml
<device>
<fullConfig>true</fullConfig>
<deviceProtocol>SIP</deviceProtocol>
<devicePool>
<dateTimeSetting>
<dateTemplate>D/M/Y</dateTemplate>
<timeZone>W. Europe Standard/Daylight Time</timeZone>
<ntps>
<ntp priority="0">
<name>10.85.191.40</name>
<ntpMode>unicast</ntpMode>
</ntp>
</ntps>
</dateTimeSetting>
<callManagerGroup>
<members>
<member priority="0">
<callManager>
<ports>
<sipPort>5060</sipPort>
</ports>
<processNodeName>10.85.188.2</processNodeName>
</callManager>
</member>
</members>
</callManagerGroup>
</devicePool>
<sipProfile>
<sipProxies>
<registerWithProxy>true</registerWithProxy>
</sipProxies>
<sipCallFeatures>
<cnfJoinEnabled>true</cnfJoinEnabled>
<localCfwdEnable>true</localCfwdEnable>
<callForwardURI>service-uri-cfwdall</callForwardURI>
<callPickupURI>service-uri-pickup</callPickupURI>
<callPickupGroupURI>service-uri-gpickup</callPickupGroupURI>
<meetMeServiceURI>service-uri-meetme</meetMeServiceURI>
<callHoldRingback>2</callHoldRingback>
<semiAttendedTransfer>true</semiAttendedTransfer>
<anonymousCallBlock>2</anonymousCallBlock>
<callerIdBlocking>2</callerIdBlocking>
<dndControl>2</dndControl>
<dndCallAlert>1</dndCallAlert>
<remoteCcEnable>true</remoteCcEnable>
</sipCallFeatures>
<sipStack>
<timerRegisterExpires>3600</timerRegisterExpires>
<timerRegisterDelta>5</timerRegisterDelta>
<timerInviteExpires>180</timerInviteExpires>
<timerKeepAliveExpires>3600</timerKeepAliveExpires>
<timerSubscribeExpires>3600</timerSubscribeExpires>
<timerSubscribeDelta>5</timerSubscribeDelta>
<timerT1>500</timerT1>
<timerT2>4000</timerT2>
<remotePartyID>true</remotePartyID>
</sipStack>
<sipLines>
<line button="1" lineIndex="1">
<featureID>9</featureID>
<featureLabel>23017</featureLabel>
<contact>8392-1EE</contact>
<speedDialNumber></speedDialNumber>
<proxy>USECALLMANAGER</proxy>
<port>5060</port>
<voipControlPort>5060</voipControlPort>
<name>23017</name>
<displayName>Foam & Sea. Room</displayName>
<autoAnswer>
<autoAnswerEnabled>2</autoAnswerEnabled>
</autoAnswer>
<callWaiting>1</callWaiting>
<authName></authName>
<authPassword></authPassword>
<sharedLine>false</sharedLine>
<messagesNumber></messagesNumber>
<messageWaitingLampPolicy>3</messageWaitingLampPolicy>
<ringSettingActive>5</ringSettingActive>
<forwardCallInfoDisplay>
<callerName>true</callerName>
<callerNumber>true</callerNumber>
<redirectedNumber>true</redirectedNumber>
<dialedNumber>true</dialedNumber>
</forwardCallInfoDisplay>
<maxNumCalls>24</maxNumCalls>
<busyTrigger>24</busyTrigger>
</line>
</sipLines>
<enableVad>true</enableVad>
<preferredCodec>g711ulaw</preferredCodec>
<softKeyFile>softkeyDefault_kpml.xml</softKeyFile>
<dialTemplate></dialTemplate>
<kpml>1</kpml>
<phoneLabel>Indoor</phoneLabel>
<stutterMsgWaiting>2</stutterMsgWaiting>
<disableLocalSpeedDialConfig>true</disableLocalSpeedDialConfig>
<dscpForAudio>184</dscpForAudio>
<dscpVideo>136</dscpVideo>
<startMediaPort>16384</startMediaPort>
<stopMediaPort>32766</stopMediaPort>
</sipProfile>
<commonProfile>
<phonePassword>Cisco</phonePassword>
<callLogBlfEnabled>2</callLogBlfEnabled>
</commonProfile>
<loadInformation>sip78xx.10-1-1SR1-4</loadInformation>
<vendorConfig>
</vendorConfig>
<commonConfig>
<videoCapability>0</videoCapability>
<ciscoCamera>0</ciscoCamera>
</commonConfig>
<sshUserId></sshUserId>
<sshPassword></sshPassword>
<versionStamp>0517332511266002</versionStamp>
<userLocale>
<name>SIP_English_United_States</name>
<langCode>en_US</langCode>
</userLocale>
<networkLocale>SIP_United_States</networkLocale>
<networkLocaleInfo>
<name>United_States</name>
</networkLocaleInfo>
<authenticationURL></authenticationURL>
<directoryURL>http://10.85.188.2:80/localdirectory</directoryURL>
<servicesURL>http://10.85.188.2:80/CMEserverForPhone/serviceurl</servicesURL>
<dscpForSCCPPhoneServices>0</dscpForSCCPPhoneServices>
<dscpForCm2Dvce>96</dscpForCm2Dvce>
<transportLayerProtocol>1</transportLayerProtocol>
</device>

OSSPBX01#
OSSPBX01#debug ccsip ver
OSSPBX01#debug ccsip verbose
This may severely impact system performance.
 Need to increase the logging queue-limit size to capture all debugs. Continue? [confirm]
All SIP Call tracing is enabled in verbose mode
OSSPBX01#term mon
% Console already monitors
OSSPBX01#
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/ccsip_is_valid_ccb:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/ccsip_is_valid_ccb:exit@8124:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/act_timer_remove_transaction:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/ccsip_is_valid_ccb:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/ccsip_is_valid_ccb:exit@8124:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/ccsip_delete_ccb:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/sipSPIRemoveChildren:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/sipSPIUfreeOneCCB:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/sipSPIUdeleteccCallIdFromTable:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Info/verbose/4096/sipSPIUdeleteccCallIdFromTable: Removing call id 4CD0
*Jun 29 11:23:02.777: //-1/xxxxxxxxxxxx/SIP/Info/verbose/4096/sipSPIDeleteContextFromTable: Context for key=[19702] removed.
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/sipSPIStopFinalStatsCleanupTimer:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/sipSPIStopCommonTimer:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/sipSPIUdeleteCcbFromUASReqTable:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/sipSPIUdeleteCcbFromTable:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Info/verbose/4096/sipSPIUdeleteCcbFromTable: Deleting from table. ccb=0x2698DBC0 key=878a4bd3e909d311b8040050c2fbde39@10.85.188.16230181954021092
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/sipSPIUdeleteCcbFromUASRespTable:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Info/verbose/4096/sipSPIFlushEventBufferQueue: There are 0 events on the internal queue that are going to be free'd
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Error/sipSPIFlushDeferredQueue:
 Invalid deferredQueue
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/sipSPIFreeSessionTargetInfo:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/sipSPIFreeHistoryInfo:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/sipSPICleanupContainerBlock:
*Jun 29 11:23:02.777: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerUnregisterCtxtInConnection: gConnTab=0x2520FA08, addr=10.85.188.16, port=5060, local_addr=10.85.188.2, unregistering context=0x2698DBC0
*Jun 29 11:23:02.777: //-1/xxxxxxxxxxxx/SIP/Transport/sipInstancePurgeContextInConnection: Purging context gcb=0x2698DBC0 from the connection=0x25211E18 context list
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/ccsip_platform_delete_ccb:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/ccsip_platform_stop_timers:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/sipSPIDropRtpSessions:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/sipSPIGetFirstStream:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/sipSPIGetMainStream:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/ccsip_qos_cleanup:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/sipSPIGetFirstStream:
*Jun 29 11:23:02.777: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_free: Freed msg=0x27003EA8
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/ccsip_platform_terminate_implicit_subscriptions:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/ccsip_free_kpml_info:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/ccsip_free_kpml_info:exit@1508:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/sipSPIFlushKpmlDigitBuffer:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/sipSPIFlushKpmlDigitBuffer:exit@2039:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/sipSPI_ipip_free_dialpeer_video_caps:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/sipSPI_ipip_free_codec_profile:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Info/verbose/1/sipSPI_ipip_free_codec_profile: Codec Profiles Freed
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/sipSPICleanupOverlapInfo:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/sipSPIStopOverlapInfoTimer:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/sipSPIStopCommonTimer:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Info/info/8192/sipSPIStopOverlapInfoTimer: Stopping Overlap Info Timer
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/sipSPIBwCacReleaseAccountedBw:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/sipSPIBwCacReleaseAccountedBw:exit@23765:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Function/ccsip_clear_rtp_session_pending_q:
*Jun 29 11:23:02.777: //19664/F71441CC8E0A/SIP/Info/verbose/4096/sipSPIUfreeOneCCB: Freeing ccb 0x2698DBC0
*Jun 29 11:23:02.995: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_create: created msg=0x27003EA8 with refCount = 1
*Jun 29 11:23:02.995: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_create: created msg=0xA7E1A38 with refCount = 1
*Jun 29 11:23:02.995: //-1/xxxxxxxxxxxx/SIP/Info/verbose/4096/HandleUdpIPv4SocketReads: Msg enqueued for SPI with IP addr: [10.85.188.17]:5060, local_address:[10.85.188.2]
*Jun 29 11:23:02.995: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_free: Freed msg=0x27003EA8
*Jun 29 11:23:02.995: //-1/xxxxxxxxxxxx/SIP/Info/info/4096/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for event 1
*Jun 29 11:23:02.995: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x0
*Jun 29 11:23:02.995: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
REGISTER sip:10.85.188.2 SIP/2.0
Via: SIP/2.0/UDP 10.85.188.17:5060;branch=z9hG4bK-B318BF57;rport
From: <sip:23012@10.85.188.2>;epid=0050c2fbde29;tag=801919710
To: <sip:23012@10.85.188.2>
Call-ID: f6f5308ee909d311a1390050c2fbde29@10.85.188.10
CSeq: 8449 REGISTER
Contact: <sip:23012@10.85.188.17:5060;transport=UDP>;expires=120
Content-Length: 0
Expires: 120
Max-Forwards: 70
User-Agent: (FernTel IP/9.00 dvl [9.061326/9061326/102])
Allow-Events: reg,dialog,message-summary,presence


*Jun 29 11:23:02.995: //-1/xxxxxxxxxxxx/SIP/Info/verbose/4096/ccsip_new_msg_preprocessor: Checking Invite Dialog
*Jun 29 11:23:02.995: //-1/xxxxxxxxxxxx/SIP/Info/verbose/4096/sipSPIFindRegisterCcb: *****CCB NOT found in UAS Request table. ccb=0x0
*Jun 29 11:23:02.995: //-1/xxxxxxxxxxxx/SIP/Info/verbose/4096/sipSPIAddContextToTable: Added context(0x2698DBC0) with key=[19703] to table
*Jun 29 11:23:02.995: //-1/000000000000/SIP/Function/sipSPIInitContainerBlock:
*Jun 29 11:23:02.995: //-1/000000000000/SIP/Function/sipSPI_ipip_init_dialpeer_video_caps:
*Jun 29 11:23:02.995: //-1/000000000000/SIP/Function/sipSPI_ipip_init_codec_profile:
*Jun 29 11:23:02.995: //-1/000000000000/SIP/Info/info/4096/ccsip_ipip_media_service_init:
*Jun 29 11:23:02.995: //-1/000000000000/SIP/Info/info/4096/ccsip_tdmip_media_service_init:
*Jun 29 11:23:02.995: //-1/000000000000/SIP/Info/verbose/36864/ccsip_ipip_media_forking_init: MF: Queue is initialised..
*Jun 29 11:23:02.995: //-1/000000000000/SIP/Function/ccsip_platform_init_ccb:exit@10934:
*Jun 29 11:23:02.995: //-1/000000000000/SIP/Function/sipSPI_sip2h323_copy_replaces:
*Jun 29 11:23:02.995: //-1/000000000000/SIP/Function/sipSPIUpdateResponseInfo:
*Jun 29 11:23:02.995: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Dialog Transaction Address 10.85.188.17,Port 5060, Transport 1, SentBy Port 5060vrfid 0
*Jun 29 11:23:02.995: //-1/000000000000/SIP/Function/resolve_sig_ip_address_to_bind:
*Jun 29 11:23:02.995: //-1/000000000000/SIP/Info/info/8192/resolve_sig_ip_address_to_bind: VRF id = 0
*Jun 29 11:23:02.995: //-1/xxxxxxxxxxxx/SIP/Info/info/8192/resolve_ip_address_to_bind: HSRP IPv4 vaddr 10.85.188.2 for SIP
*Jun 29 11:23:02.995: //-1/000000000000/SIP/Info/info/8192/resolve_sig_ip_address_to_bind: signaling bind address : 10.85.188.2
*Jun 29 11:23:02.995: //-1/000000000000/SIP/Function/sipSPIGetLocalHostName:
*Jun 29 11:23:02.995: //-1/000000000000/SIP/Function/sipSPIGetLocalHostName:
*Jun 29 11:23:02.995: //-1/xxxxxxxxxxxx/SIP/Info/info/8192/resolve_sig_ip_address_to_bind: return addr 10.85.188.2
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/Function/ccsipDisplayMsg:
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/Function/ccsipDisplayMsg:exit@12974:
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/State/sipSPIChangeState: 0x2698DBC0 : State change from (STATE_NONE, SUBSTATE_NONE)  to (STATE_IDLE, SUBSTATE_NONE)
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/Function/act_idle_new_message:
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/Function/sipSPIUpdateResponseInfo:
*Jun 29 11:23:02.995: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.85.188.17,Port 5060, Transport 1, SentBy Port 5060vrfid 0
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/Function/sipSPICheckRequestExt:
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/Function/sipSPIAddDateHeaderString:
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/Function/sipSPIGetCallHeaderString:
*Jun 29 11:23:02.995: //-1/xxxxxxxxxxxx/SIP/Info/verbose/8192/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/Function/sipSPIUpdateResponseInfo:
*Jun 29 11:23:02.995: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.85.188.17,Port 5060, Transport 1, SentBy Port 5060vrfid 0
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/Function/sip_process_request_cseq:
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/Function/sipSPICheckRequestHeaderMaxForwards:
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/Function/sipSPIVerifyURIScheme:
*Jun 29 11:23:02.995: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_lock: Increment msg (0xA7E1A38) counter, current msg->refCount = 2
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/Function/sipSPIPushInboundContainerIntoCCB:
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/Function/sact_idle_new_message_register:
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/Function/ccsip_api_register_allow_1XXResponse:
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/Function/sipSPIStopRemoveTransTimer:
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/Function/sipSPIStopTimer:
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/Info/verbose/4096/sipSPIAssignCcbLastRequest: Current ccb(0x2698DBC0)->last_request = 0xA7E1A38, refCount = 2
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/Function/sipSPIGenerateToTag:
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/Function/sipSPIAppendTagParam:
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/Function/sact_received_register_check_errors:
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/Function/sipSPIUaddCcbToUASReqTable:
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/Function/sipSPIUaddCcbToTable:
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/Info/verbose/4096/sipSPIUaddCcbToTable: Added to table. ccb=0x2698DBC0 key=f6f5308ee909d311a1390050c2fbde29@10.85.188.1023012801919710 balance 1
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/Function/sipSPIPopInboundContainerFromCCB:
*Jun 29 11:23:02.995: //-1/0A48A28E8E0B/SIP/Function/ccsip_api_register_ind:
*Jun 29 11:23:02.995: //19665/0A48A28E8E0B/SIP/Event/sact_idle_new_message_register:
 ccsip_api_register_ind return value : SIP_SUCCESS

*Jun 29 11:23:02.995: //19665/0A48A28E8E0B/SIP/Info/verbose/4096/sipSPIUaddccCallIdToTable: Adding call id 4CD1 to table
*Jun 29 11:23:02.995: //19665/0A48A28E8E0B/SIP/State/sipSPIChangeState: 0x2698DBC0 : State change from (STATE_IDLE, SUBSTATE_NONE)  to (SIP_STATE_INCOMING_REGISTER, SUBSTATE_NONE)
*Jun 29 11:23:02.995: //19665/0A48A28E8E0B/SIP/Function/ccsipValidateAndPushInboundContainerInCcb:
*Jun 29 11:23:02.995: //19665/0A48A28E8E0B/SIP/Function/sipGwPushInboundContainerIntoCCB:
*Jun 29 11:23:02.995: //19665/0A48A28E8E0B/SIP/Function/ccsipValidateAndPushInboundContainerInCcb:exit@1426:
*Jun 29 11:23:02.995: //19665/0A48A28E8E0B/SIP/Info/notify/262144/ccsip_register_process_incoming_register: CCSIP_REGISTER:: REGISTER request
*Jun 29 11:23:02.995: //19665/0A48A28E8E0B/SIP/Function/ccsip_is_valid_ccb:
*Jun 29 11:23:02.995: //19665/0A48A28E8E0B/SIP/Function/ccsip_is_valid_ccb:exit@8124:
*Jun 29 11:23:02.995: //19665/0A48A28E8E0B/SIP/Function/ccsip_spi_register_incoming_registration:
*Jun 29 11:23:02.995: //19665/0A48A28E8E0B/SIP/Info/notify/262144/ccsip_spi_register_incoming_registration: registration expires timer max is 600 and min is 60

*Jun 29 11:23:02.995: //19665/0A48A28E8E0B/SIP/Function/ccsip_register_set_expires_time:
*Jun 29 11:23:02.995: //-1/xxxxxxxxxxxx/SIP/Info/info/262144/ccsip_process_registration_passthrough: RCB Pointer : [0x238F00F4]
*Jun 29 11:23:02.995: //19665/0A48A28E8E0B/SIP/Info/critical/262144/ccsip_process_registration_passthrough: Re-Register not for passthrough, Try CME
*Jun 29 11:23:02.995: //19665/0A48A28E8E0B/SIP/Info/info/262144/ccsip_spi_register_incoming_registration: Register for CME case
*Jun 29 11:23:02.995: //19665/0A48A28E8E0B/SIP/Function/ccsip_spi_incoming_reg_contact_change:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/ccsip_spi_incoming_reg_contact_change:exit@3332:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Info/notify/262144/ccsip_spi_register_incoming_registration: CCSIP_REGISTER:: re-REGISTER request
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Info/verbose/262144/ccsip_spi_update_cc_callid: ccCallId for RCB is 7237
*Jun 29 11:23:02.997: //-1/xxxxxxxxxxxx/SIP/Error/sipSPILineGetVersionStr:
 Failed to get supported header value
*Jun 29 11:23:02.997: //-1/xxxxxxxxxxxx/SIP/Info/info/2048/ccsipRegisterStartRCBTimer: Starting timer for pattern 23012 for 120 seconds
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/ccsip_spi_registration_done:
*Jun 29 11:23:02.997: //-1/xxxxxxxxxxxx/SIP/Error/ccsipCheckVoiceRegSupportedFeatures:
 Unable to access supported header values
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/ccsip_spi_registrar_add_response_contacts:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Info/verbose/6144/ccsip_spi_registrar_add_expires_header: Inside ccsip_spi_registrar_add_expires_header for Expires
*Jun 29 11:23:02.997: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_REGISTER_RESP
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/ccsip_spi_register_incoming_registration:exit@3762:
*Jun 29 11:23:02.997: //-1/xxxxxxxxxxxx/SIP/Info/info/4096/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 for event 41
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIUisValidCcb:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/ccsip_is_valid_ccb:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/ccsip_is_valid_ccb:exit@8124:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIUisValidCcb:exit@4098:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIPreprocessAppEvent:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIPushNewContainerIntoCCB:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/act_incoming_register_response:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIPresendProcessing:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIProcessPresendRandomContact:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Info/verbose/8192/sipSPIPresendProcessing: Presend Processing called for 13 event
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/sipSPI_ipip_PassthruCopyListDataProcessing:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/sipSPI_ipip_GetPassthruCopyListDataFromTdContainer:
*Jun 29 11:23:02.997: //-1/xxxxxxxxxxxx/SIP/Info/verbose/8192/sipSPIRetrieveOutgoingPassThruData: Retrieving Data from RCB
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/sipSPI_ipip_GetPassthruCopyListDataFromTdContainer:
*Jun 29 11:23:02.997: //-1/xxxxxxxxxxxx/SIP/Info/verbose/8192/sipSPIRetrieveOutgoingPassThruData: Retrieving Data from RCB
*Jun 29 11:23:02.997: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_create: created msg=0x27003EA8 with refCount = 1
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/sipSPISendResponse:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIResponseGetAssociatedContainer:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIPushSubsqTransMsgContainerIntoHolder:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIAddStdHeaders:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIAppendTagParam:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIGetCallHeaderString:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIAddWarningHeader:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Info/info/4096/sipSPISendResponse: Associated container=0x26C81640 to REGISTER Response 200
*Jun 29 11:23:02.997: //-1/xxxxxxxxxxxx/SIP/Info/verbose/8192/sipSPIAppHandleContainerBody: sipSPIAppHandleContainerBody len 0
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Transport/sipSPISendResponse: Sending INFO Response to the transport layer
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Transport/sipSPITransportSendMessage: msg=0x27003EA8, addr=10.85.188.17, port=5060, sentBy_port=5060, local_addr=10.85.188.2, is_req=0, transport=1, switch=0, callBack=0x5CCDD80
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/ccsip_profile_application:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIGetExtensionCfg:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Info/info/2048/sipSPIGetExtensionCfg: SIP extension config:1, check sys cfg:1
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/ccsip_profile_application:exit@22598:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/ccsip_extension_application:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIGetExtensionCfg:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Info/info/2048/sipSPIGetExtensionCfg: SIP extension config:1, check sys cfg:1
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/ccsip_extension_application:exit@34380:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Transport/sipTransportLogicSendMsg: Trying to send resp=0x27003EA8 to default port=5060
*Jun 29 11:23:02.997: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerGetConnection: connection required for raddr:10.85.188.17, rport:5060 with laddr:10.85.188.2

*Jun 29 11:23:02.997: //-1/xxxxxxxxxxxx/SIP/Transport/sipInstanceGetConnectionId: Registering gcb=0x2698DBC0 with connection=0x25211D30 context list
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Transport/sipTransportLogicSendMsg: Connection obtained...sending msg=0x27003EA8
*Jun 29 11:23:02.997: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x27003EA8, addr=10.85.188.17, port=5060, local_addr=10.85.188.2, connId=3 vrfid=0 for UDP
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/sentRegisterResponse:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIStartRemoveTransTimer:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/sipSPISetTimer:
*Jun 29 11:23:02.997: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_free: Decrement msg (0xA7E1A38) counter, current msg->refCount = 1
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/State/sipSPIChangeState: 0x2698DBC0 : State change from (SIP_STATE_INCOMING_REGISTER, SUBSTATE_NONE)  to (STATE_IDLE, SUBSTATE_NONE)
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/force_internal_queue_lookup:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Function/ccsipDisplayMsg:
*Jun 29 11:23:02.997: //19665/0A48A28E8E0B/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.85.188.17:5060;branch=z9hG4bK-B318BF57;rport
From: <sip:23012@10.85.188.2>;epid=0050c2fbde29;tag=801919710
To: <sip:23012@10.85.188.2>;tag=392C46EE-13FF
Date: Mon, 29 Jun 2015 11:23:02 GMT
Call-ID: f6f5308ee909d311a1390050c2fbde29@10.85.188.10
Server: Cisco-SIPGateway/IOS-15.5.2.T
CSeq: 8449 REGISTER
Contact: <sip:23012@10.85.188.17:5060>;expires=120
Expires:  120
Content-Length: 0


*Jun 29 11:23:02.997: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_free: Freed msg=0x27003EA8
OSSPBX01#
OSSPBX01#term mon
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/ccsip_is_valid_ccb:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/ccsip_is_valid_ccb:exit@8124:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/act_timer_remove_transaction:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/ccsip_is_valid_ccb:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/ccsip_is_valid_ccb:exit@8124:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/ccsip_delete_ccb:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIRemoveChildren:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIUfreeOneCCB:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIUdeleteccCallIdFromTable:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Info/verbose/4096/sipSPIUdeleteccCallIdFromTable: Removing call id 4CD1
*Jun 29 11:23:34.997: //-1/xxxxxxxxxxxx/SIP/Info/verbose/4096/sipSPIDeleteContextFromTable: Context for key=[19703] removed.
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIStopFinalStatsCleanupTimer:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIStopCommonTimer:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIUdeleteCcbFromUASReqTable:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIUdeleteCcbFromTable:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Info/verbose/4096/sipSPIUdeleteCcbFromTable: Deleting from table. ccb=0x2698DBC0 key=f6f5308ee909d311a1390050c2fbde29@10.85.188.1023012801919710
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIUdeleteCcbFromUASRespTable:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Info/verbose/4096/sipSPIFlushEventBufferQueue: There are 0 events on the internal queue that are going to be free'd
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Error/sipSPIFlushDeferredQueue:
 Invalid deferredQueue
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIFreeSessionTargetInfo:
*Jun 29 11:23:34.9 97: //19665/0A48A28E8E0B/SIP/Function/sipSPIFreeHistoryInfo:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/sipSPICleanupContainerBlock:
*Jun 29 11:23:34.997: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerUnregisterCtxtInConnection: gConnTab=0x2520FA08, addr=10.85.188.17, port=5060, local_addr=10.85.188.2, unregistering context=0x2698DBC0
*Jun 29 11:23:34.997: //-1/xxxxxxxxxxxx/SIP/Transport/sipInstancePurgeContextInConnection: Purging context gcb=0x2698DBC0 from the connection=0x25211D30 context list
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/ccsip_platform_delete_ccb:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/ccsip_platform_stop_timers:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIDropRtpSessions:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIGetFirstStream:
*Jun 29 11:no  mon
OSSPBX01#23:34.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIGetMainStream:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/ccsip_qos_cleanup:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIGetFirstStream:
*Jun 29 11:23:34.997: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_free: Freed msg=0xA7E1A38
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/ccsip_platform_terminate_implicit_subscriptions:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/ccsip_free_kpml_info:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/ccsip_free_kpml_info:exit@1508:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIFlushKpmlDigitBuffer:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIFlushKpmlDigitBuffer:exit@2039:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/sipSPI_ipip_free_dialpeer_video_caps:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/sipSPI_ipip_free_codec_profile:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Info/verbose/1/sipSPI_ipip_free_codec_profile: Codec Profiles Freed
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/sipSPICleanupOverlapInfo:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIStopOverlapInfoTimer:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIStopCommonTimer:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Info/info/8192/sipSPIStopOverlapInfoTimer: Stopping Overlap Info Timer
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIBwCacReleaseAccountedBw:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/sipSPIBwCacReleaseAccountedBw:exit@23765:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Function/ccsip_clear_rtp_session_pending_q:
*Jun 29 11:23:34.997: //19665/0A48A28E8E0B/SIP/Info/verbose/4096/sipSPIUfreeOneCCB: Freeing ccb 0x2698DBC0
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Transport/sip_find_connid_by_fd: Map fd 0 to index 11

*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_create: created msg=0xA7E1A38 with refCount = 1
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_create: created msg=0x27003EA8 with refCount = 1
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_free: Freed msg=0xA7E1A38
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Info/info/4096/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for event 1
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x0
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerProcessNewConnMsg: gConnTab=0x2520F99C, addr=10.85.188.19, port=52540, local_addr=10.85.188.2, connid=11, transport=TCP
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Info/info/4608/sipHolderGetConnInstance: Return existing connection for port 52540 connId 11
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
REGISTER sip:10.85.188.2 SIP/2.0
Via: SIP/2.0/TCP 10.85.188.19:52540;branch=z9hG4bK627d9f7b
From: <sip:23002@10.85.188.2>;tag=c47295a8441705e449d7450f-63a70fc5
To: <sip:23002@10.85.188.2>
Call-ID: c47295a8-44170004-7f03fa83-419446e2@10.85.188.19
Max-Forwards: 70
Date: Mon, 29 Jun 2015 11:23:43 GMT
CSeq: 1595 REGISTER
User-Agent: Cisco-CP7841/10.1.1
Contact: <sip:8386-24DE@10.85.188.19:52540;transport=tcp>;+sip.instance="<urn:uuid:00000000-0000-0000-0000-c47295a84417>";+u.sip!devicename.ccm.cisco.com="SEPC47295A84417";+u.sip!model.ccm.cisco.com="622"
Supported: replaces,join,sdp-anat,norefersub,resource-priority,extended-refer,X-cisco-callinfo,X-cisco-serviceuri,X-cisco-escapecodes,X-cisco-service-control,X-cisco-srtp-fallback,X-cisco-monrec,X-cisco-config,X-cisco-sis-6.0.2,X-cisco-xsi-8.5.1
Content-Length: 0
Expires: 3600


*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Info/verbose/4096/ccsip_new_msg_preprocessor: Checking Invite Dialog
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Info/verbose/4096/sipSPIFindRegisterCcb: *****CCB NOT found in UAS Request table. ccb=0x0
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Info/verbose/4096/sipSPIAddContextToTable: Added context(0x2698DBC0) with key=[19704] to table
*Jun 29 11:23:40.217: //-1/000000000000/SIP/Function/sipSPIInitContainerBlock:
*Jun 29 11:23:40.217: //-1/000000000000/SIP/Function/sipSPI_ipip_init_dialpeer_video_caps:
*Jun 29 11:23:40.217: //-1/000000000000/SIP/Function/sipSPI_ipip_init_codec_profile:
*Jun 29 11:23:40.217: //-1/000000000000/SIP/Info/info/4096/ccsip_ipip_media_service_init:
*Jun 29 11:23:40.217: //-1/000000000000/SIP/Info/info/4096/ccsip_tdmip_media_service_init:
*Jun 29 11:23:40.217: //-1/000000000000/SIP/Info/verbose/36864/ccsip_ipip_media_forking_init: MF: Queue is initialised..
*Jun 29 11:23:40.217: //-1/000000000000/SIP/Function/ccsip_platform_init_ccb:exit@10934:
*Jun 29 11:23:40.217: //-1/000000000000/SIP/Function/sipSPI_sip2h323_copy_replaces:
*Jun 29 11:23:40.217: //-1/000000000000/SIP/Function/sipSPIUpdateResponseInfo:
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Dialog Transaction Address 10.85.188.19,Port 52540, Transport 2, SentBy Port 52540vrfid 0
*Jun 29 11:23:40.217: //-1/000000000000/SIP/Info/verbose/4608/sipSPISipIncomingMsg: copy the natted transport info to ccb natted dest: 10.85.188.19:52540,natted src: 10.85.188.2:5060, natted transport: 2
*Jun 29 11:23:40.217: //-1/000000000000/SIP/Info/info/1024/sipSPISipIncomingMsg:  sip via host 10.85.188.19
*Jun 29 11:23:40.217: //-1/000000000000/SIP/Info/info/9216/sipSPISipIncomingMsg:  sip nat auto detect 0
*Jun 29 11:23:40.217: //-1/000000000000/SIP/Function/resolve_sig_ip_address_to_bind:
*Jun 29 11:23:40.217: //-1/000000000000/SIP/Info/info/8192/resolve_sig_ip_address_to_bind: VRF id = 0
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Info/info/8192/resolve_ip_address_to_bind: HSRP IPv4 vaddr 10.85.188.2 for SIP
*Jun 29 11:23:40.217: //-1/000000000000/SIP/Info/info/8192/resolve_sig_ip_address_to_bind: signaling bind address : 10.85.188.2
*Jun 29 11:23:40.217: //-1/000000000000/SIP/Function/sipSPIGetLocalHostName:
*Jun 29 11:23:40.217: //-term no  mon1/000000000000/SIP/Function/sipSPIGetLocalHostName:
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Info/info/8192/resolve_sig_ip_address_to_bind: return addr 10.85.188.2
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/Function/ccsipDisplayMsg:
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/Function/ccsipDisplayMsg:exit@12974:
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/State/sipSPIChangeState: 0x2698DBC0 : State change from (STATE_NONE, SUBSTATE_NONE)  to (STATE_IDLE, SUBSTATE_NONE)
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/Function/act_idle_new_message:
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/Function/sipSPIUpdateResponseInfo:
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.85.188.19,Port 52540, Transport 2, SentBy Port 5060vrfid 0
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/Function/spSPICheckRequestExt:
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/Function/sipSPIAddDateHeaderString:
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/Function/sipSPIGetCallHeaderString:
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Info/verbose/8192/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/Function/sipSPIUpdateResponseInfo:
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 10.85.188.19,Port 52540, Transport 2, SentBy Port 52540vrfid 0
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/Function/sip_process_request_cseq:
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/Function/sipSPICheckRequestHeaderMaxForwards:
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/Function/sipSPIVerifyURIScheme:
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx//Info/info/1024/httpish_msg_lock: Increment msg (0x27003EA8) counter, current msg->refCount = 2
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/Function/sipSPIPushInboundContainerIntoCCB:
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/Function/sact_idle_new_message_register:
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/Function/ccsip_api_register_allow_1XXResponse:
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/Function/sipSPIStopRemoveTransTimer:
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/Function/sipSPIStopTimer:
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/Info/verbose/4096/sipSPIAssignCcbLastRequest: Current ccb(0x2698DBC0)->last_request = 0x27003EA8, refCount = 2
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/Function/sipSPIGenerateToTag:
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/Function/sipSPIAppendTagParam:
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/Fnction/sact_received_register_check_errors:
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/Function/sipSPIUaddCcbToUASReqTable:
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/Function/sipSPIUaddCcbToTable:
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/Info/verbose/4096/sipSPIUaddCcbToTable: Added to table. ccb=0x2698DBC0 key=c47295a8-44170004-7f03fa83-419446e2@10.85.188.1923002c47295a8441705e449d7450f-63a70fc5 balance 1
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/Function/sipSPIPopInboundContainerFromCCB:
*Jun 29 11:23:40.217: //-1/207844818E0C/SIP/Function/ccsip_api_register_ind:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Event/sact_idle_new_message_register:
 ccsip_api_register_ind return value : SIP_SUCCESS

*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Info/verbose/4096/sipSPIUaddccCallIdToTable: Adding call id 4CD2 to table
*
OSSPBX01#Jun 29 11:23:40.217: //19666/207844818E0C/SIP/State/sipSPIChangeState: 0x2698DBC0 : State change from (STATE_IDLE, SUBSTATE_NONE)  to (SIP_STATE_INCOMING_REGISTER, SUBSTATE_NONE)
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsipValidateAndPushInboundContainerInCcb:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipGwPushInboundContainerIntoCCB:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsipValidateAndPushInboundContainerInCcb:exit@1426:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Info/notify/262144/ccsip_register_process_incoming_register: CCSIP_REGISTER:: REGISTER request
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsip_is_valid_ccb:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsip_is_valid_ccb:exit@8124:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsip_spi_register_incoming_registration:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Info/notify/262144/ccsip_spi_register_incoming_registration: registration expires timer max is 600 and min is 60

*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsip_register_set_expires_time:
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Info/info/262144/ccsip_process_registration_passthrough: RCB Pointer : [0x26F2CAC4]
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Info/critical/262144/ccsip_process_registration_passthrough: Re-Register not for passthrough, Try CME
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Info/info/262144/ccsip_spi_register_incoming_registration: Register for CME case
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsip_spi_incoming_reg_contact_change:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsip_spi_incoming_reg_contact_change:exit@3332:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Info/notify/262144/ccsip_spi_register_incoming_registration: CCSIP_REGISTER:: re-REGISTER request
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Info/verbose/262144/ccsip_spi_update_cc_callid: ccCallId for RCB is 12593
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Info/info/2048/ccsipRegisterStartRCBTimer: Starting timer for pattern 23002 for 300 seconds
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsip_spi_registration_done:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsip_spi_registrar_add_response_contacts:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Info/verbose/6144/ccsip_spi_registrar_add_expires_header: Inside ccsip_spi_registrar_add_expires_header for Expires
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_REGISTER_RESP
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsip_spi_register_incoming_registration:exit@3762:
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Info/info/4096/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 for event 41
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIUisValidCcb:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsip_is_valid_ccb:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsip_is_valid_ccb:exit@8124:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIUisValidCcb:exit@4098:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIPreprocessAppEvent:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIPushNewContainerIntoCCB:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/act_incoming_register_response:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIPresendProcessing:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIProcessPresendRandomContact:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Info/verbose/8192/sipSPIPresendProcessing: Presend Processing called for 13 event
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPI_ipip_PassthruCopyListDataProcessing:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPI_ipip_GetPassthruCopyListDataFromTdContainer:
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Info/verbose/8192/sipSPIRetrieveOutgoingPassThruData: Retrieving Data from RCB
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPI_ipip_GetPassthruCopyListDataFromTdContainer:
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Info/verbose/8192/sipSPIRetrieveOutgoingPassThruData: Retrieving Data from RCB
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_create: created msg=0x21F7C8AC with refCount = 1
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPISendResponse:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIResponseGetAssociatedContainer:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIPushSubsqTransMsgContainerIntoHolder:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIAddStdHeaders:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIAppendTagParam:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIGetCallHeaderString:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIAddWarningHeader:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Info/info/4096/sipSPISendResponse: Associated container=0x26C801F8 to REGISTER Response 200
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Info/verbose/8192/sipSPIAppHandleContainerBody: sipSPIAppHandleContainerBody len 0
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Transport/sipSPISendResponse: Sending INFO Response to the transport layer
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Transport/sipSPITransportSendMessage: msg=0x21F7C8AC, addr=10.85.188.19, port=52540, sentBy_port=52540, local_addr=10.85.188.2, is_req=0, transport=2, switch=0, callBack=0x5CCDD80
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsip_profile_application:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIGetExtensionCfg:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Info/info/2048/sipSPIGetExtensionCfg: SIP extension config:1, check sys cfg:1
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsip_profile_application:exit@22598:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsip_extension_application:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIGetExtensionCfg:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Info/info/2048/sipSPIGetExtensionCfg: SIP extension config:1, check sys cfg:1
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsip_extension_application:exit@34380:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Transport/sipTransportLogicSendMsg: Trying to send resp=0x21F7C8AC to default port=52540
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerGetConnection: connection required for raddr:10.85.188.19, rport:52540 with laddr:10.85.188.2

*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Transport/sipInstanceGetConnectionId: Registering gcb=0x2698DBC0 with connection=0x25211C48 context list
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Transport/sipTransportLogicSendMsg: Connection obtained...sending msg=0x21F7C8AC
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x21F7C8AC, addr=10.85.188.19, port=52540, local_addr=10.85.188.2, connId=11 vrfid=0 for TCP
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sentRegisterResponse:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIUdeleteCcbFromUASReqTable:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIUdeleteCcbFromTable:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Info/verbose/4096/sipSPIUdeleteCcbFromTable: Deleting from table. ccb=0x2698DBC0 key=c47295a8-44170004-7f03fa83-419446e2@10.85.188.1923002c47295a8441705e449d7450f-63a70fc5
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsip_is_valid_ccb:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsip_is_valid_ccb:exit@8124:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsip_delete_ccb:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIRemoveChildren:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIUfreeOneCCB:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIUdeleteccCallIdFromTable:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Info/verbose/4096/sipSPIUdeleteccCallIdFromTable: Removing call id 4CD2
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Info/verbose/4096/sipSPIDeleteContextFromTable: Context for key=[19704] removed.
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIStopFinalStatsCleanupTimer:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIStopCommonTimer:
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_free: Decrement msg (0x27003EA8) counter, current msg->refCount = 1
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Info/verbose/4096/sipSPIFlushEventBufferQueue: There are 0 events on the internal queue that are going to be free'd
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Error/sipSPIFlushDeferredQueue:
 Invalid deferredQueue
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIFreeSessionTargetInfo:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIFreeHistoryInfo:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPICleanupContainerBlock:
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerUnregisterCtxtInConnection: gConnTab=0x2520F99C, addr=10.85.188.19, port=52540, local_addr=10.85.188.2, unregistering context=0x2698DBC0
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Transport/sipInstancePurgeContextInConnection: Purging context gcb=0x2698DBC0 from the connection=0x25211C48 context list
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsip_platform_delete_ccb:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsip_platform_stop_timers:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIDropRtpSessions:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIGetFirstStream:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIGetMainStream:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsip_qos_cleanup:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIGetFirstStream:
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_free: Freed termsg=0x27003EA8
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsip_platform_terminate_implicit_subscriptions:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsip_free_kpml_info:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsip_free_kpml_info:exit@1508:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIFlushKpmlDigitBuffer:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIFlushKpmlDigitBuffer:exit@2039:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPI_ipip_free_dialpeer_video_caps:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPI_ipip_free_codec_profile:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Info/verbose/1/sipSPI_ipip_free_codec_profile: Codec Profiles Freed
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPICleanupOverlapInfo:
m *Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIStopOverlapInfoTimer:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIStopCommonTimer:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Info/info/8192/sipSPIStopOverlapInfoTimer: Stopping Overlap Info Timer
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIBwCacReleaseAccountedBw:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/sipSPIBwCacReleaseAccountedBw:exit@23765:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Function/ccsip_clear_rtp_session_pending_q:
*Jun 29 11:23:40.217: //19666/207844818E0C/SIP/Info/verbose/4096/sipSPIUfreeOneCCB: Freeing ccb 0x2698DBC0
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Info/verbose/4096/sipSPIGetContextFromTable: NO context for key[19704]
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPITransportSendMessage: gcb no has cleanedup, Done with send operations for this context
*Jun 29 11:23:40.217: //-1/xxxxxxxxxxxx/SIP/Info/verbose/4096/sipSPIGetContextFromTable: NO context for key[19704]
*Jun 29 11:23:40.219: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_tcp_queue_event: Event type: send msg, connid: 11, fd: 0

*Jun 29 11:23:40.219: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 200 OK
Via: SIP/2.0/TCP 10.85.188.19:52540;branch=z9hG4bK627d9f7b
From: <sip:23002@10.85.188.2>;tag=c47295a8441705e449d7450f-63a70fc5
To: <sip:23002@10.85.188.2>;tag=392CD854-14A1
Date: Mon, 29 Jun 2015 11:23:40 GMT
Call-ID: c47295a8-44170004-7f03fa83-419446e2@10.85.188.19
Server: Cisco-SIPGateway/IOS-15.5.2.T
CSeq: 1595 REGISTER
Supported: X-cisco-cme-sis-1.0.0
Supported: X-cisco-srtp-fallback
Contact: <sip:23002@10.85.188.19:52540;transport=tcp>;expires=300
Expires:  3mon00
Content-Length: 0

IP of phone::

10.85.188.21

Hi again all.

 

The config file is identical with a phone of same model thats working.

 

Attached are to .pcap traces from both phones (working and not).

Looks to me like the one not working never initiates SIP messages...

 

Anyone has any fresh input on this?

 

File Port6-OK.pcap (Phone is working)

File Port13-NOK.pcap (Phone is not working)

 

 

 

CDP Neighbor:

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

Device ID: SEP204C9EB25678

Entry address(es):

  IP address: 10.85.188.21

Platform: Cisco IP Phone 7841,  Capabilities: Host Phone Two-port Mac Relay

Interface: GigabitEthernet0/13,  Port ID (outgoing port): Port 1

Holdtime : 168 sec

Second Port Status: Down

 

Version :

sip78xx.10-1-1SR1-4.loads

 

advertisement version: 2

Duplex: full

Power drawn: 3.745 Watts

Power request id: 30807, Power management id: 3

Power request levels are:3745 0 0 0 0

Power Available TLV:

 

    Power request id: 0, Power management id: 0, Power available: 0, Power management level: 0

Management address(es):

 

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

Device ID: SEPC47295A84417

Entry address(es):

  IP address: 10.85.188.19

Platform: Cisco IP Phone 7841,  Capabilities: Host Phone Two-port Mac Relay

Interface: GigabitEthernet0/6,  Port ID (outgoing port): Port 1

Holdtime : 177 sec

Second Port Status: Down

 

Version :

sip78xx.10-1-1SR1-4.loads

 

advertisement version: 2

Duplex: full

Power drawn: 3.745 Watts

Power request id: 5957, Power management id: 3

Power request levels are:3745 0 0 0 0

Power Available TLV:

 

    Power request id: 0, Power management id: 0, Power available: 0, Power management level: 0

Management address(es):

 

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