Buy or Renew
Buy or Renew
cancel
Turn on suggestions
Auto-suggest helps you quickly narrow down your search results by suggesting possible matches as you type.
Showing results for 
Search instead for 
Did you mean: 
cancel
Start a conversation
1146
Views
2
Helpful
7
Replies

INTERWORKING SIPS and BRI

Go to solution
Leonardo Cupellaro
Level 1
Level 1

‎01-26-2024 02:53 AM

Goodmorning,

i have a voice gateway ISR 4331 with a card NIM-2BRI-NT/TE. This is a SRST voice gateway used for cripted survival of 8851 SIP phones. Voice gateway is connected with a BRI to a Siemens Hpa 4k. 

When the phone is registered non crypted on voicegateway it can call phones on the Siemens Hpa via BRI. 

When the phone is registered crypted on voicegateway it fails to call phones on Siemens Hpa. It happends that siemens phone rings but when it pick up the phone, the call finish.

I send the gateway configuration below:

version 17.9
service tcp-keepalives-in
service tcp-keepalives-out
service timestamps debug datetime msec
service timestamps log datetime msec
service password-encryption
no service dhcp
platform qfp utilization monitor load 80
platform punt-keepalive disable-kernel-core
!
hostname VG_Test_T
!
boot-start-marker
boot system bootflash:/isr4300-universalk9.17.09.04a.SPA.bin
boot-end-marker
!
!
vrf definition Mgmt-intf
!
address-family ipv4
exit-address-family
!
address-family ipv6
exit-address-family
!
no aaa new-model
clock timezone UTC 1 0
ip options drop
!
!
!
!
!
!
!
ip name-server 192.168.16.91
ip domain name latelefonica.local
ip dhcp bootp ignore
!
!
!
login on-success log
!
!
!
!
!
!
!
subscriber templating
!
!
!
!
vtp mode off
vtp version 1
!
multilink bundle-name authenticated
!
!
!
!
!
isdn switch-type basic-net3
!
!
crypto pki trustpoint SLA-TrustPoint
enrollment pkcs12
revocation-check crl
!
crypto pki trustpoint ACT2_SUDI_CA.pem
enrollment terminal
revocation-check none
!
crypto pki trustpoint CAPF
enrollment terminal
revocation-check none
!
crypto pki trustpoint CAPF-559e4ce5
enrollment terminal
revocation-check none
!
crypto pki trustpoint CAPF-f7b0a998
enrollment terminal
revocation-check none
!
crypto pki trustpoint Cisco_Manufacturing_CA
enrollment terminal
revocation-check none
!
crypto pki trustpoint Cisco_Manufacturing_CA_SHA2
enrollment terminal
revocation-check none
!
crypto pki trustpoint Cisco_Root_CA_2048
enrollment terminal
revocation-check none
!
crypto pki trustpoint Cisco_Root_CA_M2
enrollment terminal
revocation-check none
!
!
crypto pki trustpoint srst-selfsigned
enrollment mode ra
enrollment selfsigned
subject-name CN=srst-selfsigned
revocation-check none
rsakeypair srst-selfsigned
!
!
crypto pki certificate chain SLA-TrustPoint
certificate ca 01
quit
crypto pki certificate chain ACT2_SUDI_CA.pem
xxx
quit
crypto pki certificate chain CAPF
certificate ca xxx
xxxxx
quit
crypto pki certificate chain CAPF-559e4ce5
xxxx
quit
crypto pki certificate chain CAPF-f7b0a998
certificate ca xxx
quit
crypto pki certificate chain Cisco_Manufacturing_CA
xxxxx
quit
crypto pki certificate chain Cisco_Manufacturing_CA_SHA2
certificate ca 02
xxx
quit
crypto pki certificate chain Cisco_Root_CA_2048
certificate ca xxx
quit
crypto pki certificate chain Cisco_Root_CA_M2
certificate ca 01
xxx
quit
crypto pki certificate chain srstca
xxx
quit
certificate ca xxx
quit
crypto pki certificate chain srst-selfsigned
certificate self-signed 01
xxx
quit
!
voice service voip
media disable-detailed-stats
allow-connections sip to h323
allow-connections sip to sip
no supplementary-service sip moved-temporarily
no supplementary-service sip refer
no supplementary-service sip handle-replaces
supplementary-service media-renegotiate
fax protocol t38 version 0 ls-redundancy 0 hs-redundancy 0 fallback none
trace
sip
bind control source-interface GigabitEthernet0/0/0
bind media source-interface GigabitEthernet0/0/0
registrar server expires max 600 min 60
!
voice register global
default mode
no allow-hash-in-dn
security-policy secure
timeouts interdigit 5
system message SRST
max-dn 160
max-pool 70
timezone 28
!
voice register pool 1
id network x.x.x.x mask 255.255.255.0
codec g711alaw
!
!
!
!
!
!
voice-card 0/2
no watchdog
!
voice-card 0/4
no watchdog
!
no license feature hseck9
license udi pid ISR4331/K9 sn xxxxxxxxxxxxx
license boot level securityk9
memory free low-watermark processor 62972
!
diagnostic bootup level minimal
!
spanning-tree extend system-id
!
!
username admin privilege 15 secret 9 xxxxxx
!
redundancy
mode none

!
no cdp run
!
interface GigabitEthernet0/0/0
ip address x.x.x.x 255.255.255.0
no ip redirects
no ip proxy-arp
negotiation auto
!
interface GigabitEthernet0/0/1
no ip address
shutdown
media-type rj45
negotiation auto
!
interface GigabitEthernet0/0/2
no ip address
shutdown
media-type sfp
negotiation auto
!
interface Service-Engine0/2/2
!
interface Service-Engine0/4/0
!
interface GigabitEthernet0
vrf forwarding Mgmt-intf
ip address dhcp
negotiation auto
!
interface BRI0/2/0:0
no ip address
isdn switch-type basic-net3
isdn protocol-emulate network
isdn layer1-emulate network
isdn incoming-voice voice
isdn static-tei 0
isdn skipsend-idverify
!
interface BRI0/2/1:0
no ip address
isdn switch-type basic-net3
isdn protocol-emulate network
isdn layer1-emulate network
isdn incoming-voice voice
isdn static-tei 0
isdn skipsend-idverify
!
ip default-gateway x.x.x.x
no ip http server
ip http authentication local
no ip http secure-server
ip http client source-interface GigabitEthernet0
ip forward-protocol nd
ip tftp source-interface GigabitEthernet0/0/0
ip route 0.0.0.0 0.0.0.0 x.x.x.x
ip ssh time-out 60
ip ssh source-interface GigabitEthernet0/0/0
ip ssh version 2
ip scp server enable
!
!
!
!
!
!
control-plane
!
!
voice-port 0/2/0
compand-type a-law
cptone IT
!
voice-port 0/2/1
compand-type a-law
cptone IT
!
mgcp behavior rsip-range tgcp-only
mgcp behavior comedia-role none
mgcp behavior comedia-check-media-src disable
mgcp behavior comedia-sdp-force disable
!
mgcp profile default
!
!
!
!
telephony-service
max-conferences 8 gain -6
transfer-system full-consult
!
!
dial-peer voice 2000 pots
destination-pattern 2...
no digit-strip
port 0/2/0
!
dial-peer voice 2001 pots
preference 1
destination-pattern 2...
no digit-strip
port 0/2/1
!
dial-peer voice 3000 pots
destination-pattern 3...
no digit-strip
port 0/2/0
!
dial-peer voice 3001 pots
preference 1
destination-pattern 3...
no digit-strip
port 0/2/1
!
dial-peer voice 4000 pots
destination-pattern 4...
no digit-strip
port 0/2/0
!
dial-peer voice 4001 pots
preference 1
destination-pattern 4...
no digit-strip
port 0/2/1
!
dial-peer voice 6000 pots
destination-pattern 6...
no digit-strip
port 0/2/0
!
dial-peer voice 6001 pots
destination-pattern 6...
no digit-strip
port 0/2/1
!
dial-peer voice 7000 pots
destination-pattern 7...
no digit-strip
port 0/2/0
!
dial-peer voice 7001 pots
preference 1
destination-pattern 7...
no digit-strip
port 0/2/1
!
dial-peer voice 8000 pots
destination-pattern 8...
no digit-strip
port 0/2/0
!
dial-peer voice 8001 pots
preference 1
destination-pattern 8...
no digit-strip
port 0/2/1
!
dial-peer voice 9000 pots
destination-pattern 9...
no digit-strip
port 0/2/0
!
dial-peer voice 9001 pots
preference 1
destination-pattern 9...
no digit-strip
port 0/2/1
!
dial-peer voice 5000 pots
destination-pattern 5...
no digit-strip
port 0/2/0
!
dial-peer voice 5001 pots
preference 1
destination-pattern 5...
no digit-strip
port 0/2/1
!
!
!
!
credentials
ip source-address x.x.x.x port 2445
trustpoint srst-selfsigned
!
sip-ua
crypto signaling default trustpoint srst-selfsigned
!
line con 0
login local
stopbits 1
line aux 0
exec-timeout 0 1
no exec
transport output none
line vty 0 4
exec-timeout 60 0
login local
transport input ssh
line vty 5 15
exec-timeout 60 0
login local
transport input ssh
!
network-clock synchronization automatic
call-home
! If contact email address in call-home is configured as sch-smart-licensing@cisco.com
! the email address configured in Cisco Smart License Portal will be used as contact email address to send SCH notifications.
contact-email-addr sch-smart-licensing@cisco.com
profile "CiscoTAC-1"
active
destination transport-method http
ntp server x.x.x.x
!
!
!
!
!
!
end

Debug CCSIP ALL of the call that doesn't work: 

 

 

*Jan 26 09:39:48.785: //-1/xxxxxxxxxxxx/SIP/Transport/sip_find_connid_by_fd: Map fd 0 to index 11

 

*Jan 26 09:39:48.813: //-1/xxxxxxxxxxxx/SIP/Info/notify/512/sip_tls_tcp_read_socket:

No error nbytes 2048 offset 0

*Jan 26 09:39:48.813: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_create: created msg=0x7F97B48528E8 with refCount = 1

*Jan 26 09:39:48.813: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_create: created msg=0x7F97C9FFF2D8 with refCount = 1

*Jan 26 09:39:48.814: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_process_network_msg: Content Length 1476, Bytes Remaining 893

*Jan 26 09:39:48.814: //-1/xxxxxxxxxxxx/SIP/Info/critical/1024/ccsip_process_network_message: process_network_msg: not complete

*Jan 26 09:39:48.814: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_free: Freed msg=0x7F97C9FFF2D8

*Jan 26 09:39:48.814: //-1/xxxxxxxxxxxx/SIP/Info/critical/1024/sip_tls_tcp_newmsg_to_spi: process_network_msg: not complete

*Jan 26 09:39:48.814: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_free: Freed msg=0x7F97B48528E8

*Jan 26 09:39:48.815: //-1/xxxxxxxxxxxx/SIP/Transport/sip_find_connid_by_fd: Map fd 0 to index 11

 

*Jan 26 09:39:48.815: //-1/xxxxxxxxxxxx/SIP/Info/verbose/512/sip_tls_tcp_read_socket:

Going to Read in parent process

*Jan 26 09:39:48.815: //-1/xxxxxxxxxxxx/SIP/Info/info/512/sip_tls_tcp_read_socket:

ReadBlock nbytes 583 offset 2048

*Jan 26 09:39:48.815: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_create: created msg=0x7F97B48528E8 with refCount = 1

*Jan 26 09:39:48.815: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_create: created msg=0x7F97C9FFF2D8 with refCount = 1

*Jan 26 09:39:48.815: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_free: Freed msg=0x7F97B48528E8

*Jan 26 09:39:48.815: //-1/xxxxxxxxxxxx/SIP/Info/info/4096/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for event 1

*Jan 26 09:39:48.815: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x0

*Jan 26 09:39:48.816: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerProcessNewConnMsg: gConnTab=0x7F97BE8850B0, remote_addr=192.168.36.128, remote_port=51630, local_addr=192.168.36.244, local_port=5061, connid=11, tenant=0, vrf=, transport=TLS Over TCP

*Jan 26 09:39:48.816: //-1/xxxxxxxxxxxx/SIP/Info/info/4608/sipHolderGetConnInstance: Return existing connection for port 51630 connId 11 tenant_tag 0

*Jan 26 09:39:48.816: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:

Received:

INVITE sip:2100@192.168.36.244;user=phone SIP/2.0

Via: SIP/2.0/TLS 192.168.36.128:51630;branch=z9hG4bK000deb5b

From: "Leonardo Cupellaro" <sip:603@192.168.36.244>;tag=6c5e3bf3bcd6004c65804918-72273e69

To: <sip:2100@192.168.36.244>

Call-ID: 6c5e3bf3-bcd600ff-6ab50493-330a9d66@192.168.36.128

Max-Forwards: 70

Session-ID: 09e99aac00105000a0006c5e3bf3bcd6;remote=00000000000000000000000000000000

Date: Fri, 26 Jan 2024 09:38:08 GMT

CSeq: 101 INVITE

User-Agent: Cisco-CP8851/12.5.1

Contact: <sip:034b8d2c-76ea-30a8-ae03-60218d1790db@192.168.36.128:51630;transport=tls>;+u.sip!devicename.ccm.cisco.com="SEP6C5E3BF3BCD6"

Expires: 180

Accept: application/sdp

Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER,REGISTER,UPDATE,SUBSCRIBE,INFO

Remote-Party-ID: "Leonardo Cupellaro" <sip:603@192.168.36.244>;party=calling;id-type=subscriber;privacy=off;screen=yes

Supported: replaces,join,sdp-anat,norefersub,resource-priority,X-cisco-srtp-fallback,X-cisco-xsi-8.5.1

Allow-Events: kpml,dialog

Recv-Info: conference

Recv-Info: x-cisco-conference

Content-Length: 1476

Content-Type: application/sdp

Content-Disposition: session;handling=optional

 

v=0

o=Cisco-SIPUA 26682 0 IN IP4 192.168.36.128

s=SIP Call

b=AS:4064

t=0 0

m=audio 21434 RTP/SAVP 114 9 124 113 115 0 8 116 18 101

c=IN IP4 192.168.36.128

b=TIAS:64000

a=crypto:1 AEAD_AES_256_GCM inline:xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx

a=crypto:2 AEAD_AES_128_GCM inline:xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx

a=crypto:3 AES_CM_128_HMAC_SHA1_80 inline:xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx

a=crypto:4 AES_CM_128_HMAC_SHA1_32 inline:xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx

a=crypto:5 AEAD_AES_256_GCM inline:xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx

a=crypto:6 AEAD_AES_128_GCM inline:xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx

a=crypto:7 AES_CM_128_HMAC_SHA1_80 inline:xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx

a=crypto:8 AES_CM_128_HMAC_SHA1_32 inline:xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx

a=rtpmap:114 opus/48000/2

a=fmtp:114 maxplaybackrate=16000;sprop-maxcapturerate=16000;maxaveragebitrate=64000;stereo=0;sprop-stereo=0;usedtx=0

a=rtpmap:9 G722/8000

a=rtpmap:124 ISAC/16000

a=rtpmap:113 AMR-WB/16000

a=fmtp:113 octet-align=0;mode-change-capability=2

a=rtpmap:115 AMR-WB/16000

a=fmtp:115 octet-align=1;mode-change-capability=2

a=rtpmap:0 PCMU/8000

a=rtpmap:8 PCMA/8000

a=rtpmap:116 iLBC/8000

a=fmtp:116 mode=20

a=rtpmap:18 G729/8000

a=fmtp:18 annexb=no

a=rtpmap:101 telephone-event/8000

a=fmtp:101 0-15

a=sendrecv

 

*Jan 26 09:39:48.816: //-1/xxxxxxxxxxxx/SIP/Info/verbose/4096/ccsip_new_msg_preprocessor: Checking Invite Dialog

