cancel
Showing results for 
Search instead for 
Did you mean: 
cancel
5802
Views
0
Helpful
2
Replies

Webex Call Drops at 30 minutes

putney_m
Level 1
Level 1

I am working on a system that has a H.323 gateway and when the caller is on a webex conference the call stops at exactly 1800 everytime they are on the call. I ran debug isdn q921, debug isdn 931, and debug voip ccapi inout. From the the data it seems like the provider is sending the disconnect, am I looking at the logs correctly? The number called was 6504293300 and it was connected on serial 0/1/0:2 .

Any help would be greatly appreciated.

Thanks,

Michael

Call Termination Section.

Mar 27 20:55:54.579: //49968/32F1A60B9E3F/CCAPI/cc_api_call_disconnected:

   Cause Value=16, Interface=0x30A71EB4, Call Id=49968

Mar 27 20:55:54.579: //49968/32F1A60B9E3F/CCAPI/cc_api_call_disconnected:

   Call Entry(Responsed=TRUE, Cause Value=16, Retry Count=0)

Mar 27 20:55:54.579: //49967/32F1A60B9E3F/CCAPI/ccConferenceDestroy:

   Conference Id=0x5F29, Tag=0x0

Mar 27 20:55:54.579: //49967/32F1A60B9E3F/CCAPI/cc_api_bridge_drop_done:

   Conference Id=0x5F29, Source Interface=0x311820BC, Source Call Id=49967,

   Destination Call Id=49968, Disposition=0x0, Tag=0x0

Mar 27 20:55:54.579: //49968/32F1A60B9E3F/CCAPI/cc_api_bridge_drop_done:

   Conference Id=0x5F29, Source Interface=0x30A71EB4, Source Call Id=49968,

   Destination Call Id=49967, Disposition=0x0, Tag=0x0

Mar 27 20:55:54.579: //49967/32F1A60B9E3F/CCAPI/cc_generic_bridge_done:

   Conference Id=0x5F29, Source Interface=0x30A71EB4, Source Call Id=49968,

   Destination Call Id=49967, Disposition=0x0, Tag=0x0

Mar 27 20:55:54.583: //49967/32F1A60B9E3F/CCAPI/ccCallDisconnect:

   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)

Mar 27 20:55:54.583: //49967/32F1A60B9E3F/CCAPI/ccCallDisconnect:

   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)

Mar 27 20:55:54.583: //49967/32F1A60B9E3F/CCAPI/cc_api_get_transfer_info:

   Transfer Number Is Null

Mar 27 20:55:54.583: //49968/32F1A60B9E3F/CCAPI/ccCallDisconnect:

   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=16)

Mar 27 20:55:54.583: //49968/32F1A60B9E3F/CCAPI/ccCallDisconnect:

   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)

Mar 27 20:55:54.583: //49968/32F1A60B9E3F/CCAPI/cc_api_get_transfer_info:

   Transfer Number Is Null

Mar 27 20:55:54.595: //49968/32F1A60B9E3F/CCAPI/cc_api_get_transfer_info:

   Transfer Number Is Null

Mar 27 20:55:54.599: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 2, ConnectionId 32F1A60B965711E29E3F1CDFF0F7C90, SetupTime 20:53:23.559 UTC Wed Mar 27 2013, PeerAddress 0002, PeerSubAddress , DisconnectCause 10  , DisconnectText normal call clearing (16), ConnectTime 20:53:27.429 UTC Wed Mar 27 2013, DisconnectTime 20:55:54.599 UTC Wed Mar 27 2013, CallOrigin 1, ChargedUnits 0, InfoType 2, TransmitPackets 7356, TransmitBytes 1176960, ReceivePackets 7356, ReceiveBytes 1176960

Mar 27 20:55:54.599: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

  

Mar 27 20:55:54.599: :Inside cc_build_feature_vsa

Mar 27 20:55:54.599: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

  

Mar 27 20:55:54.599:  feature call basic

Mar 27 20:55:54.599: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

  

Mar 27 20:55:54.599: cc_build_feature_vsa attr is fn:TWC,ft:03/27/2013 20:53:23.563,cgn:9252850526,cdn:0002,frs:0,fid:49968,fcid:32F1A60B965711E29E3F1CDFF0F7C90,legID:C330

Mar 27 20:55:54.599: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:TWC,ft:03/27/2013 20:53:23.563,cgn:9252850526,cdn:0002,frs:0,fid:49968,fcid:32F1A60B965711E29E3F1CDFF0F7C90,legID:C330,bguid:32F1A60B965711E29E3F1CDF0F0F7C90

Mar 27 20:55:54.599: //49968/32F1A60B9E3F/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x30A71EB4, Tag=0x0, Call Id=49968,

   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)

Mar 27 20:55:54.599: //49968/32F1A60B9E3F/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

Mar 27 20:55:54.599: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

  

Mar 27 20:55:54.599: :cc_free_feature_vsa freeing 3075EB70

Mar 27 20:55:54.599: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

  

Mar 27 20:55:54.599:  vsacount in free is 13

