VIdeo call VCS --> CUCM disconect Reason: Q.850;cause=127

[macieknowak]

Hello,

We have problem with the video connection from VCS server through CUCM to EX90 terminal. We use CUCM 9.X and TC6.1.2 software on EX90. The video is present only for 5 sesonds and the call is disconected. We see a Reason: Q.850;cause=127 in a BYE message. The BYE message is send from CUCM toEX 90.

Scenario:

Terminal---->VCS----->CUCM9.1---->EX90

VCS -                   89.25.207.155
CUCM 9.X -        172.21.66.189
EX90 TC6.1.2 -  10.36.237.227

Calling number - 48321000000
Called number -  22012

VCS to VCS video works great

CUCM to CUCM video works great

When we use only audio the call is OK. The problem is present with Video call.

SIP LOG:

SENDER: [Siptrunk] 89.25.207.155
GUID: 5ca468605c0ff09d67acf20b3e8957542961591715
MSG_LABEL: INVITE
RECEIVER: 172.21.66.189
MAC_ADDRESS: Siptrunk
MSGTAG: 1527521
MSG_TYPE: UCM_CTRACE
CORRELATIONID: 1,100,13,1245.191^89.25.207.155^*
TIMESTAMP: 2014/05/08 15:38:29.960

Detailed Sip Message

Pre Normalized Message:
INVITE sip:22012@172.21.66.189 SIP/2.0
Via: SIP/2.0/TCP 89.25.207.155:5060;egress-zone=CUCM;branch=z9hG4bKe84d123494d94b30cef06413251aedcb42882.4f6ff6b2f7950a98faab0731c5aea93c;proxy-call-id=029aa2da-d6b6-11e3-a835-0010f31add5c;rport
Via: SIP/2.0/UDP 192.168.27.49:5060;branch=z9hG4bK6254fbae;received=195.245.222.172;rport=5060;ingress-zone=DefaultZone
Call-ID: 5ca468605c0ff09d67acf20b3e8957542961591715
CSeq: 102 INVITE
Remote-Party-ID: " 48321000000" < sip:48321000000@192.168.27.49> ;privacy=off;screen=no
Contact: < sip:trisip@192.168.27.49>
From: " 48321000000" < sip:trisip@192.168.27.49> ;tag=as7ee883f4
To: < sip:callcenter2@getinbank.local>
Max-Forwards: 15
Record-Route: < sip:proxy-call-id=029aa2da-d6b6-11e3-a835-0010f31add5c@89.25.207.155:5060;transport=tcp;lr>
Record-Route: < sip:proxy-call-id=029aa2da-d6b6-11e3-a835-0010f31add5c@89.25.207.155:5060;transport=udp;lr>
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,SUBSCRIBE,NOTIFY,INFO
User-Agent: Adescom CTM5000
Date: Thu, 08 May 2014 13:38:36 GMT
Session-Expires: 1800
P-Asserted-Identity: " 48321000000" < sip:trisip@192.168.27.49>
X-TAATag: 029aa492-d6b6-11e3-b927-0010f31add5c
X-CTMG-TGStack: 3_6xcwmjp8db
Content-Type: application/sdp
Content-Length: 258
v=0
o=root 31352 31352 IN IP4 192.168.27.49
s=session
c=IN IP4 89.25.207.155
b=AS:2048
t=0 0
m=audio 50508 RTP/AVP 18
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=ptime:20
a=silenceSupp:off - - - -
m=video 50510 RTP/AVP 99
a=rtpmap:99 H264/90000
Post Normalized Message:
INVITE sip:22012@172.21.66.189 SIP/2.0
Date: Thu, 08 May 2014 13:38:36 GMT
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,SUBSCRIBE,NOTIFY,INFO
From: " 48321000000" < sip:trisip@192.168.27.49> ;tag=as7ee883f4
P-Asserted-Identity: " 48321000000" < sip:trisip@192.168.27.49>
Supported: X-cisco-srtp-fallback
Remote-Party-ID: " 48321000000" < sip:48321000000@192.168.27.49> ;privacy=off;screen=no
Content-Length: 258
User-Agent: Adescom CTM5000
Contact: < sip:trisip@192.168.27.49>
To: < sip:callcenter2@getinbank.local>
Content-Type: application/sdp
Call-ID: 5ca468605c0ff09d67acf20b3e8957542961591715
Via: SIP/2.0/TCP 89.25.207.155:5060;egress-zone=CUCM;branch=z9hG4bKe84d123494d94b30cef06413251aedcb42882.4f6ff6b2f7950a98faab0731c5aea93c;proxy-call-id=029aa2da-d6b6-11e3-a835-0010f31add5c;rport,SIP/2.0/UDP 192.168.27.49:5060;branch=z9hG4bK6254fbae;received=195.245.222.172;rport=5060;ingress-zone=DefaultZone
CSeq: 102 INVITE
Session-Expires: 1800
Max-Forwards: 15
Record-Route: < sip:proxy-call-id=029aa2da-d6b6-11e3-a835-0010f31add5c@89.25.207.155:5060;transport=tcp;lr> ,< sip:proxy-call-id=029aa2da-d6b6-11e3-a835-0010f31add5c@89.25.207.155:5060;transport=udp;lr>
v=0
o=root 31352 31352 IN IP4 192.168.27.49
s=session
c=IN IP4 89.25.207.155
b=AS:2048
t=0 0
m=audio 50508 RTP/AVP 18
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=ptime:20
a=silenceSupp:off - - - -
m=video 50510 RTP/AVP 99
a=rtpmap:99 H264/90000
SENDER: 172.21.66.189
GUID: 5ca468605c0ff09d67acf20b3e8957542961591715
MSG_LABEL: 100 Trying
RECEIVER: [Siptrunk] 89.25.207.155
MAC_ADDRESS: Siptrunk
MSGTAG: 1527522
MSG_TYPE: UCM_CTRACE
CORRELATIONID: 1,100,13,1245.191^89.25.207.155^*
TIMESTAMP: 2014/05/08 15:38:29.962

