** 3rd ATTEMPT!External calls through h323 gateway get fast busy on CUE

[Paul Dicine]

Team,

I have a customer with a UC 560 at the HQ site and 7 fxo lines. They also have a remote site with a 2800 ISR router termination the T-1 between the sites as well as providing 3 FXO ports for that site. Internally, everything works, Externally any call that comes into any of the 7 HQ FXO lines works flawlessly. Problem is any calls coming into  the 3 FXO lines at the remote site get a fast busy or disconnected when trying to talk to CUE.

99.9% of the time this is a codec issue... So here is what I have done....

1) Every single VOIP dial-peer has the codec g711ulaw command on it.

2) I have configured via voice service voip the allow-connections 323 to sip and sip to 323 etc

3) verified the sip CUE dial-peer..(Remember it works for all the lines attached to the box)

So I am pretty confident I am using g711ulaw all the way through... The only variable here is the WAN... Transfers to extensions work, Conferences work, just anything to CUE dies....

Am I missing something here? I will try to post a voice ccapi inout debug if you need it, but was just wondering if anyone had any ideas on what to check.

Thanks all

Paul

Here is the CUE Stacksip debug As you can see the codec looks right ANY help is appreciated. v=0 o=CiscoSystemsSIP-GW-UserAgent 778 983 IN IP4 10.1.10.2 s=SIP Call c=IN IP4 10.1.10.2 t=0 0 m=audio 17720 RTP/AVP 0 101 c=IN IP4 10.1.10.2 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 3539 10/17 01:03:02.912 ACCN SIPL 0 SIP invitation: targetNumber=399 3539 10/17 01:03:02.913 ACCN SIPL 0 LocalLine[399] process invitation, callId=C3 2E5712-174E11E2-BA53974A-C9095719@10.1.10.2, globalCallId=null from SIP-Remote-M T-170 dn=2034018452 addr=10.1.10.2:17720, dtmf=101, codecs=[0], ptime=20, mediaS tarted=false (sip:2034018452@10.1.10.2) 3539 10/17 01:03:02.914 ACCN SIPL 0 LocalLine[399] InboundCallInfo=SIP-InboundCa llInfo: source=2034018452, (sip:2034018452@10.1.10.2), destination=399, (sip:399 @10.1.10.1), callId=C32E5712-174E11E2-BA53974A-C9095719@10.1.10.2, gcId=null, la stRedirectDN=125, (sip:125@10.1.10.2), originalCalledDN=125, callingDisplayName= Dicine PAUL  , arrivalType=unconditional 3539 10/17 01:03:02.914 ACCN SIPL 0 NewInvitationCallback: creating new call 3539 10/17 01:03:02.914 ACCN SIPL 0 SIP-Call-86:IDLE[] <init> 3539 10/17 01:03:02.914 ACCN SIPL 0 SIP-Provider: getAbstractLine: creating Remo teLineImpl for DN 2034018452 3539 10/17 01:03:02.914 ACCN SIPL 0 RemoteLine[2034018452@10.1.10.2]: created 3539 10/17 01:03:02.914 ACCN SIPL 0 Call.createConnection: this=SIP-Call-86:IDLE [], line=RemoteLine[2034018452@10.1.10.2], state=ACTIVE, sc=null, mt=[SIP-Remote -MT-170 dn=2034018452 media=10.1.10.2:17720, mediaStarted=false], addToCall=true 3539 10/17 01:03:02.914 ACCN SIPL 0 [Conn-171-2034018452] ConnectionState.<init> : state=ACTIVE 3539 10/17 01:03:02.914 ACCN SIPL 0 [SIP-Remote-MT-170 dn=2034018452 media=10.1. 10.2:17720, mediaStarted=false] associate with [SIP-Conn-171, dn=2034018452, cal l=C32E5712-174E11E2-BA53974A-C9095719@10.1.10.2, state=ACTIVE]   ctrl=[CSTA-SC-171], MT=[[SIP-Remote-MT-170 dn=2034018452 media=10.1.10.2:17720 , mediaStarted=false]] 3539 10/17 01:03:02.914 ACCN SIPL 0 CallManager.put: callIdImpl=[C32E5712-174E11 E2-BA53974A-C9095719@10.1.10.2,null,86] 3539 10/17 01:03:02.914 ACCN SIPL 0 [Conn-171-2034018452] <init>: [SIP-Conn-171, dn=2034018452, call=C32E5712-174E11E2-BA53974A-C9095719@10.1.10.2, state=ACTIVE ]   ctrl=[CSTA-SC-171], MT=[[SIP-Remote-MT-170 dn=2034018452 media=10.1.10.2:17720 , mediaStarted=false]] 3539 10/17 01:03:02.914 ACCN SIPL 0 SIP-Call-86:ACTIVE[2034018452:ACTIVE] addCal lListener com.cisco.wf.subsystems.callcontrol.AppRoutePointCallListener@285d14 3539 10/17 01:03:02.914 ACCN SIPL 0 Call.createConnection: this=SIP-Call-86:ACTI VE[2034018452:ACTIVE], line=LocalLine[399], state=IDLE, sc=ltp170-399, State=IDL E: , mt=[SIP-Local-MT-171 dn=399 no media], addToCall=true 3539 10/17 01:03:02.914 ACCN SIPL 0 [Conn-172-399] ConnectionState.<init>: state =IDLE 3539 10/17 01:03:02.915 ACCN SIPL 0 [SIP-Local-MT-171 dn=399 no media] set conne ction [SIP-Conn-172, dn=399, call=C32E5712-174E11E2-BA53974A-C9095719@10.1.10.2, state=IDLE]   ctrl=[ltp170], MT=[[SIP-Local-MT-171 dn=399 no media]] 3539 10/17 01:03:02.915 ACCN SIPL 0 [Conn-172-399] <init>: [SIP-Conn-172, dn=399 , call=C32E5712-174E11E2-BA53974A-C9095719@10.1.10.2, state=IDLE]   ctrl=[ltp170], MT=[[SIP-Local-MT-171 dn=399 no media]] 3539 10/17 01:03:02.915 ACCN SIPL 0 SIP-Call-86:ACTIVE[2034018452:ACTIVE,399:IDL E] addCallListener com.cisco.wf.subsystems.callcontrol.AppRoutePointCallListener @285d14 3539 10/17 01:03:02.915 ACCN SIPL 0 New InvitationCallback from LocalLine[399] c reates SIP-Call-86:ACTIVE[2034018452:ACTIVE,399:IDLE] 3539 10/17 01:03:02.915 ACCN SIPL 0 NewInvitationCallback.processInvitation: id= C32E5712-174E11E2-BA53974A-C9095719@10.1.10.2, callId=C32E5712-174E11E2-BA53974A -C9095719@10.1.10.2, lastRedirectedDN=125, originalCalledDN=125, originalCalling DN=2034018452, calledDN=399, parentGlobalCallId=null, type=1002, arrivalType=100 2 3539 10/17 01:03:02.915 ACCN SIPL 0 LocalLine[399] process inbound call, gcId=C3 2E5712-174E11E2-BA53974A-C9095719@10.1.10.2 Local: [SIP-Conn-172, dn=399, call=C32E5712-174E11E2-BA53974A-C9095719@10.1.10.2 , state=IDLE]   ctrl=[ltp170], MT=[[SIP-Local-MT-171 dn=399 no media]] LocalLine[399] Remote: [SIP-Conn-171, dn=2034018452, call=C32E5712-174E11E2-BA53974A-C9095719@1 0.1.10.2, state=ACTIVE]   ctrl=[CSTA-SC-171], MT=[[SIP-Remote-MT-170 dn=2034018452 media=10.1.10.2:17720 , mediaStarted=false]] RemoteLine[2034018452@10.1.10.2] 3539 10/17 01:03:02.915 ACCN SIPL 0 [Conn-172-399] onCallConnectionOffered: stat e=IDLE 3539 10/17 01:03:02.915 ACCN SIPL 0 [Conn-172-399] setState: IDLE -> OFFERED 3539 10/17 01:03:02.915 ACCN SIPL 0 CallImpl.notifyAllListeners: ev=CALL_CONNECT ION_OFFERED (399) call=SIP-Call-86:ACTIVE[2034018452:ACTIVE,399:OFFERED] CALL_CONNECTION_OFFERED EVCall=SIP-Call-86:ACTIVE[2034018452:ACTIVE,399:OFFERED]EVConn=[SIP-Conn-172, dn =399, call=C32E5712-174E11E2-BA53974A-C9095719@10.1.10.2, state=OFFERED]   ctrl=[ltp170], MT=[[SIP-Local-MT-171 dn=399 no media]] 3539 10/17 01:03:02.915 ACCN SIPL 0 SIP-Call-86, GCID=C32E5712-174E11E2-BA53974A -C9095719@10.1.10.2 dispatch to com.cisco.wf.subsystems.callcontrol.AppRoutePoin tCallListener@285d14 3573 10/17 01:03:02.916 ACCN SIPL 0 SIP-Call-86:ACTIVE[2034018452:ACTIVE,399:OFF ERED] addCallListener com.cisco.wf.subsystems.callcontrol.AppCallListener@1708fc 8 3573 10/17 01:03:02.916 ACCN SIPL 0 SIP-Call-86:ACTIVE[2034018452:ACTIVE,399:OFF ERED] removeCallListener com.cisco.wf.subsystems.callcontrol.AppRoutePointCallLi stener@285d14 3573 10/17 01:03:02.919 ACCN SIPL 0 [SIP-Remote-MT-170 dn=2034018452 media=10.1. 10.2:17720, mediaStarted=false] - add MediaListener com.cisco.wf.subsystems.call control.AppMediaTerminalListener@beef49 3573 10/17 01:03:02.919 ACCN SIPL 0 [SIP-Local-MT-171 dn=399 no media] - add Med iaListener com.cisco.wf.subsystems.callcontrol.AppMediaTerminalListener@beef49 3573 10/17 01:03:02.922 ACCN SIPL 0 ltp170-399, State=ALERTED:  process Invite, callId=C32E5712-174E11E2-BA53974A-C9095719@10.1.10.2 3573 10/17 01:03:02.923 ACCN SIPL 0 ltp170-399, State=ALERTED:  sending ringing response: SIP/2.0 180 Ringing Via: SIP/2.0/UDP 10.1.10.2:5060;branch=z9hG4bK335216D To: <sip:399@10.1.10.1>;tag=ds76e4e95e From: "Dicine PAUL  " <sip:2034018452@10.1.10.2>;tag=69A46EE8-2017 Call-ID: C32E5712-174E11E2-BA53974A-C9095719@10.1.10.2 CSeq: 101 INVITE Content-Length: 0 Contact: <sip:399@10.1.10.1:5060;transport=udp> Allow: INVITE, BYE, CANCEL, ACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO Cisco-Gcid: C32E5712-174E11E2-BA53974A-C9095719@10.1.10.2 3573 10/17 01:03:02.923 ACCN SIPL 0 ltp170-399, State=ALERTED: setDialog: com.dy namicsoft.DsLibs.DsSipDialog.DsSipInviteDialog@1ebf324 isConfirmed=false 3573 10/17 01:03:02.923 ACCN SIPL 0 [Conn-172-399] onCallConnectionRinging: stat e=OFFERED 3573 10/17 01:03:02.923 ACCN SIPL 0 [Conn-172-399] setState: OFFERED -> RINGING 3573 10/17 01:03:02.923 ACCN SIPL 0 CallImpl.notifyAllListeners: ev=CALL_CONNECT ION_RINGING (399) call=SIP-Call-86:ACTIVE[2034018452:ACTIVE,399:RINGING] CALL_CONNECTION_RINGING EVCall=SIP-Call-86:ACTIVE[2034018452:ACTIVE,399:RINGING]EVConn=[SIP-Conn-172, dn =399, call=C32E5712-174E11E2-BA53974A-C9095719@10.1.10.2, state=RINGING]   ctrl=[ltp170], MT=[[SIP-Local-MT-171 dn=399 media=10.1.10.1:21082, mediaStarte d=false]] 3573 10/17 01:03:02.923 ACCN SIPL 0 SIP-Call-86, GCID=C32E5712-174E11E2-BA53974A -C9095719@10.1.10.2 dispatch to com.cisco.wf.subsystems.callcontrol.AppCallListe ner@1708fc8 3431 10/17 01:03:02.931 ACCN SIPL 0 ltp170-399, State=ALERTED:  sending ok respo nse for dialog SIP/2.0 200 Ok Via: SIP/2.0/UDP 10.1.10.2:5060;branch=z9hG4bK335216D To: <sip:399@10.1.10.1>;tag=ds76e4e95e From: "Dicine PAUL  " <sip:2034018452@10.1.10.2>;tag=69A46EE8-2017 Call-ID: C32E5712-174E11E2-BA53974A-C9095719@10.1.10.2 CSeq: 101 INVITE Content-Length: 183 Contact: <sip:399@10.1.10.1:5060;transport=udp> Content-Type: application/sdp Allow: INVITE, BYE, CANCEL, ACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO Cisco-Gcid: C32E5712-174E11E2-BA53974A-C9095719@10.1.10.2 v=0 o=CUE 1735426 2 IN IP4 10.1.10.1 s=SIP Call c=IN IP4 10.1.10.1 t=0 0 m=audio 21082 RTP/AVP 0 101 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 3431 10/17 01:03:02.932 ACCN SIPL 0 [SIP-Remote-MT-170 dn=2034018452 media=10.1. 10.2:17720, mediaStarted=false]: getDtmfMethodOut: rtp-nte 3431 10/17 01:03:02.932 ACCN SIPL 0 ltp170-399, State=ALERTED:  initDtmf: dtmfMe thodIn=rtp-nte 3542 10/17 01:03:02.968 ACCN SIPL 0 ltp170-399, State=ALERTED:  processAck Call- ID=C32E5712-174E11E2-BA53974A-C9095719@10.1.10.2 isReplacing=false, body=null 3542 10/17 01:03:02.968 ACCN SIPL 0 [Conn-172-399] onCallConnectionActive: state =RINGING 3542 10/17 01:03:02.968 ACCN SIPL 0 [Conn-172-399] setState: RINGING -> ACTIVE 3542 10/17 01:03:02.968 ACCN SIPL 0 CallImpl.notifyAllListeners: ev=CALL_CONNECT ION_ACTIVE (399) call=SIP-Call-86:ACTIVE[2034018452:ACTIVE,399:ACTIVE] CALL_CONNECTION_ACTIVE EVCall=SIP-Call-86:ACTIVE[2034018452:ACTIVE,399:ACTIVE]EVConn=[SIP-Conn-172, dn= 399, call=C32E5712-174E11E2-BA53974A-C9095719@10.1.10.2, state=ACTIVE]   ctrl=[ltp170], MT=[[SIP-Local-MT-171 dn=399 media=10.1.10.1:21082, mediaStarte d=false]] , cause=ANSWERED 3542 10/17 01:03:02.968 ACCN SIPL 0 SIP-Call-86, GCID=C32E5712-174E11E2-BA53974A -C9095719@10.1.10.2 dispatch to com.cisco.wf.subsystems.callcontrol.AppCallListe ner@1708fc8 3542 10/17 01:03:02.968 ACCN SIPL 0 CallImpl.notifyAllListeners: ev=CALL_ANSWERE D call=SIP-Call-86:ACTIVE[2034018452:ACTIVE,399:ACTIVE] CALL_ANSWERED EVCall=SIP-Call-86:ACTIVE[2034018452:ACTIVE,399:ACTIVE] 3542 10/17 01:03:02.968 ACCN SIPL 0 SIP-Call-86, GCID=C32E5712-174E11E2-BA53974A -C9095719@10.1.10.2 dispatch to com.cisco.wf.subsystems.callcontrol.AppCallListe ner@1708fc8 3542 10/17 01:03:02.969 ACCN SIPL 0 [SIP-Remote-MT-170 dn=2034018452 media=10.1. 10.2:17720, mediaStarted=false] dispatch media MEDIA_STARTED Event: [SIP-Remote-MT-170 dn=2034018452 media=10.1 .10.2:17720, mediaStarted=false] to com.cisco.wf.subsystems.callcontrol.AppMedia TerminalListener@beef49 3542 10/17 01:03:02.969 ACCN SIPL 0 [SIP-Local-MT-171 dn=399 media=10.1.10.1:210 82, mediaStarted=false] dispatch media MEDIA_STARTED Event: [SIP-Local-MT-171 dn=399 media=10.1.10.1:21 082, mediaStarted=false] to com.cisco.wf.subsystems.callcontrol.AppMediaTerminal Listener@beef49 3542 10/17 01:03:02.974 ACCN SIPL 0 ltp170-399, State=CONNECTED:  processTermina ted BYE sip:399@10.1.10.1:5060;transport=udp SIP/2.0 Via: SIP/2.0/UDP 10.1.10.2:5060;branch=z9hG4bK337106E Max-Forwards: 69 To: <sip:399@10.1.10.1>;tag=ds76e4e95e From: "Dicine PAUL  " <sip:2034018452@10.1.10.2>;tag=69A46EE8-2017 Call-ID: C32E5712-174E11E2-BA53974A-C9095719@10.1.10.2 CSeq: 102 BYE Content-Length: 0 Date: Wed, 17 Oct 2012 05:03:02 GMT User-Agent: Cisco-SIPGateway/IOS-12.x Timestamp: 1350450182 Reason: Q.850;cause=0 P-RTP-Stat: PS=0,OS=0,PR=0,OR=0,PL=0,JI=0,LA=0,DU=0 3542 10/17 01:03:02.974 ACCN SIPL 0 ltp170-399, State=CONNECTED:  setDisconnecte d processTerminated, cause=NORMAL 3542 10/17 01:03:02.974 ACCN SIPL 0 SIP-Call-86:ACTIVE[2034018452:ACTIVE,399:ACT IVE] clearId=C32E5712-174E11E2-BA53974A-C9095719@10.1.10.2 3542 10/17 01:03:02.975 ACCN SIPL 0  ##### ltp170-399, State=DISCONNECTED:  #### # [SIP-Local-MT-171 dn=399 media=10.1.10.1:21082, mediaStarted=true] ##### [SIP- Remote-MT-170 dn=2034018452 media=10.1.10.2:17720, mediaStarted=true]: ##### ltp 170-399, State=DISCONNECTED:  ##### [SIP-Local-MT-171 dn=399 media=10.1.10.1:210 82, mediaStarted=true] ##### [SIP-Remote-MT-170 dn=2034018452 media=10.1.10.2:17 720, mediaStarted=true] 3542 10/17 01:03:02.975 ACCN SIPL 0 [SIP-Local-MT-171 dn=399 media=10.1.10.1:210 82, mediaStarted=true] dispatch media MEDIA_STOPPED Event: [SIP-Local-MT-171 dn=399 media=10.1.10.1:21 082, mediaStarted=true] to com.cisco.wf.subsystems.callcontrol.AppMediaTerminalL istener@beef49 3542 10/17 01:03:02.976 ACCN SIPL 0 [SIP-Remote-MT-170 dn=2034018452 media=10.1. 10.2:17720, mediaStarted=true] dispatch media MEDIA_STOPPED Event: [SIP-Remote-MT-170 dn=2034018452 media=10.1 .10.2:17720, mediaStarted=true] to com.cisco.wf.subsystems.callcontrol.AppMediaT erminalListener@beef49 3542 10/17 01:03:02.976 ACCN SIPL 0 SIP-Call-86:ACTIVE[2034018452:ACTIVE], remov e connection 399, last=false 3542 10/17 01:03:02.976 ACCN SIPL 0 [Conn-172-399] onCallConnectionDisconnected: state=ACTIVE, cause=NORMAL 3542 10/17 01:03:02.976 ACCN SIPL 0 [Conn-172-399] setState: ACTIVE -> DISCONNEC TED 3542 10/17 01:03:02.976 ACCN SIPL 0 CallImpl.notifyAllListeners: ev=CALL_CONNECT ION_DISCONNECTED (399) call=SIP-Call-86:ACTIVE[2034018452:ACTIVE] CALL_CONNECTION_DISCONNECTED EVCall=SIP-Call-86:ACTIVE[2034018452:ACTIVE]EVConn=[SIP-Conn-172, dn=399, call=C 32E5712-174E11E2-BA53974A-C9095719@10.1.10.2, state=DISCONNECTED]   ctrl=[ltp170], MT=[[SIP-Local-MT-171 dn=399 media=10.1.10.1:21082, mediaStarte d=false]] , cause=NORMAL 3542 10/17 01:03:02.976 ACCN SIPL 0 SIP-Call-86, GCID=C32E5712-174E11E2-BA53974A -C9095719@10.1.10.2 dispatch to com.cisco.wf.subsystems.callcontrol.AppCallListe ner@1708fc8 3542 10/17 01:03:02.976 ACCN SIPL 0 SIP-Call-86:ACTIVE[2034018452:ACTIVE] checkC allActive 3542 10/17 01:03:02.976 ACCN SIPL 0 checkCallActive 0: isLocal=false, isMonitore d=false 3542 10/17 01:03:02.976 ACCN SIPL 0 SIP-Call-86:ACTIVE[2034018452:ACTIVE] droppe d, connLen=1 3542 10/17 01:03:02.976 ACCN SIPL 0 SIP-Call-86:ACTIVE[], remove connection 2034 847847, last=true 3542 10/17 01:03:02.976 ACCN SIPL 0 SIP-Call-86:INACTIVE[] change state to inact ive, because last connection has been removed 3542 10/17 01:03:02.976 ACCN SIPL 0 [Conn-171-2034018452] onCallConnectionDiscon nected: state=ACTIVE, cause=UNKNOWN 3542 10/17 01:03:02.976 ACCN SIPL 0 [Conn-171-2034018452] setState: ACTIVE -> DI SCONNECTED 3542 10/17 01:03:02.976 ACCN SIPL 0 CallImpl.notifyAllListeners: ev=CALL_CONNECT ION_DISCONNECTED (2034018452) call=SIP-Call-86:INACTIVE[] CALL_CONNECTION_DISCONNECTED EVCall=SIP-Call-86:INACTIVE[]EVConn=[SIP-Conn-171, dn=2034018452, call=C32E5712- 174E11E2-BA53974A-C9095719@10.1.10.2, state=DISCONNECTED]   ctrl=[CSTA-SC-171], MT=[[SIP-Remote-MT-170 dn=2034018452 media=10.1.10.2:17720 , mediaStarted=false]] , cause=UNKNOWN 3542 10/17 01:03:02.976 ACCN SIPL 0 SIP-Call-86, GCID=C32E5712-174E11E2-BA53974A -C9095719@10.1.10.2 dispatch to com.cisco.wf.subsystems.callcontrol.AppCallListe ner@1708fc8 3542 10/17 01:03:02.976 ACCN SIPL 0 CallImpl.notifyAllListeners: ev=CALL_INACTIV E call=SIP-Call-86:INACTIVE[] CALL_INACTIVE EVCall=SIP-Call-86:INACTIVE[], cause=UNKNOWN 3542 10/17 01:03:02.976 ACCN SIPL 0 SIP-Call-86, GCID=C32E5712-174E11E2-BA53974A -C9095719@10.1.10.2 dispatch to com.cisco.wf.subsystems.callcontrol.AppCallListe ner@1708fc8 3542 10/17 01:03:02.976 ACCN SIPL 0 Drop NON-monitored SIP-Call-86:INACTIVE[] be cause it has zero connections 3542 10/17 01:03:02.976 ACCN SIPL 0 SIP-Call-86:INACTIVE[] dropped, connLen=0 3542 10/17 01:03:02.976 ACCN SIPL 0 CallManager.removeCall: callIdImpl=[C32E5712 -174E11E2-BA53974A-C9095719@10.1.10.2,null,86] 3542 10/17 01:03:02.976 ACCN SIPL 0 CallImpl.notifyAllListeners: ev=CALL_DROPPED call=SIP-Call-86:INVALID[] CALL_DROPPED EVCall=SIP-Call-86:INVALID[], cause=UNKNOWN 3542 10/17 01:03:02.976 ACCN SIPL 0 SIP-Call-86, GCID=C32E5712-174E11E2-BA53974A -C9095719@10.1.10.2 dispatch to com.cisco.wf.subsystems.callcontrol.AppCallListe ner@1708fc8 3542 10/17 01:03:02.976 ACCN SIPL 0 SIP-Call-86:INVALID[] checkCallActive 3542 10/17 01:03:02.976 ACCN SIPL 0 ltp170-399, State=DISCONNECTED:  Drop Call b ecause mode= SIP 12106 10/17 01:03:02.982 ACCN SIPL 0 SIP-Call-86:INVALID[] removeCallListener co m.cisco.wf.subsystems.callcontrol.AppCallListener@1708fc8 2034018452