Mar 27 20:55:54.603: %ISDN-6-DISCONNECT: Interface Serial0/0/0:4  disconnected from 9252850526 , call lasted 147 seconds

Mar 27 20:55:54.603: ISDN Se0/0/0:23 Q921: User TX -> INFO sapi=0 tei=0, ns=40 nr=97

Mar 27 20:55:54.603: ISDN Se0/0/0:23 Q931: DISCONNECT pd = 8  callref = 0x8DD2

Cause i = 0x8090 - Normal call clearing

Mar 27 20:55:54.611: ISDN Se0/0/0:23 Q921: User RX <- RR sapi=0 tei=0 nr=41

Mar 27 20:55:54.751: ISDN Se0/0/0:23 Q921: User RX <- INFO sapi=0 tei=0, ns=97 nr=41

Mar 27 20:55:54.751: ISDN Se0/0/0:23 Q931: RELEASE pd = 8  callref = 0x0DD2

Mar 27 20:55:54.751: ISDN Se0/0/0:23 Q921: User TX -> RR sapi=0 tei=0 nr=98

Mar 27 20:55:54.751: ISDN Se0/0/0:23 Q921: User TX -> INFO sapi=0 tei=0, ns=41 nr=98

Mar 27 20:55:54.751: ISDN Se0/0/0:23 Q931: RELEASE_COMP pd = 8  callref = 0x8DD2

Mar 27 20:55:54.751: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 1, ConnectionId 32F1A60B965711E29E3F1CDFF0F7C90, SetupTime 20:53:23.561 UTC Wed Mar 27 2013, PeerAddress 9252850526, PeerSubAddress , DisconnectCause 10  , DisconnectText normal call clearing (16), ConnectTime 20:53:27.441 UTC Wed Mar 27 2013, DisconnectTime 20:55:54.751 UTC Wed Mar 27 2013, CallOrigin 2, ChargedUnits 0, InfoType 2, TransmitPackets 7356, TransmitBytes 1235808, ReceivePackets 7356, ReceiveBytes 1176960

Mar 27 20:55:54.751: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

  

Mar 27 20:55:54.751: :Inside cc_build_feature_vsa

Mar 27 20:55:54.751: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

  

Mar 27 20:55:54.751:  feature call basic

Mar 27 20:55:54.751: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

  

Mar 27 20:55:54.751: cc_build_feature_vsa attr is fn:TWC,ft:03/27/2013 20:53:23.559,cgn:9252850526,cdn:0002,frs:0,fid:49967,fcid:32F1A60B965711E29E3F1CDFF0F7C90,legID:C32F

Mar 27 20:55:54.751: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:TWC,ft:03/27/2013 20:53:23.559,cgn:9252850526,cdn:0002,frs:0,fid:49967,fcid:32F1A60B965711E29E3F1CDFF0F7C90,legID:C32F,bguid:32F1A60B965711E29E3F1CDF0F0F7C90

Mar 27 20:55:54.755: //49967/32F1A60B9E3F/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x311820BC, Tag=0x0, Call Id=49967,

   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)

Mar 27 20:55:54.755: //49967/32F1A60B9E3F/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

Mar 27 20:55:54.755: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

  

Mar 27 20:55:54.755: :cc_free_feature_vsa freeing 3075D910

Mar 27 20:55:54.755: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

  

Mar 27 20:55:54.755:  vsacount in free is 12

Mar 27 20:55:54.759: ISDN Se0/0/0:23 Q921: User RX <- RR sapi=0 tei=0 nr=42

Mar 27 20:55:55.331: %RADIUS-4-RADIUS_DEAD: RADIUS server 10.2.5.93:1645,1646 is not responding.

Mar 27 20:55:55.331: %RADIUS-4-RADIUS_ALIVE: RADIUS server 10.2.5.93:1645,1646 is being marked alive.

Mar 27 20:55:55.455: ISDN Se0/1/0:23 Q921: User RX <- INFO sapi=0 tei=0, ns=105 nr=98

Mar 27 20:55:55.455: ISDN Se0/1/0:23 Q931: DISCONNECT pd = 8  callref = 0xC3C7

Cause i = 0x8A90 - Normal call clearing

Mar 27 20:55:55.455: ISDN Se0/1/0:23 Q921: User TX -> RR sapi=0 tei=0 nr=106

Mar 27 20:55:55.455: %ISDN-6-DISCONNECT: Interface Serial0/1/0:2  disconnected from 6504293300 , call lasted 1800 seconds

Mar 27 20:55:55.455: ISDN Se0/1/0:23 Q921: User TX -> INFO sapi=0 tei=0, ns=98 nr=106

Mar 27 20:55:55.455: ISDN Se0/1/0:23 Q931: RELEASE pd = 8  callref = 0x43C7

Mar 27 20:55:55.455: //49898/808628808806/CCAPI/cc_api_call_disconnected:

   Cause Value=16, Interface=0x2AB4CBA0, Call Id=49898