Detailed Sip Message

SIP/2.0 100 Trying
Via: SIP/2.0/TCP 89.25.207.155:5060;egress-zone=CUCM;branch=z9hG4bKe84d123494d94b30cef06413251aedcb42882.4f6ff6b2f7950a98faab0731c5aea93c;proxy-call-id=029aa2da-d6b6-11e3-a835-0010f31add5c;rport,SIP/2.0/UDP 192.168.27.49:5060;branch=z9hG4bK6254fbae;received=195.245.222.172;rport=5060;ingress-zone=DefaultZone
From: " 48321000000" < sip:trisip@192.168.27.49> ;tag=as7ee883f4
To: < sip:callcenter2@getinbank.local>
Date: Thu, 08 May 2014 13:38:29 GMT
Call-ID: 5ca468605c0ff09d67acf20b3e8957542961591715
CSeq: 102 INVITE
Allow-Events: presence
Content-Length: 0

SENDER: 172.21.66.189
GUID: 8b27e00-36b188d5-1461b-bd4215ac@172.21.66.189
MSG_LABEL: INVITE
RECEIVER: [SEPD867D9725F0D] 10.36.237.227
MAC_ADDRESS: SEPD867D9725F0D
MSGTAG: 1527523
MSG_TYPE: UCM_CTRACE
CORRELATIONID: 1,100,13,1.13658^*^*
TIMESTAMP: 2014/05/08 15:38:29.975

Detailed Sip Message

INVITE sip:6d0308d2-8e8f-4993-834e-157d70ebc8d3@10.36.237.227:59001;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 172.21.66.189:5060;branch=z9hG4bK18fa4184e854d
From: " 48321000000" < sip:trisip@172.21.66.189> ;tag=463224~11f8981e-b5e8-4e8b-86a2-aaba315c4cfd-22581997
To: < sip:22012@172.21.66.189>
Date: Thu, 08 May 2014 13:38:29 GMT
Call-ID: 8b27e00-36b188d5-1461b-bd4215ac@172.21.66.189
Supported: timer,resource-priority,replaces
Min-SE: 1800
User-Agent: Cisco-CUCM9.0
Allow: INVITE, OPTIONS, INFO, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY
CSeq: 101 INVITE
Expires: 180
Allow-Events: presence
Call-Info: < urn:x-cisco-remotecc:callinfo> ; security= NotAuthenticated; orientation= from; gci= 1-28266; call-instance= 1
Send-Info: conference, x-cisco-conference
Alert-Info: < file://Bellcore-dr2/>
Remote-Party-ID: " 48321000000" < sip:trisip@172.21.66.189;x-cisco-callback-number=trisip> ;party=calling;screen=yes;privacy=off
Contact: < sip:trisip@172.21.66.189:5060;transport=tcp> ;video;audio
Max-Forwards: 14
Content-Length: 0

SENDER: [SEPD867D9725F0D] 10.36.237.227
GUID: 8b27e00-36b188d5-1461b-bd4215ac@172.21.66.189
MSG_LABEL: 180 Ringing
RECEIVER: 172.21.66.189
MAC_ADDRESS: SEPD867D9725F0D
MSGTAG: 1527524
MSG_TYPE: UCM_CTRACE
CORRELATIONID: 1,100,13,1263.23^10.36.237.227^*
TIMESTAMP: 2014/05/08 15:38:30.061

Detailed Sip Message

SIP/2.0 180 Ringing
Via: SIP/2.0/TCP 172.21.66.189:5060;branch=z9hG4bK18fa4184e854d;received=172.21.66.189
Call-ID: 8b27e00-36b188d5-1461b-bd4215ac@172.21.66.189
CSeq: 101 INVITE
Contact: < sip:22012@10.36.237.227:59001;transport=tcp>
From: " 48321000000" < sip:trisip@172.21.66.189> ;tag=463224~11f8981e-b5e8-4e8b-86a2-aaba315c4cfd-22581997
To: < sip:22012@172.21.66.189> ;tag=221d10d00d9ab606
Server: TANDBERG/518 (TC6.1.2.eb6d163)
Remote-Party-ID: < sip:22012@172.21.66.189> ;privacy=off;id-type=subscriber;screen=yes;party=calling
Content-Length: 0