[Paul Dicine]

Team,

To add a little more to this. This is what I have further discovered.

This only happens when i try to get to someones mailbox via the trnsfrVM softkey or by direct transfer to VM by hitting transfer 6xxx and transfer again or by the call coming into an extension, ringing until it hits the timeout and then when the call tries to go to the persons VM box, the call drops.

If I transfer to the main VM number (399) it works. If I transfer to the AA it works...Just seems to be individual mailboxes that get the Fast Busy or Disconnect.

Thanks all

Paul

[Paul Dicine]

Team

Here are the sip message debugs. Hopefully someone can help. This debug is me calling in on the remote site FXO, hitting the TrnsfrVM button, hitting the users extension (125) and hitting the TrnsfrVM button again. At that point the call just hangs up. Any help is appreciated.

Paul

021117: Oct  5 02:10:53.614: //4654/EA8AC4BA87E5/SIP/Msg/ccsipDisplayMsg:

Sent:

INVITE sip:399@10.1.10.1:5060 SIP/2.0

Via: SIP/2.0/UDP 10.1.10.2:5060;branch=z9hG4bK1DE200C

Remote-Party-ID: "Dicine PAUL  " <2035555555>;party=calling;scre

en=no;privacy=off

From: "Dicine PAUL  " <2035555555>;tag=2B3A83C8-19C5