Mar 27 20:55:55.455: //49898/808628808806/CCAPI/cc_api_call_disconnected:

   Call Entry(Responsed=TRUE, Cause Value=16, Retry Count=0)

Mar 27 20:55:55.455: //49897/808628808806/CCAPI/ccConferenceDestroy:

   Conference Id=0x5F06, Tag=0x0

Mar 27 20:55:55.455: //49897/808628808806/CCAPI/cc_api_bridge_drop_done:

   Conference Id=0x5F06, Source Interface=0x30A71EB4, Source Call Id=49897,

   Destination Call Id=49898, Disposition=0x0, Tag=0x0

Mar 27 20:55:55.455: //49898/808628808806/CCAPI/cc_api_bridge_drop_done:

   Conference Id=0x5F06, Source Interface=0x2AB4CBA0, Source Call Id=49898,

   Destination Call Id=49897, Disposition=0x0, Tag=0x0

Mar 27 20:55:55.455: //49897/808628808806/CCAPI/cc_generic_bridge_done:

   Conference Id=0x5F06, Source Interface=0x2AB4CBA0, Source Call Id=49898,

   Destination Call Id=49897, Disposition=0x0, Tag=0x0

Mar 27 20:55:55.455: //49897/808628808806/CCAPI/ccCallDisconnect:

   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)

Mar 27 20:55:55.455: //49897/808628808806/CCAPI/ccCallDisconnect:

   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)

Mar 27 20:55:55.455: //49897/808628808806/CCAPI/cc_api_get_transfer_info:

   Transfer Number Is Null

Mar 27 20:55:55.455: //49898/808628808806/CCAPI/ccCallDisconnect:

   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=16)

Mar 27 20:55:55.455: //49898/808628808806/CCAPI/ccCallDisconnect:

   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)

Mar 27 20:55:55.455: //49898/808628808806/CCAPI/cc_api_get_transfer_info:

   Transfer Number Is Null

Mar 27 20:55:55.459: //49897/808628808806/CCAPI/cc_api_get_transfer_info:

   Transfer Number Is Null

Mar 27 20:55:55.463: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 2, ConnectionId 80862880CA55311588068802A02154A, SetupTime 20:25:46.433 UTC Wed Mar 27 2013, PeerAddress 8479950002, PeerSubAddress , DisconnectCause 10  , DisconnectText normal call clearing (16), ConnectTime 20:25:55.323 UTC Wed Mar 27 2013, DisconnectTime 20:55:55.463 UTC Wed Mar 27 2013, CallOrigin 2, ChargedUnits 0, InfoType 2, TransmitPackets 90001, TransmitBytes 14399842, ReceivePackets 90017, ReceiveBytes 14402720

Mar 27 20:55:55.463: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

  

Mar 27 20:55:55.463: :Inside cc_build_feature_vsa

Mar 27 20:55:55.463: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

  

Mar 27 20:55:55.463:  feature call basic

Mar 27 20:55:55.463: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

  

Mar 27 20:55:55.463: cc_build_feature_vsa attr is fn:TWC,ft:03/27/2013 20:25:46.439,cgn:8479950002,cdn:816504293300,frs:0,fid:49897,fcid:80862880CA55311588068802A02154A,legID:C2E9

Mar 27 20:55:55.463: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:TWC,ft:03/27/2013 20:25:46.439,cgn:8479950002,cdn:816504293300,frs:0,fid:49897,fcid:80862880CA55311588068802A02154A,legID:C2E9,bguid:80862880CA553115880688020A02154A

Mar 27 20:55:55.463: //49897/808628808806/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x30A71EB4, Tag=0x0, Call Id=49897,

   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)

Mar 27 20:55:55.463: //49897/808628808806/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

Mar 27 20:55:55.463: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

  

Mar 27 20:55:55.463: :cc_free_feature_vsa freeing 3075D4B0

Mar 27 20:55:55.463: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

  

Mar 27 20:55:55.463:  vsacount in free is 11

Mar 27 20:55:55.483: ISDN Se0/1/0:23 Q921: User RX <- RR sapi=0 tei=0 nr=99

Mar 27 20:55:55.487: ISDN Se0/1/0:23 Q921: User RX <- INFO sapi=0 tei=0, ns=106 nr=99

Mar 27 20:55:55.487: ISDN Se0/1/0:23 Q931: RELEASE_COMP pd = 8  callref = 0xC3C7

Mar 27 20:55:55.487: ISDN Se0/1/0:23 Q921: User TX -> RR sapi=0 tei=0 nr=107

Mar 27 20:55:55.491: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 1, ConnectionId 80862880CA55311588068802A02154A, SetupTime 20:25:46.611 UTC Wed Mar 27 2013, PeerAddress 816504293300, PeerSubAddress , DisconnectCause 10  , DisconnectText normal call clearing (16), ConnectTime 20:25:55.321 UTC Wed Mar 27 2013, DisconnectTime 20:55:55.461 UTC Wed Mar 27 2013, CallOrigin 1, ChargedUnits 0, InfoType 2, TransmitPackets 90017, TransmitBytes 15122856, ReceivePackets 90003, ReceiveBytes 14400162