SENDER: 172.21.66.189
GUID: 5ca468605c0ff09d67acf20b3e8957542961591715
MSG_LABEL: 180 Ringing
RECEIVER: [Siptrunk] 89.25.207.155
MAC_ADDRESS: Siptrunk
MSGTAG: 1527525
MSG_TYPE: UCM_CTRACE
CORRELATIONID: 1,100,13,1263.23^10.36.237.227^*
TIMESTAMP: 2014/05/08 15:38:30.064

Detailed Sip Message

Pre Normalized Message:
SIP/2.0 180 Ringing
Via: SIP/2.0/TCP 89.25.207.155:5060;egress-zone=CUCM;branch=z9hG4bKe84d123494d94b30cef06413251aedcb42882.4f6ff6b2f7950a98faab0731c5aea93c;proxy-call-id=029aa2da-d6b6-11e3-a835-0010f31add5c;rport,SIP/2.0/UDP 192.168.27.49:5060;branch=z9hG4bK6254fbae;received=195.245.222.172;rport=5060;ingress-zone=DefaultZone
From: " 48321000000" < sip:trisip@192.168.27.49> ;tag=as7ee883f4
To: < sip:callcenter2@getinbank.local> ;tag=463223~11f8981e-b5e8-4e8b-86a2-aaba315c4cfd-22581996
Date: Thu, 08 May 2014 13:38:29 GMT
Call-ID: 5ca468605c0ff09d67acf20b3e8957542961591715
CSeq: 102 INVITE
Allow: INVITE, OPTIONS, INFO, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY
Allow-Events: presence
Record-Route: < sip:proxy-call-id=029aa2da-d6b6-11e3-a835-0010f31add5c@89.25.207.155:5060;transport=tcp;lr> ,< sip:proxy-call-id=029aa2da-d6b6-11e3-a835-0010f31add5c@89.25.207.155:5060;transport=udp;lr>
Supported: X-cisco-srtp-fallback
Supported: Geolocation
P-Asserted-Identity: < sip:22012@172.21.66.189>
Remote-Party-ID: < sip:22012@172.21.66.189> ;party=calling;screen=yes;privacy=off
Contact: < sip:22012@172.21.66.189:5060;transport=tcp>
Content-Length: 0

Post Normalized Message:
SIP/2.0 180 Ringing
Via: SIP/2.0/TCP 89.25.207.155:5060;egress-zone=CUCM;branch=z9hG4bKe84d123494d94b30cef06413251aedcb42882.4f6ff6b2f7950a98faab0731c5aea93c;proxy-call-id=029aa2da-d6b6-11e3-a835-0010f31add5c;rport,SIP/2.0/UDP 192.168.27.49:5060;branch=z9hG4bK6254fbae;received=195.245.222.172;rport=5060;ingress-zone=DefaultZone
From: " 48321000000" < sip:trisip@192.168.27.49> ;tag=as7ee883f4
To: < sip:callcenter2@getinbank.local> ;tag=463223~11f8981e-b5e8-4e8b-86a2-aaba315c4cfd-22581996
Date: Thu, 08 May 2014 13:38:29 GMT
Call-ID: 5ca468605c0ff09d67acf20b3e8957542961591715
CSeq: 102 INVITE
Allow: INVITE, OPTIONS, INFO, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY
Allow-Events: presence
Record-Route: < sip:proxy-call-id=029aa2da-d6b6-11e3-a835-0010f31add5c@89.25.207.155:5060;transport=tcp;lr> ,< sip:proxy-call-id=029aa2da-d6b6-11e3-a835-0010f31add5c@89.25.207.155:5060;transport=udp;lr>
Supported: X-cisco-srtp-fallback
Supported: Geolocation
P-Asserted-Identity: < sip:22012@172.21.66.189>
Remote-Party-ID: < sip:22012@172.21.66.189> ;party=calling;screen=yes;privacy=off
Contact: < sip:22012@172.21.66.189:5060;transport=tcp>
Content-Length: 0

SENDER: [SEPD867D9725F0D] 10.36.237.227
GUID: 8b27e00-36b188d5-1461b-bd4215ac@172.21.66.189
MSG_LABEL: 200 OK
RECEIVER: 172.21.66.189
MAC_ADDRESS: SEPD867D9725F0D
MSGTAG: 1527526
MSG_TYPE: UCM_CTRACE
CORRELATIONID: 1,100,13,1263.24^10.36.237.227^*
TIMESTAMP: 2014/05/08 15:38:31.200

Detailed Sip Message