*Jan 26 09:39:48.816: //-1/xxxxxxxxxxxx/SIP/Info/verbose/8192/sipSPIIpTrustSilentDiscard: sipSPIIpTrustSilentDiscard: called for method [102]

*Jan 26 09:39:48.816: //-1/xxxxxxxxxxxx/SIP/Info/verbose/4096/sipSPILocateInviteDialogCCB: CCPAI process exist, start processing

*Jan 26 09:39:48.816: //-1/xxxxxxxxxxxx/SIP/Info/verbose/4096/sipSPIAddContextToTable: Added context(0x7F97C21F4850) with key=[86] to table

*Jan 26 09:39:48.817: //-1/000000000000/SIP/Info/info/4096/ccsip_ipip_media_service_init:

*Jan 26 09:39:48.817: //-1/000000000000/SIP/Info/info/4096/ccsip_tdmip_media_service_init:

*Jan 26 09:39:48.817: //-1/000000000000/SIP/Info/verbose/36864/ccsip_ipip_media_forking_init: MF: Queue is initialised..

*Jan 26 09:39:48.817: //-1/000000000000/SIP/Info/verbose/4097/ccsip_platform_init_ccb: Initialising rtp session queue

*Jan 26 09:39:48.817: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Dialog Transaction Address 192.168.36.128,Port 51630, Transport 4, SentBy Port 51630vrfid 0, tenant 0

*Jan 26 09:39:48.817: //-1/000000000000/SIP/Info/verbose/4608/sipSPISipIncomingMsg: copy the natted transport info to ccb natted dest: 192.168.36.128:51630,natted src: 192.168.36.244:5061, natted transport: 4 tenant: 0, vrf:

*Jan 26 09:39:48.817: //-1/000000000000/SIP/Info/info/1024/sipSPISipIncomingMsg:  sip via host 192.168.36.128

*Jan 26 09:39:48.817: //-1/000000000000/SIP/Info/info/9216/sipSPISipIncomingMsg:  sip nat auto detect 0

*Jan 26 09:39:48.838: //-1/xxxxxxxxxxxx/SIP/Info/verbose/512/ccsip_get_vrf_from_sip_bind: vrfid 0 for tag 0, sip_vrfid 0, voice_vrfid 0

*Jan 26 09:39:48.838: //-1/000000000000/SIP/Info/info/8192/resolve_sig_ip_address_to_bind: VRF id = 0

*Jan 26 09:39:48.838: //-1/000000000000/SIP/Info/info/8192/resolve_sig_ip_address_to_bind: VRF id = 0

*Jan 26 09:39:48.838: //-1/xxxxxxxxxxxx/SIP/Info/info/8192/ccsip_get_ifaddress: ip_address IPv4 192.168.36.244 for SIP

*Jan 26 09:39:48.838: //-1/xxxxxxxxxxxx/SIP/Info/info/8192/resolve_ip_address_to_bind: ip_get_ifaddress IPv4 192.168.36.244 for SIP

*Jan 26 09:39:48.838: //-1/000000000000/SIP/Info/info/8192/resolve_sig_ip_address_to_bind: signaling bind address : 192.168.36.244

*Jan 26 09:39:48.838: //-1/xxxxxxxxxxxx/SIP/Info/info/8192/resolve_sig_ip_address_to_bind: bind_inuse: 1conn_reuse: 0

*Jan 26 09:39:48.838: //-1/xxxxxxxxxxxx/SIP/Info/info/8192/resolve_sig_ip_address_to_bind: return addr 192.168.36.244

*Jan 26 09:39:48.858: //-1/AE79E69580A2/SIP/State/sipSPIChangeState: 0x7F97C21F4850 : State change from (STATE_NONE, SUBSTATE_NONE)  to (STATE_IDLE, SUBSTATE_NONE)

*Jan 26 09:39:48.858: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Dialog Transaction Address 192.168.36.128,Port 51630, Transport 4, SentBy Port 5060vrfid 0, tenant 0

*Jan 26 09:39:48.858: //-1/xxxxxxxxxxxx/SIP/Info/verbose/8192/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT

*Jan 26 09:39:48.858: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Dialog Transaction Address 192.168.36.128,Port 51630, Transport 4, SentBy Port 51630vrfid 0, tenant 0

*Jan 26 09:39:48.859: //-1/xxxxxxxxxxxx/SIP/Info/verbose/512/ccsip_get_vrf_from_sip_bind: vrfid 0 for tag 0, sip_vrfid 0, voice_vrfid 0

*Jan 26 09:39:48.859: //-1/AE79E69580A2/SIP/Info/info/8192/resolve_sig_ip_address_to_bind: VRF id = 0

*Jan 26 09:39:48.859: //-1/AE79E69580A2/SIP/Info/info/8192/resolve_sig_ip_address_to_bind: VRF id = 0

*Jan 26 09:39:48.859: //-1/xxxxxxxxxxxx/SIP/Info/info/8192/ccsip_get_ifaddress: ip_address IPv4 192.168.36.244 for SIP

*Jan 26 09:39:48.859: //-1/xxxxxxxxxxxx/SIP/Info/info/8192/resolve_ip_address_to_bind: ip_get_ifaddress IPv4 192.168.36.244 for SIP

*Jan 26 09:39:48.859: //-1/AE79E69580A2/SIP/Info/info/8192/resolve_sig_ip_address_to_bind: signaling bind address : 192.168.36.244

*Jan 26 09:39:48.859: //-1/xxxxxxxxxxxx/SIP/Info/info/8192/resolve_sig_ip_address_to_bind: bind_inuse: 1conn_reuse: 0

*Jan 26 09:39:48.859: //-1/xxxxxxxxxxxx/SIP/Info/info/8192/resolve_sig_ip_address_to_bind: return addr 192.168.36.244

*Jan 26 09:39:48.859: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_lock: Increment msg (0x7F97C9FFF2D8) counter, current msg->refCount = 2

*Jan 26 09:39:48.859: //-1/xxxxxxxxxxxx/SIP/Error/httpish_msg_free:

 Freeing NULL pointer!

*Jan 26 09:39:48.859: //-1/AE79E69580A2/SIP/Info/verbose/4096/sipSPIAssignCcbLastRequest: Current ccb(0x7F97C21F4850)->last_request = 0x7F97C9FFF2D8, refCount = 2

*Jan 26 09:39:48.880: //-1/AE79E69580A2/SIP/Info/info/8192/sipSPIExtractSessionID: Parsed localuuid  - 09e99aac00105000a0006c5e3bf3bcd6  remoteuuid - 00000000000000000000000000000000

*Jan 26 09:39:48.880: //-1/AE79E69580A2/SIP/Info/notify/8192/sipSPI_Add_SessionIDtoTDContainer: localUUID - 09e99aac00105000a0006c5e3bf3bcd6remoteUUID - 00000000000000000000000000000000

*Jan 26 09:39:48.880: //-1/AE79E69580A2/SIP/Info/info/8192/sipSPIProcessSessionID: SessionID header is present- 09e99aac00105000a0006c5e3bf3bcd6

*Jan 26 09:39:48.880: //-1/AE79E69580A2/SIP/Info/info/2048/sipSPICheckAssertedIdConfig: Dialpeer match is not yet done

*Jan 26 09:39:48.880: //-1/AE79E69580A2/SIP/Info/info/4096/sipSPISetCallingInfo: calling host comes from From: 192.168.36.244

*Jan 26 09:39:48.880: //-1/AE79E69580A2/SIP/Info/verbose/32768/ccsip_ipip_media_forking_copy_prev_best_rpid: MF: This is best rpid..

*Jan 26 09:39:48.880: //-1/AE79E69580A2/SIP/Info/verbose/4096/sipSPIUpdateCallingInfoUsingRpidOrFrom: Updating Calling Info with RPID header data

*Jan 26 09:39:48.880: //-1/AE79E69580A2/SIP/Info/verbose/4096/sipSPISetInfoFromRpid: calling host comes from rpid 192.168.36.244

*Jan 26 09:39:48.880: //-1/AE79E69580A2/SIP/Info/info/4096/sipSPISetInfoFromRpid: Received current remote name: Leonardo Cupellaro, current remote number: 603

*Jan 26 09:39:48.898: //-1/AE79E69580A2/SIP/Info/info/4096/sipSPISetInfoFromRpid: Received ;screen=yes ;privacy=off -> Setting Octet3A 0x81, extended_privacy 0x00

*Jan 26 09:39:48.898: //-1/AE79E69580A2/SIP/Info/info/2048/sipSPICheckAssertedIdConfig: Dialpeer match is not yet done

*Jan 26 09:39:48.898: //-1/xxxxxxxxxxxx/SIP/Info/critical/4096/sipSPIGetContentGTD: No GTD found in inbound container

*Jan 26 09:39:48.898: //-1/xxxxxxxxxxxx/SIP/Info/critical/4096/sipSPIGetContentCSTA: No CSTA found in inbound container

*Jan 26 09:39:48.898: //-1/AE79E69580A2/SIP/Info/verbose/4096/sipSPIUaddCcbToTable: Added to table. ccb=0x7F97C21F4850 key=6c5e3bf3-bcd600ff-6ab50493-330a9d66@192.168.36.1282100 balance 1

*Jan 26 09:39:48.898: //-1/AE79E69580A2/SIP/Info/info/8192/sipSPIMatchSrcIpGroup: Match not found on carrier id

*Jan 26 09:39:48.898: //-1/AE79E69580A2/SIP/Info/critical/8192/sipSPIMatchSrcIpGroup: Match not found on Incoming called number: 2100

*Jan 26 09:39:48.898: //-1/AE79E69580A2/SIP/Info/critical/8192/sipSPIMatchSrcIpGroup: Match not found on destination pattern: 603

*Jan 26 09:39:48.898: //-1/AE79E69580A2/SIP/Info/info/12288/ccsipUpdateIncomingCallParams: ccCallInfo: Calling name Leonardo Cupellaro, number 603, Calling oct3 0x00, oct_3a 0x81, Called number 2100

*Jan 26 09:39:48.898: //-1/AE79E69580A2/SIP/Info/verbose/1024/sipSPIGetViaHostInURLFormat: VIA URL:sip:192.168.36.128:51630, Host:192.168.36.128

*Jan 26 09:39:48.899: //-1/AE79E69580A2/SIP/Info/verbose/67584/sipSPIGetShrlPeer: Try match incoming dialpeer for Calling number: : 603

*Jan 26 09:39:48.899: //-1/AE79E69580A2/SIP/Info/critical/1024/sipSPIGetFromCalledPartyId: P-Called-Party-ID header not found

*Jan 26 09:39:48.899: //-1/AE79E69580A2/SIP/Info/critical/1024/sipSPIGetPeerByCalledPartyId: P-Called-Party-ID not found or parse error

*Jan 26 09:39:48.899: //-1/AE79E69580A2/SIP/Info/critical/10240/sipSPIGetCallConfig: No match found for P-Called-Party-ID

*Jan 26 09:39:48.899: //-1/xxxxxxxxxxxx/SIP/Info/verbose/8192/ccsip_sipline_set_vrf: Mode SRST: No voice register groups here

*Jan 26 09:39:48.899: //-1/AE79E69580A2/SIP/Info/info/8192/sipSPIGetCallConfig: VRF id = 0

*Jan 26 09:39:48.899: //-1/AE79E69580A2/SIP/Info/info/2048/sipSPIGetCallConfig: Peer tag 40001 matched for incoming call

*Jan 26 09:39:48.899: //-1/AE79E69580A2/SIP/Info/verbose/1024/sipSPIGetCallConfig: Precondition tag absent in Require/Supported header

*Jan 26 09:39:48.899: //-1/xxxxxxxxxxxx/SIP/Info/verbose/512/ccsip_get_vrf_from_sip_bind: vrfid 0 for tag 0, sip_vrfid 0, voice_vrfid 0

*Jan 26 09:39:48.899: //-1/AE79E69580A2/SIP/Info/info/8192/resolve_sig_ip_address_to_bind: VRF id = 0

*Jan 26 09:39:48.899: //-1/AE79E69580A2/SIP/Info/info/8192/resolve_sig_ip_address_to_bind: VRF id = 0

*Jan 26 09:39:48.899: //-1/xxxxxxxxxxxx/SIP/Info/info/8192/ccsip_get_ifaddress: ip_address IPv4 192.168.36.244 for SIP

*Jan 26 09:39:48.899: //-1/xxxxxxxxxxxx/SIP/Info/info/8192/resolve_ip_address_to_bind: ip_get_ifaddress IPv4 192.168.36.244 for SIP

*Jan 26 09:39:48.899: //-1/AE79E69580A2/SIP/Info/info/8192/resolve_sig_ip_address_to_bind: signaling bind address : 192.168.36.244

*Jan 26 09:39:48.900: //-1/xxxxxxxxxxxx/SIP/Info/info/8192/resolve_sig_ip_address_to_bind: bind_inuse: 1conn_reuse: 0

*Jan 26 09:39:48.900: //-1/xxxxxxxxxxxx/SIP/Info/info/8192/resolve_sig_ip_address_to_bind: return addr 192.168.36.244

*Jan 26 09:39:48.900: //-1/AE79E69580A2/SIP/Info/info/2048/sipSPISetAudioForcedConfig: audio forced config is set to FALSE

*Jan 26 09:39:48.900: //-1/AE79E69580A2/SIP/Info/verbose/1024/sipSPIGetCallConfig: Precondition tag absent in Require/Supported header

*Jan 26 09:39:48.900: //-1/AE79E69580A2/SIP/Info/verbose/2048/sipSPIGetCallConfig: Media Antitrombone disabled

*Jan 26 09:39:48.900: //-1/AE79E69580A2/SIP/Info/notify/65536/sipSPISetMediaFlowMode: Forcing the flow mode to FLOW-THROUGH for SIP line

*Jan 26 09:39:48.900: //-1/AE79E69580A2/SIP/Info/info/8192/sipSPISetMediaFlowMode: Storing the configured mode as FLOW-THROUGH

*Jan 26 09:39:48.900: //-1/AE79E69580A2/SIP/Info/info/2304/sipSPISetMediaFlowMode: xcoder high-density disabled

*Jan 26 09:39:48.900: //-1/AE79E69580A2/SIP/Info/info/8192/sipSPISetMediaFlowMode: Flow Mode set to FLOW_THROUGH

*Jan 26 09:39:48.900: //-1/AE79E69580A2/SIP/Info/info/8704/sipSPIGetCallConfig: Incoming: No  Defer BYE for last call stats

*Jan 26 09:39:48.900: //-1/AE79E69580A2/SIP/Info/verbose/4/update_video_params_from_config: Checking Video Type Rate=-1 video_codec_allowed=1F

*Jan 26 09:39:48.900: //-1/AE79E69580A2/SIP/Media/sipSPICopyStunConfigFromPeerToCCB: STUN Usage is not enabled

*Jan 26 09:39:48.900: //-1/AE79E69580A2/SIP/Info/verbose/12288/sipSPIGetModemInfoPerCall: peer_callID=0

*Jan 26 09:39:48.900: //-1/AE79E69580A2/SIP/Info/critical/32768/ccsip_ipip_media_forking_update_preferred_codec: MF: Not a Forked SIP leg..

*Jan 26 09:39:48.900: //-1/AE79E69580A2/SIP/Info/info/8704/sipSPIGetCallConfig: Incoming: No defer BYE for last

                              call stats

*Jan 26 09:39:48.900: //-1/xxxxxxxxxxxx/SIP/Error/ccsip_websocket_forking_enabled_in_any_dial_peer:

 

 Media profile stream-service not configured under any dial-peer or media-class

*Jan 26 09:39:48.900: //-1/AE79E69580A2/SIP/Info/info/34816/ccsip_ipip_media_forking_anchor_leg_config: MF: en_p->encap_s.voIP.voipPeerCfgMediaClass = 0

