<div> </div>
<div>I finally got it to register but when I get calls now I only get a busy signal. Calls are supposed to come in a single number from voicepulse through a sip trunk then be turned into h323 to the cucm 7 which sends the to the hunt pilot of ext 190 for my AA. The config and debug are below. I have changed my username and password because it shows in the debug but can anyone see where things are going wrong here?</div>
<div> </div>
<div> </div>
<div>hostname Cisco2821<br>!<br>boot-start-marker<br>boot-end-marker<br>!<br>logging buffered 128000<br>enable secret 5 *************<br>!<br>aaa new-model<br>!<br>!<br>aaa authentication login default local<br>aaa authorization exec default local<br>
aaa authorization network default local<br>!<br>!<br>!<br>!<br>!<br>aaa session-id common<br>!<br>!<br>!<br>errdisable recovery cause bpduguard<br>errdisable recovery interval 400<br>!<br>dot11 syslog<br>ip source-route<br>
!<br>!<br>ip cef<br>!<br>!<br>ip domain name datasc.local<br>ip name-server 10.1.80.2<br>ip name-server 10.1.80.3<br>ip inspect udp idle-time 1800<br>ip inspect name CBAC tcp<br>ip inspect name CBAC udp<br>ip inspect name CBAC icmp<br>
no ipv6 cef<br>!<br>multilink bundle-name authenticated<br>!<br>!<br>!<br>!<br>!<br>!<br>!<br>voice service voip<br> callmonitor<br> allow-connections h323 to sip<br> allow-connections sip to h323<br> allow-connections sip to sip<br>
no supplementary-service sip moved-temporarily<br> no supplementary-service sip refer<br> fax protocol pass-through g711ulaw<br> sip<br>!<br>voice class codec 1<br> codec preference 2 g711ulaw<br>!<br>voice class h323 50<br>
h225 timeout tcp establish 3<br>!<br>!<br>!<br>voice translation-rule 1<br> rule 1 /.*/ /190/<br> rule 2 /16784663444/ /190/<br>!<br>!<br>voice translation-profile aa<br> translate called 1<br>!<br>!<br>voice-card 0<br>
!<br>!<br>crypto pki trustpoint TP-self-signed-750565274<br> enrollment selfsigned<br> subject-name cn=IOS-Self-Signed-Certificate-750565274<br> revocation-check none<br> rsakeypair TP-self-signed-750565274<br>!<br>!<br>crypto pki certificate chain TP-self-signed-750565274<br>
certificate self-signed 01<br> 3082024C 308201B5 A0030201 02020101 300D0609 2A864886 F70D0101 04050030<br> 30312E30 2C060355 04031325 494F532D 53656C66 2D536967 6E65642D 43657274<br> 69666963 6174652D 37353035 36353237 34301E17 0D303931 30313631 37333735<br>
385A170D 32303031 30313030 30303030 5A303031 2E302C06 03550403 1325494F<br> 532D5365 6C662D53 69676E65 642D4365 72746966 69636174 652D3735 30353635<br> 32373430 819F300D 06092A86 4886F70D 01010105 0003818D 00308189 02818100<br>
8ED59F59 87CC62ED 30693BBF F4D82987 291C7B8F CE770719 A94BA3AC 6FFB9C07<br> C65400F7 FBF4CD5C 53FA0B98 25286C7D FB3B36FB 5CEEE448 3A387586 97DF7034<br> E1ECA9CA FDA92A17 7737836D B9D7D534 51CDF4DA D8A9D307 4464E393 81E8C26F<br>
ABA40F6A 9B8E4008 1C0B910A 45B20D94 54F7924D 2C119E48 F46BCBC2 BD37D951<br> 02030100 01A37630 74300F06 03551D13 0101FF04 05300301 01FF3021 0603551D<br> 11041A30 18821643 6973636F 32383231 2E646174 6173632E 6C6F6361 6C301F06<br>
03551D23 04183016 80147DBD 01693A3A FDD7256C 296214F1 00382418 6935301D<br> 0603551D 0E041604 147DBD01 693A3AFD D7256C29 6214F100 38241869 35300D06<br> 092A8648 86F70D01 01040500 03818100 881FD307 FFFBEDE4 08AA8821 65E947E7<br>
ED92EFE9 65A2A81F 67B96CDA 09AD26FC 8621DE18 A35BBFB9 F75C05B6 CB645C95<br> E34217AE 41EF3014 9F66A5D6 B0ED10D3 D8BCD658 61F0B6D0 1B694E93 A68CE15A<br> 70666974 B07FAE47 B197000B CB81EBA8 1D4F76E3 0B73396A 6CFBADDB 4235179A<br>
86452D8A D36269A4 1D6E0DC5 94218FCF<br> quit<br>!<br>!<br>license udi pid CISCO2821 sn *************<br>username ******** privilege 15 secret 5 ****************<br>redundancy<br>!<br>!<br>ip ssh time-out 60<br>ip ssh version 2<br>
!<br>!<br>!<br>!<br>!<br>!<br>!<br>!<br>interface GigabitEthernet0/0<br> bandwidth 30000<br> ip address 173.14.220.57 255.255.255.248<br> no ip redirects<br> no ip unreachables<br> no ip proxy-arp<br> ip nbar protocol-discovery<br>
ip flow ingress<br> ip flow egress<br> ip nat outside<br> ip virtual-reassembly<br> duplex auto<br> speed auto<br> !<br>!<br>interface GigabitEthernet0/1<br> ip address 10.1.200.1 255.255.255.252<br> ip nat inside<br> ip virtual-reassembly<br>
duplex auto<br> speed auto<br> h323-gateway voip bind srcaddr 10.1.200.1<br> !<br>!<br>interface FastEthernet0/0/0<br> switchport access vlan 150<br> spanning-tree portfast<br> !<br>!<br>interface FastEthernet0/0/1<br> switchport access vlan 150<br>
spanning-tree portfast<br> !<br>!<br>interface FastEthernet0/0/2<br> switchport access vlan 150<br> spanning-tree portfast<br> !<br>!<br>interface FastEthernet0/0/3<br> switchport access vlan 150<br> spanning-tree portfast<br>
!<br>!<br>interface Vlan1<br> no ip address<br> !<br>!<br>interface Vlan150<br> ip address 10.1.150.1 255.255.255.0<br> ip nat inside<br> ip virtual-reassembly<br> !<br>!<br>!<br>router eigrp 1<br> network 10.0.0.0<br>!<br>
ip forward-protocol nd<br>no ip http server<br>ip http authentication local<br>ip http secure-server<br>!<br>!<br>ip nat inside source list NATNETWORKS interface GigabitEthernet0/0 overload<br>ip route 0.0.0.0 0.0.0.0 173.14.220.62<br>
!<br>ip access-list extended NATNETWORKS<br> permit ip 10.1.0.0 0.0.255.255 any<br>ip access-list extended internet<br> permit udp any any eq isakmp<br> permit tcp any any eq 22<br> permit udp any eq bootps any eq bootpc<br>
permit gre any any<br> permit esp any any<br> permit tcp any any eq 5001<br> permit tcp any any eq www<br> permit tcp any any eq 8080<br> permit icmp any any<br> permit udp any any eq domain<br> permit udp any any eq 5060<br>
!<br>nls resp-timeout 1<br>cpd cr-id 1<br>!<br>!<br>!<br>!<br>!<br>!<br>control-plane<br> !<br>!<br>!<br>voice-port 0/1/0<br>!<br>voice-port 0/1/1<br>!<br>!<br>mgcp fax t38 ecm<br>mgcp behavior g729-variants static-pt<br>
!<br>!<br>dial-peer voice 501 voip<br> description Services<br> preference 1<br> destination-pattern [2-8]11<br> progress_ind setup enable 3<br> progress_ind progress enable 8<br> session protocol sipv2<br> session target dns:<a href="http://jfk-primary.voicepulse.com">jfk-primary.voicepulse.com</a><br>
voice-class codec 1<br> dtmf-relay rtp-nte<br> no vad<br>!<br>dial-peer voice 511 voip<br> description local seven digit<br> preference 1<br> destination-pattern [2-9]......<br> progress_ind setup enable 3<br> progress_ind progress enable 8<br>
session protocol sipv2<br> session target dns:<a href="http://jfk-primary.voicepulse.com">jfk-primary.voicepulse.com</a><br> voice-class codec 1<br> dtmf-relay rtp-nte<br> no vad<br>!<br>dial-peer voice 521 voip<br> description local ten digit<br>
preference 1<br> destination-pattern 678.......<br> progress_ind setup enable 3<br> progress_ind progress enable 8<br> session protocol sipv2<br> session target dns:<a href="http://jfk-primary.voicepulse.com">jfk-primary.voicepulse.com</a><br>
voice-class codec 1<br> dtmf-relay rtp-nte<br> no vad<br>!<br>dial-peer voice 531 voip<br> description long distance<br> preference 1<br> destination-pattern [2-9]........<br> progress_ind setup enable 3<br> progress_ind progress enable 8<br>
session protocol sipv2<br> session target dns:<a href="http://jfk-primary.voicepulse.com">jfk-primary.voicepulse.com</a><br> voice-class codec 1<br> dtmf-relay rtp-nte<br> no vad<br>!<br>dial-peer voice 571 voip<br> description long distance with one<br>
preference 1<br> destination-pattern 1[2-9]........<br> progress_ind setup enable 3<br> progress_ind progress enable 8<br> session protocol sipv2<br> session target dns:<a href="http://jfk-primary.voicepulse.com">jfk-primary.voicepulse.com</a><br>
voice-class codec 1<br> dtmf-relay rtp-nte<br> no vad<br>!<br>dial-peer voice 541 voip<br> description toll free distance<br> preference 1<br> destination-pattern [800,866,877,888].......<br> progress_ind setup enable 3<br>
progress_ind progress enable 8<br> session protocol sipv2<br> session target dns:<a href="http://jfk-primary.voicepulse.com">jfk-primary.voicepulse.com</a><br> voice-class codec 1<br> dtmf-relay rtp-nte<br> no vad<br>!<br>
dial-peer voice 551 voip<br> description premium distance<br> preference 1<br> destination-pattern [900,976].......<br> progress_ind setup enable 3<br> progress_ind progress enable 8<br> session protocol sipv2<br> session target dns:<a href="http://jfk-primary.voicepulse.com">jfk-primary.voicepulse.com</a><br>
voice-class codec 1<br> dtmf-relay rtp-nte<br> no vad<br>!<br>dial-peer voice 561 voip<br> description international<br> preference 1<br> destination-pattern 011...........<br> progress_ind setup enable 3<br> progress_ind progress enable 8<br>
session protocol sipv2<br> session target dns:<a href="http://jfk-primary.voicepulse.com">jfk-primary.voicepulse.com</a><br> voice-class codec 1<br> dtmf-relay rtp-nte<br> no vad<br>!<br>dial-peer voice 911 voip<br> description 911 Call<br>
preference 1<br> destination-pattern 911<br> progress_ind setup enable 3<br> progress_ind progress enable 8<br> session protocol sipv2<br> session target dns:<a href="http://jfk-primary.voicepulse.com">jfk-primary.voicepulse.com</a><br>
voice-class codec 1<br> dtmf-relay rtp-nte<br> no vad<br>!<br>dial-peer voice 100 voip<br> description 1-5xx extension to PUBLISHER<br> preference 1<br> destination-pattern [1-5]..<br> session target ipv4:10.1.80.6<br> incoming called-number [1-5]..<br>
voice-class h323 50<br> dtmf-relay h245-alphanumeric<br> codec g711ulaw<br> no vad<br>!<br>dial-peer voice 1000 voip<br> description incoming Call<br> translation-profile incoming aa<br> preference 1<br> session protocol sipv2<br>
session target sip-server<br> incoming called-number 16784663444<br> dtmf-relay rtp-nte<br> no vad<br>!<br>dial-peer voice 101 voip<br> description 1-5xx extension to subscriber<br> preference 2<br> destination-pattern [1-5]..<br>
session target ipv4:10.1.80.7<br> incoming called-number [1-5]..<br> voice-class h323 50<br> dtmf-relay h245-alphanumeric<br> codec g711ulaw<br> no vad<br>!<br>!<br>sip-ua<br> credentials username ******** password 7 ********** realm <a href="http://jfk-primary.voicepulse.com">jfk-primary.voicepulse.com</a><br>
authentication username ************ password 7 ************* realm <a href="http://jfk-primary.voicepulse.com">jfk-primary.voicepulse.com</a><br> no remote-party-id<br> set pstn-cause 3 sip-status 486<br> set pstn-cause 34 sip-status 486<br>
set pstn-cause 47 sip-status 486<br> registrar dns:<a href="http://jfk-primary.voicepulse.com">jfk-primary.voicepulse.com</a> expires 180<br> sip-server dns:<a href="http://jfk-primary.voicepulse.com">jfk-primary.voicepulse.com</a><br>
connection-reuse<br>!<br>!<br>!<br>gatekeeper<br> shutdown<br>!<br>!<br>line con 0<br>line aux 0<br>line vty 0 4<br> privilege level 15<br> transport input ssh<br>line vty 5 15<br> privilege level 15<br> transport input ssh<br>
!<br>scheduler allocate 20000 1000<br>end</div>
<div>Cisco2821#</div>
<div> </div>
<div> </div>
<div>#<br>*Oct 17 01:09:32.911: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpIPv4SocketReads: Msg enqueued for SPI with IP addr: [64.61.93.190]:5060<br>*Oct 17 01:09:32.911: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for event 1<br>
*Oct 17 01:09:32.911: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x0<br>*Oct 17 01:09:32.915: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:<br>Received:<br>INVITE <a href="mailto:sip%3A16784663444@173.14.220.57">sip:16784663444@173.14.220.57</a> SIP/2.0<br>
Record-Route: <sip:64.61.93.190;lr=on;ftag=as26da9258;vsf=AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA><br>Via: SIP/2.0/UDP 64.61.93.190;branch=z9hG4bK95a8.910c7db2.0<br>Via: SIP/2.0/UDP 64.61.93.174;rport=5060;branch=z9hG4bK95a8.f864086.0<br>
Via: SIP/2.0/UDP 64.61.93.170:5060;received=64.61.93.170;branch=z9hG4bK771ee36c;rport=5060<br>From: "Cell Phone NY" <<a href="mailto:sip%3A5163076981@64.61.93.170">sip:5163076981@64.61.93.170</a>>;tag=as26da9258<br>
To: <<a href="mailto:sip%3A16784663444@nycinpro01.voicepulse.net">sip:16784663444@nycinpro01.voicepulse.net</a>><br>Contact: <<a href="mailto:sip%3A5163076981@64.61.93.170">sip:5163076981@64.61.93.170</a>><br>
Call-ID: <a href="mailto:527c7f413568d0060423fe5f115487b7@64.61.93.170">527c7f413568d0060423fe5f115487b7@64.61.93.170</a><br>CSeq: 102 INVITE<br>User-Agent: Asterisk PBX<br>Max-Forwards: 68<br>Remote-Party-ID: "Cell Phone NY" <<a href="mailto:sip%3A5163076981@64.61.93.170">sip:5163076981@64.61.93.170</a>>;privacy=off;screen=no<br>
Date: Fri, 16 Oct 2009 23:48:14 GMT<br>Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY<br>Supported: replaces<br>X-VP-DNIS: 16784663444<br>Content-Type: application/sdp<br>Content-Length: 410</div>
<div>v=0<br>o=root 29667 29667 IN IP4 64.61.93.170<br>s=session<br>c=IN IP4 64.61.93.170<br>t=0 0<br>m=audio 19376 RTP/AVP 0 8 3 97 111 5 7 101<br>a=rtpmap:0 PCMU/8000<br>a=rtpmap:8 PCMA/8000<br>a=rtpmap:3 GSM/8000<br>a=rtpmap:97 iLBC/8000<br>
a=fmtp:97 mode=30<br>a=rtpmap:111 G726-32/8000<br>a=rtpmap:5 DVI4/8000<br>a=rtpmap:7 LPC/8000<br>a=rtpmap:101 telephone-event/8000<br>a=fmtp:101 0-16<br>a=silenceSupp:off - - - -<br>a=ptime:20<br>a=sendrecv</div>
<div>*Oct 17 01:09:32.915: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_new_msg_preprocessor: Checking Invite Dialog<br>*Oct 17 01:09:32.915: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIAddContextToTable: Added context(0x4BB834D0) with key=[112] to table<br>
*Oct 17 01:09:32.915: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Dialog Transaction Address 64.61.93.190,Port 5060, Transport 1, SentBy Port 5060<br>*Oct 17 01:09:32.915: //-1/9022661681B2/SIP/State/sipSPIChangeState: 0x4BB834D0 : State change from (STATE_NONE, SUBSTATE_NONE) to (STATE_IDLE, SUBSTATE_NONE)<br>
*Oct 17 01:09:32.915: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Dialog Transaction Address 64.61.93.190,Port 5060, Transport 1, SentBy Port 5060<br>*Oct 17 01:09:32.915: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT<br>
*Oct 17 01:09:32.915: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Dialog Transaction Address 64.61.93.190,Port 5060, Transport 1, SentBy Port 5060<br>*Oct 17 01:09:32.915: //-1/xxxxxxxxxxxx/SIP/Info/sipSPICheckIpip: VOIP dialpeer (peer=0x479FF944) found for sip_user: 16784663444<br>
*Oct 17 01:09:32.915: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetContentGTD: No GTD found in inbound container<br>*Oct 17 01:09:32.915: //-1/9022661681B2/SIP/Info/sipSPIUaddCcbToUASReqTable: ****Adding to UAS Request table.<br>*Oct 17 01:09:32.915: //-1/9022661681B2/SIP/Info/sipSPIUaddCcbToTable: Added to table. ccb=0x4BB834D0 <a href="mailto:key=527c7f413568d0060423fe5f115487b7@64.61.93.17016784663444">key=527c7f413568d0060423fe5f115487b7@64.61.93.17016784663444</a><br>
*Oct 17 01:09:32.915: //-1/9022661681B2/SIP/Info/sipSPIMatchSrcIpGroup: Match not found on carrier id<br>*Oct 17 01:09:32.915: //-1/9022661681B2/SIP/Info/sipSPIMatchSrcIpGroup: Match not found on Incoming called number: 16784663444<br>
*Oct 17 01:09:32.915: //-1/9022661681B2/SIP/Info/sipSPIMatchSrcIpGroup: Match not found on destination pattern: 5163076981<br>*Oct 17 01:09:32.915: //-1/9022661681B2/SIP/Info/ccsipUpdateIncomingCallParams: ccCallInfo: Calling name Cell Phone NY, number 5163076981, Calling oct3 0x00, oct_3a 0x80, Called number 16784663444<br>
*Oct 17 01:09:32.919: //-1/9022661681B2/SIP/Info/sipSPIGetShrlPeer: Try match incoming dialpeer for Calling number: : 5163076981<br>*Oct 17 01:09:32.919: //-1/9022661681B2/SIP/Info/sipSPIGetFromCalledPartyId: P-Called-Party-ID header not found<br>
*Oct 17 01:09:32.919: //-1/9022661681B2/SIP/Info/sipSPIGetPeerByCalledPartyId: P-Called-Party-ID not found or parse error<br>*Oct 17 01:09:32.919: //-1/9022661681B2/SIP/Info/sipSPIGetCallConfig: No match found for P-Called-Party-ID<br>
*Oct 17 01:09:32.919: //-1/9022661681B2/SIP/Info/sipSPIGetCallConfig: Peer tag 1000 matched for incoming call<br>*Oct 17 01:09:32.919: //-1/9022661681B2/SIP/Info/sipSPIGetCallConfig: Precondition tag absent in Require/Supported header<br>
*Oct 17 01:09:32.919: //-1/9022661681B2/SIP/Info/sipSPIGetCallConfig: Precondition tag absent in Require/Supported header<br>*Oct 17 01:09:32.919: //-1/9022661681B2/SIP/Info/sipSPIGetCallConfig: Not using Voice Class Codec<br>
*Oct 17 01:09:32.919: //-1/9022661681B2/SIP/Info/sipSPIGetCallConfig: Checking Video Type Rate=-1 video_codec_allowed=1F<br>*Oct 17 01:09:32.919: //-1/9022661681B2/SIP/Media/sipSPICopyStunConfigFromPeerToCCB: Firewall traversal is not enabled<br>
*Oct 17 01:09:32.919: //-1/9022661681B2/SIP/Info/sipSPIGetCallConfig: xcoder high-density disabled<br>*Oct 17 01:09:32.919: //-1/9022661681B2/SIP/Info/sipSPIGetCallConfig: Flow Mode set to FLOW_THROUGH<br>*Oct 17 01:09:32.919: //-1/9022661681B2/SIP/Info/sipSPIGetCallConfig: Media forking disabled<br>
*Oct 17 01:09:32.919: //-1/9022661681B2/SIP/Info/sipSPIContinueNewMsgInvite: Calling name Cell Phone NY, number 5163076981, Calling oct3 0x00, oct_3a 0x80, ext_priv 0x00, Called number 16784663444, oct3 0x00<br>*Oct 17 01:09:32.919: //-1/9022661681B2/SIP/Info/sipSPIContinueNewMsgInvite: Carrier id code , prev_cid NONE, next_cid NONE, prev_tgrp NONE, next_tgrp NONE<br>
*Oct 17 01:09:32.919: //-1/9022661681B2/SIP/Info/sipSPIValidateRequestUri: Not Enabled<br>*Oct 17 01:09:32.919: //-1/9022661681B2/SIP/Info/sipSPIRscmsmAvail: Value returned by check is = 0<br>*Oct 17 01:09:32.919: //131/9022661681B2/SIP/Info/sipSPI_ipip_IsSDPPassthruEnabled: - 0<br>
*Oct 17 01:09:32.919: //131/9022661681B2/SIP/Info/sipSPI_ipip_GetHdrPassthruCfg: Hdr passthrough config:1 tag:0<br>*Oct 17 01:09:32.919: //131/9022661681B2/SIP/Info/sipSPIProcessHistoryInfoHeader: No HI headers recvd from app container<br>
*Oct 17 01:09:32.919: //131/9022661681B2/SIP/Info/sipSPIProcessDiversionHeader: No diversion headers recvd from app container<br>*Oct 17 01:09:32.919: //131/9022661681B2/SIP/Info/sipSPIProcessReplacesHeader: No replaces hdr found<br>
*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/sipSPIDoMediaNegotiation: Number of m-lines = 1<br>SIP: (131) Attribute mid, level 1 instance 1 not found.<br>*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Media/sipSPISetMediaSrcAddr: Media src addr for stream 1 = 173.14.220.57<br>
*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/sipSPICheckFaxUpspeed: Fax upspeed codec (g711ulaw) negotiation successful for m-line 1</div>
<div>*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/sipSPIDoPtimeNegotiation: One ptime attribute found - value:20<br>*Oct 17 01:09:32.923: //-1/xxxxxxxxxxxx/SIP/Info/convert_ptime_to_codec_bytes: Values :Codec: g711ulaw ptime :20, codecbytes: 160<br>
*Oct 17 01:09:32.923: //-1/xxxxxxxxxxxx/SIP/Info/convert_codec_bytes_to_ptime: Values :Codec: g711ulaw codecbytes :160, ptime: 20<br>*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Media/sipSPIDoPtimeNegotiation: Offered ptime:20, Negotiated ptime:20 Negotiated codec bytes: 160 for codec g711ulaw<br>
*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/sipSPISetFaxFlags: Fax passthrough negotiated<br>*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/sipSPIDoDTMFRelayNegotiation: m-line index 1<br>*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/sipSPICheckDynPayloadUse: Dynamic payload(101) could not be reserved.<br>
*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/sipSPIDoDTMFRelayNegotiation: RTP-NTE DTMF relay option<br>*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/sipSPIDoDTMFRelayNegotiation: Case of full named event(NE) match in fmtp list of events.<br>
*Oct 17 01:09:32.923: //-1/xxxxxxxxxxxx/SIP/Info/sip_sdp_get_modem_relay_cap_params: NSE payload from X-cap = 0<br>*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/sip_select_modem_relay_params: X-tmr not present in SDP. Disable modem relay<br>
*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/sipSPIGetSDPDirectionAttribute: No direction attribute present or multiple direction attributes that can't be handled for m-line:1 and num-a-lines:0<br>*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/sipSPIDoAudioNegotiation: Codec negotiation successful for media line 1<br>
payload_type=0, codec_bytes=160, codec=g711ulaw, dtmf_relay=rtp-nte<br> stream_type=voice+dtmf (1), dest_ip_address=64.61.93.170, dest_port=19376<br>*Oct 17 01:09:32.923: //131/9022661681B2/SIP/State/sipSPIChangeStreamState: Stream (callid = -1) State changed from (STREAM_DEAD) to (STREAM_ADDING)<br>
*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Media/sipSPIUpdCallWithSdpInfo:<br> Preferred Codec : g729r8, bytes :20<br> Preferred DTMF relay : rtp-nte<br> Preferred NTE payload : 101<br> Early Media : No<br>
Delayed Media : No<br> Bridge Done : No<br> New Media : No<br> DSP DNLD Reqd : No</div>
<div>*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/resolve_media_ip_address_to_bind: Media already bound, use existing source_media_ip_addr<br>*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Media/sipSPISetMediaSrcAddr: Media src addr for stream 1 = 173.14.220.57<br>
*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/sipSPI_ipip_report_media_to_peer:<br> callId 131 peer 0 flags 0x201 state STATE_IDLE<br>*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:<br>
CallID 131, sdp 0x4DA48754 channels 0x4BB84790<br>*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/copy_channels:<br> callId 131 size 0 ptr 0x4DE36C70)<br>*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:<br>
Hndl ptype 0 mline 1<br>*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Selecting codec g711ulaw<br>*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/codec_found:<br>Codec to be matched: 5<br>
*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: ADD AUDIO CODEC 5</div>
<div>*Oct 17 01:09:32.923: //-1/xxxxxxxxxxxx/SIP/Info/convert_codec_bytes_to_ptime: Values :Codec: g711ulaw codecbytes :160, ptime: 20<br>*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Media negotiation done: stream->negotiated_ptime=20,stream->negotiated_codec_bytes=160, coverted ptime=20 stream->mline_index=1, media_ndx=1<br>
*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Error/sipSPI_ipip_copy_sdp_to_channelInfo:<br>failed to update call entry<br>*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:<br>Adding codec 5 ptype 0 time 20, bytes 160 as channel 0 mline 1 ss 0 <a href="http://64.61.93.170:19376">64.61.93.170:19376</a><br>
*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:<br>Hndl ptype 8 mline 1<br>*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Selecting codec g711alaw<br>
*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/codec_found:<br>Codec to be matched: 6<br>*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: ADD AUDIO CODEC 6</div>
<div>*Oct 17 01:09:32.923: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Media negotiation NOT done, get ptime from sdp: ptime=20, media_ndx=1<br>*Oct 17 01:09:32.923: //-1/xxxxxxxxxxxx/SIP/Info/convert_ptime_to_codec_bytes: Values :Codec: g711alaw ptime :20, codecbytes: 160<br>
*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Error/sipSPI_ipip_copy_sdp_to_channelInfo:<br>failed to update call entry<br>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:<br>Adding codec 6 ptype 8 time 20, bytes 160 as channel 1 mline 1 ss 0 <a href="http://64.61.93.170:19376">64.61.93.170:19376</a><br>
*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:<br>Hndl ptype 3 mline 1<br>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Selecting codec gsmfr<br>
*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/codec_found:<br>Codec to be matched: 10<br>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: ADD AUDIO CODEC 10</div>
<div>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Media negotiation NOT done, get ptime from sdp: ptime=20, media_ndx=1<br>*Oct 17 01:09:32.927: //-1/xxxxxxxxxxxx/SIP/Info/convert_ptime_to_codec_bytes: Values :Codec: gsmfr ptime :20, codecbytes: 66<br>
*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Error/sipSPI_ipip_copy_sdp_to_channelInfo:<br>failed to update call entry<br>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:<br>Adding codec 10 ptype 3 time 20, bytes 66 as channel 2 mline 1 ss 0 <a href="http://64.61.93.170:19376">64.61.93.170:19376</a><br>
*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:<br>Hndl ptype 97 mline 1<br>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/codec_found:<br>Codec to be matched: 33<br>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: ADD AUDIO CODEC 33</div>
<div>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Media negotiation NOT done, get ptime from sdp: ptime=20, media_ndx=1<br>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Codec bytes 0, use default packet rate 38<br>
*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Error/sipSPI_ipip_copy_sdp_to_channelInfo:<br>failed to update call entry<br>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:<br>Adding codec 33 ptype 97 time 20, bytes 38 as channel 3 mline 1 ss 0 <a href="http://64.61.93.170:19376">64.61.93.170:19376</a><br>
*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:<br>Hndl ptype 111 mline 1<br>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/codec_found:<br>Codec to be matched: 4<br>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: ADD AUDIO CODEC 4</div>
<div>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Media negotiation NOT done, get ptime from sdp: ptime=20, media_ndx=1<br>*Oct 17 01:09:32.927: //-1/xxxxxxxxxxxx/SIP/Info/convert_ptime_to_codec_bytes: Values :Codec: g726r32 ptime :20, codecbytes: 80<br>
*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Error/sipSPI_ipip_copy_sdp_to_channelInfo:<br>failed to update call entry<br>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:<br>Adding codec 4 ptype 111 time 20, bytes 80 as channel 4 mline 1 ss 0 <a href="http://64.61.93.170:19376">64.61.93.170:19376</a><br>
*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:<br>Hndl ptype 5 mline 1<br>*Oct 17 01:09:32.927: //-1/xxxxxxxxxxxx/SIP/Error/rtpAvpCodec_to_voipCodec: Unexpected RTP PayloadType :5 in SDP Body<br>
*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Selecting codec No Codec<br>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:<br>Hndl ptype 7 mline 1<br>
*Oct 17 01:09:32.927: //-1/xxxxxxxxxxxx/SIP/Error/rtpAvpCodec_to_voipCodec: Unexpected RTP PayloadType :7 in SDP Body<br>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Selecting codec No Codec<br>
*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:<br>Hndl ptype 101 mline 1<br>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: setting ipip_caps DTMF to RFC2833: callid = 131, dtmf = 6<br>
*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Copy sdp to channel- AFTER CODEC FILTERING: ccb->pld.ipip_caps.codecInfo[channel_ndx].codec = 5</div>
<div>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Copy sdp to channel- AFTER CODEC FILTERING: ccb->pld.ipip_caps.codecInfo[channel_ndx].codec = 6</div>
<div>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Copy sdp to channel- AFTER CODEC FILTERING: ccb->pld.ipip_caps.codecInfo[channel_ndx].codec = 10</div>
<div>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Copy sdp to channel- AFTER CODEC FILTERING: ccb->pld.ipip_caps.codecInfo[channel_ndx].codec = 33</div>
<div>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Copy sdp to channel- AFTER CODEC FILTERING: ccb->pld.ipip_caps.codecInfo[channel_ndx].codec = 4</div>
<div>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Copy sdp to channel- AFTER CODEC FILTERING: ccb->pld.ipip_caps.codecInfo[channel_ndx].codec = -1</div>
<div>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_report_media_to_peer:<br> Audio to Fax scenario<br>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_report_media_to_peer:<br> callId 131 flags 0x100 state STATE_IDLE<br>
*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_report_media_to_peer:<br>Report initial call media<br>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_report_media_to_peer: ccb->flags 0xC, ccb->pld.flags_ipip 0x201</div>
<div>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/copy_channels:<br> callId 131 size 1152 ptr 0x4DB1C43C)<br>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_report_media_to_peer:<br>CCSIP: Unable to report channel ind<br>
*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/ccsip_update_srtp_caps: 5253: Posting Remote SRTP caps to other callleg.<br>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPI_ipip_report_media_to_peer: do cc_api_caps_ind()<br>
*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Media/sipSPIUpdCallWithSdpInfo:<br> Stream type : voice+dtmf<br> Media line : 1<br> State : STREAM_ADDING (2)<br>
Stream address type : 1<br> Callid : -1<br> Negotiated Codec : g711ulaw, bytes :160<br> Nego. Codec payload : 0 (tx), 0 (rx)<br> Negotiated DTMF relay : rtp-nte<br>
Negotiated NTE payload : 101 (tx), 101 (rx)<br> Negotiated CN payload : 0<br> Media Srce Addr/Port : [173.14.220.57]:0<br> Media Dest Addr/Port : [64.61.93.170]:19376</div>
<div>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPIHandleInviteMedia:<br>Negotiated Codec : g711ulaw, bytes :160<br>Preferred Codec : g729r8, bytes :20<br>Preferred DTMF relay 1 : 6<br>Preferred DTMF relay 2 : 0<br>
Negotiated DTMF relay : 6<br>Preferred and Negotiated NTE payloads: 101 101<br>Preferred and Negotiated NSE payloads: 100 0<br>Preferred and Negotiated Modem Relay: 0 0<br>Preferred and Negotiated Modem Relay GwXid: 1 0</div>
<div>*Oct 17 01:09:32.927: //131/9022661681B2/SIP/Info/sipSPIDoQoSNegotiationWithMediaLine: Entry<br>*Oct 17 01:09:32.931: //131/9022661681B2/SIP/Info/sipSPIDoQoSNegotiationWithMediaLine: QOS negotiation for mline_index 1<br>
*Oct 17 01:09:32.931: //131/9022661681B2/SIP/Info/sipSPIDoStreamQoSNegotiation: Best effort<br>*Oct 17 01:09:32.931: //131/9022661681B2/SIP/Info/sipSPICanSetFallbackFlag: Local Fallback is not active<br>*Oct 17 01:09:32.931: //-1/xxxxxxxxxxxx/SIP/Media/sipSPIReserveRtpPort: reserved port 19164 for stream 1<br>
*Oct 17 01:09:32.931: //131/9022661681B2/SIP/Info/sipSPIUpdateSrcSdpFixedPart: Reserving rtp port for stream 1, src_port=19164<br>*Oct 17 01:09:32.931: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetMediaDirectionForStream: Setting Media direction SENDRECV for stream 1<br>
*Oct 17 01:09:32.931: //131/9022661681B2/SIP/Info/sipSPIUpdateSrcSdpVariablePart: Setting stream 1 portnum to 19164<br>*Oct 17 01:09:32.931: //131/9022661681B2/SIP/Info/sipSPIUpdateSrcSdpVariablePart:<br> SIP update src sdp, negoitated codec 5, payload type 0</div>
<div>*Oct 17 01:09:32.931: //131/9022661681B2/SIP/Info/sipSPIAddBillingInfoToCcb: sipCallId for billing records = <a href="mailto:527c7f413568d0060423fe5f115487b7@64.61.93.170">527c7f413568d0060423fe5f115487b7@64.61.93.170</a><br>
*Oct 17 01:09:32.931: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetContentCPA: No CPA found in inbound container<br>*Oct 17 01:09:32.931: //131/9022661681B2/SIP/Info/sipSPIProcessCPA: No x-cisco-cpa content found<br>*Oct 17 01:09:32.931: //131/9022661681B2/SIP/Info/sipSPI_ipip_GetHdrPassthruCfg: Hdr passthrough config:1 tag:0<br>
*Oct 17 01:09:32.931: //131/9022661681B2/SIP/Info/sipSPI_ipip_IsContentPassthruEnabled: - 0<br>*Oct 17 01:09:32.931: //131/9022661681B2/SIP/Info/sipSPI_ipip_ExtractPassthruContentFromSipContainer: Passthru Content Not Enabled<br>
*Oct 17 01:09:32.931: //131/9022661681B2/SIP/Info/sipSPI_ipip_store_channel_info: Store channelInfo in CallInfo<br>*Oct 17 01:09:32.931: //131/9022661681B2/SIP/Info/sipSPI_ipip_store_channel_info: dtmf negotiation done, storing negotiated dtmf = 6,<br>
*Oct 17 01:09:32.931: //131/9022661681B2/SIP/Info/sipSPIShrlCall: Check peer: 1000 for Shared-Line call, callid: 131<br>*Oct 17 01:09:32.931: //131/9022661681B2/SIP/Info/ccsip_set_bearer_capability:<br> Bearer Capability: Speech (0x00)<br>
*Oct 17 01:09:32.931: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetContentQSIG: No QSIG Body found in inbound container<br>*Oct 17 01:09:32.931: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetContentQ931: No RawMsg Body found in inbound container<br>
*Oct 17 01:09:32.931: //-1/xxxxxxxxxxxx/SIP/Info/sipSPICreateNewRawMsg: No Data to form The Raw Message</div>
<div>*Oct 17 01:09:32.931: //131/9022661681B2/SIP/Info/sipSPIContinueNewMsgInvite: ccsip_api_call_setup_ind returned: SIP_SUCCESS<br>*Oct 17 01:09:32.931: //131/9022661681B2/SIP/Info/sipSPIUaddccCallIdToTable: Adding call id 83 to table<br>
*Oct 17 01:09:32.935: //131/9022661681B2/SIP/Info/sipSPISendInviteResponse: Associated container=0x48150FA0 to Invite Response 100<br>*Oct 17 01:09:32.935: //131/9022661681B2/SIP/Transport/sipSPITransportSendMessage: msg=0x4A69B344, addr=64.61.93.190, port=5060, sentBy_port=5060, is_req=0, transport=1, switch=0, callBack=0x0<br>
*Oct 17 01:09:32.935: //131/9022661681B2/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately<br>*Oct 17 01:09:32.935: //131/9022661681B2/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0<br>
*Oct 17 01:09:32.935: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x4A69B344, addr=64.61.93.190, port=5060, connId=0 for UDP<br>*Oct 17 01:09:32.935: //131/9022661681B2/SIP/State/sipSPIChangeState: 0x4BB834D0 : State change from (STATE_IDLE, SUBSTATE_NONE) to (STATE_RECD_INVITE, SUBSTATE_NONE)<br>
*Oct 17 01:09:32.935: //131/9022661681B2/SIP/Info/sipSPIProcessContactInfo: Previous Hop <a href="http://64.61.93.190:5060">64.61.93.190:5060</a><br>*Oct 17 01:09:32.939: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_CALL_PROCEEDING<br>
*Oct 17 01:09:32.939: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_event_handler:<br>*Oct 17 01:09:32.939: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_event_handler: switch(ev.ev_id: 162)<br>*Oct 17 01:09:32.939: //131/9022661681B2/SIP/Info/ccsip_event_handler:<br>
ccsip_event_handler: peer ID 132 chans 0x4E1CDC80 event 162 flags 0x40001C 0x100 0x601 data 0x4E1CDC80<br>*Oct 17 01:09:32.939: //131/9022661681B2/SIP/Info/ccsip_event_handler:<br> ccsip_event_handler: CC_EV_H245_SET_MODE: peer ID 132 chans 0x4E1CDC80 event 162 flags 0x40001C 0x100 0x601 data 0x4E1CDC80, type = 1<br>
*Oct 17 01:09:32.939: //131/9022661681B2/SIP/Info/ccsip_gw_set_sipspi_mode: Setting SPI mode to SIP-H323<br>*Oct 17 01:09:32.943: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_event_handler: CC_R_SUCCESS_WITH_CONFIRMED<br>*Oct 17 01:09:32.943: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 for event 3<br>
*Oct 17 01:09:32.947: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:<br>Sent:<br>SIP/2.0 100 Trying<br>Via: SIP/2.0/UDP 64.61.93.190;branch=z9hG4bK95a8.910c7db2.0,SIP/2.0/UDP 64.61.93.174;rport=5060;branch=z9hG4bK95a8.f864086.0,SIP/2.0/UDP 64.61.93.170:5060;received=64.61.93.170;branch=z9hG4bK771ee36c;rport=5060<br>
From: "Cell Phone NY" <<a href="mailto:sip%3A5163076981@64.61.93.170">sip:5163076981@64.61.93.170</a>>;tag=as26da9258<br>To: <<a href="mailto:sip%3A16784663444@nycinpro01.voicepulse.net">sip:16784663444@nycinpro01.voicepulse.net</a>><br>
Date: Sat, 17 Oct 2009 01:09:32 GMT<br>Call-ID: <a href="mailto:527c7f413568d0060423fe5f115487b7@64.61.93.170">527c7f413568d0060423fe5f115487b7@64.61.93.170</a><br>CSeq: 102 INVITE<br>Allow-Events: telephone-event<br>Server: Cisco-SIPGateway/IOS-12.x<br>
Content-Length: 0</div>
<div><br>*Oct 17 01:09:33.215: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_CALL_PROGRESS<br>*Oct 17 01:09:33.215: //131/9022661681B2/SIP/Info/sipSPI_ipip_codec_byte_transrating: NOT SIP-SIP CALL. Will be addressed in future.<br>
*Oct 17 01:09:33.215: //131/9022661681B2/SIP/Info/sipSPI_ipip_codec_byte_transrating: NOT SIP-SIP CALL. Will be addressed in future.<br>*Oct 17 01:09:33.215: //131/9022661681B2/SIP/Info/ccsip_bridge: confID = 20, srcCallID = 131, dstCallID = 132<br>
*Oct 17 01:09:33.215: //131/9022661681B2/SIP/Info/sipSPIUupdateCcCallIds: Old src/dest ccCallids: -1/-1, new src/dest ccCallids: 131/132<br>*Oct 17 01:09:33.215: //131/9022661681B2/SIP/Info/sipSPIUupdateCcCallIds: Old streamcallid=-1, new streamcallid=131<br>
*Oct 17 01:09:33.215: //131/9022661681B2/SIP/Info/ccsip_gw_set_sipspi_mode: Setting SPI mode to SIP-H323<br>*Oct 17 01:09:33.215: //131/9022661681B2/SIP/Info/ccsip_bridge: xcoder_attached = 0, xmitFunc = 1135158960, ccb xmitFunc = 1135158960<br>
*Oct 17 01:09:33.215: //131/9022661681B2/SIP/Media/sipSPIProcessRtpSessions: sipSPIProcessRtpSessions<br>*Oct 17 01:09:33.215: //131/9022661681B2/SIP/Media/sipSPIAddStream: Adding stream 1 of type voice+dtmf (callid 131) to the VOIP RTP library<br>
*Oct 17 01:09:33.215: //131/9022661681B2/SIP/Info/resolve_media_ip_address_to_bind: Media already bound, use existing source_media_ip_addr<br>*Oct 17 01:09:33.215: //131/9022661681B2/SIP/Media/sipSPISetMediaSrcAddr: Media src addr for stream 1 = 173.14.220.57<br>
*Oct 17 01:09:33.215: //131/9022661681B2/SIP/Media/sipSPIUpdateRtcpSession: sipSPIUpdateRtcpSession for m-line 1<br>*Oct 17 01:09:33.215: //131/9022661681B2/SIP/Media/sipSPIUpdateRtcpSession: rtcp_session info<br> laddr = 173.14.220.57, lport = 19164, raddr = 64.61.93.170, rport=19376, do_rtcp=TRUE<br>
src_callid = 131, dest_callid = 132, stream type = voice+dtmf, stream direction = SENDRECV<br> media_ip_addr = 64.61.93.170, vrf tableid = 0 media_addr_type = 1<br>*Oct 17 01:09:33.215: //131/9022661681B2/SIP/Media/sipSPIUpdateRtcpSession: No rtp session, creating a new one<br>
*Oct 17 01:09:33.215: //131/9022661681B2/SIP/Info/sipSPICreateRtpSession: sess: 4DE33FD0 do_rtcp:1<br>*Oct 17 01:09:33.215: //131/9022661681B2/SIP/Media/sipSPICreateRtpSession: stun is disabled<br>*Oct 17 01:09:33.219: //131/9022661681B2/SIP/Info/sipSPICreateAndStartRtpTimer:<br>
*Oct 17 01:09:33.219: //131/9022661681B2/SIP/Info/sipSPICreateAndStartRtpTimer: Media Inactivity Timer is disabled.<br>*Oct 17 01:09:33.219: //131/9022661681B2/SIP/Media/sipSPIGetNewLocalMediaDirection:<br> New Remote Media Direction = SENDRECV<br>
Present Local Media Direction = SENDRECV<br> New Local Media Direction = SENDRECV<br> retVal = 0</div>
<div>*Oct 17 01:09:33.219: //131/9022661681B2/SIP/State/sipSPIChangeStreamState: Stream (callid = 131) State changed from (STREAM_ADDING) to (STREAM_ACTIVE)<br>*Oct 17 01:09:33.219: //131/9022661681B2/SIP/Info/ccsip_bridge: really can't find peer_stream for<br>
dtmf-relay interworking<br>*Oct 17 01:09:33.219: //131/9022661681B2/SIP/Info/ccsip_bridge: Enabling DTMF_IWF....<br>*Oct 17 01:09:33.219: //131/9022661681B2/SIP/Info/ccsip_bridge:<br>
DTMF inb/oob iwf enabled 101<br>*Oct 17 01:09:33.219: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 for event 4<br>*Oct 17 01:09:33.219: //131/9022661681B2/SIP/Error/sipSPIAddCiscoGcid: Fatal Error in parsing CCB/Msg<br>
*Oct 17 01:09:33.219: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIStoreTunnelData: Container /RawMessage Absent<br>*Oct 17 01:09:33.219: //131/9022661681B2/SIP/Error/sipSPI_ipip_set_history_info_header: Not SIP2SIP mode<br>*Oct 17 01:09:33.219: //131/9022661681B2/SIP/Info/sipSPIUaddCcbToUASRespTable: ****Adding to UAS Response table.<br>
*Oct 17 01:09:33.219: //131/9022661681B2/SIP/Info/sipSPIUaddCcbToTable: Added to table. ccb=0x4BB834D0 <a href="mailto:key=527c7f413568d0060423fe5f115487b7@64.61.93.1703DD208-133">key=527c7f413568d0060423fe5f115487b7@64.61.93.1703DD208-133</a><br>
SIP: (131) Group (a= group line) attribute, level 65535 instance 1 not found.<br>*Oct 17 01:09:33.219: //131/9022661681B2/SIP/Info/sipSPIGetCallExtensionSupported: anat enabled, src_sdp and dest_sdp available, should be a midcall request<br>
*Oct 17 01:09:33.223: //131/9022661681B2/SIP/Info/sipSPISendInviteResponse: Associated container=0x48150B28 to Invite Response 183<br>*Oct 17 01:09:33.223: //131/9022661681B2/SIP/Transport/sipSPISendInviteResponse: Sending 183 Response to the Transport Layer<br>
*Oct 17 01:09:33.223: //131/9022661681B2/SIP/Transport/sipSPITransportSendMessage: msg=0x4E1BA484, addr=64.61.93.190, port=5060, sentBy_port=5060, is_req=0, transport=1, switch=0, callBack=0x41956738<br>*Oct 17 01:09:33.223: //131/9022661681B2/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately<br>
*Oct 17 01:09:33.223: //131/9022661681B2/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0<br>*Oct 17 01:09:33.223: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x4E1BA484, addr=64.61.93.190, port=5060, connId=0 for UDP<br>
*Oct 17 01:09:33.223: //131/9022661681B2/SIP/Info/sentInviteResponse18x: Sent a 18x Response<br>*Oct 17 01:09:33.227: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:<br>Sent:<br>SIP/2.0 183 Session Progress<br>Via: SIP/2.0/UDP 64.61.93.190;branch=z9hG4bK95a8.910c7db2.0,SIP/2.0/UDP 64.61.93.174;rport=5060;branch=z9hG4bK95a8.f864086.0,SIP/2.0/UDP 64.61.93.170:5060;received=64.61.93.170;branch=z9hG4bK771ee36c;rport=5060<br>
From: "Cell Phone NY" <<a href="mailto:sip%3A5163076981@64.61.93.170">sip:5163076981@64.61.93.170</a>>;tag=as26da9258<br>To: <<a href="mailto:sip%3A16784663444@nycinpro01.voicepulse.net">sip:16784663444@nycinpro01.voicepulse.net</a>>;tag=3DD208-133<br>
Date: Sat, 17 Oct 2009 01:09:32 GMT<br>Call-ID: <a href="mailto:527c7f413568d0060423fe5f115487b7@64.61.93.170">527c7f413568d0060423fe5f115487b7@64.61.93.170</a><br>CSeq: 102 INVITE<br>Allow: INVITE, OPTIONS, B<br>*Oct 17 01:09:33.227: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_MEDIA_EVENT<br>
*Oct 17 01:09:33.227: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 for event 29</div>
<div> </div>
<div> </div>
<div> </div>
<div> </div>
<div> </div>
<div> </div>
<div> </div>