SIP/2.0 200 OK
Via: SIP/2.0/TCP 172.21.66.189:5060;branch=z9hG4bK18fa4184e854d;received=172.21.66.189
Call-ID: 8b27e00-36b188d5-1461b-bd4215ac@172.21.66.189
CSeq: 101 INVITE
Contact: < sip:22012@10.36.237.227:59001;transport=tcp>
From: " 48321000000" < sip:trisip@172.21.66.189> ;tag=463224~11f8981e-b5e8-4e8b-86a2-aaba315c4cfd-22581997
To: < sip:22012@172.21.66.189> ;tag=221d10d00d9ab606
Allow: INVITE,ACK,CANCEL,BYE,UPDATE,INFO,OPTIONS,REFER,NOTIFY
Server: TANDBERG/518 (TC6.1.2.eb6d163)
Supported: replaces,100rel,timer,gruu,path,outbound,X-cisco-serviceuri,X-cisco-callinfo,X-cisco-service-control,X-cisco-srtp-fallback,X-cisco-sis-6.0.0,norefersub,extended-refer
Require: timer
Session-Expires: 1800;refresher=uas
Min-SE: 1800
Allow-Events: dialog
Remote-Party-ID: < sip:22012@172.21.66.189> ;privacy=off;id-type=subscriber;screen=yes;party=calling
Content-Type: application/sdp
Content-Length: 2701
v=0
o=tandberg 4 1 IN IP4 10.36.237.227
s=-
c=IN IP4 10.36.237.227
b=AS:6000
t=0 0
m=audio 2346 RTP/AVP 107 108 109 110 104 105 9 18 8 0 101
b=TIAS:128000
a=rtpmap:107 MP4A-LATM/90000
a=fmtp:107 profile-level-id=25;object=23;bitrate=128000
a=rtpmap:108 MP4A-LATM/90000
a=fmtp:108 profile-level-id=24;object=23;bitrate=64000
a=rtpmap:109 MP4A-LATM/90000
a=fmtp:109 profile-level-id=24;object=23;bitrate=56000
a=rtpmap:110 MP4A-LATM/90000
a=fmtp:110 profile-level-id=24;object=23;bitrate=48000
a=rtpmap:104 G7221/16000
a=fmtp:104 bitrate=32000
a=rtpmap:105 G7221/16000
a=fmtp:105 bitrate=24000
a=rtpmap:9 G722/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=yes
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
m=video 2348 RTP/AVP 97 126 96 34 31
b=TIAS:6000000
a=rtpmap:97 H264/90000
a=fmtp:97 profile-level-id=428016;max-br=5000;max-mbps=108000;max-fs=3600;max-smbps=108000;max-fps=6000;max-rcmd-nalu-size=1382400
a=rtpmap:126 H264/90000
a=fmtp:126 profile-level-id=428016;max-br=5000;max-mbps=108000;max-fs=3600;max-smbps=108000;packetization-mode=1;max-fps=6000;max-rcmd-nalu-size=1382400
a=rtpmap:96 H263-1998/90000
a=fmtp:96 custom=1280,768,3;custom=1280,720,3;custom=1024,768,1;custom=1024,576,2;custom=800,600,1;cif4=1;custom=720,480,1;custom=640,480,1;custom=512,288,1;cif=1;custom=352,240,1;qcif=1;maxbr=20000
a=rtpmap:34 H263/90000
a=fmtp:34 cif4=1;cif=1;qcif=1;maxbr=20000
a=rtpmap:31 H261/90000
a=fmtp:31 cif=1;qcif=1;maxbr=20000
a=rtcp-fb:* nack pli
a=rtcp-fb:* ccm fir
a=rtcp-fb:* ccm tmmbr
a=sendrecv
a=content:main
a=label:11
a=answer:full
m=application 5070 UDP/BFCP *
a=floorctrl:c-s
a=confid:1
a=floorid:2 mstrm:12
a=userid:4
a=setup:actpass
a=connection:new
m=video 2350 RTP/AVP 97 126 96 34 31
b=TIAS:6000000
a=rtpmap:97 H264/90000
a=fmtp:97 profile-level-id=428016;max-br=5000;max-mbps=108000;max-fs=3840;max-smbps=108000;max-fps=6000;max-rcmd-nalu-size=1474560
a=rtpmap:126 H264/90000
a=fmtp:126 profile-level-id=428016;max-br=5000;max-mbps=108000;max-fs=3840;max-smbps=108000;packetization-mode=1;max-fps=6000;max-rcmd-nalu-size=1474560
a=rtpmap:96 H263-1998/90000
a=fmtp:96 custom=1280,768,3;custom=1280,720,3;custom=1024,768,1;custom=1024,576,2;custom=800,600,1;cif4=1;custom=720,480,1;custom=640,480,1;custom=512,288,1;cif=1;custom=352,240,1;qcif=1;maxbr=20000
a=rtpmap:34 H263/90000
a=fmtp:34 cif4=1;cif=1;qcif=1;maxbr=20000
a=rtpmap:31 H261/90000
a=fmtp:31 cif=1;qcif=1;maxbr=20000
a=rtcp-fb:* nack pli
a=rtcp-fb:* ccm fir
a=rtcp-fb:* ccm tmmbr
a=sendrecv
a=content:slides
a=label:12
m=application 2352 RTP/AVP 98
a=rtpmap:98 H224/4800
a=sendrecv
SENDER: 172.21.66.189
GUID: 8b27e00-36b188d5-1461b-bd4215ac@172.21.66.189
MSG_LABEL: ACK
RECEIVER: [SEPD867D9725F0D] 10.36.237.227
MAC_ADDRESS: SEPD867D9725F0D
MSGTAG: 1527527
MSG_TYPE: UCM_CTRACE
CORRELATIONID: 1,100,13,1263.24^10.36.237.227^*
TIMESTAMP: 2014/05/08 15:38:31.209