*Jan 26 09:39:48.900: //-1/AE79E69580A2/SIP/Info/info/34816/ccsip_ipip_media_forking_anchor_leg_config: MF: Dial-peer has no media class recorder.

*Jan 26 09:39:48.900: //-1/AE79E69580A2/SIP/Info/info/32768/ccsip_ipip_media_forking_intra_frame_request_config: MF: FIR en_p->encap_s.voIP.voipPeerCfgMediaClass = 0

*Jan 26 09:39:48.900: //-1/AE79E69580A2/SIP/Info/info/32768/ccsip_ipip_media_forking_get_forked_leg_config: MF: This leg is not forked call leg.

*Jan 26 09:39:48.900: //-1/AE79E69580A2/SIP/Info/info/1/ccsip_set_srtp_config: Crypto class is not configured on Dial-peer. Populate default behaviour.

*Jan 26 09:39:48.900: //-1/AE79E69580A2/SIP/Info/info/1/ccsip_set_srtp_config: AEAD_AES_256_GCM

*Jan 26 09:39:48.900: //-1/AE79E69580A2/SIP/Info/info/1/ccsip_set_srtp_config: AEAD_AES_128_GCM

*Jan 26 09:39:48.900: //-1/AE79E69580A2/SIP/Info/info/1/ccsip_set_srtp_config: AES_CM_128_HMAC_SHA1_80

*Jan 26 09:39:48.901: //-1/AE79E69580A2/SIP/Info/info/1/ccsip_set_srtp_config: AES_CM_128_HMAC_SHA1_32

*Jan 26 09:39:48.901: //-1/AE79E69580A2/SIP/Info/verbose/1/ccsip_set_srtp_config: Srtp crypto suite bm is 51

*Jan 26 09:39:48.901: //-1/AE79E69580A2/SIP/Info/info/8192/sipSPIGetCallConfig: Media forking disabled

*Jan 26 09:39:48.901: //-1/AE79E69580A2/SIP/Info/critical/11264/ccsipInitDSCPPolicyInfo: No DSCP Profile configured, No RPH 2 DSCP Mapping and DSCP policing

*Jan 26 09:39:48.901: //-1/AE79E69580A2/SIP/Info/verbose/8192/sipSPIGetCallConfig: Initilise the DSCP policy

*Jan 26 09:39:48.901: //-1/AE79E69580A2/SIP/Info/verbose/8192/sipSPICheckFAAnatAssymetricOrDO2EO: Not a SIP-SIP call or not in FA mode

*Jan 26 09:39:48.901: //-1/AE79E69580A2/SIP/Info/notify/8192/sipSPISetOverlapConfiguration: Overlap signaling: FALSE: Endpt: SIP Line

*Jan 26 09:39:48.901: //-1/AE79E69580A2/SIP/Info/verbose/10240/sipSPI_ipip_GetHdrPassthruCfg: Hdr passthrough config:1 tag:0

*Jan 26 09:39:48.901: //-1/AE79E69580A2/SIP/Info/verbose/2048/sipSPI_ipip_GetCopyListCfg: Copy-list config:2 tag:0

*Jan 26 09:39:48.901: //-1/AE79E69580A2/SIP/Info/info/2048/sipSPIGetExtensionCfg: SIP extension config:1, check sys cfg:1

*Jan 26 09:39:48.901: //-1/AE79E69580A2/SIP/Info/notify/10240/sipSPI_ipip_build_consolidated_header_list: Both passthru and copylist are disabled

*Jan 26 09:39:48.901: //-1/AE79E69580A2/SIP/Info/info/4096/sipSPIContinueNewMsgInvite: Calling name Leonardo Cupellaro, number 603, Calling oct3 0x00, oct_3a 0x81, ext_priv 0x00, Called number 2100, oct3 0x00

*Jan 26 09:39:48.901: //-1/AE79E69580A2/SIP/Info/info/4096/sipSPIContinueNewMsgInvite: Carrier id code , prev_cid NONE, next_cid NONE, prev_tgrp NONE, next_tgrp NONE

*Jan 26 09:39:48.901: //-1/AE79E69580A2/SIP/Info/critical/10240/sipSPIValidateRequestUri: Not Enabled

*Jan 26 09:39:48.901: //-1/AE79E69580A2/SIP/Info/info/65536/UpdateSIPDirectVoiceMailNumber: Direct call from SIP line: called number 2100

*Jan 26 09:39:48.901: //-1/AE79E69580A2/SIP/Info/info/131072/sipSPIRscmsmAvail: Value returned by check is = 0

*Jan 26 09:39:48.901: //117/AE79E69580A2/SIP/Info/critical/4096/sipSPICheckOutBoundDpProvisioning: Cannot obtain the the header bitmap

*Jan 26 09:39:48.901: //117/AE79E69580A2/SIP/Info/critical/8192/sipSPI_ipip_IsSDPPassthruEnabled:  - 0

*Jan 26 09:39:48.901: //117/AE79E69580A2/SIP/Info/info/8192/sipSPIExtractSessionID: Parsed localuuid  - 09e99aac00105000a0006c5e3bf3bcd6  remoteuuid - 00000000000000000000000000000000

*Jan 26 09:39:48.901: //117/AE79E69580A2/SIP/Info/notify/8192/sipSPI_Add_SessionIDtoTDContainer: localUUID - 09e99aac00105000a0006c5e3bf3bcd6remoteUUID - 00000000000000000000000000000000

*Jan 26 09:39:48.901: //117/AE79E69580A2/SIP/Info/info/8192/sipSPIProcessSessionID: SessionID header is present- 09e99aac00105000a0006c5e3bf3bcd6

*Jan 26 09:39:48.901: //-1/xxxxxxxxxxxx/SIP/Info/info/32768/ccsip_voip_trace_update_peer_sessionId: Cover Buffer:16, Updating peer Session-ID:09e99aac00105000a0006c5e3bf3bcd6

*Jan 26 09:39:48.902: //117/AE79E69580A2/SIP/Event/Session-Timer/sipSTSLMain: Event: E_STSL_SESSION_REFRESH_REQ

*Jan 26 09:39:48.902: //117/AE79E69580A2/SIP/Event/Session-Timer/sipSTSLMain: dir:2, method:102, resp_code:0, container:7F97CAE75118

*Jan 26 09:39:48.902: //117/AE79E69580A2/SIP/Info/notify/8192/Session-Timer/sipSTSLExtractSessionExpiresHdr: Not received session expires header

*Jan 26 09:39:48.902: //117/AE79E69580A2/SIP/Info/info/8192/Session-Timer/sipSTSLGetInternalSREvent: E_STSL_INITIAL_SR_REQ

*Jan 26 09:39:48.902: //117/AE79E69580A2/SIP/Event/Session-Timer/sipSTSLPrintTDContainer: Peer-Event: E_STSL_LEG_BY_LEG, SE Value:0, SE Refresher:none, Min-SE Value:1800, flags:2000

*Jan 26 09:39:48.902: //117/AE79E69580A2/SIP/Info/info/8192/Session-Timer/sipSTSLMain:

        SE: 0;refresher:none peer refresher:none, flags:2000, posted event:E_STSL_INVALID_PEER_EVENT, reason:4

        Configured SE:1800, Configured Min-SE:1800

*Jan 26 09:39:48.902: //117/AE79E69580A2/SIP/Info/critical/1024/sipSPIProcessHistoryInfoHeader: No HI headers recvd from app container

*Jan 26 09:39:48.902: //117/AE79E69580A2/SIP/Info/critical/1024/sipSPIProcessDiversionHeader: No diversion headers recvd from app container

*Jan 26 09:39:48.902: //117/AE79E69580A2/SIP/Info/critical/16384/sipSPIProcessReplacesHeader: No replaces hdr found

*Jan 26 09:39:48.902: //-1/xxxxxxxxxxxx/SIP/Info/verbose/1024/sipSPIGetContentCPA: No CPA found in inbound container

*Jan 26 09:39:48.902: //117/AE79E69580A2/SIP/Info/verbose/1024/sipSPIProcessCPA: No x-cisco-cpa content found

*Jan 26 09:39:48.903: //117/AE79E69580A2/SIP/Info/verbose/1/sipSPIDoMediaNegotiation: Number of m-lines = 1

*Jan 26 09:39:48.903: //117/AE79E69580A2/SIP/Info/verbose/1/sipSPIValidateConnectionAddress: Dest port = 21434

SIP: (117) Attribute mid, level 1 instance 1 not found.

*Jan 26 09:39:48.931: //117/AE79E69580A2/SIP/Info/notify/6/sipSPIValidateStreamAddrType: stream:1, Mode : 1

*Jan 26 09:39:48.931: //117/AE79E69580A2/SIP/Info/verbose/513/resolve_media_ip_address_to_bind: peer_tag=40001

*Jan 26 09:39:48.931: //117/AE79E69580A2/SIP/Info/info/2048/resolve_media_ip_address_to_bind: Configuration not found for bind media source-ip

*Jan 26 09:39:48.931: //-1/xxxxxxxxxxxx/SIP/Info/verbose/512/ccsip_get_vrf_from_sip_bind: vrfid 0 for tag 0, sip_vrfid 0, voice_vrfid 0

*Jan 26 09:39:48.931: //-1/xxxxxxxxxxxx/SIP/Info/info/8192/resolve_media_ip_address_to_bind: VRF id = 0

*Jan 26 09:39:48.931: //-1/xxxxxxxxxxxx/SIP/Info/info/8192/ccsip_get_ifaddress: ip_address IPv4 192.168.36.244 for SIP

*Jan 26 09:39:48.931: //-1/xxxxxxxxxxxx/SIP/Info/info/8192/resolve_ip_address_to_bind: ip_get_ifaddress IPv4 192.168.36.244 for SIP

*Jan 26 09:39:48.931: //117/AE79E69580A2/SIP/Media/sipSPISetMediaSrcAddr: Media src addr for stream 1 = 192.168.36.244

*Jan 26 09:39:48.931: //117/AE79E69580A2/SIP/Info/verbose/1/sipSPI_detect_media_loop: Number of media loops detected - 0

*Jan 26 09:39:48.931: //117/AE79E69580A2/SIP/Info/info/17/sipIfSRTPAllowed: accepting SRTP with unsecure signaling, url type = 1

*Jan 26 09:39:48.931: //117/AE79E69580A2/SIP/Info/verbose/16/sipIfSRTPCryptoSuiteAllow: Configured 0, 0

*Jan 26 09:39:48.931: //117/AE79E69580A2/SIP/Info/verbose/16/sipIfSRTPCryptoSuiteAllow: Found 6 in SDP at 1

*Jan 26 09:39:48.931: //117/AE79E69580A2/SIP/Info/verbose/16/sipIfSRTPCryptoSuiteAllow: Found 5 in SDP at 2

*Jan 26 09:39:48.931: //117/AE79E69580A2/SIP/Info/verbose/16/sipIfSRTPCryptoSuiteAllow: Found 2 in SDP at 3

*Jan 26 09:39:48.931: //117/AE79E69580A2/SIP/Info/verbose/16/sipIfSRTPCryptoSuiteAllow: Found 1 in SDP at 4

*Jan 26 09:39:48.931: //117/AE79E69580A2/SIP/Info/verbose/16/sipIfSRTPCryptoSuiteAllow: Found 6 in SDP at 5

*Jan 26 09:39:48.931: //117/AE79E69580A2/SIP/Info/verbose/16/sipIfSRTPCryptoSuiteAllow: Found 5 in SDP at 6

*Jan 26 09:39:48.931: //117/AE79E69580A2/SIP/Info/verbose/16/sipIfSRTPCryptoSuiteAllow: Found 2 in SDP at 7

*Jan 26 09:39:48.931: //117/AE79E69580A2/SIP/Info/verbose/16/sipIfSRTPCryptoSuiteAllow: Found 1 in SDP at 8

*Jan 26 09:39:48.931: //117/AE79E69580A2/SIP/Info/verbose/16/sipIfSRTPCryptoSuiteAllow: Remote crypto bm 0x33, Local prefered crypto bm 0x33

*Jan 26 09:39:48.931: //-1/xxxxxxxxxxxx/SIP/Info/notify/1/sipSPICheckDynPayloadUse: Dynamic payload(114) reserved for codec opus

*Jan 26 09:39:48.931: //-1/xxxxxxxxxxxx/SIP/Info/notify/1/sipSPICheckDynPayloadUse: Dynamic payload(124) reserved for codec isac

*Jan 26 09:39:48.931: //-1/xxxxxxxxxxxx/SIP/Info/notify/1/sipSPICheckDynPayloadUse: Dynamic payload(113) reserved for codec No Codec

*Jan 26 09:39:48.931: //-1/xxxxxxxxxxxx/SIP/Info/info/1/sipSPIUpdateDynamicPayloadunused: Unreserving dynamic payload type 96

*Jan 26 09:39:48.931: //-1/xxxxxxxxxxxx/SIP/Info/notify/1/sipSPICheckDynPayloadUse: Dynamic payload(113) reserved for codec No Codec

*Jan 26 09:39:48.931: //-1/xxxxxxxxxxxx/SIP/Info/info/1/sipSPIUpdateDynamicPayloadunused: Unreserving dynamic payload type 98

*Jan 26 09:39:48.932: //-1/xxxxxxxxxxxx/SIP/Info/notify/1/sipSPICheckDynPayloadUse: Dynamic payload(115) reserved for codec No Codec

*Jan 26 09:39:48.932: //-1/xxxxxxxxxxxx/SIP/Info/info/1/sipSPIUpdateDynamicPayloadunused: Unreserving dynamic payload type 96

*Jan 26 09:39:48.932: //-1/xxxxxxxxxxxx/SIP/Info/critical/1/sipSPICheckDynPayloadUse: Dynamic payload(115) could not be reserved  as its in use by other codec mpeg4

*Jan 26 09:39:48.932: //-1/xxxxxxxxxxxx/SIP/Info/critical/1/sipSPIUpdateDynamicPT: Requested payload-Type (115) is  reserved by another application

*Jan 26 09:39:48.932: //-1/xxxxxxxxxxxx/SIP/Info/info/1/sipSPIUpdateDynamicPayloadunused: Unreserving dynamic payload type 98

*Jan 26 09:39:48.932: //-1/xxxxxxxxxxxx/SIP/Info/info/1/sipSPIUpdateDynamicPayloadunused: Unreserving dynamic payload type 115

*Jan 26 09:39:48.932: //-1/xxxxxxxxxxxx/SIP/Info/info/1/sipSPIAllocateFreeDynamicPT: Allocating free Dynamic Payload : 98 for Codec: mpeg4

*Jan 26 09:39:48.932: //-1/xxxxxxxxxxxx/SIP/Info/notify/1/sipSPICheckDynPayloadUse: Dynamic payload(116) reserved for codec ilbc

*Jan 26 09:39:48.932: //-1/xxxxxxxxxxxx/SIP/Info/notify/1/sipSPICheckDynPayloadUse: Dynamic payload(101) reserved for codec No Codec

*Jan 26 09:39:48.932: //-1/xxxxxxxxxxxx/SIP/Info/info/1/sipSPIUpdateDynamicPayloadunused: Unreserving dynamic payload type 96

*Jan 26 09:39:48.932: //-1/xxxxxxxxxxxx/SIP/Info/critical/1/sipSPICheckDynPayloadUse: Dynamic payload(101) could not be reserved  as its in use by other codec

*Jan 26 09:39:48.932: //-1/xxxxxxxxxxxx/SIP/Info/critical/1/sipSPIUpdateDynamicPT: Requested payload-Type (101) is  reserved by another application

*Jan 26 09:39:48.932: //-1/xxxxxxxxxxxx/SIP/Info/info/1/sipSPIUpdateDynamicPayloadunused: Unreserving dynamic payload type 99