Mar 27 20:55:55.491: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

  

Mar 27 20:55:55.491: :Inside cc_build_feature_vsa

Mar 27 20:55:55.491: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

  

Mar 27 20:55:55.491:  feature call basic

Mar 27 20:55:55.491: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

  

Mar 27 20:55:55.491: cc_build_feature_vsa attr is fn:TWC,ft:03/27/2013 20:25:46.447,cgn:8479950002,cdn:816504293300,frs:0,fid:49898,fcid:80862880CA55311588068802A02154A,legID:C2EA

Mar 27 20:55:55.491: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:TWC,ft:03/27/2013 20:25:46.447,cgn:8479950002,cdn:816504293300,frs:0,fid:49898,fcid:80862880CA55311588068802A02154A,legID:C2EA,bguid:80862880CA553115880688020A02154A

Mar 27 20:55:55.491: //49898/808628808806/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x2AB4CBA0, Tag=0x0, Call Id=49898,

   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)

Mar 27 20:55:55.491: //49898/808628808806/CCAPI/cc_api_call_disconnect_done:

   tg for this call is qwest success/fail is 1

Mar 27 20:55:55.491: //49898/808628808806/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

Mar 27 20:55:55.491: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

  

Mar 27 20:55:55.491: :cc_free_feature_vsa freeing 3075D750

Mar 27 20:55:55.491: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

  

Mar 27 20:55:55.491:  vsacount in free is 10

Mar 27 20:56:02.263: //49971/807FB2A8A306/CCAPI/cc_api_call_digit_begin:

   Consume mask is not set. Relaying Digit 4 to dstCallId 0xC334

Mar 27 20:56:02.263: //49971/807FB2A8A306/CCAPI/cc_relay_digit_begin_for_3way_conference:

   Check DTMF relay digit begin for 3way conf

Mar 27 20:56:02.463: //49971/807FB2A8A306/CCAPI/cc_api_call_digit_end:

   Consume mask is not set. Relaying Digit 4 to dstCallId 0xC334

Mar 27 20:56:02.463: //49971/807FB2A8A306/CCAPI/cc_relay_digit_end_for_3way_conference:

   Check DTMF relay digit end for 3way conf

Mar 27 20:56:03.303: ISDN Se0/0/0:23 Q921: User RX <- INFO sapi=0 tei=0, ns=98 nr=42

Mar 27 20:56:03.303: ISDN Se0/0/0:23 Q931: CONNECT pd = 8  callref = 0xC3E2

Mar 27 20:56:03.303: ISDN Se0/0/0:23 Q921: User TX -> RR sapi=0 tei=0 nr=99

Mar 27 20:56:03.303: %ISDN-6-CONNECT: Interface Serial0/0/0:0 is now connected to 18884009828 N/A

Mar 27 20:56:03.303: ISDN Se0/0/0:23 Q921: User TX -> INFO sapi=0 tei=0, ns=42 nr=99

Mar 27 20:56:03.303: ISDN Se0/0/0:23 Q931: CONNECT_ACK pd = 8  callref = 0x43E2

Mar 27 20:56:03.303: //49972/807FB2A8A306/CCAPI/cc_api_call_connected:

   Interface=0x311820BC, Data Bitmask=0x1, Progress Indication=NULL(0),

   Connection Handle=0

Mar 27 20:56:03.303: //49972/807FB2A8A306/CCAPI/cc_api_call_connected:

   Call Entry(Connected=TRUE, Responsed=TRUE, Retry Count=0)

Mar 27 20:56:03.303: //49971/807FB2A8A306/CCAPI/ccCallConnect:

   Progress Indication=INBAND(8), Data Bitmask=0x1

Mar 27 20:56:03.303: //49972/807FB2A8A306/CCAPI/cc_api_get_called_ccm_detected:

   CallInfo(ccm detected=0)

Mar 27 20:56:03.303: //49971/807FB2A8A306/CCAPI/ccCallConnect:

   Call Entry(Connected=TRUE, Responsed=TRUE)

Mar 27 20:56:03.303: //49971/807FB2A8A306/CCAPI/ccCallNotify:

   Data Bitmask=0x7, Call Id=49971

Mar 27 20:56:03.303: //49972/807FB2A8A306/CCAPI/cc_api_get_called_ccm_detected:

   CallInfo(ccm detected=0)

Mar 27 20:56:03.311: ISDN Se0/0/0:23 Q921: User RX <- RR sapi=0 tei=0 nr=43

Mar 27 20:56:05.491: ISDN Se0/1/0:23 Q921: User RX <- RRp sapi=0 tei=0 nr=99

Mar 27 20:56:05.491: ISDN Se0/1/0:23 Q921: User TX -> RRf sapi=0 tei=0 nr=107

            

Mar 27 20:55:54.579: //49968/32F1A60B9E3F/CCAPI/cc_api_call_disconnected:

   Cause Value=16, Interface=0x30A71EB4, Call Id=49968