Detailed Sip Message

ACK sip:22012@10.36.237.227:59001;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 172.21.66.189:5060;branch=z9hG4bK18fa56b7cc48c
From: " 48321000000" < sip:trisip@172.21.66.189> ;tag=463224~11f8981e-b5e8-4e8b-86a2-aaba315c4cfd-22581997
To: < sip:22012@172.21.66.189> ;tag=221d10d00d9ab606
Date: Thu, 08 May 2014 13:38:29 GMT
Call-ID: 8b27e00-36b188d5-1461b-bd4215ac@172.21.66.189
Max-Forwards: 70
CSeq: 101 ACK
Allow-Events: presence
Content-Type: application/sdp
Content-Length: 635
v=0
o=CiscoSystemsCCM-SIP 463224 1 IN IP4 172.21.66.189
s=SIP Call
b=AS:2048
t=0 0
m=audio 50508 RTP/AVP 18
c=IN IP4 89.25.207.155
b=TIAS:8000
a=rtpmap:18 G729/8000
a=ptime:20
a=fmtp:18 annexb=no
m=video 50510 RTP/AVP 99
c=IN IP4 89.25.207.155
b=TIAS:1984000
a=rtpmap:99 H264/90000
a=content:main
m=application 0 UDP/BFCP *
c=IN IP4 89.25.207.155
m=video 0 RTP/AVP 31 34 96 97
c=IN IP4 89.25.207.155
a=rtpmap:31 H261/90000
a=rtpmap:34 H263/90000
a=rtpmap:96 H263-1998/90000
a=rtpmap:97 H264/90000
a=content:slides
a=inactive
m=application 0 RTP/AVP 96
c=IN IP4 89.25.207.155
a=rtpmap:96 H224/0
a=inactive
SENDER: 172.21.66.189
GUID: 5ca468605c0ff09d67acf20b3e8957542961591715
MSG_LABEL: 200 OK
RECEIVER: [Siptrunk] 89.25.207.155
MAC_ADDRESS: Siptrunk
MSGTAG: 1527528
MSG_TYPE: UCM_CTRACE
CORRELATIONID: 1,100,13,1263.24^10.36.237.227^*
TIMESTAMP: 2014/05/08 15:38:31.212

Detailed Sip Message