*Jan 26 09:39:48.932: //-1/xxxxxxxxxxxx/SIP/Info/info/1/sipSPIUpdateDynamicPayloadunused: Unreserving dynamic payload type 101

*Jan 26 09:39:48.932: //-1/xxxxxxxxxxxx/SIP/Info/info/1/sipSPIAllocateFreeDynamicPT: Allocating free Dynamic Payload : 99 for Codec:

*Jan 26 09:39:48.932: //-1/xxxxxxxxxxxx/SIP/Info/info/1/rtpAvpCodec_to_voipCodec: Dynamic Payload :114 in SDP Body

*Jan 26 09:39:48.932: //-1/xxxxxxxxxxxx/SIP/Info/info/1/rtpAvpCodec_to_voipCodec: Dynamic Payload :124 in SDP Body

*Jan 26 09:39:48.932: //-1/xxxxxxxxxxxx/SIP/Info/info/1/rtpAvpCodec_to_voipCodec: Dynamic Payload :113 in SDP Body

*Jan 26 09:39:48.932: //-1/xxxxxxxxxxxx/SIP/Info/info/1/rtpAvpCodec_to_voipCodec: Dynamic Payload :115 in SDP Body

*Jan 26 09:39:48.932: //117/AE79E69580A2/SIP/Info/notify/1/sipSPIDoAudioNegotiation: Codec (g711alaw) Negotiation Successful on Static Payload for m-line 1

*Jan 26 09:39:48.932: //117/AE79E69580A2/SIP/Info/notify/1/sipSPIDoPtimeNegotiation: No ptime present or multiple ptime attributes that can't be handled

*Jan 26 09:39:48.932: //117/AE79E69580A2/SIP/Info/info/8/sipSPISetFaxFlags: FAX_PASSTHROUGH = 0, END_FAX_PASSTHROUGH = 0

*Jan 26 09:39:48.932: //117/AE79E69580A2/SIP/Info/info/1/sipSPIDoDTMFRelayNegotiation: m-line index 1

*Jan 26 09:39:48.932: //117/AE79E69580A2/SIP/Info/info/2080/sipSPIDoDTMFRelayNegotiation: Requested DTMF-RELAY option(s) not found in Preferred DTMF-RELAY option list!

*Jan 26 09:39:48.933: //117/AE79E69580A2/SIP/Info/info/32/sipSPIStreamTypeAndDtmfRelay: DTMF Relay mode: Inband Voice

*Jan 26 09:39:48.933: //-1/xxxxxxxxxxxx/SIP/Info/info/8193/sip_sdp_get_modem_relay_cap_params: ptype is 114

*Jan 26 09:39:48.933: //-1/xxxxxxxxxxxx/SIP/Info/info/8193/sip_sdp_get_modem_relay_cap_params: encname is opus

*Jan 26 09:39:48.933: //-1/xxxxxxxxxxxx/SIP/Info/info/8193/sip_sdp_get_modem_relay_cap_params: ptype is 9

*Jan 26 09:39:48.933: //-1/xxxxxxxxxxxx/SIP/Info/info/8193/sip_sdp_get_modem_relay_cap_params: ptype is 124

*Jan 26 09:39:48.933: //-1/xxxxxxxxxxxx/SIP/Info/info/8193/sip_sdp_get_modem_relay_cap_params: encname is ISAC

*Jan 26 09:39:48.933: //-1/xxxxxxxxxxxx/SIP/Info/info/8193/sip_sdp_get_modem_relay_cap_params: ptype is 113

*Jan 26 09:39:48.933: //-1/xxxxxxxxxxxx/SIP/Info/info/8193/sip_sdp_get_modem_relay_cap_params: encname is AMR-WB

*Jan 26 09:39:48.933: //-1/xxxxxxxxxxxx/SIP/Info/info/8193/sip_sdp_get_modem_relay_cap_params: ptype is 115

*Jan 26 09:39:48.933: //-1/xxxxxxxxxxxx/SIP/Info/info/8193/sip_sdp_get_modem_relay_cap_params: encname is AMR-WB

*Jan 26 09:39:48.933: //-1/xxxxxxxxxxxx/SIP/Info/info/8193/sip_sdp_get_modem_relay_cap_params: ptype is 0

*Jan 26 09:39:48.933: //-1/xxxxxxxxxxxx/SIP/Info/info/8193/sip_sdp_get_modem_relay_cap_params: ptype is 8

*Jan 26 09:39:48.933: //-1/xxxxxxxxxxxx/SIP/Info/info/8193/sip_sdp_get_modem_relay_cap_params: ptype is 116

*Jan 26 09:39:48.933: //-1/xxxxxxxxxxxx/SIP/Info/info/8193/sip_sdp_get_modem_relay_cap_params: encname is iLBC

*Jan 26 09:39:48.933: //-1/xxxxxxxxxxxx/SIP/Info/info/8193/sip_sdp_get_modem_relay_cap_params: ptype is 18

*Jan 26 09:39:48.933: //-1/xxxxxxxxxxxx/SIP/Info/info/8193/sip_sdp_get_modem_relay_cap_params: ptype is 101

*Jan 26 09:39:48.967: //117/AE79E69580A2/SIP/Info/info/4096/ccsip_get_flow_mode_frm_set_flow_mode_ev:

*Jan 26 09:39:48.967: //117/AE79E69580A2/SIP/Info/info/4096/is_fa2ft_flow_mode_transition:

*Jan 26 09:39:48.967: //117/AE79E69580A2/SIP/Info/info/4096/ccsip_get_flow_mode_frm_set_flow_mode_ev:

*Jan 26 09:39:48.967: //117/AE79E69580A2/SIP/Info/verbose/4096/ccsip_iwf_process_event: IWF - cnfsm ret 2

*Jan 26 09:39:48.967: //117/AE79E69580A2/SIP/Info/info/4096/ccsip_iwf_handle_peer_event: Return value: SIP_IWF_SUCCESS

*Jan 26 09:39:48.968: //-1/xxxxxxxxxxxx/SIP/Info/info/4096/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 for event 3

*Jan 26 09:39:49.113: //117/AE79E69580A2/SIP/Info/notify/4/sip_gw_video_handle_alert: Video caps are not detected in the caps posted by peer leg

*Jan 26 09:39:49.113: //117/AE79E69580A2/SIP/Info/info/4096/ccsip_call_alert: CCSIP_CALL_ALERT: app_diaplay_name[] app_display_num[2100]

*Jan 26 09:39:49.113: //117/AE79E69580A2/SIP/Info/notify/4096/ccsip_call_alert: CCSIP_CALL_ALERT : KPML_CONFIGURED[TRUE] collect_digits[2100] calledNumber[2100] display_name[] display_num[2100]

*Jan 26 09:39:49.113: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_CALL_ALERTING

*Jan 26 09:39:49.113: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_MEDIA_EVENT

*Jan 26 09:39:49.113: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_MEDIA_EVENT

*Jan 26 09:39:49.113: //-1/xxxxxxxxxxxx/SIP/Info/info/4096/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 for event 5

*Jan 26 09:39:49.113: //117/AE79E69580A2/SIP/Info/critical/8192/sipSPIValidateGtd: Signal Forward disabled

*Jan 26 09:39:49.114: //117/AE79E69580A2/SIP/Info/critical/1024/sipSPIAddCiscoGcid: Fatal Error in parsing CCB/Msg

*Jan 26 09:39:49.114: //117/AE79E69580A2/SIP/Info/critical/8192/sipSPIValidateTunnelData: RawMsg/QSIG Tunneling Not Enabled

*Jan 26 09:39:49.114: //117/AE79E69580A2/SIP/Info/critical/1/sipSPIUpdateCPAInfo: cpa not present

*Jan 26 09:39:49.114: //117/AE79E69580A2/SIP/Error/sipSPI_ipip_set_history_info_header:

 Not SIP2SIP mode

*Jan 26 09:39:49.114: //117/AE79E69580A2/SIP/Info/verbose/4096/sipSPISendInviteResponse: Dialog State: [1]

*Jan 26 09:39:49.114: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_create: created msg=0x7F97CB61A8E0 with refCount = 1

*Jan 26 09:39:49.114: //117/AE79E69580A2/SIP/Info/verbose/4096/sipSPIUaddCcbToTable: Added to table. ccb=0x7F97C21F4850 key=6c5e3bf3-bcd600ff-6ab50493-330a9d66@192.168.36.128B72E5F-B1E balance 1

*Jan 26 09:39:49.114: //117/AE79E69580A2/SIP/Info/info/8192/sipSPIGenerateSessionUUID: Generate uuid

*Jan 26 09:39:49.114: //117/AE79E69580A2/SIP/Info/info/8192/sipSPIGenerateSessionUUID: generated uuid - 27c3e71332855d07b6bf65a2f95ce190

*Jan 26 09:39:49.114: //117/AE79E69580A2/SIP/Info/notify/8192/sipSPIAddSessionID:  localUUID - 27c3e71332855d07b6bf65a2f95ce190 remoteUUID - 09e99aac00105000a0006c5e3bf3bcd6

*Jan 26 09:39:49.114: //117/AE79E69580A2/SIP/Info/notify/8192/sipSPIAddSessionID: Session-ID header 27c3e71332855d07b6bf65a2f95ce190;remote=09e99aac00105000a0006c5e3bf3bcd6

*Jan 26 09:39:49.114: //117/AE79E69580A2/SIP/Event/Session-Timer/sipSTSLMain: Event: E_STSL_SESSION_REFRESH_RESP

*Jan 26 09:39:49.114: //117/AE79E69580A2/SIP/Event/Session-Timer/sipSTSLMain: dir:1, method:102, resp_code:180, container:7F97CAE722C8

*Jan 26 09:39:49.114: //117/AE79E69580A2/SIP/Info/critical/8192/Session-Timer/sipSTSLValidateSessRefreshMsg: Ignoring 1xx response for session timer processing

*Jan 26 09:39:49.114: //117/AE79E69580A2/SIP/Info/verbose/8192/sipSPIPresendProcessing: Presend Processing called for 10 event

*Jan 26 09:39:49.114: //117/AE79E69580A2/SIP/Info/notify/4096/sipSPI_ipip_GetPassthruCopyListDataFromTdContainer: Could not get any elements from TD Container for instance 10, tag 82

*Jan 26 09:39:49.114: //117/AE79E69580A2/SIP/Info/notify/4096/sipSPI_ipip_GetPassthruCopyListDataFromTdContainer: Could not get any elements from TD Container for instance 10, tag 93

*Jan 26 09:39:49.115: //117/AE79E69580A2/SIP/Info/info/4096/ccsip_offer_ans_handle_update_allowed:

*Jan 26 09:39:49.115: //117/AE79E69580A2/SIP/Event/sipSPICreateRpid: Received Octet3A=0x00 -> Setting ;screen=no ;privacy=off

*Jan 26 09:39:49.115: //117/AE79E69580A2/SIP/Info/info/4096/sipSPISendInviteResponse: Associated container=0x7F97CAE722C8 to Invite Response 180

*Jan 26 09:39:49.115: //-1/xxxxxxxxxxxx/SIP/Info/verbose/8192/sipSPIAppHandleContainerBody: sipSPIAppHandleContainerBody len 0

*Jan 26 09:39:49.115: //117/AE79E69580A2/SIP/Transport/sipSPISendInviteResponse: Sending 180 Response to the Transport Layer

*Jan 26 09:39:49.115: //117/AE79E69580A2/SIP/Transport/sipSPITransportSendMessage: msg=0x7F97CB61A8E0, addr=192.168.36.128, port=51630, sentBy_port=51630, local_addr=192.168.36.244, is_req=0, tenant=0, transport=4, switch=0, callBack=0x55836A279580

*Jan 26 09:39:49.115: //117/AE79E69580A2/SIP/Info/info/2048/sipSPIGetExtensionCfg: SIP extension config:1, check sys cfg:1

*Jan 26 09:39:49.115: //117/AE79E69580A2/SIP/Info/info/2048/sipSPIGetExtensionCfg: SIP extension config:1, check sys cfg:1

*Jan 26 09:39:49.115: //117/AE79E69580A2/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately

*Jan 26 09:39:49.115: //117/AE79E69580A2/SIP/Transport/sipTransportLogicSendMsg: Trying to send resp=0x7F97CB61A8E0 to default port=51630

*Jan 26 09:39:49.115: //-1/xxxxxxxxxxxx/SIP/Info/info/4608/sipHolderGetConnInstance: Returning connection details for port 51630 connId 11 tenant_tag 0

*Jan 26 09:39:49.115: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerGetConnection: connection required for raddr:192.168.36.128, rport:51630 with laddr:192.168.36.244

 

*Jan 26 09:39:49.115: //-1/xxxxxxxxxxxx/SIP/Transport/sipInstanceGetConnectionId: gcb=0x7F97C21F4850 is already on connection=0x7F97BECE7F18 context_list

*Jan 26 09:39:49.115: //117/AE79E69580A2/SIP/Transport/sipTransportLogicSendMsg: Connection obtained...sending msg=0x7F97CB61A8E0

*Jan 26 09:39:49.115: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x7F97CB61A8E0, addr=192.168.36.128, port=51630, local_addr=192.168.36.244, tenant=0, connId=11, vrf=, sig_tos=0x60 for TLS

*Jan 26 09:39:49.115: //117/AE79E69580A2/SIP/Info/info/512/sentInviteResponse18x: Sent a 18x Response

*Jan 26 09:39:49.115: //117/AE79E69580A2/SIP/Info/info/8193/ccsipDOInviteResponseSent:

ccsipDOInviteResponseSent: entered, ccb->flags != DELAYED_MEDIA, ccb->flags != EARLY_MEDIA

 

*Jan 26 09:39:49.115: //117/AE79E69580A2/SIP/State/sipSPIChangeState: 0x7F97C21F4850 : State change from (STATE_RECD_INVITE, SUBSTATE_NONE)  to (STATE_SENT_ALERTING, SUBSTATE_NONE)

*Jan 26 09:39:49.115: //-1/xxxxxxxxxxxx/SIP/Info/info/32768/symp_upd_voip_trace_sessionId: Cover Buffer:16, Updating Session-ID:27c3e71332855d07b6bf65a2f95ce190

*Jan 26 09:39:49.116: //-1/xxxxxxxxxxxx/SIP/Info/info/4096/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 for event 29

*Jan 26 09:39:49.116: //-1/xxxxxxxxxxxx/SIP/Info/info/4096/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 for event 29

*Jan 26 09:39:49.116: //117/AE79E69580A2/SIP/Msg/ccsipDisplayMsg:

Sent:

SIP/2.0 180 Ringing

Via: SIP/2.0/TLS 192.168.36.128:51630;branch=z9hG4bK000deb5b

From: "Leonardo Cupellaro" <sip:603@192.168.36.244>;tag=6c5e3bf3bcd6004c65804918-72273e69

To: <sip:2100@192.168.36.244>;tag=B72E5F-B1E

Date: Fri, 26 Jan 2024 09:39:48 GMT

Call-ID: 6c5e3bf3-bcd600ff-6ab50493-330a9d66@192.168.36.128

CSeq: 101 INVITE

Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER

Allow-Events: telephone-event

Remote-Party-ID: <sip:2100@192.168.36.244>;party=called;screen=no;privacy=off

Contact: <sip:2100@192.168.36.244:5061;transport=tls>

Server: Cisco-SIPGateway/IOS-17.9.4a

Session-ID: 27c3e71332855d07b6bf65a2f95ce190;remote=09e99aac00105000a0006c5e3bf3bcd6

Content-Length: 0

 

 

*Jan 26 09:39:49.116: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_free: Freed msg=0x7F97CB61A8E0

*Jan 26 09:39:54.122: //117/AE79E69580A2/SIP/Info/notify/1/ccsip_query_codec_info: Negotiated codec = 6