Mar 27 20:55:54.579: //49968/32F1A60B9E3F/CCAPI/cc_api_call_disconnected:

   Call Entry(Responsed=TRUE, Cause Value=16, Retry Count=0)

Mar 27 20:55:54.579: //49967/32F1A60B9E3F/CCAPI/ccConferenceDestroy:

   Conference Id=0x5F29, Tag=0x0

Mar 27 20:55:54.579: //49967/32F1A60B9E3F/CCAPI/cc_api_bridge_drop_done:

   Conference Id=0x5F29, Source Interface=0x311820BC, Source Call Id=49967,

   Destination Call Id=49968, Disposition=0x0, Tag=0x0

Mar 27 20:55:54.579: //49968/32F1A60B9E3F/CCAPI/cc_api_bridge_drop_done:

   Conference Id=0x5F29, Source Interface=0x30A71EB4, Source Call Id=49968,

   Destination Call Id=49967, Disposition=0x0, Tag=0x0

Mar 27 20:55:54.579: //49967/32F1A60B9E3F/CCAPI/cc_generic_bridge_done:

   Conference Id=0x5F29, Source Interface=0x30A71EB4, Source Call Id=49968,

   Destination Call Id=49967, Disposition=0x0, Tag=0x0

Mar 27 20:55:54.583: //49967/32F1A60B9E3F/CCAPI/ccCallDisconnect:

   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)

Mar 27 20:55:54.583: //49967/32F1A60B9E3F/CCAPI/ccCallDisconnect:

   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)

Mar 27 20:55:54.583: //49967/32F1A60B9E3F/CCAPI/cc_api_get_transfer_info:

   Transfer Number Is Null

Mar 27 20:55:54.583: //49968/32F1A60B9E3F/CCAPI/ccCallDisconnect:

   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=16)

Mar 27 20:55:54.583: //49968/32F1A60B9E3F/CCAPI/ccCallDisconnect:

   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)

Mar 27 20:55:54.583: //49968/32F1A60B9E3F/CCAPI/cc_api_get_transfer_info:

   Transfer Number Is Null

Mar 27 20:55:54.595: //49968/32F1A60B9E3F/CCAPI/cc_api_get_transfer_info:

   Transfer Number Is Null

Mar 27 20:55:54.599: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 2, ConnectionId 32F1A60B965711E29E3F1CDFF0F7C90, SetupTime 20:53:23.559 UTC Wed Mar 27 2013, PeerAddress 0002, PeerSubAddress , DisconnectCause 10  , DisconnectText normal call clearing (16), ConnectTime 20:53:27.429 UTC Wed Mar 27 2013, DisconnectTime 20:55:54.599 UTC Wed Mar 27 2013, CallOrigin 1, ChargedUnits 0, InfoType 2, TransmitPackets 7356, TransmitBytes 1176960, ReceivePackets 7356, ReceiveBytes 1176960

Mar 27 20:55:54.599: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

  

Mar 27 20:55:54.599: :Inside cc_build_feature_vsa

Mar 27 20:55:54.599: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

  

Mar 27 20:55:54.599:  feature call basic

Mar 27 20:55:54.599: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

  

Mar 27 20:55:54.599: cc_build_feature_vsa attr is fn:TWC,ft:03/27/2013 20:53:23.563,cgn:9252850526,cdn:0002,frs:0,fid:49968,fcid:32F1A60B965711E29E3F1CDFF0F7C90,legID:C330

Mar 27 20:55:54.599: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:TWC,ft:03/27/2013 20:53:23.563,cgn:9252850526,cdn:0002,frs:0,fid:49968,fcid:32F1A60B965711E29E3F1CDFF0F7C90,legID:C330,bguid:32F1A60B965711E29E3F1CDF0F0F7C90

Mar 27 20:55:54.599: //49968/32F1A60B9E3F/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x30A71EB4, Tag=0x0, Call Id=49968,

   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)

Mar 27 20:55:54.599: //49968/32F1A60B9E3F/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

Mar 27 20:55:54.599: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

  

Mar 27 20:55:54.599: :cc_free_feature_vsa freeing 3075EB70

Mar 27 20:55:54.599: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

  

Mar 27 20:55:54.599:  vsacount in free is 13

Mar 27 20:55:54.603: %ISDN-6-DISCONNECT: Interface Serial0/0/0:4  disconnected from 9252850526 , call lasted 147 seconds

Mar 27 20:55:54.603: ISDN Se0/0/0:23 Q921: User TX -> INFO sapi=0 tei=0, ns=40 nr=97

Mar 27 20:55:54.603: ISDN Se0/0/0:23 Q931: DISCONNECT pd = 8  callref = 0x8DD2

Cause i = 0x8090 - Normal call clearing

Mar 27 20:55:54.611: ISDN Se0/0/0:23 Q921: User RX <- RR sapi=0 tei=0 nr=41

Mar 27 20:55:54.751: ISDN Se0/0/0:23 Q921: User RX <- INFO sapi=0 tei=0, ns=97 nr=41