Pre Normalized Message:
SIP/2.0 200 OK
Via: SIP/2.0/TCP 89.25.207.155:5060;egress-zone=CUCM;branch=z9hG4bKe84d123494d94b30cef06413251aedcb42882.4f6ff6b2f7950a98faab0731c5aea93c;proxy-call-id=029aa2da-d6b6-11e3-a835-0010f31add5c;rport,SIP/2.0/UDP 192.168.27.49:5060;branch=z9hG4bK6254fbae;received=195.245.222.172;rport=5060;ingress-zone=DefaultZone
From: " 48321000000" < sip:trisip@192.168.27.49> ;tag=as7ee883f4
To: < sip:callcenter2@getinbank.local> ;tag=463223~11f8981e-b5e8-4e8b-86a2-aaba315c4cfd-22581996
Date: Thu, 08 May 2014 13:38:29 GMT
Call-ID: 5ca468605c0ff09d67acf20b3e8957542961591715
CSeq: 102 INVITE
Allow: INVITE, OPTIONS, INFO, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY
Allow-Events: presence
Record-Route: < sip:proxy-call-id=029aa2da-d6b6-11e3-a835-0010f31add5c@89.25.207.155:5060;transport=tcp;lr> ,< sip:proxy-call-id=029aa2da-d6b6-11e3-a835-0010f31add5c@89.25.207.155:5060;transport=udp;lr>
Supported: replaces
Supported: X-cisco-srtp-fallback
Supported: Geolocation
Session-Expires: 1800;refresher=uas
Require: timer
P-Asserted-Identity: < sip:22012@172.21.66.189>
Remote-Party-ID: < sip:22012@172.21.66.189> ;party=calling;screen=yes;privacy=off
Contact: < sip:22012@172.21.66.189:5060;transport=tcp>
Content-Type: application/sdp
Content-Length: 443
v=0
o=CiscoSystemsCCM-SIP 463223 1 IN IP4 172.21.66.189
s=SIP Call
c=IN IP4 10.36.237.227
b=AS:2048
t=0 0
m=audio 2346 RTP/AVP 18
b=TIAS:8000
a=rtpmap:18 G729/8000
a=ptime:20
a=fmtp:18 annexb=no
m=video 2348 RTP/AVP 97
b=TIAS:1984000
a=label:11
a=rtpmap:97 H264/90000
a=fmtp:97 profile-level-id=428016;max-mbps=108000;max-fs=3600;max-cpb=200;max-br=1654;max-rcmd-nalu-size=1382400;max-smbps=108000;max-fps=6000
a=content:main
Post Normalized Message:
SIP/2.0 200 OK
Via: SIP/2.0/TCP 89.25.207.155:5060;egress-zone=CUCM;branch=z9hG4bKe84d123494d94b30cef06413251aedcb42882.4f6ff6b2f7950a98faab0731c5aea93c;proxy-call-id=029aa2da-d6b6-11e3-a835-0010f31add5c;rport,SIP/2.0/UDP 192.168.27.49:5060;branch=z9hG4bK6254fbae;received=195.245.222.172;rport=5060;ingress-zone=DefaultZone
From: " 48321000000" < sip:trisip@192.168.27.49> ;tag=as7ee883f4
To: < sip:callcenter2@getinbank.local> ;tag=463223~11f8981e-b5e8-4e8b-86a2-aaba315c4cfd-22581996
Date: Thu, 08 May 2014 13:38:29 GMT
Call-ID: 5ca468605c0ff09d67acf20b3e8957542961591715
CSeq: 102 INVITE
Allow: INVITE, OPTIONS, INFO, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY
Allow-Events: presence
Record-Route: < sip:proxy-call-id=029aa2da-d6b6-11e3-a835-0010f31add5c@89.25.207.155:5060;transport=tcp;lr> ,< sip:proxy-call-id=029aa2da-d6b6-11e3-a835-0010f31add5c@89.25.207.155:5060;transport=udp;lr>
Supported: replaces
Supported: X-cisco-srtp-fallback
Supported: Geolocation
Session-Expires: 1800;refresher=uas
Require: timer
P-Asserted-Identity: < sip:22012@172.21.66.189>
Remote-Party-ID: < sip:22012@172.21.66.189> ;party=calling;screen=yes;privacy=off
Contact: < sip:22012@172.21.66.189:5060;transport=tcp>
Content-Length: 443
Content-Type: application/sdp
v=0
o=CiscoSystemsCCM-SIP 463223 1 IN IP4 172.21.66.189
s=SIP Call
c=IN IP4 10.36.237.227
b=AS:2048
t=0 0
m=audio 2346 RTP/AVP 18
b=TIAS:8000
a=rtpmap:18 G729/8000
a=ptime:20
a=fmtp:18 annexb=no
m=video 2348 RTP/AVP 97
b=TIAS:1984000
a=label:11
a=rtpmap:97 H264/90000
a=fmtp:97 profile-level-id=428016;max-mbps=108000;max-fs=3600;max-cpb=200;max-br=1654;max-rcmd-nalu-size=1382400;max-smbps=108000;max-fps=6000
a=content:main
SENDER: [Siptrunk] 89.25.207.155
GUID: 5ca468605c0ff09d67acf20b3e8957542961591715
MSG_LABEL: ACK
RECEIVER: 172.21.66.189
MAC_ADDRESS: Siptrunk
MSGTAG: 1527529
MSG_TYPE: UCM_CTRACE
CORRELATIONID: 1,100,13,1245.192^89.25.207.155^*
TIMESTAMP: 2014/05/08 15:38:31.226

Detailed Sip Message

Pre Normalized Message:
ACK sip:22012@172.21.66.189:5060;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 89.25.207.155:5060;egress-zone=CUCM;branch=z9hG4bK4d617a80981d3aed460e6cfd6ee37f5642883.4f6ff6b2f7950a98faab0731c5aea93c;proxy-call-id=029aa2da-d6b6-11e3-a835-0010f31add5c;rport
Via: SIP/2.0/UDP 192.168.27.49:5060;branch=z9hG4bK19ed0dde;received=195.245.222.172;rport=5060;ingress-zone=DefaultZone
Call-ID: 5ca468605c0ff09d67acf20b3e8957542961591715
CSeq: 102 ACK
Remote-Party-ID: " 48321000000" < sip:48321000000@192.168.27.49> ;privacy=off;screen=no
Contact: < sip:trisip@192.168.27.49>
From: " 48321000000" < sip:trisip@192.168.27.49> ;tag=as7ee883f4
To: < sip:callcenter2@getinbank.local> ;tag=463223~11f8981e-b5e8-4e8b-86a2-aaba315c4cfd-22581996
Max-Forwards: 69
User-Agent: Adescom CTM5000
X-TAATag: 029aa492-d6b6-11e3-b927-0010f31add5c
Content-Length: 0