*Jan 26 09:39:54.122: //117/AE79E69580A2/SIP/Info/verbose/8192/sipSPI_ipip_codec_byte_transrating: NOT SIP-SIP CALL. Will be addressed in future.

*Jan 26 09:39:54.122: //117/AE79E69580A2/SIP/Info/info/4096/ccsip_bridge: confID = 15, srcCallID = 117, dstCallID = 118

*Jan 26 09:39:54.122: //117/AE79E69580A2/SIP/Info/verbose/1/sipSPIUupdateCcCallIds: Old src/dest ccCallids: -1/-1, new src/dest ccCallids: 117/118

*Jan 26 09:39:54.122: //117/AE79E69580A2/SIP/Info/verbose/1/sipSPIUupdateCcCallIds: Old streamcallid=117, new streamcallid=117

*Jan 26 09:39:54.122: //117/AE79E69580A2/SIP/Info/notify/256/ccsip_bridge: xcoder_attached = 0, xmitFunc = 0x558369C0AAC0, ccb xmitFunc = 0x558369C0AAC0

*Jan 26 09:39:54.122: //117/AE79E69580A2/SIP/Info/info/4096/ccsip_iwf_handle_generic_event:

*Jan 26 09:39:54.122: //117/AE79E69580A2/SIP/State/ccsip_cnfsm_debugs: IWF:cur_container:sip_iwf_default_early_dialog_container, cur_state:S_SIP_IWF_SDP_RCVD_AWAIT_PEER_EVENT, event:E_SIP_IWF_EV_CALL_BRIDGE

*Jan 26 09:39:54.122: //117/AE79E69580A2/SIP/State/ccsip_cnfsm_debugs: IWF:new_container:sip_iwf_main_container

*Jan 26 09:39:54.122: //117/AE79E69580A2/SIP/Info/verbose/4096/ccsip_iwf_process_event: IWF - cnfsm ret 2

*Jan 26 09:39:54.123: //117/AE79E69580A2/SIP/Info/verbose/512/ccsip_is_cme_hw_conf: Hardware Conference: False

*Jan 26 09:39:54.123: //117/AE79E69580A2/SIP/Info/info/24576/ccsip_spi_check_call_locally_held: CCSIP: call is locally noton-hold

*Jan 26 09:39:54.123: //117/AE79E69580A2/SIP/Media/sipSPIProcessRtpSessions: Processing stream state = STREAM_ADDING

*Jan 26 09:39:54.123: //117/AE79E69580A2/SIP/Info/verbose/6/sipSPIAddStream: set stream_callid from ccb->ccCallID:0x75, media_type:0

*Jan 26 09:39:54.123: //117/AE79E69580A2/SIP/Media/sipSPIAddStream: Adding stream 1 of type voice-only (callid 117) to the VOIP RTP library

*Jan 26 09:39:54.123: //117/AE79E69580A2/SIP/Info/notify/6/sipSPIValidateStreamAddrType: stream:1, Mode : 1

*Jan 26 09:39:54.123: //117/AE79E69580A2/SIP/Info/verbose/513/resolve_media_ip_address_to_bind: Media already bound, use existing source_media_ip_addr

*Jan 26 09:39:54.123: //117/AE79E69580A2/SIP/Media/sipSPISetMediaSrcAddr: Media src addr for stream 1 = 192.168.36.244

*Jan 26 09:39:54.123: //117/AE79E69580A2/SIP/Media/sipSPIUpdateRtcpSession: sipSPIUpdateRtcpSession for m-line 1

*Jan 26 09:39:54.123: //117/AE79E69580A2/SIP/Info/info/1/sipSPIAssignStreamCallId: Assigning streamid 117 to stream 1. Old streamid = 117

*Jan 26 09:39:54.123: //117/AE79E69580A2/SIP/Info/info/8192/sipSPIUpdateRtcpSession: ccb->flags != LOOPBACK

*Jan 26 09:39:54.123: //117/AE79E69580A2/SIP/Media/sipSPIUpdateRtcpSession: setting do_rtcp= TRUE for non forked leg 1

*Jan 26 09:39:54.123: //117/AE79E69580A2/SIP/Info/info/1/is_call_held: Remote media IP addr: 192.168.36.128

*Jan 26 09:39:54.123: //117/AE79E69580A2/SIP/Info/info/1/is_call_held: Media IP Addr 192.168.36.128, RTCP Type 3

*Jan 26 09:39:54.123: //117/AE79E69580A2/SIP/Media/sipSPIUpdateRtcpSession: rtcp_session info

        laddr = 192.168.36.244, lport = 8030, raddr = 192.168.36.128, rport=21434, do_rtcp=TRUE

        src_callid = 117, dest_callid = 118, stream type = voice-only, stream direction = SENDRECV

        media_ip_addr = 192.168.36.128, vrf tableid = 0 media_addr_type = 1     negotiated_bandwidth (kbps) = 0 srtp_services = 0 nat_flag = 0

*Jan 26 09:39:54.123: //117/AE79E69580A2/SIP/Media/sipSPIUpdateRtcpSession: No rtp session, creating a new one

*Jan 26 09:39:54.124: //117/AE79E69580A2/SIP/Info/verbose/1/sipSPICreateRtpSession: sess: 7F97CA002FD8 do_rtcp:1

*Jan 26 09:39:54.124: //117/AE79E69580A2/SIP/Media/sipSPICreateRtpSession: Stun packet reporting for ICE disabled in sipSPICreateRtpSession

*Jan 26 09:39:54.124: //117/AE79E69580A2/SIP/Media/sipSPICreateRtpSession: Pin hole for firewall traversal is disabled

*Jan 26 09:39:54.124: //117/AE79E69580A2/SIP/Info/critical/131072/sipSPIUpdateRtcpSession: Not able to Associate DSCP Profile with GCCB dscp_policy = 0x0, IS_SIPSPI_MODE_IN_SIP_SIP = 0 dscpPolicySeviceBlock = 0x0 , stream->qos_info = 0x0

*Jan 26 09:39:54.124: //-1/xxxxxxxxxxxx/SIP/Media/sipSPIUpdateRtcpSession: Voice quality monitoring is not enabled for this RTP session due to sdp passthru enabled

*Jan 26 09:39:54.124: //-1/xxxxxxxxxxxx/SIP/Media/sipSPIUpdateRtcpSession: VQM: gccb=0x0, gccb->callId=0, ccb->ccCallID=117

*Jan 26 09:39:54.124: //117/AE79E69580A2/SIP/Info/notify/8193/sipSPICreateAndStartRtpTimer: Media Inactivity Timer is disabled.

*Jan 26 09:39:54.124: //117/AE79E69580A2/SIP/Info/notify/2080/sipSPIUpdateRtcpSession:  DTMF inb/oob disabled

*Jan 26 09:39:54.124: //117/AE79E69580A2/SIP/Info/verbose/4097/sipSPI_ipip_is_escalation: local channels = 1, peer channels = 0

*Jan 26 09:39:54.124: //117/AE79E69580A2/SIP/Info/verbose/4096/sipSPI_ipip_is_escalation: De-escalation

*Jan 26 09:39:54.124: //117/AE79E69580A2/SIP/Media/sipSPIGetNewLocalMediaDirection:

        New Remote Media Direction = SENDRECV

        Present Local Media Direction = SENDRECV

        New Local Media Direction = SENDRECV

        retVal = 0

 

*Jan 26 09:39:54.124: //117/AE79E69580A2/SIP/State/sipSPIChangeStreamState: Stream (callid =  117)  State changed from (STREAM_ADDING) to (STREAM_ACTIVE)

*Jan 26 09:39:54.125: //117/AE79E69580A2/SIP/Info/notify/32/ccsip_bridge:

set dtmf_iw_enabled to FALSE

*Jan 26 09:39:54.125: //117/AE79E69580A2/SIP/Info/info/4096/ccsip_run_deferred_media_negotiate:

*Jan 26 09:39:54.125: //117/AE79E69580A2/SIP/Info/info/4096/ccsip_is_media_negotiate_app_trigger_reinvite_deferred: retVal : 0

*Jan 26 09:39:54.125: //117/AE79E69580A2/SIP/Info/verbose/4096/ccsip_iwf_map_ccapi_event_to_iwf_event: Event Category: 3, Event Id: CC_EV_CONF_CREATE_DONE

*Jan 26 09:39:54.125: //117/AE79E69580A2/SIP/Info/verbose/4096/ccsip_iwf_map_ccapi_event_to_iwf_event: IWF Event: E_SIP_IWF_EV_PEER_CAPS

*Jan 26 09:39:54.125: //117/AE79E69580A2/SIP/State/ccsip_cnfsm_debugs: IWF:cur_container:sip_iwf_default_early_dialog_container, cur_state:S_SIP_IWF_SDP_RCVD_AWAIT_PEER_EVENT, event:E_SIP_IWF_EV_PEER_CAPS

*Jan 26 09:39:54.125: //117/AE79E69580A2/SIP/State/ccsip_cnfsm_debugs: IWF:new_container:sip_iwf_main_container

*Jan 26 09:39:54.126: //117/AE79E69580A2/SIP/Info/info/4096/is_mode_sip_sccp_do_video:

*Jan 26 09:39:54.126: //117/AE79E69580A2/SIP/Info/info/4096/sip_iwf_def_peer_caps_ind_hdlr:

*Jan 26 09:39:54.126: //117/AE79E69580A2/SIP/Info/verbose/4097/ccsip_get_rtcp_session_parameters: CURRENT VALUES: stream_callid=117, current_seq_num=0x9A8

*Jan 26 09:39:54.126: //117/AE79E69580A2/SIP/Info/verbose/4097/ccsip_get_rtcp_session_parameters: NEW VALUES: stream_callid=117, current_seq_num=0x7C0

*Jan 26 09:39:54.126: //117/AE79E69580A2/SIP/Info/info/1/sip_iwf_def_process_caps_ind: Load DSP with negotiated codec: g711alaw, Bytes=160

*Jan 26 09:39:54.126: //117/AE79E69580A2/SIP/Info/verbose/1/sip_iwf_def_process_caps_ind: Set forking flag to 0x0

*Jan 26 09:39:54.126: //117/AE79E69580A2/SIP/Info/info/32/sipSPISetDTMFRelayMode: Set DSP for dtmf-relay = CC_CAP_DTMF_RELAY_INBAND_VOICE_AND_OOB

*Jan 26 09:39:54.126: //117/AE79E69580A2/SIP/Info/info/10241/sip_set_modem_caps: Preferred (or the one that came from DSM) modem relay=1, from CLI config=0

*Jan 26 09:39:54.126: //117/AE79E69580A2/SIP/Info/verbose/12288/sipSPIGetModemInfoPerCall: peer_callID=118

*Jan 26 09:39:54.126: //117/AE79E69580A2/SIP/Info/info/8193/sip_set_modem_caps: Disabling Modem Relay...

*Jan 26 09:39:54.126: //117/AE79E69580A2/SIP/Info/notify/8193/sip_generate_sdp_xcaps_list: Negotiation_done v150_capable 0

*Jan 26 09:39:54.126: //117/AE79E69580A2/SIP/Info/notify/8193/sip_generate_sdp_xcaps_list: Modem Relay and T38 disabled. X-cap not needed

*Jan 26 09:39:54.126: //117/AE79E69580A2/SIP/Info/info/8193/sip_set_modem_caps: Negotiation already Done. Set negotiated Modem caps and generate SDP Xcap list

*Jan 26 09:39:54.127: //117/AE79E69580A2/SIP/Info/info/8193/sip_set_modem_caps: Modem Relay & Passthru both disabled

*Jan 26 09:39:54.127: //117/AE79E69580A2/SIP/Info/info/8193/sip_set_modem_caps: negotiated_mr_cap 0  preferred_mr_cap  0

*Jan 26 09:39:54.127: //117/AE79E69580A2/SIP/Info/info/8193/sip_set_modem_caps: nse payload = 0, ptru mode = 0, ptru-codec=0, redundancy=0, xid=0, relay=0, sprt-retry=12, latecncy=200, compres-dir=3, dict=1024, strnlen=32

*Jan 26 09:39:54.127: //117/AE79E69580A2/SIP/Media/sipSPISetStreamInfo: 1 Active Streams

*Jan 26 09:39:54.127: //117/AE79E69580A2/SIP/Media/sipSPISetStreamInfo: Adding stream type (voice-only) from media

line 1 codec g711alaw

*Jan 26 09:39:54.127: //117/AE79E69580A2/SIP/Media/sipSPISetStreamInfo:

caps.stream_count=1,caps.stream[0].stream_type=0x1, caps.stream_list.xmitFunc=

*Jan 26 09:39:54.127: //117/AE79E69580A2/SIP/Media/sipSPISetStreamInfo: voip_rtp_xmit, caps.stream_list.context=

*Jan 26 09:39:54.127: //117/AE79E69580A2/SIP/Media/sipSPISetStreamInfo: 0x7F97CB5701C8 (gccb)

*Jan 26 09:39:54.127: //117/AE79E69580A2/SIP/Info/info/1/sip_iwf_def_process_caps_ind: Load DSP with codec : g711alaw, Bytes=160, payload = 8

*Jan 26 09:39:54.127: //117/AE79E69580A2/SIP/Info/verbose/1/sip_iwf_def_process_caps_ind: ccsip_caps_ind: ccb->pld.flags_ipip = 0x203

*Jan 26 09:39:54.127: //117/AE79E69580A2/SIP/Info/verbose/1/sip_iwf_def_process_caps_ind: Calling cc_api_caps_ack()

*Jan 26 09:39:54.127: //117/AE79E69580A2/SIP/Info/verbose/4096/ccsip_ipip_media_service_get_event_data: Event id = 8

*Jan 26 09:39:54.127: //117/AE79E69580A2/SIP/State/ccsip_cnfsm_debugs: IPIPMS:cur_container:ccsip_ipip_media_service_main_container, cur_state:S_IPIP_MEDIA_SERV_STATE_IDLE, event:E_IPIP_MEDIA_SERV_EV_PEER_CAPS_IND

*Jan 26 09:39:54.127: //117/AE79E69580A2/SIP/State/ccsip_cnfsm_debugs: IWF:next_state:CNFSM_NO_STATE_CHANGE

*Jan 26 09:39:54.127: //117/AE79E69580A2/SIP/Info/info/4096/ccsip_iwf_handle_peer_event: Return value: SIP_IWF_SUCCESS

*Jan 26 09:39:54.127: //117/AE79E69580A2/SIP/Info/verbose/4096/ccsip_iwf_map_cc_return_code: Mapping SIP_IWF_SUCCESS

*Jan 26 09:39:54.127: //117/AE79E69580A2/SIP/Info/verbose/4096/ccsip_iwf_map_ccapi_event_to_iwf_event: Event Category: 3, Event Id: CC_EV_CONF_DESTROY_DONE

*Jan 26 09:39:54.127: //117/AE79E69580A2/SIP/Info/verbose/4096/ccsip_iwf_map_ccapi_event_to_iwf_event: IWF Event: E_SIP_IWF_EV_PEER_CAPS_ACK,

*Jan 26 09:39:54.127: //117/AE79E69580A2/SIP/State/ccsip_cnfsm_debugs: IWF:cur_container:sip_iwf_default_early_dialog_container, cur_state:S_SIP_IWF_SDP_RCVD_AWAIT_PEER_EVENT, event:E_SIP_IWF_EV_PEER_CAPS_ACK,

*Jan 26 09:39:54.127: //117/AE79E69580A2/SIP/State/ccsip_cnfsm_debugs: IWF:new_container:sip_iwf_main_container

*Jan 26 09:39:54.128: //117/AE79E69580A2/SIP/Info/is_mode_sip_sccp:

*Jan 26 09:39:54.128: //117/AE79E69580A2/SIP/Info/info/4096/sip_iwf_def_peer_caps_ack_hdlr:

*Jan 26 09:39:54.128: //117/AE79E69580A2/SIP/Info/verbose/8193/sip_iwf_tdm_process_caps_ack: Set forking flag to 0x7

*Jan 26 09:39:54.128: //117/AE79E69580A2/SIP/State/ccsip_cnfsm_debugs: IWF:next_state:CNFSM_NO_STATE_CHANGE

*Jan 26 09:39:54.128: //117/AE79E69580A2/SIP/Info/info/4096/ccsip_iwf_handle_peer_event: Return value: SIP_IWF_SUCCESS

*Jan 26 09:39:54.128: //117/AE79E69580A2/SIP/Info/verbose/4096/ccsip_iwf_map_cc_return_code: Mapping SIP_IWF_SUCCESS

*Jan 26 09:39:54.128: //117/AE79E69580A2/SIP/Info/info/4096/ccsip_iwf_handle_generic_event:

*Jan 26 09:39:54.128: //117/AE79E69580A2/SIP/State/ccsip_cnfsm_debugs: IWF:cur_container:sip_iwf_default_early_dialog_container, cur_state:S_SIP_IWF_SDP_RCVD_AWAIT_PEER_EVENT, event:E_SIP_IWF_EV_CALL_CONNECT

*Jan 26 09:39:54.128: //117/AE79E69580A2/SIP/State/ccsip_cnfsm_debugs: IWF:new_container:sip_iwf_main_container

*Jan 26 09:39:54.142: //117/AE79E69580A2/SIP/Info/info/4096/sip_iwf_common_call_connect_hdlr:

*Jan 26 09:39:54.142: //117/AE79E69580A2/SIP/State/ccsip_cnfsm_debugs: IWF:next_state:CNFSM_NO_STATE_CHANGE

*Jan 26 09:39:54.142: //117/AE79E69580A2/SIP/Info/notify/4096/ccsip_call_connect: Connected Number IE received in raw message

*Jan 26 09:39:54.142: //117/AE79E69580A2/SIP/Info/notify/4096/ccsip_call_connect: CCSIP_CALL_CONNECT :  after parsing Display name[] Connected_num[2100] oct3a[128]  update[2]

*Jan 26 09:39:54.142: //-1/xxxxxxxxxxxx/SIP/Info/notify/4096/ccsip_call_connect: CCSIP_CALL_CONNECT: app_diaplay_name[] app_display_num[2100]

*Jan 26 09:39:54.143: //117/AE79E69580A2/SIP/Info/notify/4096/ccsip_call_connect: CCSIP_CALL_CONNECT : KPML_CONFIGURED[TRUE] collect_digits[2100] calledNumber[2100] display_name[] display_num[2100]

*Jan 26 09:39:54.143: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_CALL_CONNECT

*Jan 26 09:39:54.143: //117/AE79E69580A2/SIP/Info/info/4096/ccsip_run_deferred_media_negotiate:

*Jan 26 09:39:54.143: //117/AE79E69580A2/SIP/Info/info/4096/ccsip_is_media_negotiate_app_trigger_reinvite_deferred: retVal : 0

*Jan 26 09:39:54.162: //117/AE79E69580A2/SIP/Info/verbose/4096/ccsip_is_valid_cube_sess_leg_for_count: peer_tag: 40001, CME/SRST sip line: True, CUBE line side: False

*Jan 26 09:39:54.162: //117/AE79E69580A2/SIP/Info/verbose/4096/ccsip_is_valid_cube_sess_leg_for_count: returning False

*Jan 26 09:39:54.162: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_MEDIA_EVENT

*Jan 26 09:39:54.165: //-1/xxxxxxxxxxxx/SIP/Info/info/4096/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 for event 7

*Jan 26 09:39:54.165: //117/AE79E69580A2/SIP/Info/notify/4096/sipAppMsgPlatformPreprocessor: delayed_media:FALSE, recvd msg->type == SIPSPI_EV_CC_CALL_CONNECT, invoke preprocessConnect

*Jan 26 09:39:54.165: //117/AE79E69580A2/SIP/Info/info/9216/sipSPIAddCiscoGcid: Gcid value not set - not adding header.

*Jan 26 09:39:54.165: //117/AE79E69580A2/SIP/Error/sipSPI_ipip_set_history_info_header:

 Not SIP2SIP mode

*Jan 26 09:39:54.165: //117/AE79E69580A2/SIP/Info/notify/1/preprocessConnect: Write sdp_info into msg_body

*Jan 26 09:39:54.165: //117/AE79E69580A2/SIP/Info/critical/8192/sipSPIValidateGtd: Signal Forward disabled

*Jan 26 09:39:54.165: //117/AE79E69580A2/SIP/Info/critical/8192/sipSPIValidateTunnelData: RawMsg/QSIG Tunneling Not Enabled

*Jan 26 09:39:54.166: //117/AE79E69580A2/SIP/Info/critical/1/sipSPIUpdateCPAInfo: cpa not present

*Jan 26 09:39:54.166: //117/AE79E69580A2/SIP/Info/verbose/16/sipSPIGetPreferredSrtpSuiteForBw: Return : 6

*Jan 26 09:39:54.166: //-1/xxxxxxxxxxxx/SIP/Info/verbose/16/sipSPIBwCacGetSrtpOverhead: Return: 16

*Jan 26 09:39:54.166: //-1/xxxxxxxxxxxx/SIP/Info/notify/1/convert_codec_bytes_to_ptime: Values :Codec: g711alaw codecbytes :160, ptime: 20

*Jan 26 09:39:54.166: //117/AE79E69580A2/SIP/Info/info/131074/sipSPIBwCacCalcNegoAudioBandwidth: max audio bw (including pak overhead) from negotiated stream : codec g711alaw   bw 86400 bps    index 1

*Jan 26 09:39:54.166: //117/AE79E69580A2/SIP/Info/info/131072/sipSPIBwCacUpdateAccountedBw: bwcac update accounted BW Option 1 flow mode flow-through

audio bw 86400 bps video bw 0 bps fax bw 0 bps total bw 86400 bps  accounted bw 86400 bps

*Jan 26 09:39:54.166: //117/AE79E69580A2/SIP/Info/info/131072/sipSPIBwCacUpdateAccountedBw: bwcac update accounted bw (initial answer) no change in accounted bw 86400

*Jan 26 09:39:54.166: //117/AE79E69580A2/SIP/Info/info/139264/sipSPIBwCacUpdateInterfaceBw: NOP (no interface change)

*Jan 26 09:39:54.166: //117/AE79E69580A2/SIP/Info/info/133120/sipSPIBwCacIsDialPeerBwAvailable: bwcac NOP dial-peer bw available tag 40001

*Jan 26 09:39:54.166: //117/AE79E69580A2/SIP/Info/info/131072/sipSPIBwCacVerifyBwThreshold: bwcac verify bw threshold, bw available allow call total bw 86400 bps

*Jan 26 09:39:54.166: //117/AE79E69580A2/SIP/Info/verbose/4096/sipSPISendInviteResponse: Dialog State: [1]

*Jan 26 09:39:54.166: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_create: created msg=0x7F97CA000958 with refCount = 1

*Jan 26 09:39:54.166: //117/AE79E69580A2/SIP/Info/info/8192/sipSPIGenerateSessionUUID: Generate uuid

*Jan 26 09:39:54.166: //117/AE79E69580A2/SIP/Info/info/8192/sipSPIGenerateSessionUUID: generated uuid - 27c3e71332855d07b6bf65a2f95ce190

*Jan 26 09:39:54.166: //117/AE79E69580A2/SIP/Info/notify/8192/sipSPIAddSessionID:  localUUID - 27c3e71332855d07b6bf65a2f95ce190 remoteUUID - 09e99aac00105000a0006c5e3bf3bcd6

*Jan 26 09:39:54.166: //117/AE79E69580A2/SIP/Info/notify/8192/sipSPIAddSessionID: Session-ID header 27c3e71332855d07b6bf65a2f95ce190;remote=09e99aac00105000a0006c5e3bf3bcd6

*Jan 26 09:39:54.166: //117/AE79E69580A2/SIP/Event/Session-Timer/sipSTSLMain: Event: E_STSL_SESSION_REFRESH_RESP

*Jan 26 09:39:54.166: //117/AE79E69580A2/SIP/Event/Session-Timer/sipSTSLMain: dir:1, method:102, resp_code:200, container:7F97CAE736B0

*Jan 26 09:39:54.166: //117/AE79E69580A2/SIP/Info/info/8192/Session-Timer/sipSTSLTurnOffSessionTimer: Session timer turned off

*Jan 26 09:39:54.166: //117/AE79E69580A2/SIP/Info/info/8192/Session-Timer/sipSTSLMain:

        SE: 0;refresher:none peer refresher:none, flags:40, posted event:E_STSL_INVALID_PEER_EVENT, reason:4

        Configured SE:1800, Configured Min-SE:1800

*Jan 26 09:39:54.166: //117/AE79E69580A2/SIP/Info/verbose/8192/sipSPIPresendProcessing: Presend Processing called for 29 event

*Jan 26 09:39:54.166: //117/AE79E69580A2/SIP/Info/notify/4096/sipSPI_ipip_GetPassthruCopyListDataFromTdContainer: Could not get any elements from TD Container for instance 29, tag 82

*Jan 26 09:39:54.167: //117/AE79E69580A2/SIP/Info/notify/4096/sipSPI_ipip_GetPassthruCopyListDataFromTdContainer: Could not get any elements from TD Container for instance 29, tag 93

*Jan 26 09:39:54.167: //117/AE79E69580A2/SIP/Info/info/4096/ccsip_offer_ans_handle_sent_sdp:

*Jan 26 09:39:54.167: //117/AE79E69580A2/SIP/State/ccsip_cnfsm_debugs: OA:cur_container:ccsip_offer_ans_main_container, cur_state:S_SIP_EARLY_DIALOG_OFFER_RCVD, event:E_SIP_INVITE_RESP_SDP_SENT

*Jan 26 09:39:54.167: //117/AE79E69580A2/SIP/Info/info/4096/ccsip_offer_ans_is_outgoing_invite_resp_answer_valid:  TRUE

*Jan 26 09:39:54.167: //117/AE79E69580A2/SIP/Info/info/4096/ccsip_offer_ans_common_answer_sent_hdlr:

*Jan 26 09:39:54.167: //117/AE79E69580A2/SIP/Info/info/4096/ccsip_iwf_handle_network_event:

*Jan 26 09:39:54.167: //117/AE79E69580A2/SIP/State/ccsip_cnfsm_debugs: IWF:cur_container:sip_iwf_default_early_dialog_container, cur_state:S_SIP_IWF_SDP_RCVD_AWAIT_PEER_EVENT, event:E_SIP_IWF_EV_SENT_SDP

*Jan 26 09:39:54.167: //117/AE79E69580A2/SIP/Info/info/4096/sip_iwf_def_ed_sent_sdp_answer_hdlr:

*Jan 26 09:39:54.167: //117/AE79E69580A2/SIP/State/ccsip_cnfsm_debugs: IWF:next_state:S_SIP_IWF_SDP_DONE

*Jan 26 09:39:54.167: //117/AE79E69580A2/SIP/State/ccsip_cnfsm_debugs: OA:next_state:S_SIP_EARLY_DIALOG_OFFER_ANSWER_COMPLETE

*Jan 26 09:39:54.167: //117/AE79E69580A2/SIP/Event/sipSPICreateRpid: Received Octet3A=0x00 -> Setting ;screen=no ;privacy=off

*Jan 26 09:39:54.167: //117/AE79E69580A2/SIP/Info/verbose/4096/sipSPIAppAddCallInfoUI: callinfo UI update request for callid: 117

 

*Jan 26 09:39:54.167: //117/AE79E69580A2/SIP/Info/verbose/4096/sipSPIAppAddCallInfoUI: Adding callinfo header=<urn:x-cisco-remotecc:callinfo>; security= Encrypted to msg

*Jan 26 09:39:54.167: //117/AE79E69580A2/SIP/Info/notify/4096/sipSPISendInviteResponse: Add Accept was successful 0

*Jan 26 09:39:54.167: //117/AE79E69580A2/SIP/Info/verbose/4096/sipSPISendInviteResponse: Transaction active. Facilities will be queued.

*Jan 26 09:39:54.167: //117/AE79E69580A2/SIP/Info/info/4096/sipSPISendInviteResponse: Associated container=0x7F97CAE736B0 to Invite Response 200

*Jan 26 09:39:54.168: //-1/xxxxxxxxxxxx/SIP/Info/verbose/8192/sipSPIAppHandleContainerBody: sipSPIAppHandleContainerBody len 184

*Jan 26 09:39:54.168: //117/AE79E69580A2/SIP/Transport/sipSPISendInviteResponse: Sending 200OK Response to the Transport Layer

*Jan 26 09:39:54.168: //117/AE79E69580A2/SIP/Transport/sipSPITransportSendMessage: msg=0x7F97CA000958, addr=192.168.36.128, port=51630, sentBy_port=51630, local_addr=192.168.36.244, is_req=0, tenant=0, transport=4, switch=0, callBack=0x55836A279DE0

*Jan 26 09:39:54.168: //117/AE79E69580A2/SIP/Info/info/2048/sipSPIGetExtensionCfg: SIP extension config:1, check sys cfg:1

*Jan 26 09:39:54.168: //117/AE79E69580A2/SIP/Info/info/2048/sipSPIGetExtensionCfg: SIP extension config:1, check sys cfg:1

*Jan 26 09:39:54.168: //117/AE79E69580A2/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately

*Jan 26 09:39:54.168: //117/AE79E69580A2/SIP/Transport/sipTransportLogicSendMsg: Trying to send resp=0x7F97CA000958 to default port=51630

*Jan 26 09:39:54.168: //-1/xxxxxxxxxxxx/SIP/Info/info/4608/sipHolderGetConnInstance: Returning connection details for port 51630 connId 11 tenant_tag 0

*Jan 26 09:39:54.168: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerGetConnection: connection required for raddr:192.168.36.128, rport:51630 with laddr:192.168.36.244

 

*Jan 26 09:39:54.168: //-1/xxxxxxxxxxxx/SIP/Transport/sipInstanceGetConnectionId: gcb=0x7F97C21F4850 is already on connection=0x7F97BECE7F18 context_list

*Jan 26 09:39:54.168: //117/AE79E69580A2/SIP/Transport/sipTransportLogicSendMsg: Connection obtained...sending msg=0x7F97CA000958

*Jan 26 09:39:54.168: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x7F97CA000958, addr=192.168.36.128, port=51630, local_addr=192.168.36.244, tenant=0, connId=11, vrf=, sig_tos=0x60 for TLS

*Jan 26 09:39:54.168: //117/AE79E69580A2/SIP/Info/info/512/sentInviteResponse200: Sent 200Ok for Invite in state STATE_SENT_ALERTING

*Jan 26 09:39:54.168: //-1/xxxxxxxxxxxx/SIP/Info/verbose/4096/sentInviteResponse200: Transaction active. Facilities will be queued.

*Jan 26 09:39:54.168: //117/AE79E69580A2/SIP/State/sipSPIChangeState: 0x7F97C21F4850 : State change from (STATE_SENT_ALERTING, SUBSTATE_NONE)  to (STATE_SENT_SUCCESS, SUBSTATE_NONE)

*Jan 26 09:39:54.168: //-1/xxxxxxxxxxxx/SIP/Info/info/4096/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 for event 29

*Jan 26 09:39:54.168: //117/AE79E69580A2/SIP/Event/Session-Timer/sipSTSLMain: Event: E_STSL_SPI_EVENT

*Jan 26 09:39:54.168: //117/AE79E69580A2/SIP/Info/info/8192/Session-Timer/sipSTSLMain:

        SE: 0;refresher:none peer refresher:none, flags:40, posted event:E_STSL_INVALID_PEER_EVENT, reason:4

        Configured SE:1800, Configured Min-SE:1800