Mar 27 20:55:54.751: ISDN Se0/0/0:23 Q931: RELEASE pd = 8  callref = 0x0DD2

Mar 27 20:55:54.751: ISDN Se0/0/0:23 Q921: User TX -> RR sapi=0 tei=0 nr=98

Mar 27 20:55:54.751: ISDN Se0/0/0:23 Q921: User TX -> INFO sapi=0 tei=0, ns=41 nr=98

Mar 27 20:55:54.751: ISDN Se0/0/0:23 Q931: RELEASE_COMP pd = 8  callref = 0x8DD2

Mar 27 20:55:54.751: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 1, ConnectionId 32F1A60B965711E29E3F1CDFF0F7C90, SetupTime 20:53:23.561 UTC Wed Mar 27 2013, PeerAddress 9252850526, PeerSubAddress , DisconnectCause 10  , DisconnectText normal call clearing (16), ConnectTime 20:53:27.441 UTC Wed Mar 27 2013, DisconnectTime 20:55:54.751 UTC Wed Mar 27 2013, CallOrigin 2, ChargedUnits 0, InfoType 2, TransmitPackets 7356, TransmitBytes 1235808, ReceivePackets 7356, ReceiveBytes 1176960

Mar 27 20:55:54.751: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

  

Mar 27 20:55:54.751: :Inside cc_build_feature_vsa

Mar 27 20:55:54.751: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

  

Mar 27 20:55:54.751:  feature call basic

Mar 27 20:55:54.751: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

  

Mar 27 20:55:54.751: cc_build_feature_vsa attr is fn:TWC,ft:03/27/2013 20:53:23.559,cgn:9252850526,cdn:0002,frs:0,fid:49967,fcid:32F1A60B965711E29E3F1CDFF0F7C90,legID:C32F

Mar 27 20:55:54.751: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:TWC,ft:03/27/2013 20:53:23.559,cgn:9252850526,cdn:0002,frs:0,fid:49967,fcid:32F1A60B965711E29E3F1CDFF0F7C90,legID:C32F,bguid:32F1A60B965711E29E3F1CDF0F0F7C90

Mar 27 20:55:54.755: //49967/32F1A60B9E3F/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x311820BC, Tag=0x0, Call Id=49967,

   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)

Mar 27 20:55:54.755: //49967/32F1A60B9E3F/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

Mar 27 20:55:54.755: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

  

Mar 27 20:55:54.755: :cc_free_feature_vsa freeing 3075D910

Mar 27 20:55:54.755: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

  

Mar 27 20:55:54.755:  vsacount in free is 12

Mar 27 20:55:54.759: ISDN Se0/0/0:23 Q921: User RX <- RR sapi=0 tei=0 nr=42

Mar 27 20:55:55.331: %RADIUS-4-RADIUS_DEAD: RADIUS server 10.2.5.93:1645,1646 is not responding.

Mar 27 20:55:55.331: %RADIUS-4-RADIUS_ALIVE: RADIUS server 10.2.5.93:1645,1646 is being marked alive.

Mar 27 20:55:55.455: ISDN Se0/1/0:23 Q921: User RX <- INFO sapi=0 tei=0, ns=105 nr=98

Mar 27 20:55:55.455: ISDN Se0/1/0:23 Q931: DISCONNECT pd = 8  callref = 0xC3C7

Cause i = 0x8A90 - Normal call clearing

Mar 27 20:55:55.455: ISDN Se0/1/0:23 Q921: User TX -> RR sapi=0 tei=0 nr=106

Mar 27 20:55:55.455: %ISDN-6-DISCONNECT: Interface Serial0/1/0:2  disconnected from 6504293300 , call lasted 1800 seconds

Mar 27 20:55:55.455: ISDN Se0/1/0:23 Q921: User TX -> INFO sapi=0 tei=0, ns=98 nr=106

Mar 27 20:55:55.455: ISDN Se0/1/0:23 Q931: RELEASE pd = 8  callref = 0x43C7

Mar 27 20:55:55.455: //49898/808628808806/CCAPI/cc_api_call_disconnected:

   Cause Value=16, Interface=0x2AB4CBA0, Call Id=49898

Mar 27 20:55:55.455: //49898/808628808806/CCAPI/cc_api_call_disconnected:

   Call Entry(Responsed=TRUE, Cause Value=16, Retry Count=0)

Mar 27 20:55:55.455: //49897/808628808806/CCAPI/ccConferenceDestroy:

   Conference Id=0x5F06, Tag=0x0

Mar 27 20:55:55.455: //49897/808628808806/CCAPI/cc_api_bridge_drop_done:

   Conference Id=0x5F06, Source Interface=0x30A71EB4, Source Call Id=49897,

   Destination Call Id=49898, Disposition=0x0, Tag=0x0

Mar 27 20:55:55.455: //49898/808628808806/CCAPI/cc_api_bridge_drop_done:

   Conference Id=0x5F06, Source Interface=0x2AB4CBA0, Source Call Id=49898,

   Destination Call Id=49897, Disposition=0x0, Tag=0x0