To: <399>

Date: Fri, 05 Oct 2012 02:10:53 GMT

Call-ID: B9C8C803-DC811E2-9DFC974A-C9095719@10.1.10.2

Supported: 100rel,timer,resource-priority,replaces,sdp-anat

Min-SE:  1800

Cisco-Guid: 3934962874-0231215586-2279993872-0125821984

User-Agent: Cisco-SIPGateway/IOS-12.x

Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIF

Y, INFO, REGISTER

CSeq: 101 INVITE

Max-Forwards: 70

Timestamp: 1349403053

Contact: <2035555555>

Diversion: <125>;privacy=off;reason=unconditional;counter=1;screen

=no

Expires: 180

Allow-Events: telephone-event

Content-Type: application/sdp

Content-Disposition: session;handling=required

Content-Length: 238

v=0

o=CiscoSystemsSIP-GW-UserAgent 1503 9301 IN IP4 10.1.10.2

s=SIP Call

c=IN IP4 10.1.10.2

t=0 0

m=audio 17294 RTP/AVP 0 101

c=IN IP4 10.1.10.2

a=rtpmap:0 PCMU/8000

a=rtpmap:101 telephone-event/8000

a=fmtp:101 0-16

a=ptime:20

021118: Oct  5 02:10:54.114: //4654/EA8AC4BA87E5/SIP/Msg/ccsipDisplayMsg:

Sent:

INVITE sip:399@10.1.10.1:5060 SIP/2.0

Via: SIP/2.0/UDP 10.1.10.2:5060;branch=z9hG4bK1DE200C

Remote-Party-ID: "Dicine PAUL  " <2035555555>;party=calling;scre

en=no;privacy=off

From: "Dicine PAUL  " <2035555555>;tag=2B3A83C8-19C5

To: <399>

Date: Fri, 05 Oct 2012 02:10:54 GMT

Call-ID: B9C8C803-DC811E2-9DFC974A-C9095719@10.1.10.2

Supported: 100rel,timer,resource-priority,replaces,sdp-anat

Min-SE:  1800

Cisco-Guid: 3934962874-0231215586-2279993872-0125821984

User-Agent: Cisco-SIPGateway/IOS-12.x

Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIF

Y, INFO, REGISTER

CSeq: 101 INVITE

Max-Forwards: 70

Timestamp: 1349403054

Contact: <2035555555>

Diversion: <125>;privacy=off;reason=unconditional;counter=1;screen

=no

Expires: 180

Allow-Events: telephone-event

Content-Type: application/sdp

Content-Disposition: session;handling=required

Content-Length: 238

v=0

o=CiscoSystemsSIP-GW-UserAgent 1503 9301 IN IP4 10.1.10.2