*Jan 26 09:39:54.168: //117/AE79E69580A2/SIP/Info/verbose/4096/ccsip_buffer_media_event: Buffering event SIPSPI_EV_CC_MEDIA_EVENT - Purpose 1: FALSE

 

*Jan 26 09:39:54.169: //117/AE79E69580A2/SIP/Msg/ccsipDisplayMsg:

Sent:

SIP/2.0 200 OK

Via: SIP/2.0/TLS 192.168.36.128:51630;branch=z9hG4bK000deb5b

From: "Leonardo Cupellaro" <sip:603@192.168.36.244>;tag=6c5e3bf3bcd6004c65804918-72273e69

To: <sip:2100@192.168.36.244>;tag=B72E5F-B1E

Date: Fri, 26 Jan 2024 09:39:48 GMT

Call-ID: 6c5e3bf3-bcd600ff-6ab50493-330a9d66@192.168.36.128

CSeq: 101 INVITE

Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER

Allow-Events: telephone-event

Remote-Party-ID: <sip:2100@192.168.36.244>;party=called;screen=no;privacy=off

Call-Info: <urn:x-cisco-remotecc:callinfo>; security= Encrypted

Contact: <sip:2100@192.168.36.244:5061;transport=tls>

Supported: replaces

Server: Cisco-SIPGateway/IOS-17.9.4a

Session-ID: 27c3e71332855d07b6bf65a2f95ce190;remote=09e99aac00105000a0006c5e3bf3bcd6

Supported: timer

Content-Type: application/sdp

Content-Disposition: session;handling=required

Content-Length: 184

 

v=0

o=CiscoSystemsSIP-GW-UserAgent 8605 630 IN IP4 192.168.36.244

s=SIP Call

c=IN IP4 192.168.36.244

t=0 0

m=audio 8030 RTP/SAVP 8

c=IN IP4 192.168.36.244

a=rtpmap:8 PCMA/8000

 

*Jan 26 09:39:54.169: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_free: Freed msg=0x7F97CA000958

*Jan 26 09:39:54.195: //-1/xxxxxxxxxxxx/SIP/Transport/sip_find_connid_by_fd: Map fd 0 to index 11

 

*Jan 26 09:39:54.195: //-1/xxxxxxxxxxxx/SIP/Info/notify/512/sip_tls_tcp_read_socket:

ReadBlock nbytes 1226 offset 0

*Jan 26 09:39:54.195: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_create: created msg=0x7F97CA000958 with refCount = 1

*Jan 26 09:39:54.195: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_create: created msg=0x7F97CA001358 with refCount = 1

*Jan 26 09:39:54.196: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_process_network_msg: Content Length 0, Bytes Remaining 526

*Jan 26 09:39:54.196: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_create: created msg=0x7F97CA001600 with refCount = 1

*Jan 26 09:39:54.196: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_free: Freed msg=0x7F97CA000958

*Jan 26 09:39:54.196: //-1/xxxxxxxxxxxx/SIP/Info/info/4096/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for event 1

*Jan 26 09:39:54.196: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x0

*Jan 26 09:39:54.196: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerProcessNewConnMsg: gConnTab=0x7F97BE8850B0, remote_addr=192.168.36.128, remote_port=51630, local_addr=192.168.36.244, local_port=5061, connid=11, tenant=0, vrf=, transport=TLS Over TCP

*Jan 26 09:39:54.196: //-1/xxxxxxxxxxxx/SIP/Info/info/4608/sipHolderGetConnInstance: Return existing connection for port 51630 connId 11 tenant_tag 0

*Jan 26 09:39:54.196: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:

Received:

ACK sip:2100@192.168.36.244:5061;transport=tls SIP/2.0

Via: SIP/2.0/TLS 192.168.36.128:51630;branch=z9hG4bK7bbe787d

From: "Leonardo Cupellaro" <sip:603@192.168.36.244>;tag=6c5e3bf3bcd6004c65804918-72273e69

To: <sip:2100@192.168.36.244>;tag=B72E5F-B1E

Call-ID: 6c5e3bf3-bcd600ff-6ab50493-330a9d66@192.168.36.128

Max-Forwards: 70

Session-ID: 09e99aac00105000a0006c5e3bf3bcd6;remote=27c3e71332855d07b6bf65a2f95ce190

Date: Fri, 26 Jan 2024 09:38:13 GMT

CSeq: 101 ACK

User-Agent: Cisco-CP8851/12.5.1

Remote-Party-ID: "Leonardo Cupellaro" <sip:603@192.168.36.244>;party=calling;id-type=subscriber;privacy=off;screen=yes

Content-Length: 0

Recv-Info: conference

Recv-Info: x-cisco-conference

 

 

*Jan 26 09:39:54.196: //-1/xxxxxxxxxxxx/SIP/Info/verbose/4096/ccsip_new_msg_preprocessor: Checking Invite Dialog

*Jan 26 09:39:54.197: //117/AE79E69580A2/SIP/Info/verbose/4096/sipSPIFindCcbUASRespTable: *****CCB found in UAS Response table. ccb=0x7F97C21F4850

*Jan 26 09:39:54.197: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_lock: Increment msg (0x7F97CA001358) counter, current msg->refCount = 2

*Jan 26 09:39:54.197: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 192.168.36.128,Port 51630, Transport 4, SentBy Port 5060vrfid 0, tenant 0

*Jan 26 09:39:54.197: //-1/xxxxxxxxxxxx/SIP/Info/verbose/8192/sipSPISetDateHeader: Clock Time Zone is UTC, same as GMT: Using GMT

*Jan 26 09:39:54.197: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 192.168.36.128,Port 51630, Transport 4, SentBy Port 51630vrfid 0, tenant 0

*Jan 26 09:39:54.197: //117/AE79E69580A2/SIP/Info/info/4096/sipSPISetCallingInfo: calling host comes from From: 192.168.36.244

*Jan 26 09:39:54.197: //117/AE79E69580A2/SIP/Info/verbose/32768/ccsip_ipip_media_forking_copy_prev_best_rpid: MF: Delete the previous remote party id..

*Jan 26 09:39:54.197: //117/AE79E69580A2/SIP/Info/verbose/32768/ccsip_ipip_media_forking_copy_prev_best_rpid: MF: This is best rpid..

*Jan 26 09:39:54.197: //117/AE79E69580A2/SIP/Info/verbose/4096/sipSPIUpdateCallingInfoUsingRpidOrFrom: Updating Calling Info with RPID header data

*Jan 26 09:39:54.197: //117/AE79E69580A2/SIP/Info/verbose/4096/sipSPISetInfoFromRpid: calling host comes from rpid 192.168.36.244

*Jan 26 09:39:54.197: //117/AE79E69580A2/SIP/Info/info/4096/sipSPISetInfoFromRpid: Received current remote name: Leonardo Cupellaro, current remote number: 603

*Jan 26 09:39:54.198: //117/AE79E69580A2/SIP/Info/info/4096/sipSPISetInfoFromRpid: Received ;screen=yes ;privacy=off -> Setting Octet3A 0x81, extended_privacy 0x00

*Jan 26 09:39:54.198: //117/AE79E69580A2/SIP/Info/verbose/4096/act_sentsucc_new_message_request: Transaction Complete. Lock on Facilities released.

*Jan 26 09:39:54.198: //117/AE79E69580A2/SIP/Info/info/8192/sipSPIExtractSessionID: Parsed localuuid  - 09e99aac00105000a0006c5e3bf3bcd6  remoteuuid - 27c3e71332855d07b6bf65a2f95ce190

*Jan 26 09:39:54.198: //117/AE79E69580A2/SIP/Info/notify/8192/sipSPI_Add_SessionIDtoTDContainer: localUUID - 09e99aac00105000a0006c5e3bf3bcd6remoteUUID - 27c3e71332855d07b6bf65a2f95ce190

*Jan 26 09:39:54.198: //117/AE79E69580A2/SIP/Info/info/8192/sipSPIProcessSessionID: SessionID header is present- 09e99aac00105000a0006c5e3bf3bcd6

*Jan 26 09:39:54.198: //117/AE79E69580A2/SIP/State/sipSPIChangeState: 0x7F97C21F4850 : State change from (STATE_SENT_SUCCESS, SUBSTATE_NONE)  to (STATE_ACTIVE, SUBSTATE_NONE)

*Jan 26 09:39:54.198: //117/AE79E69580A2/SIP/Call/sipSPICallInfo:

The Call Setup Information is:

Call Control Block (CCB) : 0x0x7F97C21F4850

State of The Call        : STATE_ACTIVE

TCP Sockets Used         : YES

Calling Number           : 603

Called Number            : 2100