Mar 27 20:55:55.455: //49897/808628808806/CCAPI/cc_generic_bridge_done:

   Conference Id=0x5F06, Source Interface=0x2AB4CBA0, Source Call Id=49898,

   Destination Call Id=49897, Disposition=0x0, Tag=0x0

Mar 27 20:55:55.455: //49897/808628808806/CCAPI/ccCallDisconnect:

   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)

Mar 27 20:55:55.455: //49897/808628808806/CCAPI/ccCallDisconnect:

   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)

Mar 27 20:55:55.455: //49897/808628808806/CCAPI/cc_api_get_transfer_info:

   Transfer Number Is Null

Mar 27 20:55:55.455: //49898/808628808806/CCAPI/ccCallDisconnect:

   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=16)

Mar 27 20:55:55.455: //49898/808628808806/CCAPI/ccCallDisconnect:

   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)

Mar 27 20:55:55.455: //49898/808628808806/CCAPI/cc_api_get_transfer_info:

   Transfer Number Is Null

Mar 27 20:55:55.459: //49897/808628808806/CCAPI/cc_api_get_transfer_info:

   Transfer Number Is Null

Mar 27 20:55:55.463: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 2, ConnectionId 80862880CA55311588068802A02154A, SetupTime 20:25:46.433 UTC Wed Mar 27 2013, PeerAddress 8479950002, PeerSubAddress , DisconnectCause 10  , DisconnectText normal call clearing (16), ConnectTime 20:25:55.323 UTC Wed Mar 27 2013, DisconnectTime 20:55:55.463 UTC Wed Mar 27 2013, CallOrigin 2, ChargedUnits 0, InfoType 2, TransmitPackets 90001, TransmitBytes 14399842, ReceivePackets 90017, ReceiveBytes 14402720

Mar 27 20:55:55.463: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

  

Mar 27 20:55:55.463: :Inside cc_build_feature_vsa

Mar 27 20:55:55.463: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

  

Mar 27 20:55:55.463:  feature call basic

Mar 27 20:55:55.463: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

  

Mar 27 20:55:55.463: cc_build_feature_vsa attr is fn:TWC,ft:03/27/2013 20:25:46.439,cgn:8479950002,cdn:816504293300,frs:0,fid:49897,fcid:80862880CA55311588068802A02154A,legID:C2E9

Mar 27 20:55:55.463: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:TWC,ft:03/27/2013 20:25:46.439,cgn:8479950002,cdn:816504293300,frs:0,fid:49897,fcid:80862880CA55311588068802A02154A,legID:C2E9,bguid:80862880CA553115880688020A02154A

Mar 27 20:55:55.463: //49897/808628808806/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x30A71EB4, Tag=0x0, Call Id=49897,

   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)

Mar 27 20:55:55.463: //49897/808628808806/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

Mar 27 20:55:55.463: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

  

Mar 27 20:55:55.463: :cc_free_feature_vsa freeing 3075D4B0

Mar 27 20:55:55.463: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

  

Mar 27 20:55:55.463:  vsacount in free is 11

Mar 27 20:55:55.483: ISDN Se0/1/0:23 Q921: User RX <- RR sapi=0 tei=0 nr=99

Mar 27 20:55:55.487: ISDN Se0/1/0:23 Q921: User RX <- INFO sapi=0 tei=0, ns=106 nr=99

Mar 27 20:55:55.487: ISDN Se0/1/0:23 Q931: RELEASE_COMP pd = 8  callref = 0xC3C7

Mar 27 20:55:55.487: ISDN Se0/1/0:23 Q921: User TX -> RR sapi=0 tei=0 nr=107

Mar 27 20:55:55.491: %VOIPAAA-5-VOIP_CALL_HISTORY: CallLegType 1, ConnectionId 80862880CA55311588068802A02154A, SetupTime 20:25:46.611 UTC Wed Mar 27 2013, PeerAddress 816504293300, PeerSubAddress , DisconnectCause 10  , DisconnectText normal call clearing (16), ConnectTime 20:25:55.321 UTC Wed Mar 27 2013, DisconnectTime 20:55:55.461 UTC Wed Mar 27 2013, CallOrigin 1, ChargedUnits 0, InfoType 2, TransmitPackets 90017, TransmitBytes 15122856, ReceivePackets 90003, ReceiveBytes 14400162

Mar 27 20:55:55.491: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

  

Mar 27 20:55:55.491: :Inside cc_build_feature_vsa

Mar 27 20:55:55.491: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

  

Mar 27 20:55:55.491:  feature call basic

Mar 27 20:55:55.491: //-1/xxxxxxxxxxxx/CCAPI/cc_build_feature_vsa:

  

Mar 27 20:55:55.491: cc_build_feature_vsa attr is fn:TWC,ft:03/27/2013 20:25:46.447,cgn:8479950002,cdn:816504293300,frs:0,fid:49898,fcid:80862880CA55311588068802A02154A,legID:C2EA