s=SIP Call

c=IN IP4 10.1.10.2

t=0 0

m=audio 17294 RTP/AVP 0 101

c=IN IP4 10.1.10.2

a=rtpmap:0 PCMU/8000

a=rtpmap:101 telephone-event/8000

a=fmtp:101 0-16

a=ptime:20

021119: Oct  5 02:10:54.118: //4654/EA8AC4BA87E5/SIP/Msg/ccsipDisplayMsg:

Received:

SIP/2.0 100 Trying

Via: SIP/2.0/UDP 10.1.10.2:5060;branch=z9hG4bK1DE200C

To: <399>

From: "Dicine PAUL  " <2035555555>;tag=2B3A83C8-19C5

Call-ID: B9C8C803-DC811E2-9DFC974A-C9095719@10.1.10.2

CSeq: 101 INVITE

Content-Length: 0

Timestamp: 1349403054

021120: Oct  5 02:10:54.134: //4654/EA8AC4BA87E5/SIP/Msg/ccsipDisplayMsg:

Received:

SIP/2.0 180 Ringing

Via: SIP/2.0/UDP 10.1.10.2:5060;branch=z9hG4bK1DE200C

To: <399>;tag=dsf07fc022

From: "Dicine PAUL  " <2035555555>;tag=2B3A83C8-19C5

