cancel
Showing results for 
Search instead for 
Did you mean: 
cancel
3340
Views
10
Helpful
18
Replies

CUBE Help please! VOIP dial peer to Lync

rrobles007
Level 1
Level 1

Hello,

i'm having inbound call setup issues and hoping someone might be able to point me in the right direction.. its been a while since i worked on a Cube.

 

I have a 4 port FXO card on CUBE with VOIP dial peers pointing to a Microsoft Lync 2013

Any help would be HUGELY APPRECIATED. right now i don't believe i'm sending the call towards the lync server..

 

 

I can make outbound calls no problem, on inbound I get a fast busy. During the debug ccsip for inbound calls  i see the following:

(this is a dev environment so i don't mind sharing config)

 

The Call Setup Information is:
Call Control Block (CCB) : 0x23D03C8
State of The Call        : STATE_DEAD
TCP Sockets Used         : YES
Calling Number           : 
Called Number            : 8409
Source IP Address (Sig  ): 0.0.0.0
Destn SIP Req Addr:Port  : :0
Destn SIP Resp Addr:Port : :0
Destination Name         : 

 

 

 

I see that i match 2 dial peers on the inbound call: Matching Dial peer 10 for inbound and dial-peer 7 for outgoing:

ccsip_target_is_busied: SIP Dialpeer 7 busied out due to options-keepalive failure

 

dial-peer voice 7 voip
 translation-profile outgoing toLync
 huntstop
 destination-pattern ....
 rtp payload-type comfort-noise 13
 session protocol sipv2
 session target dns:dev-lync-01v.test.lcl
 session transport tcp
 voice-class codec 1
 voice-class sip localhost dns:GoPro_CUBE.test.lcl 
 no voice-class sip early-offer forced
 voice-class sip block 183 sdp absent
 voice-class sip options-keepalive
 dtmf-relay rtp-nte

 

 

 

dial-peer voice 10 pots
 description outbound_to_FXO
 destination-pattern .T
 direct-inward-dial
 port 0/0/1
 forward-digits all

 

 

 

 

 

 

*Nov 26 18:31:17.481: //25003/36D36F9EA3E9/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x21290A8, Tag=0x0, Call Id=25003,
   Call Entry(Disconnect Cause=3, Voice Class Cause Code=0, Retry Count=0)
*Nov 26 18:31:17.481: //25003/36D36F9EA3E9/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
*Nov 26 18:31:17.481: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
   
*Nov 26 18:31:17.481: :cc_free_feature_vsa freeing 259C1D0
*Nov 26 18:31:17.481: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
   
*Nov 26 18:31:17.481:  vsacount in free is 0
*Nov 26 18:31:21.977: //-1/4141B85CA3EE/CCAPI/cc_api_display_ie_subfields:
   cc_api_call_setup_ind_common:
   cisco-username=
   ----- ccCallInfo IE subfields -----
   cisco-ani=
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=8409
   cisco-desttype=0
   cisco-destplan=0
   cisco-rdie=FFFFFFFF
   cisco-rdn=
   cisco-lastrdn=
   cisco-rdntype=0
   cisco-rdnplan=0
   cisco-rdnpi=0
   cisco-rdnsi=0
   cisco-redirectreason=0   fwd_final_type =0
   final_redirectNumber =
   hunt_group_timeout =0

*Nov 26 18:31:21.977: //-1/4141B85CA3EE/CCAPI/cc_api_call_setup_ind_common:
   Interface=0x21290A8, Call Info(
   Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=8409(TON=Unknown, NPI=Unknown),
   Calling Translated=FALSE, Subscriber Type Str=RegularLine, FinalDestinationFlag=TRUE,
   Incoming Dial-peer=10, Progress Indication=ORIGINATING SIDE IS NON ISDN(3), Calling IE Present=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=-1
*Nov 26 18:31:21.977: //-1/4141B85CA3EE/CCAPI/ccCheckClipClir:
   In: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
*Nov 26 18:31:21.977: //-1/4141B85CA3EE/CCAPI/ccCheckClipClir:
   Out: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
*Nov 26 18:31:21.977: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
   
*Nov 26 18:31:21.977: :cc_get_feature_vsa malloc success
*Nov 26 18:31:21.977: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
   
*Nov 26 18:31:21.977:  cc_get_feature_vsa count is 1
*Nov 26 18:31:21.977: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
   
*Nov 26 18:31:21.977: :FEATURE_VSA attributes are: feature_name:0,feature_time:39436760,feature_id:288
*Nov 26 18:31:21.977: //25005/4141B85CA3EE/CCAPI/cc_api_call_setup_ind_common:
   Set Up Event Sent;
   Call Info(Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=8409(TON=Unknown, NPI=Unknown))
*Nov 26 18:31:21.977: //25005/4141B85CA3EE/CCAPI/cc_process_call_setup_ind:
   Event=0x135E87D8
*Nov 26 18:31:21.977: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
   Try with the demoted called number 8409
*Nov 26 18:31:21.977: //25005/4141B85CA3EE/CCAPI/ccCallSetContext:
   Context=0x11B14348
*Nov 26 18:31:21.977: //25005/4141B85CA3EE/CCAPI/cc_process_call_setup_ind:
   >>>>CCAPI handed cid 25005 with tag 10 to app "_ManagedAppProcess_Default"
*Nov 26 18:31:21.977: //25005/4141B85CA3EE/CCAPI/ccCallProceeding:
   Progress Indication=NULL(0)
*Nov 26 18:31:21.977: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
   Try with the demoted called number 8409
*Nov 26 18:31:21.977: //25005/4141B85CA3EE/CCAPI/ccCallSetupRequest:
   Destination=, Calling IE Present=FALSE, Mode=0,
   Outgoing Dial-peer=7, Params=0x11B1A2C0, Progress Indication=ORIGINATING SIDE IS NON ISDN(3)
*Nov 26 18:31:21.977: //25005/4141B85CA3EE/CCAPI/ccCheckClipClir:
   In: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
*Nov 26 18:31:21.977: //25005/4141B85CA3EE/CCAPI/ccCheckClipClir:
   Out: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
*Nov 26 18:31:21.977: //25005/4141B85CA3EE/CCAPI/ccCallSetupRequest:
   Destination Pattern=...., Called Number=8409, Digit Strip=FALSE
*Nov 26 18:31:21.977: //25005/4141B85CA3EE/CCAPI/ccCallSetupRequest:
   Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=8409(TON=Unknown, NPI=Unknown),
   Redirect Number=, Display Info=
   Account Number=, Final Destination Flag=TRUE,
   Guid=4141B85C-74D1-11E4-A3EE-80FA62F158C4, Outgoing Dial-peer=7
*Nov 26 18:31:21.977: //25005/4141B85CA3EE/CCAPI/cc_api_display_ie_subfields:
   ccCallSetupRequest:
   cisco-username=
   ----- ccCallInfo IE subfields -----
   cisco-ani=
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=8409
   cisco-desttype=0
   cisco-destplan=0
   cisco-rdie=FFFFFFFF
   cisco-rdn=
   cisco-lastrdn=
   cisco-rdntype=0
   cisco-rdnplan=0
   cisco-rdnpi=0
   cisco-rdnsi=0
   cisco-redirectreason=0   fwd_final_type =0
   final_redirectNumber =
   hunt_group_timeout =0

*Nov 26 18:31:21.981: //25005/4141B85CA3EE/CCAPI/ccIFCallSetupRequestPrivate:
   Interface=0x1979710, Interface Type=3, Destination=, Mode=0x0,
   Call Params(Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=8409(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
   Subscriber Type Str=RegularLine, FinalDestinationFlag=TRUE, Outgoing Dial-peer=7, Call Count On=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
*Nov 26 18:31:21.981: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
   
*Nov 26 18:31:21.981: :cc_get_feature_vsa malloc success
*Nov 26 18:31:21.981: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
   
*Nov 26 18:31:21.981:  cc_get_feature_vsa count is 2
*Nov 26 18:31:21.981: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
   
*Nov 26 18:31:21.981: :FEATURE_VSA attributes are: feature_name:0,feature_time:39436536,feature_id:289
*Nov 26 18:31:21.981: //25006/4141B85CA3EE/CCAPI/ccIFCallSetupRequestPrivate:
   SPI Call Setup Request Is Success; Interface Type=3, FlowMode=1
*Nov 26 18:31:21.981: //25006/4141B85CA3EE/CCAPI/ccCallSetContext:
   Context=0x11B1A270
*Nov 26 18:31:21.981: //25005/4141B85CA3EE/CCAPI/ccSaveDialpeerTag:
   Outgoing Dial-peer=7
*Nov 26 18:31:21.981: //25006/4141B85CA3EE/CCAPI/cc_api_call_disconnected:
   Cause Value=3, Interface=0x1979710, Call Id=25006
*Nov 26 18:31:21.981: //25006/4141B85CA3EE/CCAPI/cc_api_call_disconnected:
   Call Entry(Responsed=TRUE, Cause Value=3, Retry Count=0)
*Nov 26 18:31:21.981: //25005/xxxxxxxxxxxx/CCAPI/ccCallReleaseResources:
   release reserved xcoding resource.
*Nov 26 18:31:21.981: //25006/4141B85CA3EE/CCAPI/ccCallSetAAA_Accounting:
   Accounting=0, Call Id=25006
*Nov 26 18:31:21.981: //25006/4141B85CA3EE/CCAPI/ccCallDisconnect:
   Cause Value=3, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=3)
*Nov 26 18:31:21.981: //25006/4141B85CA3EE/CCAPI/ccCallDisconnect:
   Cause Value=3, Call Entry(Responsed=TRUE, Cause Value=3)
*Nov 26 18:31:21.981: //25006/4141B85CA3EE/CCAPI/cc_api_call_disconnect_done:
   Disposition=-11, Interface=0x1979710, Tag=0x0, Call Id=25006,
   Call Entry(Disconnect Cause=3, Voice Class Cause Code=0, Retry Count=0)
*Nov 26 18:31:21.981: //25006/4141B85CA3EE/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
*Nov 26 18:31:21.981: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
   
*Nov 26 18:31:21.981: :cc_free_feature_vsa freeing 259C0F0
*Nov 26 18:31:21.981: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
   
*Nov 26 18:31:21.981:  vsacount in free is 1
*Nov 26 18:31:21.981: //25005/4141B85CA3EE/CCAPI/ccCallDisconnect:
   Cause Value=3, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
*Nov 26 18:31:21.981: //25005/4141B85CA3EE/CCAPI/ccCallDisconnect:
   Cause Value=3, Call Entry(Responsed=TRUE, Cause Value=3)
*Nov 26 18:31:21.981: //25005/4141B85CA3EE/CCAPI/cc_api_get_transfer_info:
   Transfer Number Is Null
*Nov 26 18:31:34.901: //25005/4141B85CA3EE/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x21290A8, Tag=0x0, Call Id=25005,
   Call Entry(Disconnect Cause=3, Voice Class Cause Code=0, Retry Count=0)
*Nov 26 18:31:34.901: //25005/4141B85CA3EE/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
*Nov 26 18:31:34.901: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
   
*Nov 26 18:31:34.901: :cc_free_feature_vsa freeing 259C1D0
*Nov 26 18:31:34.901: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
   
*Nov 26 18:31:34.901:  vsacount in free is 0

 

 

aaa new-model
!
!
!
!
!
!
!
aaa session-id common
!
!
!
!
!
!
no ipv6 cef
ip source-route
ip cef
!
!
!
!
no ip domain lookup
ip domain name test.lcl
ip name-server 172.16.12.10
ip name-server 172.16.12.11
!
multilink bundle-name authenticated
!
!
!
!
!
voice-card 0
!
!
!
voice service voip
 allow-connections sip to sip
 no supplementary-service sip refer
 supplementary-service media-renegotiate
 fax protocol t38 ls-redundancy 0 hs-redundancy 0 fallback none
 sip
  min-se 600 
  asserted-id pai
  midcall-signaling passthru
  privacy-policy passthru
  privacy-policy send-always
  sip-profiles 1
!
voice class codec 1
 codec preference 1 g711ulaw
 codec preference 2 g711alaw
!
voice class sip-profiles 1
 request INVITE sip-header Expires remove 
 request INVITE sip-header Session-Expires add "Session-expires: 600" 
!
!
!
voice translation-rule 1
 rule 1 /\(..........\)/ /+1\1/
!
voice translation-rule 2
 rule 1 /\+1\(..........\)/ /\1/
!
voice translation-rule 3
 rule 1 /\(..........\)/ /+\1/
!
!
voice translation-profile toAnalog
 translate called 3
!
voice translation-profile toLync
 translate called 1
!
voice translation-profile toPRI
 translate called 2
!
!
!
application
 service dsapp
  param dialpeer 7
  param callHold TRUE
 !
!
license udi pid C3900-SPE100/K9 sn FOC16216VXU
license boot module c3900 technology-package securityk9
license boot module c3900 technology-package uck9
license boot module c3900 technology-package datak9
hw-module pvdm 0/0
!
!
!

!
redundancy
!
!
ip ssh time-out 60

!
!
!
!
!
!
interface GigabitEthernet0/0
 no ip address
 shutdown
 duplex auto
 speed auto
 !
!
interface GigabitEthernet0/1
 no ip address
 shutdown
 duplex auto
 speed auto
 !
!
interface GigabitEthernet0/2
 ip address 172.16.12.6 255.255.255.0
 duplex auto
 speed auto
 !
!
!
ip default-gateway 172.16.12.1
ip forward-protocol nd
!
no ip http server
no ip http secure-server
!
ip route 0.0.0.0 0.0.0.0 172.16.12.1
!
!
!
!
!
nls resp-timeout 1
cpd cr-id 1
!
!
control-plane
 !
!
!
voice-port 0/0/0
!
voice-port 0/0/1
 connection plar 8409
!
voice-port 0/0/2
!
voice-port 0/0/3
!
!
!
!
dial-peer voice 2 pots
 destination-pattern 5206803
 direct-inward-dial
 port 0/0/0
!
dial-peer voice 3 pots
 destination-pattern 6505206803
 direct-inward-dial
 port 0/0/2
!
dial-peer voice 1 voip
 description outgoing to Lync
 translation-profile outgoing toLync
 huntstop
 rtp payload-type comfort-noise 13
 session protocol sipv2
 session target dns:dev-lync-01v.test.lcl
 session transport tcp
 incoming called-number .
 voice-class codec 1
 voice-class sip localhost dns:GOPRO_CUBE.test.lcl 
 no voice-class sip early-offer forced
 no voice-class sip block 183
 voice-class sip options-keepalive
 dtmf-relay rtp-nte
!
dial-peer voice 4 voip
 description outgoint toAnalog
 huntstop
 destination-pattern 9728522617
 rtp payload-type comfort-noise 13
 session protocol sipv2
 session target dns:dev-lync-01v.test.lcl
 session transport tcp
 incoming called-number .
 voice-class codec 1
 voice-class sip localhost dns:GOPRO_CUBE.test.lcl 
 no voice-class sip early-offer forced
 no voice-class sip block 183
 voice-class sip options-keepalive
 dtmf-relay rtp-nte sip-notify sip-kpml
!
dial-peer voice 6 voip
 description outgoint toAnalog
 huntstop
 destination-pattern ..........
 rtp payload-type comfort-noise 13
 session protocol sipv2
 session target dns:dev-lync-01v.test.lcl
 session transport tcp
 incoming called-number .
 voice-class codec 1
 voice-class sip localhost dns:GOPRO_CUBE.test.lcl 
 no voice-class sip early-offer forced
 no voice-class sip block 183
 voice-class sip options-keepalive
 dtmf-relay rtp-nte sip-notify sip-kpml
!
dial-peer voice 7 voip
 translation-profile outgoing toLync
 huntstop
 destination-pattern ....
 rtp payload-type comfort-noise 13
 session protocol sipv2
 session target dns:dev-lync-01v.test.lcl
 session transport tcp
 voice-class codec 1
 voice-class sip localhost dns:GOPRO_CUBE.test.lcl 
 no voice-class sip early-offer forced
 voice-class sip block 183 sdp absent
 voice-class sip options-keepalive
 dtmf-relay rtp-nte
!
dial-peer voice 8 voip
 description toPSTN
 translation-profile outgoing fromAnalog
 shutdown
 destination-pattern 1..........
 rtp payload-type comfort-noise 13
 session protocol sipv2
 session target dns:dev-lync-01v.test.lcl
 session transport tcp
 incoming called-number .
 voice-class codec 1
 voice-class sip localhost dns:GOPRO_CUBE.test.lcl 
 no voice-class sip early-offer forced
 no voice-class sip block 183
 voice-class sip options-keepalive
 dtmf-relay rtp-nte sip-notify sip-kpml
!
dial-peer voice 5 pots
 destination-pattern T
 incoming called-number .
 forward-digits all
!         
dial-peer voice 10 pots
 description outbound_to_FXO
 destination-pattern .T
 direct-inward-dial
 port 0/0/1
 forward-digits all
!
dial-peer voice 11 pots
 shutdown
 destination-pattern 1..........
 direct-inward-dial
 port 0/0/3
 forward-digits 0
!
dial-peer voice 8409 pots
 destination-pattern .T
 port 0/0/1
!
!
sip-ua 
 set pstn-cause 31 sip-status 480
 timers expires 1800000
!
!
!
gatekeeper
 shutdown
!
!

!
scheduler allocate 20000 1000
end

 

 

 

 

 

 

 

CCSIP DEBUG:

 

*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIAddContextToTable: Added context(0x23D03C8) with key=[24907] to table
*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetSipProfilesTag: voice class SIP Profiles tag is set : 1
*Nov 26 18:43:09.685: //25117/000000000000/SIP/State/sipSPIChangeState: 0x23D03C8 : State change from (STATE_NONE, SUBSTATE_NONE)  to (STATE_IDLE, SUBSTATE_NONE)
*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIAddContextToTable: Added context(0x23D56B8) with key=[24908] to table
*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetSipProfilesTag: voice class SIP Profiles tag is set : 1
*Nov 26 18:43:09.685: //25118/000000000000/SIP/State/sipSPIChangeState: 0x23D56B8 : State change from (STATE_NONE, SUBSTATE_NONE)  to (STATE_IDLE, SUBSTATE_NONE)
*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 for event 37
*Nov 26 18:43:09.685: //25117/000000000000/SIP/Info/sipSPIUaddccCallIdToTable: Adding call id 621D to table
*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_DNS_RESOLVE
*Nov 26 18:43:09.685: //25117/000000000000/SIP/State/sipSPIChangeState: 0x23D03C8 : State change from (STATE_IDLE, SUBSTATE_NONE)  to (STATE_IDLE, SUBSTATE_SENT_DNS)
*Nov 26 18:43:09.685: //25117/000000000000/SIP/State/sipSPIChangeState: 0x23D03C8 : State change from (STATE_IDLE, SUBSTATE_SENT_DNS)  to (SIP_STATE_OPTIONS_WAIT, SUBSTATE_SENT_DNS)
*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 for event 37
*Nov 26 18:43:09.685: //25118/000000000000/SIP/Info/sipSPIUaddccCallIdToTable: Adding call id 621E to table
*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_DNS_RESOLVE
*Nov 26 18:43:09.685: //25118/000000000000/SIP/State/sipSPIChangeState: 0x23D56B8 : State change from (STATE_IDLE, SUBSTATE_NONE)  to (STATE_IDLE, SUBSTATE_SENT_DNS)
*Nov 26 18:43:09.685: //25118/000000000000/SIP/State/sipSPIChangeState: 0x23D56B8 : State change from (STATE_IDLE, SUBSTATE_SENT_DNS)  to (SIP_STATE_OPTIONS_WAIT, SUBSTATE_SENT_DNS)
*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_srv_query: TYPE SRV query for _sip._tcp.dev-lync-01v.test.lcl and type:1
*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_a_aaaa_query: DNS query for dev-lync-01v.test.lcl and type:1
*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_a_query: TYPE A query successful for dev-lync-01v.test.lcl
*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_a_aaaa_query: IP Address of dev-lync-01v.test.lcl is:

*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_a_aaaa_query: 172.16.12.28

*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_srv_query: TYPE SRV query for _sip._tcp.dev-lync-01v.test.lcl and type:1
*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for event 43
*Nov 26 18:43:09.685: //25117/000000000000/SIP/State/sipSPIChangeState: 0x23D03C8 : State change from (SIP_STATE_OPTIONS_WAIT, SUBSTATE_SENT_DNS)  to (SIP_STATE_OPTIONS_WAIT, SUBSTATE_NONE)
*Nov 26 18:43:09.685: //25117/000000000000/SIP/Info/sipSPIUaddCcbToUACTable: ****Adding to UAC table.
*Nov 26 18:43:09.685: //25117/000000000000/SIP/Info/sipSPIUaddCcbToTable: Added to table. ccb=0x23D03C8 key=E715629F-74D211E4-A46A80FA-62F158C4@GOPRO_CUBE.test.lcl
*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT
*Nov 26 18:43:09.685: //25117/000000000000/SIP/Error/sipSPIAddPrivacyHeader: Orig Container is NULL...should have value
*Nov 26 18:43:09.685: //25117/000000000000/SIP/Error/sipSPIAddAssertedIDHeader: Orig Container is NULL...should have value
*Nov 26 18:43:09.685: //25117/000000000000/SIP/Error/sipSPIAddPreferredIDHeader: Orig Container is NULL...should have value
*Nov 26 18:43:09.685: //25117/000000000000/SIP/Info/sipSPISendOptionsRequest: Associated container=0x138CA8B8 to Options
*Nov 26 18:43:09.685: //25117/000000000000/SIP/Transport/sipSPIGetSwitchTransportFlag: Return the Dial peer configuration, Switch Transport is FALSE
*Nov 26 18:43:09.685: //25117/000000000000/SIP/Transport/sipSPITransportSendMessage: msg=0x11A7429C, addr=172.16.12.28, port=5060, sentBy_port=0, is_req=1, transport=2, switch=0, callBack=0x7A03A18
*Nov 26 18:43:09.685: //25117/000000000000/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Nov 26 18:43:09.685: //25117/000000000000/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
*Nov 26 18:43:09.685: //25117/000000000000/SIP/Transport/sipTransportLogicSendMsg: Set to send the msg=0x11A7429C
*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x11A7429C, addr=172.16.12.28, port=5060, connId=2 for TCP
*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent: 
OPTIONS sip:dev-lync-01v.test.lcl:5060 SIP/2.0
Via: SIP/2.0/TCP 172.16.12.6:5060;branch=z9hG4bK5ACE1D7E
From: <sip:GOPRO_CUBE.test.lcl>;tag=978AB0C-1C3E
To: <sip:dev-lync-01v.test.lcl>
Date: Wed, 26 Nov 2014 18:43:09 GMT
Call-ID: E715629F-74D211E4-A46A80FA-62F158C4@GOPRO_CUBE.test.lcl
User-Agent: Cisco-SIPGateway/IOS-12.x
Max-Forwards: 70
CSeq: 101 OPTIONS
Contact: <sip:172.16.12.6:5060;transport=tcp>
Content-Length: 0


*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_a_aaaa_query: DNS query for dev-lync-01v.test.lcl and type:1
*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_a_query: TYPE A query successful for dev-lync-01v.test.lcl
*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_a_aaaa_query: IP Address of dev-lync-01v.test.lcl is:

*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_a_aaaa_query: 172.16.12.28

*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for event 43
*Nov 26 18:43:09.685: //25118/000000000000/SIP/State/sipSPIChangeState: 0x23D56B8 : State change from (SIP_STATE_OPTIONS_WAIT, SUBSTATE_SENT_DNS)  to (SIP_STATE_OPTIONS_WAIT, SUBSTATE_NONE)
*Nov 26 18:43:09.685: //25118/000000000000/SIP/Info/sipSPIUaddCcbToUACTable: ****Adding to UAC table.
*Nov 26 18:43:09.685: //25118/000000000000/SIP/Info/sipSPIUaddCcbToTable: Added to table. ccb=0x23D56B8 key=E715629F-74D211E4-A46B80FA-62F158C4@GOPRO_CUBE.test.lcl
*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT
*Nov 26 18:43:09.685: //25118/000000000000/SIP/Error/sipSPIAddPrivacyHeader: Orig Container is NULL...should have value
*Nov 26 18:43:09.685: //25118/000000000000/SIP/Error/sipSPIAddAssertedIDHeader: Orig Container is NULL...should have value
*Nov 26 18:43:09.685: //25118/000000000000/SIP/Error/sipSPIAddPreferredIDHeader: Orig Container is NULL...should have value
*Nov 26 18:43:09.685: //25118/000000000000/SIP/Info/sipSPISendOptionsRequest: Associated container=0x138CA5F8 to Options
*Nov 26 18:43:09.685: //25118/000000000000/SIP/Transport/sipSPIGetSwitchTransportFlag: Return the Dial peer configuration, Switch Transport is FALSE
*Nov 26 18:43:09.685: //25118/000000000000/SIP/Transport/sipSPITransportSendMessage: msg=0x11A4F654, addr=172.16.12.28, port=5060, sentBy_port=0, is_req=1, transport=2, switch=0, callBack=0x7A03A18
*Nov 26 18:43:09.685: //25118/000000000000/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Nov 26 18:43:09.685: //25118/000000000000/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
*Nov 26 18:43:09.685: //25118/000000000000/SIP/Transport/sipTransportLogicSendMsg: Set to send the msg=0x11A4F654
*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x11A4F654, addr=172.16.12.28, port=5060, connId=2 for TCP
*Nov 26 18:43:09.685: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent: 
OPTIONS sip:dev-lync-01v.test.lcl:5060 SIP/2.0
Via: SIP/2.0/TCP 172.16.12.6:5060;branch=z9hG4bK5ACF12E0
From: <sip:GOPRO_CUBE.test.lcl>;tag=978AB0C-2045
To: <sip:dev-lync-01v.test.lcl>
Date: Wed, 26 Nov 2014 18:43:09 GMT
Call-ID: E715629F-74D211E4-A46B80FA-62F158C4@GOPRO_CUBE.test.lcl
User-Agent: Cisco-SIPGateway/IOS-12.x
Max-Forwards: 70
CSeq: 101 OPTIONS
Contact: <sip:172.16.12.6:5060;transport=tcp>
Content-Length: 0


*Nov 26 18:43:09.689: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for event 1
*Nov 26 18:43:09.689: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x133503FC
*Nov 26 18:43:09.689: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerProcessNewConnMsg: gConnTab=0x133503FC, addr=172.16.12.28, port=5060, connid=2, transport=TCP
*Nov 26 18:43:09.689: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_new_msg_preprocessor: Checking Invite Dialog
*Nov 26 18:43:09.689: Parse Error: url_parseSipUrl: Received Bad Host
*Nov 26 18:43:09.689: //-1/xxxxxxxxxxxx/SIP/Error/sipSPIMatchRespToReqTran: Error in matching From header tags
*Nov 26 18:43:09.689: Parse Error: url_parseSipUrl: Received Bad Host
*Nov 26 18:43:09.689: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received: 
SIP/2.0 200 OK
FROM: <sip:GOPRO_CUBE.test.lcl>;tag=978AB0C-1C3E
TO: <sip:dev-lync-01v.test.lcl>;tag=14f067e6da
CSEQ: 101 OPTIONS
CALL-ID: E715629F-74D211E4-A46A80FA-62F158C4@GOPRO_CUBE.test.lcl
VIA: SIP/2.0/TCP 172.16.12.6:5060;branch=z9hG4bK5ACE1D7E
ACCEPT: application/sdp
CONTENT-LENGTH: 0
ACCEPT-ENCODING: gzip
ACCEPT-LANGUAGE: en
ALLOW: NOTIFY
ALLOW: BENOTIFY
SERVER: RTCC/5.0.0.0 MediationServer


*Nov 26 18:43:09.689: //-1/xxxxxxxxxxxx/SIP/Info/sipSPILocateInviteDialogCCB: Could not find matching transaction for this response, Dropping it
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIAddContextToTable: Added context(0x23C0AF8) with key=[24909] to table
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetSipProfilesTag: voice class SIP Profiles tag is set : 1
*Nov 26 18:43:09.697: //25119/000000000000/SIP/State/sipSPIChangeState: 0x23C0AF8 : State change from (STATE_NONE, SUBSTATE_NONE)  to (STATE_IDLE, SUBSTATE_NONE)
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIAddContextToTable: Added context(0x23C5DE8) with key=[24910] to table
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetSipProfilesTag: voice class SIP Profiles tag is set : 1
*Nov 26 18:43:09.697: //25120/000000000000/SIP/State/sipSPIChangeState: 0x23C5DE8 : State change from (STATE_NONE, SUBSTATE_NONE)  to (STATE_IDLE, SUBSTATE_NONE)
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 for event 37
*Nov 26 18:43:09.697: //25119/000000000000/SIP/Info/sipSPIUaddccCallIdToTable: Adding call id 621F to table
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_DNS_RESOLVE
*Nov 26 18:43:09.697: //25119/000000000000/SIP/State/sipSPIChangeState: 0x23C0AF8 : State change from (STATE_IDLE, SUBSTATE_NONE)  to (STATE_IDLE, SUBSTATE_SENT_DNS)
*Nov 26 18:43:09.697: //25119/000000000000/SIP/State/sipSPIChangeState: 0x23C0AF8 : State change from (STATE_IDLE, SUBSTATE_SENT_DNS)  to (SIP_STATE_OPTIONS_WAIT, SUBSTATE_SENT_DNS)
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 for event 37
*Nov 26 18:43:09.697: //25120/000000000000/SIP/Info/sipSPIUaddccCallIdToTable: Adding call id 6220 to table
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_DNS_RESOLVE
*Nov 26 18:43:09.697: //25120/000000000000/SIP/State/sipSPIChangeState: 0x23C5DE8 : State change from (STATE_IDLE, SUBSTATE_NONE)  to (STATE_IDLE, SUBSTATE_SENT_DNS)
*Nov 26 18:43:09.697: //25120/000000000000/SIP/State/sipSPIChangeState: 0x23C5DE8 : State change from (STATE_IDLE, SUBSTATE_SENT_DNS)  to (SIP_STATE_OPTIONS_WAIT, SUBSTATE_SENT_DNS)
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_srv_query: TYPE SRV query for _sip._tcp.dev-lync-01v.test.lcl and type:1
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_a_aaaa_query: DNS query for dev-lync-01v.test.lcl and type:1
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_a_query: TYPE A query successful for dev-lync-01v.test.lcl
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_a_aaaa_query: IP Address of dev-lync-01v.test.lcl is:

*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_a_aaaa_query: 172.16.12.28

*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_srv_query: TYPE SRV query for _sip._tcp.dev-lync-01v.test.lcl and type:1
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for event 43
*Nov 26 18:43:09.697: //25119/000000000000/SIP/State/sipSPIChangeState: 0x23C0AF8 : State change from (SIP_STATE_OPTIONS_WAIT, SUBSTATE_SENT_DNS)  to (SIP_STATE_OPTIONS_WAIT, SUBSTATE_NONE)
*Nov 26 18:43:09.697: //25119/000000000000/SIP/Info/sipSPIUaddCcbToUACTable: ****Adding to UAC table.
*Nov 26 18:43:09.697: //25119/000000000000/SIP/Info/sipSPIUaddCcbToTable: Added to table. ccb=0x23C0AF8 key=E7173716-74D211E4-A46C80FA-62F158C4@GOPRO_CUBE.test.lcl
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT
*Nov 26 18:43:09.697: //25119/000000000000/SIP/Error/sipSPIAddPrivacyHeader: Orig Container is NULL...should have value
*Nov 26 18:43:09.697: //25119/000000000000/SIP/Error/sipSPIAddAssertedIDHeader: Orig Container is NULL...should have value
*Nov 26 18:43:09.697: //25119/000000000000/SIP/Error/sipSPIAddPreferredIDHeader: Orig Container is NULL...should have value
*Nov 26 18:43:09.697: //25119/000000000000/SIP/Info/sipSPISendOptionsRequest: Associated container=0x138CA548 to Options
*Nov 26 18:43:09.697: //25119/000000000000/SIP/Transport/sipSPIGetSwitchTransportFlag: Return the Dial peer configuration, Switch Transport is FALSE
*Nov 26 18:43:09.697: //25119/000000000000/SIP/Transport/sipSPITransportSendMessage: msg=0x11A700A4, addr=172.16.12.28, port=5060, sentBy_port=0, is_req=1, transport=2, switch=0, callBack=0x7A03A18
*Nov 26 18:43:09.697: //25119/000000000000/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Nov 26 18:43:09.697: //25119/000000000000/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
*Nov 26 18:43:09.697: //25119/000000000000/SIP/Transport/sipTransportLogicSendMsg: Set to send the msg=0x11A700A4
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x11A700A4, addr=172.16.12.28, port=5060, connId=2 for TCP
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent: 
OPTIONS sip:dev-lync-01v.test.lcl:5060 SIP/2.0
Via: SIP/2.0/TCP 172.16.12.6:5060;branch=z9hG4bK5AD02446
From: <sip:GOPRO_CUBE.test.lcl>;tag=978AB18-197A
To: <sip:dev-lync-01v.test.lcl>
Date: Wed, 26 Nov 2014 18:43:09 GMT
Call-ID: E7173716-74D211E4-A46C80FA-62F158C4@GOPRO_CUBE.test.lcl
User-Agent: Cisco-SIPGateway/IOS-12.x
Max-Forwards: 70
CSeq: 101 OPTIONS
Contact: <sip:172.16.12.6:5060;transport=tcp>
Content-Length: 0


*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for event 1
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x133503FC
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerProcessNewConnMsg: gConnTab=0x133503FC, addr=172.16.12.28, port=5060, connid=2, transport=TCP
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_new_msg_preprocessor: Checking Invite Dialog
*Nov 26 18:43:09.697: Parse Error: url_parseSipUrl: Received Bad Host
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Error/sipSPIMatchRespToReqTran: Error in matching From header tags
*Nov 26 18:43:09.697: Parse Error: url_parseSipUrl: Received Bad Host
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received: 
SIP/2.0 200 OK
FROM: <sip:GOPRO_CUBE.test.lcl>;tag=978AB0C-2045
TO: <sip:dev-lync-01v.test.lcl>;tag=8358923a7
CSEQ: 101 OPTIONS
CALL-ID: E715629F-74D211E4-A46B80FA-62F158C4@GOPRO_CUBE.test.lcl
VIA: SIP/2.0/TCP 172.16.12.6:5060;branch=z9hG4bK5ACF12E0
ACCEPT: application/sdp
CONTENT-LENGTH: 0
ACCEPT-ENCODING: gzip
ACCEPT-LANGUAGE: en
ALLOW: NOTIFY
ALLOW: BENOTIFY
SERVER: RTCC/5.0.0.0 MediationServer


*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Info/sipSPILocateInviteDialogCCB: Could not find matching transaction for this response, Dropping it
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_a_aaaa_query: DNS query for dev-lync-01v.test.lcl and type:1
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_a_query: TYPE A query successful for dev-lync-01v.test.lcl
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_a_aaaa_query: IP Address of dev-lync-01v.test.lcl is:

*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_a_aaaa_query: 172.16.12.28

*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for event 43
*Nov 26 18:43:09.697: //25120/000000000000/SIP/State/sipSPIChangeState: 0x23C5DE8 : State change from (SIP_STATE_OPTIONS_WAIT, SUBSTATE_SENT_DNS)  to (SIP_STATE_OPTIONS_WAIT, SUBSTATE_NONE)
*Nov 26 18:43:09.697: //25120/000000000000/SIP/Info/sipSPIUaddCcbToUACTable: ****Adding to UAC table.
*Nov 26 18:43:09.697: //25120/000000000000/SIP/Info/sipSPIUaddCcbToTable: Added to table. ccb=0x23C5DE8 key=E7173716-74D211E4-A46D80FA-62F158C4@GOPRO_CUBE.test.lcl
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT
*Nov 26 18:43:09.697: //25120/000000000000/SIP/Error/sipSPIAddPrivacyHeader: Orig Container is NULL...should have value
*Nov 26 18:43:09.697: //25120/000000000000/SIP/Error/sipSPIAddAssertedIDHeader: Orig Container is NULL...should have value
*Nov 26 18:43:09.697: //25120/000000000000/SIP/Error/sipSPIAddPreferredIDHeader: Orig Container is NULL...should have value
*Nov 26 18:43:09.697: //25120/000000000000/SIP/Info/sipSPISendOptionsRequest: Associated container=0x138CA5A0 to Options
*Nov 26 18:43:09.697: //25120/000000000000/SIP/Transport/sipSPIGetSwitchTransportFlag: Return the Dial peer configuration, Switch Transport is FALSE
*Nov 26 18:43:09.697: //25120/000000000000/SIP/Transport/sipSPITransportSendMessage: msg=0x1396E6D8, addr=172.16.12.28, port=5060, sentBy_port=0, is_req=1, transport=2, switch=0, callBack=0x7A03A18
*Nov 26 18:43:09.697: //25120/000000000000/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Nov 26 18:43:09.697: //25120/000000000000/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
*Nov 26 18:43:09.697: //25120/000000000000/SIP/Transport/sipTransportLogicSendMsg: Set to send the msg=0x1396E6D8
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x1396E6D8, addr=172.16.12.28, port=5060, connId=2 for TCP
*Nov 26 18:43:09.697: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent: 
OPTIONS sip:dev-lync-01v.test.lcl:5060 SIP/2.0
Via: SIP/2.0/TCP 172.16.12.6:5060;branch=z9hG4bK5AD15AA
From: <sip:GOPRO_CUBE.test.lcl>;tag=978AB18-139B
To: <sip:dev-lync-01v.test.lcl>
Date: Wed, 26 Nov 2014 18:43:09 GMT
Call-ID: E7173716-74D211E4-A46D80FA-62F158C4@GOPRO_CUBE.test.lcl
User-Agent: Cisco-SIPGateway/IOS-12.x
Max-Forwards: 70
CSeq: 101 OPTIONS
Contact: <sip:172.16.12.6:5060;transport=tcp>
Content-Length: 0


*Nov 26 18:43:09.701: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for event 1
*Nov 26 18:43:09.701: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x133503FC
*Nov 26 18:43:09.701: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerProcessNewConnMsg: gConnTab=0x133503FC, addr=172.16.12.28, port=5060, connid=2, transport=TCP
*Nov 26 18:43:09.701: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_new_msg_preprocessor: Checking Invite Dialog
*Nov 26 18:43:09.701: Parse Error: url_parseSipUrl: Received Bad Host
*Nov 26 18:43:09.701: //-1/xxxxxxxxxxxx/SIP/Error/sipSPIMatchRespToReqTran: Error in matching From header tags
*Nov 26 18:43:09.701: Parse Error: url_parseSipUrl: Received Bad Host
*Nov 26 18:43:09.701: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received: 
SIP/2.0 200 OK
FROM: <sip:GOPRO_CUBE.test.lcl>;tag=978AB18-197A
TO: <sip:dev-lync-01v.test.lcl>;tag=7292bc3259
CSEQ: 101 OPTIONS
CALL-ID: E7173716-74D211E4-A46C80FA-62F158C4@GOPRO_CUBE.test.lcl
VIA: SIP/2.0/TCP 172.16.12.6:5060;branch=z9hG4bK5AD02446
ACCEPT: application/sdp
CONTENT-LENGTH: 0
ACCEPT-ENCODING: gzip
ACCEPT-LANGUAGE: en
ALLOW: NOTIFY
ALLOW: BENOTIFY
SERVER: RTCC/5.0.0.0 MediationServer


*Nov 26 18:43:09.701: //-1/xxxxxxxxxxxx/SIP/Info/sipSPILocateInviteDialogCCB: Could not find matching transaction for this response, Dropping it
*Nov 26 18:43:09.853: //-1/xxxxxxxxxxxx/SIP/Error/ccsip_send_ood_options_ping: Dialpeer is down; not sending ood options ping
*Nov 26 18:43:09.901: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for event 1
*Nov 26 18:43:09.901: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x133503FC
*Nov 26 18:43:09.901: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerProcessNewConnMsg: gConnTab=0x133503FC, addr=172.16.12.28, port=5060, connid=2, transport=TCP
*Nov 26 18:43:09.901: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_new_msg_preprocessor: Checking Invite Dialog
*Nov 26 18:43:09.901: Parse Error: url_parseSipUrl: Received Bad Host
*Nov 26 18:43:09.901: //-1/xxxxxxxxxxxx/SIP/Error/sipSPIMatchRespToReqTran: Error in matching From header tags
*Nov 26 18:43:09.901: Parse Error: url_parseSipUrl: Received Bad Host
*Nov 26 18:43:09.901: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received: 
SIP/2.0 200 OK
FROM: <sip:GOPRO_CUBE.test.lcl>;tag=978AB18-139B
TO: <sip:dev-lync-01v.test.lcl>;tag=eff2ad64f6
CSEQ: 101 OPTIONS
CALL-ID: E7173716-74D211E4-A46D80FA-62F158C4@GOPRO_CUBE.test.lcl
VIA: SIP/2.0/TCP 172.16.12.6:5060;branch=z9hG4bK5AD15AA
ACCEPT: application/sdp
CONTENT-LENGTH: 0
ACCEPT-ENCODING: gzip
ACCEPT-LANGUAGE: en
ALLOW: NOTIFY
ALLOW: BENOTIFY
SERVER: RTCC/5.0.0.0 MediationServer


*Nov 26 18:43:09.901: //-1/xxxxxxxxxxxx/SIP/Info/sipSPILocateInviteDialogCCB: Could not find matching transaction for this response, Dropping it
*Nov 26 18:43:10.185: //25117/000000000000/SIP/Error/act_sent_OODoptions_wait_response: Out of retries
*Nov 26 18:43:10.185: //25117/000000000000/SIP/Info/sipSPIUdeleteccCallIdFromTable: Removing call id 621D
*Nov 26 18:43:10.185: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIDeleteContextFromTable: Context for key=[24907] removed.
*Nov 26 18:43:10.185: //25117/000000000000/SIP/Info/sipSPIUdeleteCcbFromUACTable: ****Deleting from UAC table.
*Nov 26 18:43:10.185: //25117/000000000000/SIP/Info/sipSPIUdeleteCcbFromTable: Deleting from table. ccb=0x23D03C8 key=E715629F-74D211E4-A46A80FA-62F158C4@GOPRO_CUBE.test.lcl
*Nov 26 18:43:10.185: //25117/000000000000/SIP/Info/sipSPIFlushEventBufferQueue: There are 0 events on the internal queue that are going to be free'd
*Nov 26 18:43:10.185: //25117/000000000000/SIP/Info/ccsip_qos_cleanup: Entry
*Nov 26 18:43:10.185: //25117/000000000000/SIP/Info/sipSPI_ipip_free_codec_profile: Codec Profiles Freed
*Nov 26 18:43:10.185: //25117/000000000000/SIP/Info/sipSPIUfreeOneCCB: Freeing ccb 23D03C8
*Nov 26 18:43:10.185: //25118/000000000000/SIP/Error/act_sent_OODoptions_wait_response: Out of retries
*Nov 26 18:43:10.185: //25118/000000000000/SIP/Info/sipSPIUdeleteccCallIdFromTable: Removing call id 621E
*Nov 26 18:43:10.185: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIDeleteContextFromTable: Context for key=[24908] removed.
*Nov 26 18:43:10.185: //25118/000000000000/SIP/Info/sipSPIUdeleteCcbFromUACTable: ****Deleting from UAC table.
*Nov 26 18:43:10.185: //25118/000000000000/SIP/Info/sipSPIUdeleteCcbFromTable: Deleting from table. ccb=0x23D56B8 key=E715629F-74D211E4-A46B80FA-62F158C4@GOPRO_CUBE.test.lcl
*Nov 26 18:43:10.185: //25118/000000000000/SIP/Info/sipSPIFlushEventBufferQueue: There are 0 events on the internal queue that are going to be free'd
*Nov 26 18:43:10.185: //25118/000000000000/SIP/Info/ccsip_qos_cleanup: Entry
*Nov 26 18:43:10.185: //25118/000000000000/SIP/Info/sipSPI_ipip_free_codec_profile: Codec Profiles Freed
*Nov 26 18:43:10.185: //25118/000000000000/SIP/Info/sipSPIUfreeOneCCB: Freeing ccb 23D56B8
*Nov 26 18:43:10.197: //25119/000000000000/SIP/Error/act_sent_OODoptions_wait_response: Out of retries
*Nov 26 18:43:10.197: //25119/000000000000/SIP/Info/sipSPIUdeleteccCallIdFromTable: Removing call id 621F
*Nov 26 18:43:10.197: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIDeleteContextFromTable: Context for key=[24909] removed.
*Nov 26 18:43:10.197: //25119/000000000000/SIP/Info/sipSPIUdeleteCcbFromUACTable: ****Deleting from UAC table.
*Nov 26 18:43:10.197: //25119/000000000000/SIP/Info/sipSPIUdeleteCcbFromTable: Deleting from table. ccb=0x23C0AF8 key=E7173716-74D211E4-A46C80FA-62F158C4@GOPRO_CUBE.test.lcl
*Nov 26 18:43:10.197: //25119/000000000000/SIP/Info/sipSPIFlushEventBufferQueue: There are 0 events on the internal queue that are going to be free'd
*Nov 26 18:43:10.197: //25119/000000000000/SIP/Info/ccsip_qos_cleanup: Entry
*Nov 26 18:43:10.197: //25119/000000000000/SIP/Info/sipSPI_ipip_free_codec_profile: Codec Profiles Freed
*Nov 26 18:43:10.197: //25119/000000000000/SIP/Info/sipSPIUfreeOneCCB: Freeing ccb 23C0AF8
*Nov 26 18:43:10.197: //25120/000000000000/SIP/Error/act_sent_OODoptions_wait_response: Out of retries
*Nov 26 18:43:10.197: //25120/000000000000/SIP/Info/sipSPIUdeleteccCallIdFromTable: Removing call id 6220
*Nov 26 18:43:10.197: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIDeleteContextFromTable: Context for key=[24910] removed.
*Nov 26 18:43:10.197: //25120/000000000000/SIP/Info/sipSPIUdeleteCcbFromUACTable: ****Deleting from UAC table.
*Nov 26 18:43:10.197: //25120/000000000000/SIP/Info/sipSPIUdeleteCcbFromTable: Deleting from table. ccb=0x23C5DE8 key=E7173716-74D211E4-A46D80FA-62F158C4@GOPRO_CUBE.test.lcl
*Nov 26 18:43:10.197: //25120/000000000000/SIP/Info/sipSPIFlushEventBufferQueue: There are 0 events on the internal queue that are going to be free'd
*Nov 26 18:43:10.197: //25120/000000000000/SIP/Info/ccsip_qos_cleanup: Entry
*Nov 26 18:43:10.197: //25120/000000000000/SIP/Info/sipSPI_ipip_free_codec_profile: Codec Profiles Freed
*Nov 26 18:43:10.197: //25120/000000000000/SIP/Info/sipSPIUfreeOneCCB: Freeing ccb 23C5DE8
*Nov 26 18:43:10.477: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIAddContextToTable: Added context(0x23C5DE8) with key=[24911] to table
*Nov 26 18:43:10.477: //25122/000000000000/SIP/State/sipSPIChangeState: 0x23C5DE8 : State change from (STATE_NONE, SUBSTATE_NONE)  to (STATE_IDLE, SUBSTATE_NONE)
*Nov 26 18:43:10.477: //25122/000000000000/SIP/Info/ccsip_call_setup_request: Before processing SETUP REQccb->pld.flags_ipip = 200
*Nov 26 18:43:10.477: //25122/000000000000/SIP/Info/ccsip_call_setup_request: This is a TDM-IP call: callID= 25122, peer_callID = 25121
*Nov 26 18:43:10.477: //25122/000000000000/SIP/Info/ccsip_call_setup_request: This is a TDM-IP call: callID= 25122, peer_callID = 25121
*Nov 26 18:43:10.477: //25122/000000000000/SIP/Info/ccsip_call_setup_request: After processing SETUP REQccb->pld.flags_ipip = 200
*Nov 26 18:43:10.477: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetOutboundHostAndDestHostPrivate: CCSIP: target_host : dev-lync-01v.test.lcl target_port : 5060

*Nov 26 18:43:10.477: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_CALL_SETUP
*Nov 26 18:43:10.477: //25122/E78DA014A46E/SIP/Info/ccsip_call_setup_request: Incrementing call counter in dial-peer [7]
*Nov 26 18:43:10.477: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 for event 2
*Nov 26 18:43:10.477: //25122/E78DA014A46E/SIP/Info/sipSPIUaddccCallIdToTable: Adding call id 6222 to table
*Nov 26 18:43:10.477: //25122/E78DA014A46E/SIP/Info/sipSPIGetCallConfig: preferred_codec set[0] type :No Codec    bytes: 0 
*Nov 26 18:43:10.477: //25122/E78DA014A46E/SIP/Info/sipSPIGetCallConfig: Media forking disabled
*Nov 26 18:43:10.477: //25122/E78DA014A46E/SIP/Info/sipSPICanSetFallbackFlag: Local Fallback is not active
*Nov 26 18:43:10.477: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetSipProfilesTag: voice class SIP Profiles tag is set : 1
*Nov 26 18:43:10.477: //25122/E78DA014A46E/SIP/Info/sipSPIGetCallConfig: Using Voice Class Codec, tag = 1
*Nov 26 18:43:10.477: //25122/E78DA014A46E/SIP/Media/sipSPICopyStunConfigFromPeerToCCB: Firewall traversal is not enabled
*Nov 26 18:43:10.477: //25122/E78DA014A46E/SIP/Info/sipSPIGetCallConfig: xcoder high-density disabled
*Nov 26 18:43:10.477: //25122/E78DA014A46E/SIP/Info/sipSPIGetCallConfig: Flow Mode set to FLOW_THROUGH
*Nov 26 18:43:10.477: //25122/E78DA014A46E/SIP/Info/sipSPIGetCallConfig: Media forking disabled
*Nov 26 18:43:10.477: //25122/E78DA014A46E/SIP/Info/preprocessSetup: 
 This is a not a SIGO Call -, could be DM call 
*Nov 26 18:43:10.477: //25122/E78DA014A46E/SIP/Info/sipSPIValidateAndCopyOutboundHost: CCSIP: copy target_host to outbound_host
*Nov 26 18:43:10.477: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIDeleteContextFromTable: Context for key=[24911] removed.
*Nov 26 18:43:10.477: //25122/E78DA014A46E/SIP/Info/sipSPIFlushEventBufferQueue: There are 0 events on the internal queue that are going to be free'd
*Nov 26 18:43:10.477: //25122/E78DA014A46E/SIP/Info/ccsip_qos_cleanup: Entry
*Nov 26 18:43:10.477: //25122/E78DA014A46E/SIP/Info/sipSPI_ipip_free_codec_profile: Codec Profiles Freed
*Nov 26 18:43:10.477: //25122/E78DA014A46E/SIP/Info/sipSPIUfreeOneCCB: Freeing ccb 23C5DE8
*Nov 26 18:43:10.477: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetContextFromTable: NO context for key[24911]u all
All possible debugging has been turned off
GOPRO_CUBE#

 

18 Replies 18

I am  not sure why you insist on putting dev-lync-01v subdomain in your session target.

The successful lync client call only has gopro-test.com..

8409@gopro-test.com

Please use gopro-test.con only and test again

The dev-lync-01v is a registrar pool, not a sip domain. The sip domain is gopro-test.com

Please rate all useful posts

Hello Ayodeji,

as always, thank you for your reply.. very much appreciated.. I see exactly what you're referring to now but i can't seem to remove the subdomain? i've made a few changes and it still adding it to the inbound call?

 

Would you mind taking a peek at my config and seeing what i need to modify?

thanks again for you help... can't do this without you.. (i'm using dial-peer 1 and 7 for the call legs..)

 

 


ip cef
!
!
!
!
ip domain name gopro-test.com
ip name-server 172.16.12.10
ip name-server 172.16.12.11
!
multilink bundle-name authenticated
!
!
!
!
!
voice-card 0
!
!
!
voice service voip
 allow-connections sip to sip
 no supplementary-service sip refer
 supplementary-service media-renegotiate
 fax protocol t38 ls-redundancy 0 hs-redundancy 0 fallback none
 sip
  min-se 600 
  asserted-id pai
  midcall-signaling passthru
  privacy-policy passthru
  privacy-policy send-always
  sip-profiles 1
!
voice class codec 1
 codec preference 1 g711ulaw
 codec preference 2 g711alaw
!
voice class sip-profiles 1
 request INVITE sip-header Expires remove 
 request INVITE sip-header Session-Expires add "Session-expires: 600" 
!
!
!
voice translation-rule 1
 rule 1 /\(..........\)/ /+1\1/
!
voice translation-rule 2
 rule 1 /\+1\(..........\)/ /\1/
!
voice translation-rule 3
 rule 1 /\(..........\)/ /+\1/
!         
!
voice translation-profile toAnalog
 translate called 3
!
voice translation-profile toLync
 translate called 1
!
voice translation-profile toPRI
 translate called 2
!
!
!
application
 service dsapp
  param dialpeer 7
  param callHold TRUE
 !
!
license udi pid C3900-SPE100/K9 sn FOC16216VXU
license boot module c3900 technology-package securityk9
license boot module c3900 technology-package uck9
license boot module c3900 technology-package datak9
hw-module pvdm 0/0
!
!
!
username gonetadmin password 0 LetMe1nBr0
!
redundancy
!
!
ip ssh time-out 60

!
!
!
!
!
!
interface GigabitEthernet0/0
 no ip address
 shutdown
 duplex auto
 speed auto
 !
!
interface GigabitEthernet0/1
 no ip address
 shutdown
 duplex auto
 speed auto
 !
!
interface GigabitEthernet0/2
 ip address 172.16.12.6 255.255.255.0
 duplex auto
 speed auto
 !
!
!
ip default-gateway 172.16.12.1
ip forward-protocol nd
!
no ip http server
no ip http secure-server
!
ip route 0.0.0.0 0.0.0.0 172.16.12.1
!
!
!
!
!
nls resp-timeout 1
cpd cr-id 1
!
!
control-plane
 !
!
!
voice-port 0/0/0
!
voice-port 0/0/1
 connection plar 8409
!
voice-port 0/0/2
!
voice-port 0/0/3
!
!
!
!
dial-peer voice 2 pots
 destination-pattern 5206803
 direct-inward-dial
 port 0/0/0
!
dial-peer voice 3 pots
 destination-pattern 6505206803
 direct-inward-dial
 port 0/0/2
!
dial-peer voice 1 voip
 description outgoing to Lync
 translation-profile outgoing toLync
 huntstop
 rtp payload-type comfort-noise 13
 session protocol sipv2
 session target dns:dev-lync-01v.test.lcl
 session transport tcp
 incoming called-number .
 voice-class codec 1
 voice-class sip localhost dns:GOPRO_CUBE.gopro-test.com 
 no voice-class sip early-offer forced
 no voice-class sip block 183
 voice-class sip options-keepalive
 dtmf-relay rtp-nte
!
dial-peer voice 4 voip
 description outgoint toAnalog
 huntstop
 destination-pattern 9728522617
 rtp payload-type comfort-noise 13
 session protocol sipv2
 session target dns:dev-lync-01v.test.lcl
 session transport tcp
 incoming called-number .
 voice-class codec 1
 voice-class sip localhost dns:GOPRO_CUBE.test.lcl 
 no voice-class sip early-offer forced
 no voice-class sip block 183
 voice-class sip options-keepalive
 dtmf-relay rtp-nte sip-notify sip-kpml
!
dial-peer voice 6 voip
 description outgoint toAnalog
 huntstop
 destination-pattern ..........
 rtp payload-type comfort-noise 13
 session protocol sipv2
 session target dns:dev-lync-01v.test.lcl
 session transport tcp
 incoming called-number .
 voice-class codec 1
 voice-class sip localhost dns:GOPRO_CUBE.test.lcl 
 no voice-class sip early-offer forced
 no voice-class sip block 183
 voice-class sip options-keepalive
 dtmf-relay rtp-nte sip-notify sip-kpml
!
dial-peer voice 7 voip
 translation-profile outgoing toLync
 huntstop
 destination-pattern ....
 rtp payload-type comfort-noise 13
 session protocol sipv2
 session transport tcp
 voice-class codec 1
 no voice-class sip localhost
 no voice-class sip early-offer forced
 voice-class sip block 183 sdp absent
 voice-class sip options-keepalive
 dtmf-relay rtp-nte
!
dial-peer voice 8 voip
 description toPSTN
 translation-profile outgoing fromAnalog
 shutdown
 destination-pattern 1..........
 rtp payload-type comfort-noise 13
 session protocol sipv2
 session target dns:dev-lync-01v.test.lcl
 session transport tcp
 incoming called-number .
 voice-class codec 1
 voice-class sip localhost dns:GOPRO_CUBE.test.lcl 
 no voice-class sip early-offer forced
 no voice-class sip block 183
 voice-class sip options-keepalive
 dtmf-relay rtp-nte sip-notify sip-kpml
!
dial-peer voice 5 pots
 destination-pattern T
 incoming called-number .
 forward-digits all
!
dial-peer voice 10 pots
 description outbound_to_FXO
 destination-pattern .T
 port 0/0/1
 forward-digits all
!
dial-peer voice 11 pots
 shutdown
 destination-pattern 1..........
 direct-inward-dial
 port 0/0/3
 forward-digits 0
!
dial-peer voice 8409 pots
 destination-pattern .T
 port 0/0/1
!
!
sip-ua 
 set pstn-cause 31 sip-status 480
 timers expires 1800000
!
!
!
gatekeeper
 shutdown
!
!
line con 0
 exec-timeout 5 30
 password LetMe1nBr0
line aux 0
line vty 0 4
 exec-timeout 5 30
 password LetMe1nBr0
 transport input telnet ssh
!
scheduler allocate 20000 1000
end

 

So is your outbound call to lync working now? The inbound call is generated by LYNC, so the mediation server determines what URI to use for the call..

Please rate all useful posts

outbound from Lync to PSTN (through the CUBE is working now)

inbound from PSTN to lync is still not working and latest debug now shows i'm sending the digits correctly:

 

i'm sending calls to 8409@gopro-test.com

 

 

*Dec  2 02:13:34.838: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIAddContextToTable: Added context(0x22E1310) with key=[2135] to table
*Dec  2 02:13:34.838: //2148/000000000000/SIP/State/sipSPIChangeState: 0x22E1310 : State change from (STATE_NONE, SUBSTATE_NONE)  to (STATE_IDLE, SUBSTATE_NONE)
*Dec  2 02:13:34.838: //2148/000000000000/SIP/Info/ccsip_call_setup_request: Before processing SETUP REQccb->pld.flags_ipip = 200
*Dec  2 02:13:34.838: //2148/000000000000/SIP/Info/ccsip_call_setup_request: This is a TDM-IP call: callID= 2148, peer_callID = 2147
*Dec  2 02:13:34.838: //2148/000000000000/SIP/Info/ccsip_call_setup_request: This is a TDM-IP call: callID= 2148, peer_callID = 2147
*Dec  2 02:13:34.838: //2148/000000000000/SIP/Info/ccsip_call_setup_request: After processing SETUP REQccb->pld.flags_ipip = 200
*Dec  2 02:13:34.838: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetOutboundHostAndDestHostPrivate: CCSIP: target_host : gopro-test.com target_port : 5060

*Dec  2 02:13:34.838: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_CALL_SETUP
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/Info/ccsip_call_setup_request: Incrementing call counter in dial-peer [7]
*Dec  2 02:13:34.838: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 for event 2
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/Info/sipSPIUaddccCallIdToTable: Adding call id 864 to table
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/Info/sipSPIGetCallConfig: preferred_codec set[0] type :No Codec    bytes: 0 
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/Info/sipSPIGetCallConfig: Media forking disabled
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/Info/sipSPICanSetFallbackFlag: Local Fallback is not active
*Dec  2 02:13:34.838: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetSipProfilesTag: voice class SIP Profiles tag is set : 1
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/Info/sipSPIGetCallConfig: Using Voice Class Codec, tag = 1
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/Media/sipSPICopyStunConfigFromPeerToCCB: Firewall traversal is not enabled
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/Info/sipSPIGetCallConfig: xcoder high-density disabled
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/Info/sipSPIGetCallConfig: Flow Mode set to FLOW_THROUGH
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/Info/sipSPIGetCallConfig: Media forking disabled
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/Info/preprocessSetup: 
 This is a not a SIGO Call -, could be DM call 
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/Info/sipSPIValidateAndCopyOutboundHost: CCSIP: copy target_host to outbound_host
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/Info/sip_gw_pre_setup_add_sdp_container: DNS/ENUM resolution required; Deferred Creating SDP
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/Info/sipSPIValidateGtd: Signal Forward disabled
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/Info/sipSPIValidateTunnelData: RawMsg/QSIG Tunneling Not Enabled
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/Info/sipSPIAddMLPPServicesInfo: No MLP Info available on incoming leg
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/Info/sipSPIPreprocessUriFormat: Url cfg for 1: 2,phone-ctxt=FALSE
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/Info/sipSPIShrlGetInstanceInfo: Obtained the call instance 0 for non-shared-line '....' with callid: 2148
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/Info/sipSPIAddCiscoGcid: Gcid value not set - not adding header.
*Dec  2 02:13:34.838: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIAddPrivacyandIdentityInfo: ccb->local_host_name,ccb->src_addr_str is NULL
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/Error/sipSPI_ipip_set_history_info_header: Not SIP2SIP mode 
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/Info/act_idle_continue_call_setup: 
*Dec  2 02:13:34.838: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_DNS_RESOLVE
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/State/sipSPIChangeState: 0x22E1310 : State change from (STATE_IDLE, SUBSTATE_NONE)  to (STATE_IDLE, SUBSTATE_SENT_DNS)
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/State/sipSPIChangeState: 0x22E1310 : State change from (STATE_IDLE, SUBSTATE_SENT_DNS)  to (STATE_IDLE, SUBSTATE_SENT_DNS)
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/Info/sipSPIUaddCcbToUACTable: ****Adding to UAC table.
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/Info/sipSPIUaddCcbToTable: Added to table. ccb=0x22E1310 key=A7655A26-78FF11E4-8894FCF1-D04EB2@172.16.12.6
*Dec  2 02:13:34.838: //2148/A764BDFE888F/SIP/Info/sipSPIUsetBillingProfile: sipCallId for billing records = A7655A26-78FF11E4-8894FCF1-D04EB2@172.16.12.6
*Dec  2 02:13:34.838: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_srv_query: TYPE SRV query for _sip._tcp.gopro-test.com and type:1
*Dec  2 02:13:34.842: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_a_aaaa_query: DNS query for gopro-test.com and type:1
*Dec  2 02:13:34.842: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_a_query: TYPE A query successful for gopro-test.com
*Dec  2 02:13:34.842: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_a_aaaa_query: IP Address of gopro-test.com is:

*Dec  2 02:13:34.842: //-1/xxxxxxxxxxxx/SIP/Info/sip_dns_type_a_aaaa_query: 172.16.12.28

*Dec  2 02:13:34.842: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for event 43
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/State/sipSPIChangeState: 0x22E1310 : State change from (STATE_IDLE, SUBSTATE_SENT_DNS)  to (STATE_IDLE, SUBSTATE_NONE)
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Info/sipSPIRscmsmAvail: Value returned by check is = 0
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Error/sipSPI_ipip_set_history_info_header: Not SIP2SIP mode 
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Info/sipSPIAddPrivacyandIdentityInfo: Using globally configured pai header
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Info/sipSPIAddPrivacyandIdentityInfo: Setting Privacy: none
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Media/sipSPISetMediaSrcAddr: Media src addr for stream 1 = 172.16.12.6
*Dec  2 02:13:34.842: //-1/xxxxxxxxxxxx/SIP/Media/sipSPIReserveRtpPort: reserved port 27024 for stream 1
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Media/sipSPIAddSDPMediaPayload: Preferred method of dtmf relay is: 6, with payload: 101
*Dec  2 02:13:34.842: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetMediaDirectionForStream: Setting Media direction SENDRECV for stream 1
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Info/sip_generate_sdp_xcaps_list: Modem Relay and T38 disabled. X-cap not needed
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Info/sipSPIOutgoingCallSDP: Creating recv-only stream for outbound call
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Media/sipSPIProcessRtpSessions: sipSPIProcessRtpSessions
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Media/sipSPIProcessRtpSessions: No active streams.
*Dec  2 02:13:34.842: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Dialog Transaction Address 172.16.12.28,Port 5060, Transport 2, SentBy Port 5060
*Dec  2 02:13:34.842: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT
*Dec  2 02:13:34.842: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIgetRegistrarHost: registrar is not configured
SIP: (2148) Group (a= group line) attribute, level 65535 instance 1 not found.
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Info/sipSPIGetCallExtensionSupported: anat enabled, src_sdp dont have anat
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Info/sipSPISendInvite: Associated container=0x2345BCC to Invite
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Transport/sipSPISendInvite: Sending Invite to the transport layer
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Transport/sipSPIGetSwitchTransportFlag: Return the Dial peer configuration, Switch Transport is FALSE
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Transport/sipSPITransportSendMessage: msg=0x14286B88, addr=172.16.12.28, port=5060, sentBy_port=0, is_req=1, transport=2, switch=0, callBack=0x7A00A3C
*Dec  2 02:13:34.842: //-1/xxxxxxxxxxxx/SIP/Info/sip_profiles_application_modify_remove_header: Expires is removed from the SIP message
*Dec  2 02:13:34.842: //-1/xxxxxxxxxxxx/SIP/Info/sip_profiles_application_change_sip_headers:  New header added to the SIP message : Session-expires: 600
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Transport/sipTransportLogicSendMsg: Set to send the msg=0x14286B88
*Dec  2 02:13:34.842: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x14286B88, addr=172.16.12.28, port=5060, connId=2 for TCP
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Info/sentInviteRequest: Sent Invite in state STATE_IDLE
*Dec  2 02:13:34.842: //-1/xxxxxxxxxxxx/SIP/Info/sentInviteRequest: Transaction active. Facilities will be queued.
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/State/sipSPIChangeState: 0x22E1310 : State change from (STATE_IDLE, SUBSTATE_NONE)  to (STATE_SENT_INVITE, SUBSTATE_NONE)
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Media/sipSPIProcessRtpSessions: sipSPIProcessRtpSessions
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Media/sipSPIAddStream: Adding stream 1 of type voice+dtmf (callid 2148) to the VOIP RTP library
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Info/resolve_media_ip_address_to_bind: Media already bound, use existing source_media_ip_addr
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Media/sipSPISetMediaSrcAddr: Media src addr for stream 1 = 172.16.12.6
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Media/sipSPIUpdateRtcpSession: sipSPIUpdateRtcpSession for m-line 1
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Media/sipSPIUpdateRtcpSession: rtcp_session info
        laddr = 172.16.12.6, lport = 27024, raddr = 0.0.0.0, rport=0, do_rtcp=FALSE
        src_callid = 2148, dest_callid = -1, stream type = voice+dtmf, stream direction = RECVONLY
        media_ip_addr =  - , vrf tableid = 0 media_addr_type = 1
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Media/sipSPIUpdateRtcpSession: No rtp session, creating a new one
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Info/sipSPICreateRtpSession: sess: 11A94E9C do_rtcp:0
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Media/sipSPICreateRtpSession: stun is disabled
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/State/sipSPIChangeStreamState: Stream (callid =  2148)  State changed from (STREAM_ADDING) to (STREAM_ACTIVE) 
*Dec  2 02:13:34.842: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent: 
INVITE sip:8409@gopro-test.com:5060 SIP/2.0
Via: SIP/2.0/TCP 172.16.12.6:5060;branch=z9hG4bK74F590
From: <sip:172.16.12.6>;tag=F65F18-21B9
To: <sip:8409@gopro-test.com>
Date: Tue, 02 Dec 2014 02:13:34 GMT
Call-ID: A7655A26-78FF11E4-8894FCF1-D04EB2@172.16.12.6
Supported: timer,resource-priority,replaces,sdp-anat
Min-SE:  600
Cisco-Guid: 2808397310-2029982180-2291137777-0013651634
User-Agent: Cisco-SIPGateway/IOS-12.x
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
CSeq: 101 INVITE
Max-Forwards: 70
Timestamp: 1417486414
Contact: <sip:172.16.12.6:5060;transport=tcp>
Allow-Events: telephone-event
P-Asserted-Identity: <sip:@172.16.12.6>
Privacy: none
Content-Type: application/sdp
Content-Disposition: session;handling=required
Content-Length: 280
Session-expires: 600

v=0
o=CiscoSystemsSIP-GW-UserAgent 1195 9791 IN IP4 172.16.12.6
s=SIP Call
c=IN IP4 172.16.12.6
t=0 0
m=audio 27024 RTP/AVP 0 8 101 13
c=IN IP4 172.16.12.6
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=rtpmap:13 CN/8000

*Dec  2 02:13:34.842: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for event 1
*Dec  2 02:13:34.842: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x1DC0D20
*Dec  2 02:13:34.842: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerProcessNewConnMsg: gConnTab=0x1DC0D20, addr=172.16.12.28, port=5060, connid=2, transport=TCP
*Dec  2 02:13:34.842: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_new_msg_preprocessor: Checking Invite Dialog
*Dec  2 02:13:34.842: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received: 
SIP/2.0 100 Trying
FROM: <sip:172.16.12.6>;tag=F65F18-21B9
TO: <sip:8409@gopro-test.com>
CSEQ: 101 INVITE
CALL-ID: A7655A26-78FF11E4-8894FCF1-D04EB2@172.16.12.6
VIA: SIP/2.0/TCP 172.16.12.6:5060;branch=z9hG4bK74F590
CONTENT-LENGTH: 0
TIMESTAMP: 1417486414


*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/Info/sipSPICheckResponseExt: INVITE response with no RSEQ - disable IS_REL1XX
*Dec  2 02:13:34.842: //2148/A764BDFE888F/SIP/State/sipSPIChangeState: 0x22E1310 : State change from (STATE_SENT_INVITE, SUBSTATE_NONE)  to (STATE_RECD_PROCEEDING, SUBSTATE_PROCEEDING_PROCEEDING)
*Dec  2 02:13:35.042: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for event 1
*Dec  2 02:13:35.042: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x1DC0D20
*Dec  2 02:13:35.042: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerProcessNewConnMsg: gConnTab=0x1DC0D20, addr=172.16.12.28, port=5060, connid=2, transport=TCP
*Dec  2 02:13:35.042: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_new_msg_preprocessor: Checking Invite Dialog
*Dec  2 02:13:35.042: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received: 
SIP/2.0 400 Bad Request
FROM: <sip:172.16.12.6>;tag=F65F18-21B9
TO: <sip:8409@gopro-test.com>;tag=3d8a9916ee
CSEQ: 101 INVITE
CALL-ID: A7655A26-78FF11E4-8894FCF1-D04EB2@172.16.12.6
VIA: SIP/2.0/TCP 172.16.12.6:5060;branch=z9hG4bK74F590
CONTENT-LENGTH: 0
SERVER: RTCC/5.0.0.0 MediationServer


*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/Info/sipSPICheckResponseExt: INVITE response with no RSEQ - disable IS_REL1XX
*Dec  2 02:13:35.042: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetContentGTD: No GTD found in inbound container
*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/Info/sipSPISendAck: Associated container=0x2345754 to Ack
*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/Transport/sipSPISendAck: Sending ACK to the transport layer
*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/Transport/sipSPIGetSwitchTransportFlag: Return the Dial peer configuration, Switch Transport is FALSE
*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/Transport/sipSPITransportSendMessage: msg=0x11A94FB0, addr=172.16.12.28, port=5060, sentBy_port=0, is_req=1, transport=2, switch=0, callBack=0x0
*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/Transport/sipTransportLogicSendMsg: Set to send the msg=0x11A94FB0
*Dec  2 02:13:35.042: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x11A94FB0, addr=172.16.12.28, port=5060, connId=2 for TCP
*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/Info/act_recdproc_new_message_response: Received a 4/5/6xx message with StatusCode: 400
*Dec  2 02:13:35.042: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_set_release_source_for_peer: ownCallId[2148], src[4]
*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/Info/sipSPIInitiateDisconnect: Initiate call disconnect(127) for outgoing call
*Dec  2 02:13:35.042: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetContentQSIG: No QSIG Body found in inbound container
*Dec  2 02:13:35.042: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetContentQ931: No RawMsg Body found in inbound container
*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/State/sipSPIChangeState: 0x22E1310 : State change from (STATE_RECD_PROCEEDING, SUBSTATE_PROCEEDING_PROCEEDING)  to (STATE_DISCONNECTING, SUBSTATE_NONE)
*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/Info/ccsip_call_statistics: Requesting stats for callid=2148
*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/Info/ccsip_call_statistics: Stats request failed for callid=2148, dstCallID=-1, rc=-7
*Dec  2 02:13:35.042: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_CALL_DISCONNECT
*Dec  2 02:13:35.042: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 for event 7
*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/Info/sipSPIIcpifUpdate: CallState: 2 Playout: 0 DiscTime:1614640 ConnTime 0
*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/Media/sipSPIDestroyRtpSession: stream:11A95EE4
*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/State/sipSPIChangeState: 0x22E1310 : State change from (STATE_DISCONNECTING, SUBSTATE_NONE)  to (STATE_DEAD, SUBSTATE_NONE)
*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/Call/sipSPICallInfo: 
The Call Setup Information is:
Call Control Block (CCB) : 0x22E1310
State of The Call        : STATE_DEAD
TCP Sockets Used         : YES
Calling Number           : 
Called Number            : 8409
Source IP Address (Sig  ): 172.16.12.6
Destn SIP Req Addr:Port  : 172.16.12.28:5060
Destn SIP Resp Addr:Port : 172.16.12.28:5060
Destination Name         : gopro-test.com

*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/Call/sipSPIMediaCallInfo: 
Number of Media Streams: 1
Media Stream             : 1
Negotiated Codec         : No Codec   
Negotiated Codec Bytes   : 0
Nego. Codec payload      : 255 (tx), 255 (rx)
Negotiated Dtmf-relay    : 0
Dtmf-relay Payload       : 0 (tx), 0 (rx)
Source IP Address (Media): 172.16.12.6
Source IP Port    (Media): 27024
Destn  IP Address (Media):  - 
Destn  IP Port    (Media): 0
Orig Destn IP Address:Port (Media): [ - ]:0

*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/Call/sipSPICallInfo: 
Disconnect Cause (CC)    : 127
Disconnect Cause (SIP)   : 400

*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/Info/sipSPIUdeleteccCallIdFromTable: Removing call id 864
*Dec  2 02:13:35.042: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIDeleteContextFromTable: Context for key=[2135] removed.
*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/Info/sipSPIUdeleteCcbFromUACTable: ****Deleting from UAC table.
*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/Info/sipSPIUdeleteCcbFromTable: Deleting from table. ccb=0x22E1310 key=A7655A26-78FF11E4-8894FCF1-D04EB2@172.16.12.6
*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/Info/sipSPIFlushEventBufferQueue: There are 0 events on the internal queue that are going to be free'd
*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/Info/ccsip_qos_cleanup: Entry
*Dec  2 02:13:35.042: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISipSdpFree: 
*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/Info/sipSPI_ipip_free_codec_profile: Codec Profiles Freed
*Dec  2 02:13:35.042: //2148/A764BDFE888F/SIP/Info/sipSPIUfreeOneCCB: Freeing ccb 22E1310
*Dec  2 02:13:35.042: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetContextFromTable: NO context for key[2135]
*Dec  2 02:13:35.042: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent: 
ACK sip:8409@gopro-test.com:5060 SIP/2.0
Via: SIP/2.0/TCP 172.16.12.6:5060;branch=z9hG4bK74F590
From: <sip:172.16.12.6>;tag=F65F18-21B9
To: <sip:8409@gopro-test.com>;tag=3d8a9916ee
Date: Tue, 02 Dec 2014 02:13:34 GMT
Call-ID: A7655A26-78FF11E4-8894FCF1-D04EB2@172.16.12.6
Max-Forwards: 70
CSeq: 101 ACK
Allow-Events: telephone-event
Privacy: none
Content-Length: 0

 

thanks,