Mar 27 20:55:55.491: %VOIPAAA-5-VOIP_FEAT_HISTORY: FEAT_VSA=fn:TWC,ft:03/27/2013 20:25:46.447,cgn:8479950002,cdn:816504293300,frs:0,fid:49898,fcid:80862880CA55311588068802A02154A,legID:C2EA,bguid:80862880CA553115880688020A02154A

Mar 27 20:55:55.491: //49898/808628808806/CCAPI/cc_api_call_disconnect_done:

   Disposition=0, Interface=0x2AB4CBA0, Tag=0x0, Call Id=49898,

   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)

Mar 27 20:55:55.491: //49898/808628808806/CCAPI/cc_api_call_disconnect_done:

   tg for this call is qwest success/fail is 1

Mar 27 20:55:55.491: //49898/808628808806/CCAPI/cc_api_call_disconnect_done:

   Call Disconnect Event Sent

Mar 27 20:55:55.491: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

  

Mar 27 20:55:55.491: :cc_free_feature_vsa freeing 3075D750

Mar 27 20:55:55.491: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

  

Mar 27 20:55:55.491:  vsacount in free is 10

Mar 27 20:56:02.263: //49971/807FB2A8A306/CCAPI/cc_api_call_digit_begin:

   Consume mask is not set. Relaying Digit 4 to dstCallId 0xC334

Mar 27 20:56:02.263: //49971/807FB2A8A306/CCAPI/cc_relay_digit_begin_for_3way_conference:

   Check DTMF relay digit begin for 3way conf

Mar 27 20:56:02.463: //49971/807FB2A8A306/CCAPI/cc_api_call_digit_end:

   Consume mask is not set. Relaying Digit 4 to dstCallId 0xC334

Mar 27 20:56:02.463: //49971/807FB2A8A306/CCAPI/cc_relay_digit_end_for_3way_conference:

   Check DTMF relay digit end for 3way conf

Mar 27 20:56:03.303: ISDN Se0/0/0:23 Q921: User RX <- INFO sapi=0 tei=0, ns=98 nr=42

Mar 27 20:56:03.303: ISDN Se0/0/0:23 Q931: CONNECT pd = 8  callref = 0xC3E2

Mar 27 20:56:03.303: ISDN Se0/0/0:23 Q921: User TX -> RR sapi=0 tei=0 nr=99

Mar 27 20:56:03.303: %ISDN-6-CONNECT: Interface Serial0/0/0:0 is now connected to 18884009828 N/A

Mar 27 20:56:03.303: ISDN Se0/0/0:23 Q921: User TX -> INFO sapi=0 tei=0, ns=42 nr=99

Mar 27 20:56:03.303: ISDN Se0/0/0:23 Q931: CONNECT_ACK pd = 8  callref = 0x43E2

Mar 27 20:56:03.303: //49972/807FB2A8A306/CCAPI/cc_api_call_connected:

   Interface=0x311820BC, Data Bitmask=0x1, Progress Indication=NULL(0),

   Connection Handle=0

Mar 27 20:56:03.303: //49972/807FB2A8A306/CCAPI/cc_api_call_connected:

   Call Entry(Connected=TRUE, Responsed=TRUE, Retry Count=0)

Mar 27 20:56:03.303: //49971/807FB2A8A306/CCAPI/ccCallConnect:

   Progress Indication=INBAND(8), Data Bitmask=0x1

Mar 27 20:56:03.303: //49972/807FB2A8A306/CCAPI/cc_api_get_called_ccm_detected:

   CallInfo(ccm detected=0)

Mar 27 20:56:03.303: //49971/807FB2A8A306/CCAPI/ccCallConnect:

   Call Entry(Connected=TRUE, Responsed=TRUE)

Mar 27 20:56:03.303: //49971/807FB2A8A306/CCAPI/ccCallNotify:

   Data Bitmask=0x7, Call Id=49971

Mar 27 20:56:03.303: //49972/807FB2A8A306/CCAPI/cc_api_get_called_ccm_detected:

   CallInfo(ccm detected=0)

Mar 27 20:56:03.311: ISDN Se0/0/0:23 Q921: User RX <- RR sapi=0 tei=0 nr=43

Mar 27 20:56:05.491: ISDN Se0/1/0:23 Q921: User RX <- RRp sapi=0 tei=0 nr=99

Mar 27 20:56:05.491: ISDN Se0/1/0:23 Q921: User TX -> RRf sapi=0 tei=0 nr=107

2 Replies 2

Himank Pande
Level 1
Level 1

Hi Mike,

Kindly attach the outputs of:

debug isdn q931

debug h225 asn1

debug h245 asn1

debug voice ccapi inout

debug ip tcp transactions

for a failed call.

Also mention the calling and called party numbers along with the time stamp here.

I should not be that difficult to isolate in case this is a provider issue or in case there is a problem on the H323 leg.

Regards

Ank

Were there any further updates on this?  I've started seeing the same issues on WebEx sessions but only when the call is made to my conference room from an outside WebEx server.

I'm not too familiar with the WebEx platform but this post is about as close as I have gotten to finding an answer.

Thanks,

Andrew