Source IP Address (Sig  192.168.36.244

Destn SIP Req Addr:Port  : 192.168.36.128:51630

Destn SIP Resp Addr:Port : 192.168.36.128:51630

Destination Name         : 192.168.36.128

 

*Jan 26 09:39:54.198: //117/AE79E69580A2/SIP/Call/sipSPIMediaCallInfo:

Number of Media Streams: 1

Media Stream             : 1

Negotiated Codec         : g711alaw

Negotiated Codec Bytes   : 160

Nego. Codec payload      : 8 (tx), 8 (rx)

Negotiated Dtmf-relay    : 0

Dtmf-relay Payload       : 0 (tx), 0 (rx)

Source IP Address (Media): 192.168.36.244

Source IP Port    (Media): 8030

Destn  IP Address (Media): 192.168.36.128

Destn  IP Port    (Media): 21434

Orig Destn IP Address:Port (Media): [ - ]:0

 

*Jan 26 09:39:54.198: //117/AE79E69580A2/SIP/Info/notify/8193/sipSPICreateAndStartRtpTimer: Media Inactivity Timer is disabled.

*Jan 26 09:39:54.229: //-1/xxxxxxxxxxxx/SIP/Info/info/1024/httpish_msg_free: Freed msg=0x7F97C9FFF218

 

Debug ISDN Q931 detail and Debug ISDN Q931 of the call:

 

 

*Jan 26 09:47:20.070: ISDN BR0/2/0:0 Q931d: Default type/plan 0x0 0x0 sw-type 1 Calling number 603 isdn_map 0 mask 0x3042

*Jan 26 09:47:20.070: ISDN BR0/2/0:0 Q931d: Calling plan/type unspecified in call_decode, so ignored.

*Jan 26 09:47:20.070: ISDN BR0/2/0:0 Q931d: No call_decode, isdn default set

*Jan 26 09:47:20.071: ISDN BR0/2/0:0 Q931: Applying typeplan for sw-type 0x1 is 0x0 0x0, Calling num 603; Oct3a 0x81

*Jan 26 09:47:20.071: ISDN BR0/2/0:0 Q931d: Default type/plan 0x0 0x0 sw-type 1 Called number 2100 isdn_map 0 mask 0x3042

*Jan 26 09:47:20.071: ISDN BR0/2/0:0 Q931d: Called plan/type unspecified in call_decode, so ignored.

*Jan 26 09:47:20.071: ISDN BR0/2/0:0 Q931d: No call_decode, isdn default set

*Jan 26 09:47:20.071: ISDN BR0/2/0:0 Q931: Applying typeplan for sw-type 0x1 is 0x0 0x0, Called num 2100

*Jan 26 09:47:20.071: ISDN BR0/2/0:0 Q931d: L3_Go: source 0x0400, ces 1, event 0x0080, call id 0x800D, int id 0x0

*Jan 26 09:47:20.071: ISDN BR0/2/0:0 Q931d: L3_Go: event 0x80  cr_len 1 cr 0

*Jan 26 09:47:20.071: ISDN BR0/2/0:0 Q931d: L3_state_change: callref 0x0000 old UNKNOWN_STATE, new NULL_STATE

*Jan 26 09:47:20.071: ISDN BR0/2/0:0 Q931d: L3_Go: call_id 0x800D cr 0x0 state 0 event 0x80 ces 0

*Jan 26 09:47:20.071: ISDN BR0/2/0:0 Q931d: L3_ProcessEvent: callref = 0x0000 CC_SETUP_REQ:U0_SetupReq(nlcb)

*Jan 26 09:47:20.071: ISDN BR0/2/0:0 Q931d: srl_send_l3_pak:

        source_id = Q.931 0x0300, dest_id = Q.921 0x0000, prim = DL_UI_DATA_REQ 0x0250

        priv_len = 4 int_id = 0x0x7F97B9FB2E58 datasize = 66

*Jan 26 09:47:20.071: ISDN BR0/2/0:0 Q931d: data =

*Jan 26 09:47:20.071:   00007F97B9FB2E5800000300025004A5

*Jan 26 09:47:20.071:   000027060801060504038090A3180189

*Jan 26 09:47:20.071:   28124C656F6E6172646F20437570656C

*Jan 26 09:47:20.071:   6C61726F6C0500813630337005803231

*Jan 26 09:47:20.071:   3030

*Jan 26 09:47:20.072: ISDN BR0/2/0:0 Q931: Sending SETUP  callref = 0x0006 callID = 0x800D switch = basic-net3 interface = Network

*Jan 26 09:47:20.072: ISDN BR0/2/0:0 Q931d: L3_state_change: callref 0x0006 old NULL_STATE, new CALL_INIT

*Jan 26 09:47:20.072: ISDN BR0/2/0:0 Q931: TX -> SETUP pd = 8  callref = 0x06

        Bearer Capability i = 0x8090A3

                Standard = CCITT

                Transfer Capability = Speech

                Transfer Mode = Circuit

                Transfer Rate = 64 kbit/s

        Channel ID i = 0x89

                Exclusive, B1

        Display i = 'Leonardo Cupellaro'

        Calling Party Number i = 0x0081, '603'

                Plan:Unknown, Type:Unknown

        Called Party Number i = 0x80, '2100'

                Plan:Unknown, Type:Unknown

*Jan 26 09:47:20.179: ISDN BR0/2/0:0 Q931: RX <- SETUP_ACK pd = 8  callref = 0x86

        Channel ID i = 0x89

                Exclusive, B1

*Jan 26 09:47:20.179: ISDN BR0/2/0:0 Q931d: L3IF_rx_L2_pak: received data

*Jan 26 09:47:20.179:   0801860D180189

*Jan 26 09:47:20.180: ISDN BR0/2/0:0 Q931d: L3_Go: source 0x020A, ces 1, event 0x000D, call id 0x0000, int id 0x0

*Jan 26 09:47:20.180: ISDN BR0/2/0:0 Q931d: L3_Go: event 0xD  cr_len 1 cr 6

*Jan 26 09:47:20.180: ISDN BR0/2/0:0 Q931d: L3_Go: call_id 0x800D cr 0x6 state 1 event 0xD ces 0

*Jan 26 09:47:20.180: ISDN BR0/2/0:0 Q931d: L3_ProcessEvent: callref = 0x0006 SETUP_ACK:U1_SetupAck(nlcb)

*Jan 26 09:47:20.180: ISDN BR0/2/0:0 Q931d: L3_GetNew_NLCB: call_id 0x800D int_id 0, ces 1

*Jan 26 09:47:20.180: ISDN BR0/2/0:0 Q931d: L3_state_change: callref 0x0006 old DL_IDLE_STATE, new BROADCAST_STATE

*Jan 26 09:47:20.181: ISDN BR0/2/0:0 Q931d: L3_state_change: callref 0x0006 old CALL_INIT, new OVERLAP_SENDING

*Jan 26 09:47:20.181: ISDN BR0/2/0:0 Q931d: L3_ProcessEvent: callref = 0x0006 L3_INT_SETUP_ACK_REQ:U0I_IntSetupAckReq(nlcb)

*Jan 26 09:47:20.181: ISDN BR0/2/0:0 Q931d: L3_state_change: callref 0x0006 old BROADCAST_STATE, new UNKNOWN_STATE

*Jan 26 09:47:20.231: ISDN BR0/2/0:0 Q931: RX <- ALERTING pd = 8  callref = 0x86

*Jan 26 09:47:20.231: ISDN BR0/2/0:0 Q931d: L3IF_rx_L2_pak: received data

*Jan 26 09:47:20.231:   08018601

*Jan 26 09:47:20.231: ISDN BR0/2/0:0 Q931d: L3_Go: source 0x020A, ces 1, event 0x0001, call id 0x0000, int id 0x0

*Jan 26 09:47:20.231: ISDN BR0/2/0:0 Q931d: L3_Go: event 0x1  cr_len 1 cr 6

*Jan 26 09:47:20.231: ISDN BR0/2/0:0 Q931d: L3_Go: call_id 0x800D cr 0x6 state 32 event 0x1 ces 1

*Jan 26 09:47:20.231: ISDN BR0/2/0:0 Q931d: L3_ProcessEvent: callref = 0x0006 ALERTING:U2I_Alerting(nlcb)

*Jan 26 09:47:20.231: ISDN BR0/2/0:0 Q931d: L3_state_change: callref 0x0006 old UNKNOWN_STATE, new UNKNOWN_STATE

*Jan 26 09:47:20.231: ISDN BR0/2/0:0 Q931d: L3_ProcessEvent: callref = 0x0006 L3_INT_ALERT_IND:U2_IntAlertInd(nlcb)

*Jan 26 09:47:20.232: ISDN BR0/2/0:0 Q931d: L3_state_change: callref 0x0006 old OVERLAP_SENDING, new CALL_DELIVERED

*Jan 26 09:47:24.660: ISDN BR0/2/0:0 Q931: RX <- CONNECT pd = 8  callref = 0x86

        Connected Number i = 0x0080, '2100'

*Jan 26 09:47:24.660: ISDN BR0/2/0:0 Q931d: L3IF_rx_L2_pak: received data

*Jan 26 09:47:24.660:   080186074C06008032313030

*Jan 26 09:47:24.661: ISDN BR0/2/0:0 Q931d: L3_Go: source 0x020A, ces 1, event 0x0007, call id 0x0000, int id 0x0

*Jan 26 09:47:24.661: ISDN BR0/2/0:0 Q931d: L3_Go: event 0x7  cr_len 1 cr 6

*Jan 26 09:47:24.661: ISDN BR0/2/0:0 Q931d: L3_Go: call_id 0x800D cr 0x6 state 34 event 0x7 ces 1

*Jan 26 09:47:24.661: ISDN BR0/2/0:0 Q931d: L3_ProcessEvent: callref = 0x0006 CONNECT:U4I_Connect(nlcb)

*Jan 26 09:47:24.661: ISDN BR0/2/0:0 Q931d: L3_state_change: callref 0x0006 old UNKNOWN_STATE, new UNKNOWN_STATE

*Jan 26 09:47:24.661: ISDN BR0/2/0:0 Q931d: L3_ProcessEvent: callref = 0x0006 L3_INT_CONN_IND:U4_IntConnInd(nlcb)

*Jan 26 09:47:24.661: ISDN BR0/2/0:0 Q931d: L3_ProcessEvent: callref = 0x0006 L3_INT_CONN_COMP_REQ:U8I_IntConnCompReq(nlcb)

*Jan 26 09:47:24.661: ISDN BR0/2/0:0 Q931d: srl_send_l3_pak:

        source_id = Q.931 0x0300, dest_id = Q.921 0x0000, prim = DL_DATA_REQ 0x0240

        priv_len = 4 int_id = 0x0x7F97B9FB2E58 datasize = 24

*Jan 26 09:47:24.661: ISDN BR0/2/0:0 Q931d: data =

*Jan 26 09:47:24.661:   00007F97B9FB2E580000030002400401

*Jan 26 09:47:24.661:   000127000801060F

*Jan 26 09:47:24.661: ISDN BR0/2/0:0 Q931d: L3_state_change: callref 0x0006 old UNKNOWN_STATE, new CALL_ACTIVE

*Jan 26 09:47:24.661: ISDN BR0/2/0:0 Q931d: L3_state_change: callref 0x0006 old CALL_DELIVERED, new UNKNOWN_STATE

*Jan 26 09:47:24.661: ISDN BR0/2/0:0 Q931d: isdn_get_name: No Name

*Jan 26 09:47:24.662: ISDN BR0/2/0:0 Q931: TX -> CONNECT_ACK pd = 8  callref = 0x06

*Jan 26 09:47:24.772: ISDN BR0/2/0:0 Q931d: L3_Go: source 0x0400, ces 1, event 0x0084, call id 0x800D, int id 0x0

*Jan 26 09:47:24.772: ISDN BR0/2/0:0 Q931d: L3_Go: event 0x84  cr_len 1 cr 6

*Jan 26 09:47:24.772: ISDN BR0/2/0:0 Q931d: L3_Go: call_id 0x800D cr 0x6 state 10 event 0x84 ces 1

*Jan 26 09:47:24.772: ISDN BR0/2/0:0 Q931d: L3_ProcessEvent: callref = 0x0006 CC_DISCONNECT_REQ:Ux_DiscReq(nlcb)

*Jan 26 09:47:24.772: ISDN BR0/2/0:0 Q931d: srl_send_l3_pak:

        source_id = Q.931 0x0300, dest_id = Q.921 0x0000, prim = DL_DATA_REQ 0x0240

        priv_len = 4 int_id = 0x0x7F97B9FB2E58 datasize = 28

*Jan 26 09:47:24.772: ISDN BR0/2/0:0 Q931d: data =

*Jan 26 09:47:24.772:   00007F97B9FB2E580000030002400409

*Jan 26 09:47:24.772:   000127000801064508028290

*Jan 26 09:47:24.772: ISDN BR0/2/0:0 Q931d: L3_state_change: callref 0x0006 old CALL_ACTIVE, new DISCONNECT_REQUEST

*Jan 26 09:47:24.773: ISDN BR0/2/0:0 Q931: TX -> DISCONNECT pd = 8  callref = 0x06

        Cause i = 0x8290 - Normal call clearing

*Jan 26 09:47:24.858: ISDN BR0/2/0:0 Q931: RX <- RELEASE pd = 8  callref = 0x86

        Cause i = 0x8090 - Normal call clearing

*Jan 26 09:47:24.858: ISDN BR0/2/0:0 Q931d: L3IF_rx_L2_pak: received data

*Jan 26 09:47:24.858:   0801864D08028090

*Jan 26 09:47:24.858: ISDN BR0/2/0:0 Q931d: L3_Go: source 0x020A, ces 1, event 0x004D, call id 0x0000, int id 0x0

*Jan 26 09:47:24.859: ISDN BR0/2/0:0 Q931d: L3_Go: event 0x4D  cr_len 1 cr 6

*Jan 26 09:47:24.859: ISDN BR0/2/0:0 Q931d: L3_Go: call_id 0x800D cr 0x6 state 11 event 0x4D ces 1

*Jan 26 09:47:24.859: ISDN BR0/2/0:0 Q931d: L3_ProcessEvent: callref = 0x0006 RELEASE:U11_Release(nlcb)

*Jan 26 09:47:24.859: ISDN BR0/2/0:0 Q931d: srl_send_l3_pak:

        source_id = Q.931 0x0300, dest_id = Q.921 0x0000, prim = DL_DATA_REQ 0x0240

        priv_len = 4 int_id = 0x0x7F97B9FB2E58 datasize = 24

*Jan 26 09:47:24.859: ISDN BR0/2/0:0 Q931d: data =

*Jan 26 09:47:24.859:   00007F97B9FB2E580000030002400400

*Jan 26 09:47:24.859:   000127020801065A

*Jan 26 09:47:24.859: ISDN BR0/2/0:0 Q931d: L3_Go: source 0x0400, ces 1, event 0x00AB, call id 0x800D, int id 0x0

*Jan 26 09:47:24.859: ISDN BR0/2/0:0 Q931d: L3_Go: event 0xAB  cr_len 1 cr 6

*Jan 26 09:47:24.859: ISDN BR0/2/0:0 Q931d: L3_Go: call_id 0x800D cr 0x0 state 0 event 0xAB ces 1

*Jan 26 09:47:24.859: ISDN BR0/2/0:0 Q931d: L3_ProcessEvent: callref = 0x0000 CC_REL_COMP_REQ:Ux_RelCompReq(nlcb)

*Jan 26 09:47:24.860: ISDN BR0/2/0:0 Q931: TX -> RELEASE_COMP pd = 8  callref = 0x06

 

 

 

Preview file
34 KB
Preview file
15 KB
0 Helpful
1 Accepted Solution

Accepted Solutions

Go to solution
Leonardo Cupellaro
Level 1
Level 1

‎01-30-2024 01:10 AM

Thanks anyway, i solved the problem by adding the command "srtp pass-thru" under "voice service voip".

View solution in original post

7 Replies 7

Go to solution
Carlo Poggiarelli
VIP
VIP

‎01-26-2024 06:30 AM

Hi Leonardo,

Under Voice Register Global, please add "mode cme" command.

Under Voice service Voip / sip

early-offer forced

 

Please than send a debug ccisp message output only after placing a call.

 

 

thanks a lot

 

Regards

 

Carlo

Please rate all helpful posts "The more you help the more you learn"
0 Helpful

Go to solution
Leonardo Cupellaro
Level 1
Level 1
In response to Carlo Poggiarelli

‎01-29-2024 01:11 AM

Good morning Carlo,

i haven't configured the voice gateway as Call Manager Express so if i add the command "mode cme" it will no longer register the phones.

I send you the ccsip trace after forcing the early offer.

Thanks.

Debug CCSIP

*Jan 29 08:41:30.552: //199/05A42F888089/SIP/Msg/ccsipDisplayMsg:

Sent:

SIP/2.0 200 OK

Via: SIP/2.0/TLS 192.168.36.128:50183;branch=z9hG4bK05c17be7

From: "Leonardo Cupellaro" <sip:603@192.168.36.244>;tag=6c5e3bf3bcd6001518344441-770fdb3e

To: <sip:2100@192.168.36.244>;tag=58DAE7-686

Date: Mon, 29 Jan 2024 08:41:25 GMT

Call-ID: 6c5e3bf3-bcd60008-7cf1fb41-08a0a4a4@192.168.36.128

CSeq: 101 INVITE

Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER

Allow-Events: telephone-event

Remote-Party-ID: <sip:2100@192.168.36.244>;party=called;screen=no;privacy=off

Call-Info: <urn:x-cisco-remotecc:callinfo>; security= Encrypted

Contact: <sip:2100@192.168.36.244:5061;transport=tls>

Supported: replaces

Server: Cisco-SIPGateway/IOS-17.9.4a

Session-ID: 1e17365bd60e522bbca58d7735ff7393;remote=5968b4c800105000a0006c5e3bf3bcd6

Supported: timer

Content-Type: application/sdp

Content-Disposition: session;handling=required

Content-Length: 185

 

v=0

o=CiscoSystemsSIP-GW-UserAgent 6733 7714 IN IP4 192.168.36.244

s=SIP Call

c=IN IP4 192.168.36.244

t=0 0

m=audio 8004 RTP/SAVP 8

c=IN IP4 192.168.36.244

a=rtpmap:8 PCMA/8000

 

*Jan 29 08:41:30.580: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:

Received:

ACK sip:2100@192.168.36.244:5061;transport=tls SIP/2.0

Via: SIP/2.0/TLS 192.168.36.128:50183;branch=z9hG4bK773d90c0

From: "Leonardo Cupellaro" <sip:603@192.168.36.244>;tag=6c5e3bf3bcd6001518344441-770fdb3e

To: <sip:2100@192.168.36.244>;tag=58DAE7-686

Call-ID: 6c5e3bf3-bcd60008-7cf1fb41-08a0a4a4@192.168.36.128

Max-Forwards: 70

Session-ID: 5968b4c800105000a0006c5e3bf3bcd6;remote=1e17365bd60e522bbca58d7735ff7393

Date: Mon, 29 Jan 2024 08:39:49 GMT

CSeq: 101 ACK

User-Agent: Cisco-CP8851/12.5.1

Remote-Party-ID: "Leonardo Cupellaro" <sip:603@192.168.36.244>;party=calling;id-type=subscriber;privacy=off;screen=yes

Content-Length: 0

Recv-Info: conference

Recv-Info: x-cisco-conference

 

 

*Jan 29 08:41:30.582: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:

Received:

BYE sip:2100@192.168.36.244:5061;transport=tls SIP/2.0

Via: SIP/2.0/TLS 192.168.36.128:50183;branch=z9hG4bK5302c378

From: "Leonardo Cupellaro" <sip:603@192.168.36.244>;tag=6c5e3bf3bcd6001518344441-770fdb3e

To: <sip:2100@192.168.36.244>;tag=58DAE7-686

Call-ID: 6c5e3bf3-bcd60008-7cf1fb41-08a0a4a4@192.168.36.128

Max-Forwards: 70

Session-ID: 5968b4c800105000a0006c5e3bf3bcd6;remote=1e17365bd60e522bbca58d7735ff7393

Date: Mon, 29 Jan 2024 08:39:49 GMT

CSeq: 102 BYE

User-Agent: Cisco-CP8851/12.5.1

Content-Length: 0

 

 

*Jan 29 08:41:30.657: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:

Sent:

SIP/2.0 200 OK

Via: SIP/2.0/TLS 192.168.36.128:50183;branch=z9hG4bK5302c378

From: "Leonardo Cupellaro" <sip:603@192.168.36.244>;tag=6c5e3bf3bcd6001518344441-770fdb3e

To: <sip:2100@192.168.36.244>;tag=58DAE7-686

Date: Mon, 29 Jan 2024 08:41:30 GMT

Call-ID: 6c5e3bf3-bcd60008-7cf1fb41-08a0a4a4@192.168.36.128

Server: Cisco-SIPGateway/IOS-17.9.4a

CSeq: 102 BYE

Reason: Q.850;cause=16

P-RTP-Stat: PS=0,OS=0,PR=0,OR=0,PL=0,JI=1,LA=-1,DU=0

Session-ID: 1e17365bd60e522bbca58d7735ff7393;remote=1e17365bd60e522bbca58d7735ff7393

Content-Length: 0

 

 

 

Preview file
14 KB
0 Helpful

Go to solution
Carlo Poggiarelli
VIP
VIP

‎01-29-2024 06:36 AM

Hi Leonardo,

Please send a complete debug isdn q931 and debug ccsip message from the beginning to the end of the call.

Please make an inboud (From Siemens) and an outbound call

 

 

Thanks

 

Regards

 

Carlo

Please rate all helpful posts "The more you help the more you learn"
0 Helpful

Go to solution
Maren Mahoney
VIP
VIP
In response to Carlo Poggiarelli

‎01-29-2024 01:00 PM

And, if you would, please post your debug as a file attached to a post here, rather than pasting the debug into the window. It makes it easier for us to look at the data. Thanks!

Maren

0 Helpful

Go to solution
Leonardo Cupellaro
Level 1
Level 1

‎01-29-2024 11:27 PM

Good morning,

i attach the debugs you requested.

Thanks.

Leonardo.

Preview file
15 KB
Preview file
15 KB
Preview file
13 KB
Preview file
13 KB
0 Helpful

Go to solution
Leonardo Cupellaro
Level 1
Level 1

‎01-30-2024 01:10 AM

Thanks anyway, i solved the problem by adding the command "srtp pass-thru" under "voice service voip".

Go to solution
Carlo Poggiarelli
VIP
VIP

‎01-30-2024 01:32 AM

Hi Leonardo,

You beat me on time ':)'

After your log I was suggesting the same

 

Nice one!

 

 

Please rate all helpful posts "The more you help the more you learn"
0 Helpful
Customers Also Viewed These Support Documents