Post Normalized Message:
ACK sip:22012@172.21.66.189:5060;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 89.25.207.155:5060;egress-zone=CUCM;branch=z9hG4bK4d617a80981d3aed460e6cfd6ee37f5642883.4f6ff6b2f7950a98faab0731c5aea93c;proxy-call-id=029aa2da-d6b6-11e3-a835-0010f31add5c;rport
Via: SIP/2.0/UDP 192.168.27.49:5060;branch=z9hG4bK19ed0dde;received=195.245.222.172;rport=5060;ingress-zone=DefaultZone
Call-ID: 5ca468605c0ff09d67acf20b3e8957542961591715
CSeq: 102 ACK
Remote-Party-ID: " 48321000000" < sip:48321000000@192.168.27.49> ;privacy=off;screen=no
Contact: < sip:trisip@192.168.27.49>
From: " 48321000000" < sip:trisip@192.168.27.49> ;tag=as7ee883f4
To: < sip:callcenter2@getinbank.local> ;tag=463223~11f8981e-b5e8-4e8b-86a2-aaba315c4cfd-22581996
Max-Forwards: 69
User-Agent: Adescom CTM5000
X-TAATag: 029aa492-d6b6-11e3-b927-0010f31add5c
Content-Length: 0

SENDER: [SEPD867D9725F0D] 10.36.237.227
GUID: 8b27e00-36b188d5-1461b-bd4215ac@172.21.66.189
MSG_LABEL: INFO
RECEIVER: 172.21.66.189
MAC_ADDRESS: SEPD867D9725F0D
MSGTAG: 1527533
MSG_TYPE: UCM_CTRACE
CORRELATIONID: 1,100,13,1263.25^10.36.237.227^*
TIMESTAMP: 2014/05/08 15:38:32.164

Detailed Sip Message

INFO sip:trisip@172.21.66.189:5060;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 10.36.237.227:5060;branch=z9hG4bKb452d58aefdda4814a90a165fa70232f.1;rport
Call-ID: 8b27e00-36b188d5-1461b-bd4215ac@172.21.66.189
CSeq: 501 INFO
Contact: < sip:6d0308d2-8e8f-4993-834e-157d70ebc8d3@10.36.237.227:59001;transport=tcp>
From: < sip:22012@172.21.66.189> ;tag=221d10d00d9ab606
To: " 48321000000" < sip:trisip@172.21.66.189> ;tag=463224~11f8981e-b5e8-4e8b-86a2-aaba315c4cfd-22581997
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,BYE,UPDATE,INFO,OPTIONS,REFER,NOTIFY
User-Agent: TANDBERG/518 (TC6.1.2.eb6d163)
Supported: replaces,100rel,timer,gruu,path,outbound,X-cisco-serviceuri,X-cisco-callinfo,X-cisco-service-control,X-cisco-srtp-fallback,X-cisco-sis-6.0.0,norefersub,extended-refer
Allow-Events: dialog
Content-Type: application/media_control+xml
Content-Length: 193
< ?xml version=" 1.0" encoding=" utf-8" ?> < media_control> < vc_primitive> < to_encoder> < picture_fast_update> < /picture_fast_update> < /to_encoder> < stream_id> 11< /stream_id> < /vc_primitive> < /media_control>
SENDER: 172.21.66.189
GUID: 8b27e00-36b188d5-1461b-bd4215ac@172.21.66.189
MSG_LABEL: 200 OK
RECEIVER: [SEPD867D9725F0D] 10.36.237.227
MAC_ADDRESS: SEPD867D9725F0D
MSGTAG: 1527534
MSG_TYPE: UCM_CTRACE
CORRELATIONID: 1,100,13,1263.25^10.36.237.227^*
TIMESTAMP: 2014/05/08 15:38:32.165

Detailed Sip Message

SIP/2.0 200 OK
Via: SIP/2.0/TCP 10.36.237.227:5060;branch=z9hG4bKb452d58aefdda4814a90a165fa70232f.1;rport
From: < sip:22012@172.21.66.189> ;tag=221d10d00d9ab606
To: " 48321000000" < sip:trisip@172.21.66.189> ;tag=463224~11f8981e-b5e8-4e8b-86a2-aaba315c4cfd-22581997
Date: Thu, 08 May 2014 13:38:32 GMT
Call-ID: 8b27e00-36b188d5-1461b-bd4215ac@172.21.66.189
CSeq: 501 INFO
Contact: < sip:trisip@172.21.66.189:5060;transport=tcp>
Content-Length: 0

SENDER: 172.21.66.189
GUID: 8b27e00-36b188d5-1461b-bd4215ac@172.21.66.189
MSG_LABEL: BYE
RECEIVER: [SEPD867D9725F0D] 10.36.237.227
MAC_ADDRESS: SEPD867D9725F0D
MSGTAG: 1527550
MSG_TYPE: UCM_CTRACE
CORRELATIONID: 1,100,37,1.246^*^*
TIMESTAMP: 2014/05/08 15:38:37.056