Call-ID: B9C8C803-DC811E2-9DFC974A-C9095719@10.1.10.2

CSeq: 101 INVITE

Content-Length: 0

Contact: <399>

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

Cisco-Gcid: B9C8C803-DC811E2-9DFC974A-C9095719@10.1.10.2

021121: Oct  5 02:10:54.170: //4654/EA8AC4BA87E5/SIP/Msg/ccsipDisplayMsg:

Received:

SIP/2.0 200 Ok

Via: SIP/2.0/UDP 10.1.10.2:5060;branch=z9hG4bK1DE200C

To: <399>;tag=dsf07fc022

From: "Dicine PAUL  " <2035555555>;tag=2B3A83C8-19C5

Call-ID: B9C8C803-DC811E2-9DFC974A-C9095719@10.1.10.2

CSeq: 101 INVITE

Content-Length: 184

Contact: <399>

Content-Type: application/sdp

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

Cisco-Gcid: B9C8C803-DC811E2-9DFC974A-C9095719@10.1.10.2

v=0

o=CUE 11571244 2 IN IP4 10.1.10.1

s=SIP Call

c=IN IP4 10.1.10.1

t=0 0

m=audio 20512 RTP/AVP 0 101

a=rtpmap:0 PCMU/8000

a=rtpmap:101 telephone-event/8000