Detailed Sip Message

BYE sip:22012@10.36.237.227:59001;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 172.21.66.189:5060;branch=z9hG4bK18fae3f5e41e0
From: " 48321000000" < sip:trisip@172.21.66.189> ;tag=463224~11f8981e-b5e8-4e8b-86a2-aaba315c4cfd-22581997
To: < sip:22012@172.21.66.189> ;tag=221d10d00d9ab606
Date: Thu, 08 May 2014 13:38:35 GMT
Call-ID: 8b27e00-36b188d5-1461b-bd4215ac@172.21.66.189
User-Agent: Cisco-CUCM9.0
Max-Forwards: 70
CSeq: 102 BYE
Reason: Q.850;cause=127
Content-Type: application/x-cisco-remotecc-request+xml
Content-Length: 418

< x-cisco-remotecc-request>
< playtonereq>
< dialogid>
< callid> 8b27e00-36b188d5-1461b-bd4215ac@172.21.66.189< /callid>
< localtag> 463224~11f8981e-b5e8-4e8b-86a2-aaba315c4cfd-22581997< /localtag>
< remotetag> 221d10d00d9ab606< /remotetag>
< /dialogid>
< tonetype> DtReorderTone< /tonetype>
< direction> user< /direction>
< duration> 10< /duration>
< /playtonereq>
< /x-cisco-remotecc-request>

[cgeorgia4 · Accepted solution]

This is where the problem starts

09378063.004 |15:38:37.053 |AppInfo  |//SIP/Stack/Transport/0x0/sipTransportPostCloseConnection: Posting TCP conn close for addr=89.25.207.155, port=5060, connid=12073
09378063.005 |15:38:37.053 |AppInfo  |//SIP/Stack/Transport/0x0/sipDeleteConnInstance: Deleted conn=0xb4f03db0, connid=12073, addr=89.25.207.155, port=5060, transport=TCP
09378064.000 |15:38:37.053 |SdlSig   |SIPSPISignal                           |wait                           |SIPHandler(1,100,72,1)           |SIPHandler(1,100,72,1)           |1,100,37,1.246^*^*                       |*TraceFlagOverrode
09378064.001 |15:38:37.053 |AppInfo  |//SIP/Stack/Info/0x0/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for event 63
09378064.002 |15:38:37.053 |AppInfo  |//SIP/Stack/Error/0xb4f66f90/sipTransportPostSendFailure: Posting send failure msg with tcb:(nil) reason=4
09378064.003 |15:38:37.053 |AppInfo  |//SIP/Stack/Info/0x0/httpish_msg_free: #### Freed msg=0xc0f6a30
09378065.000 |15:38:37.053 |SdlSig   |SIPSPISignal                           |wait                           |SIPHandler(1,100,72,1)           |SIPHandler(1,100,72,1)           |1,100,37,1.246^*^*                       |*TraceFlagOverrode
09378065.001 |15:38:37.053 |AppInfo  |//SIP/Stack/Info/0x0/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for event 63
09378065.002 |15:38:37.053 |AppInfo  |//SIP/Stack/Error/0xb4f61090/sipTransportPostSendFailure: Posting send failure msg with tcb:(nil) reason=4

09378066.001 |15:38:37.053 |AppInfo  |//SIP/SIPHandler/ccbId=0/scbId=0/getRemoteAddrInfo: RemoteAddrInfo = 89.25.207.155:5060
09378067.000 |15:38:37.053 |SdlSig   |SIPSPISignal                           |wait                           |SIPHandler(1,100,72,1)           |SIPHandler(1,100,72,1)           |1,100,37,1.246^*^*                       |*TraceFlagOverrode
09378067.001 |15:38:37.053 |AppInfo  |//SIP/Stack/Info/0x0/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for event 54
09378067.002 |15:38:37.053 |AppInfo  |//SIP/Stack/Error/0x0/act_options_wait_send_msg_failure: Send Error to 89.25.207.155:5060 for transport TCP
09378068.000 |15:38:37.053 |SdlSig   |SIPConnControlInd                      |restart0                       |SIPD(1,100,74,18) 

09378067.013 |15:38:37.053 |AppInfo  |//SIP/Stack/Transport/0x0/sipConnectionManagerUnregisterCtxtInCon: gConnTab=0xb4f02648, addr=89.25.207.155, port=5060, unregistering context=
09378067.014 |15:38:37.053 |AppInfo  |//SIP/Stack/Error/0x0/sipConnectionManagerUnregisterCtxtInCon: Connection not found for addr=89.25.207.155, port=5060

I would put a sniffer on both CUCM and vcs and see what's going on at the TCP level

Regards,

[macieknowak]

 Hello,

You have right we had problem with the TCP level :).

We have change the parameter SIP record route address type on VCS to hostname:We have change the parameter SIP record route address type on VCS to hostname.

IP: uses the VCS's IP address.

Hostname: uses the VCS's Local host name (if it is blank the IP address is used instead).

Thanks a lot,