a=fmtp:101 0-15

021122: Oct  5 02:10:54.174: //4654/EA8AC4BA87E5/SIP/Msg/ccsipDisplayMsg:

Sent:

ACK sip:399@10.1.10.1:5060;transport=udp SIP/2.0

Via: SIP/2.0/UDP 10.1.10.2:5060;branch=z9hG4bK1DF14C2

From: "Dicine PAUL  " <2035555555>;tag=2B3A83C8-19C5

To: <399>;tag=dsf07fc022

Date: Fri, 05 Oct 2012 02:10:54 GMT

Call-ID: B9C8C803-DC811E2-9DFC974A-C9095719@10.1.10.2

Max-Forwards: 70

CSeq: 101 ACK

Allow-Events: telephone-event

Content-Length: 0

021123: Oct  5 02:10:54.182: //4654/EA8AC4BA87E5/SIP/Msg/ccsipDisplayMsg:

Sent:

BYE sip:399@10.1.10.1:5060;transport=udp SIP/2.0

Via: SIP/2.0/UDP 10.1.10.2:5060;branch=z9hG4bK1E01313

From: "Dicine PAUL  " <2035555555>;tag=2B3A83C8-19C5

To: <399>;tag=dsf07fc022

Date: Fri, 05 Oct 2012 02:10:54 GMT

Call-ID: B9C8C803-DC811E2-9DFC974A-C9095719@10.1.10.2

User-Agent: Cisco-SIPGateway/IOS-12.x

Max-Forwards: 70

Timestamp: 1349403054

CSeq: 102 BYE

Reason: Q.850;cause=0

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

Content-Length: 0

021124: Oct  5 02:10:54.182: //4654/EA8AC4BA87E5/SIP/Msg/ccsipDisplayMsg:

Received:

SIP/2.0 200 Ok

Via: SIP/2.0/UDP 10.1.10.2:5060;branch=z9hG4bK1E01313

To: <399>;tag=dsf07fc022

From: "Dicine PAUL  " <2035555555>;tag=2B3A83C8-19C5

Call-ID: B9C8C803-DC811E2-9DFC974A-C9095719@10.1.10.2

CSeq: 102 BYE

Content-Length: 0

[placroix]

Team, doesn't anyone want to take a crack at this

Sent from Cisco Technical Support iPad App