Cisco Support Community
cancel
Showing results for 
Search instead for 
Did you mean: 

IP IVR Not Accepting Call (UCCE System PG)

Hi all,

I am configuring UCCE 9.0, with System PG.

The script is very simple:

Start -> Translation Route to VRU -> Queue to Skill Group -> Run Ext. Script (BasicQ) -> <-- Wait

When I make a call, the Translation Route to VRU redirects call to IP IVR, but then I get the message:

“I am sorry, we are currently experiencing system problems.”

And I have checked, and the "Call Control Group ID on the UCCX" is correct on the Trunk Group.

I get the following logs on the router:

20:31:27 rtr      Trace: (2 x 0 : 0 0) NewCall: CID=(150807,72239101), DN=8000,

ANI=2001, CED=, RCID=5000, MRDID=1, CallAtVRU=0, OpCode=0

20:31:27 rtr      Trace: (2 x 0 : 0 0) TranRouteToVRU: Label=6000, CorID=1, VRUI

D=5000

20:31:27 rtr      Trace: (2 x 0 : 0 0) Connect: CID=(150807,72239101), EventSele

ct=0, ServiceType=0, RCID=5000, Label(s)=6000

20:31:28 rtr      Trace: Dialog (3) has a correlation id (0 ) that is unknown.

20:31:47 rtr      No default label available for dialed number RCLIENT1.8000 (ID

5005).

20:31:47 rtr      Trace: (2 x 1 : 0 0) No default label available for dialed num

ber RCLIENT1.8000 (ID 5005).

20:31:47 rtr      Trace: (2 x 1 : 0 0) Deleting Dialog.

And the following is the PG logs:

C:\Users\lostchild.IPCORP>emsmon lab1 PG1A pim2

Events from November 24, 2013:

20:38:36 pim2     Trace: EMSServer connection established in node name: lab1\PG1

A process: pim2 for user lostchild.

20:38:53 pim2     Trace: VRU->PG:REQUEST_INSTRUCTION(50 bytes):DID=20 SendSeq#=1

TrkGrpID=3 TrkNum=0 SrvID=0 ANI=2001 UUI=1019/1 CalledNumber=6000 DNIS=6000

20:38:53 pim2     Trace: FromVRU_RequestInstruction:REQUEST_INSTRUCTION  RCID=50

00 PID=5000 DID=20 DIDRelSeq#=1 CorrID= CalledParty#=6000 CallingParty#=2001 UUI

(Type=1)=1019/1

20:38:53 pim2     Trace: ProcessDialogFail:DIALOG_FAIL  RCID=5000 PID=5000 Failu

reType=2 NumOfEvents=1 DID=20 DIDRelSeqNo=0 ReasonCode=11

20:38:53 pim2     Trace: PG->VRU:DIALOGUE_FAILURE_EVENT(16 bytes):DID=20 SendSeq

#=1 ErrorCode=Unspecified Failure (15)

20:39:01 pim2     Trace: VRU->PG:VRU_STATUS(88 bytes):DID=4294967295 SendSeq#=42

94967295 CurrentTime=11/24/2013 20:39:00 TZDelta=+00:00:00(0) OpStatus=4(Transpa

rent failure; still fully operational) StatusVariables[16]={0, 0, 0, 0, 0, 0, 0,

0, 0, 0, 0, 0, 0, 0, 0, 0}

20:39:01 pim2     Trace: RTPeripheralConfig: Mode=1 TimeZone=0 UCTTime=138532554

0 AbsHalfHour=0 PeripheralData[41]={0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0,

0}

20:40:01 pim2     Trace: VRU->PG:VRU_STATUS(88 bytes):DID=4294967295 SendSeq#=42

94967295 CurrentTime=11/24/2013 20:40:00 TZDelta=+00:00:00(0) OpStatus=4(Transpa

rent failure; still fully operational) StatusVariables[16]={0, 0, 0, 0, 0, 0, 0,

0, 0, 0, 0, 0, 0, 0, 0, 0}

20:40:01 pim2     Trace: RTPeripheralConfig: Mode=1 TimeZone=0 UCTTime=138532560

0 AbsHalfHour=0 PeripheralData[41]={0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0,

0}

the are the logs of CCX Engine:

598431815: Nov 24 20:38:52.034 GMT %MIVR-SS_ICM-7-CHANNEL_EVENT:CTI Port Channel event received: Channel id=0,Event=com.cisco.channel.ChannelEvent[CHANNEL_IN_USE,state=IN_USE,contact=JTAPICallContact[id=20,implId=1019/1,state=STATE_RECEIVED_IDX,inbound=true,App name=IPIVR_TP,task=null,session=2000000021,seq num=0,cn=6000,dn=6000,cgn=2001,ani=null,dnis=null,clid=null,atype=REDIRECT,lrd=8000,ocn=8000,route=RP[num=6000],OrigProtocolCallRef=00000000000003FB014889B300000000,DestProtocolCallRef=null,TP=null] on TP[type=Cisco CTI Port,id=0,implId=6009,active=true,state=IN_USE] at Sun Nov 24 20:38:52 GMT 2013

598431816: Nov 24 20:38:52.110 GMT %MIVR-SS_ICM-7-CALL_EVENT:Call event received: Contact id=20,Media id=1019/1,Task id=null,Event=com.cisco.call.CallEvent[CALL_ATTRIBUTED,state=CALL_RECEIVED,task=AppTask[id=0x5d21dba29,time=1385325532098,state=STARTED,active=true,aborting=null,app=App[name=IPIVR_TP,type=Cisco ICM Translation-Routing,id=0,desc=IPIVR_TP,enabled=true,max=10,valid=true,cfg=[ApplicationConfig[schema=ApplicationConfig,time=2013-11-21 16:06:31.0,recordId=4,desc=IPIVR_TP,name=IPIVR_TP,type=Cisco ICM Translation-Routing,id=0,enabled=true,sessions=10,defaultScript=,defaultVars=null,idleTimeout=4000]]],trigger=ContactApplicationTrigger[time=1385325532096,locale=en_GB,cfg=JTAPITriggerConfig[schema=ApplicationTriggerConfig,time=2013-11-20 14:10:30.0,recordId=2,desc=Cisco JTAPI Trigger,name=6000,type=Cisco JTAPI Trigger,appName=IPIVR_TP,enabled=true,sessions=10,idleTimeout=5000,locale=en_GB,parms={},taskGroups=[],controlClass=class com.cisco.call.CallControlChannel,controlGroupId=3,contactGroups=[GroupInfo[class=com.cisco.dialog.DialogChannel,id=0]],dn=6000,redirectCSS=default,cmDeviceName=IPIVR_RP,cmDeviceInvalid=false,cmDescription=IP IVR,cmDevicePoolUUID={1B1B9EB6-7803-11D3-BDF0-00108302EAD1},cmDevicePoolName=Default,cmCallingSearchSpaceUUID=,cmCallingSearchSpaceName=None,cmLocationUUID={29C5C1C4-8871-4D1E-8394-0B9181E8C54D},cmLocationName=Hub_None,cmPartitionUUID=,cmPartitionName=None,cmVoiceMailProfileUUID=,cmVoiceMailProfileName=None,cmCallPickUpGroupUUID=,cmCallPickUpGroupName=,cmDisplay=,cmExternalPhNumMask=,cmFwdBusyVM=false,cmFwdBusyDest=,cmFwdBusyCSSUUID=,cmFwdBusyCSSName=None,cmAlertingNameAscii=,cmPresenceGroupUUID=ad243d17-98b4-4118-8feb-5ff2e1b781ac,cmPresenceGroupName=Standard Presence group,campaignID=-1],contact=JTAPICallContact[id=20,implId=1019/1,state=STATE_ATTRIBUTED_IDX,inbound=true,App name=IPIVR_TP,task=25000000041,session=2000000021,seq num=0,cn=6000,dn=6000,cgn=2001,ani=null,dnis=null,clid=null,atype=REDIRECT,lrd=8000,ocn=8000,route=RP[num=6000],OrigProtocolCallRef=00000000000003FB014889B400000000,DestProtocolCallRef=null,TP=6009]],task=com.cisco.wf.subsystems.ged125.ICMApplicationTask@1031d21,default=null],contactImplId=1019/1,lastContactImplId=1019/1,session=Session[id=001-0x77359415,parent=null,active=true,state=SESSION_IN_USE,time=1385325532018],lastSession=Session[id=001-0x77359415,parent=null,active=true,state=SESSION_IN_USE,time=1385325532018],contactSeqNum=0,lastContactSeqNum=0] on JTAPICallContact[id=20,implId=1019/1,state=STATE_ATTRIBUTED_IDX,inbound=true,App name=IPIVR_TP,task=25000000041,session=2000000021,seq num=0,cn=6000,dn=6000,cgn=2001,ani=null,dnis=null,clid=null,atype=REDIRECT,lrd=8000,ocn=8000,route=RP[num=6000],OrigProtocolCallRef=00000000000003FB014889B400000000,DestProtocolCallRef=null,TP=6009] at Sun Nov 24 20:38:52 GMT 2013

598431817: Nov 24 20:38:52.120 GMT %MIVR-SS_ICM-7-UNK:Initializing ICM Call from event: com.cisco.call.CallEvent[CALL_ATTRIBUTED,state=CALL_RECEIVED,task=AppTask[id=0x5d21dba29,time=1385325532098,state=STARTED,active=true,aborting=null,app=App[name=IPIVR_TP,type=Cisco ICM Translation-Routing,id=0,desc=IPIVR_TP,enabled=true,max=10,valid=true,cfg=[ApplicationConfig[schema=ApplicationConfig,time=2013-11-21 16:06:31.0,recordId=4,desc=IPIVR_TP,name=IPIVR_TP,type=Cisco ICM Translation-Routing,id=0,enabled=true,sessions=10,defaultScript=,defaultVars=null,idleTimeout=4000]]],trigger=ContactApplicationTrigger[time=1385325532096,locale=en_GB,cfg=JTAPITriggerConfig[schema=ApplicationTriggerConfig,time=2013-11-20 14:10:30.0,recordId=2,desc=Cisco JTAPI Trigger,name=6000,type=Cisco JTAPI Trigger,appName=IPIVR_TP,enabled=true,sessions=10,idleTimeout=5000,locale=en_GB,parms={},taskGroups=[],controlClass=class com.cisco.call.CallControlChannel,controlGroupId=3,contactGroups=[GroupInfo[class=com.cisco.dialog.DialogChannel,id=0]],dn=6000,redirectCSS=default,cmDeviceName=IPIVR_RP,cmDeviceInvalid=false,cmDescription=IP IVR,cmDevicePoolUUID={1B1B9EB6-7803-11D3-BDF0-00108302EAD1},cmDevicePoolName=Default,cmCallingSearchSpaceUUID=,cmCallingSearchSpaceName=None,cmLocationUUID={29C5C1C4-8871-4D1E-8394-0B9181E8C54D},cmLocationName=Hub_None,cmPartitionUUID=,cmPartitionName=None,cmVoiceMailProfileUUID=,cmVoiceMailProfileName=None,cmCallPickUpGroupUUID=,cmCallPickUpGroupName=,cmDisplay=,cmExternalPhNumMask=,cmFwdBusyVM=false,cmFwdBusyDest=,cmFwdBusyCSSUUID=,cmFwdBusyCSSName=None,cmAlertingNameAscii=,cmPresenceGroupUUID=ad243d17-98b4-4118-8feb-5ff2e1b781ac,cmPresenceGroupName=Standard Presence group,campaignID=-1],contact=JTAPICallContact[id=20,implId=1019/1,state=STATE_ATTRIBUTED_IDX,inbound=true,App name=IPIVR_TP,task=25000000041,session=2000000021,seq num=0,cn=6000,dn=6000,cgn=2001,ani=null,dnis=null,clid=null,atype=REDIRECT,lrd=8000,ocn=8000,route=RP[num=6000],OrigProtocolCallRef=00000000000003FB014889B400000000,DestProtocolCallRef=null,TP=6009]],task=com.cisco.wf.subsystems.ged125.ICMApplicationTask@1031d21,default=null],contactImplId=1019/1,lastContactImplId=1019/1,session=Session[id=001-0x77359415,parent=null,active=true,state=SESSION_IN_USE,time=1385325532018],lastSession=Session[id=001-0x77359415,parent=null,active=true,state=SESSION_IN_USE,time=1385325532018],contactSeqNum=0,lastContactSeqNum=0] on JTAPICallContact[id=20,implId=1019/1,state=STATE_ATTRIBUTED_IDX,inbound=true,App name=IPIVR_TP,task=25000000041,session=2000000021,seq num=0,cn=6000,dn=6000,cgn=2001,ani=null,dnis=null,clid=null,atype=REDIRECT,lrd=8000,ocn=8000,route=RP[num=6000],OrigProtocolCallRef=00000000000003FB014889B400000000,DestProtocolCallRef=null,TP=6009] at Sun Nov 24 20:38:52 GMT 2013

598431818: Nov 24 20:38:52.134 GMT %MIVR-LIB_ICM-6-ABORTING_CALL:Aborting ICM Call: Call id=20,Media id=1019/1,Trunk number=0,Trunk Group id=3

598431819: Nov 24 20:38:52.135 GMT %MIVR-SS_ICM-7-UNK:queue.poll(4000): ICM Message=ABORT_CALL,Contact id=20,Media id=1019/1,Task id=25000000041

598431820: Nov 24 20:38:52.135 GMT %MIVR-SS_ICM-7-UNK:Aborting call before processing request: ICM Message=ABORT_CALL,Contact id=20,Media id=1019/1,Task id=25000000041

598431821: Nov 24 20:38:52.139 GMT %MIVR-APP_MGR-3-TASK_ABORTED:Application task aborted: Application=App[name=IPIVR_TP,type=Cisco ICM Translation-Routing,id=0,desc=IPIVR_TP,enabled=true,max=10,valid=true,cfg=[ApplicationConfig[schema=ApplicationConfig,time=2013-11-21 16:06:31.0,recordId=4,desc=IPIVR_TP,name=IPIVR_TP,type=Cisco ICM Translation-Routing,id=0,enabled=true,sessions=10,defaultScript=,defaultVars=null,idleTimeout=4000]]],Application Trigger=ContactApplicationTrigger[time=1385325532096,locale=en_GB,cfg=JTAPITriggerConfig[schema=ApplicationTriggerConfig,time=2013-11-20 14:10:30.0,recordId=2,desc=Cisco JTAPI Trigger,name=6000,type=Cisco JTAPI Trigger,appName=IPIVR_TP,enabled=true,sessions=10,idleTimeout=5000,locale=en_GB,parms={},taskGroups=[],controlClass=class com.cisco.call.CallControlChannel,controlGroupId=3,contactGroups=[GroupInfo[class=com.cisco.dialog.DialogChannel,id=0]],dn=6000,redirectCSS=default,cmDeviceName=IPIVR_RP,cmDeviceInvalid=false,cmDescription=IP IVR,cmDevicePoolUUID={1B1B9EB6-7803-11D3-BDF0-00108302EAD1},cmDevicePoolName=Default,cmCallingSearchSpaceUUID=,cmCallingSearchSpaceName=None,cmLocationUUID={29C5C1C4-8871-4D1E-8394-0B9181E8C54D},cmLocationName=Hub_None,cmPartitionUUID=,cmPartitionName=None,cmVoiceMailProfileUUID=,cmVoiceMailProfileName=None,cmCallPickUpGroupUUID=,cmCallPickUpGroupName=,cmDisplay=,cmExternalPhNumMask=,cmFwdBusyVM=false,cmFwdBusyDest=,cmFwdBusyCSSUUID=,cmFwdBusyCSSName=None,cmAlertingNameAscii=,cmPresenceGroupUUID=ad243d17-98b4-4118-8feb-5ff2e1b781ac,cmPresenceGroupName=Standard Presence group,campaignID=-1],contact=JTAPICallContact[id=20,implId=1019/1,state=STATE_ATTRIBUTED_IDX,inbound=true,App name=IPIVR_TP,task=25000000041,session=2000000021,seq num=0,cn=6000,dn=6000,cgn=2001,ani=null,dnis=null,clid=null,atype=REDIRECT,lrd=8000,ocn=8000,route=RP[num=6000],OrigProtocolCallRef=00000000000003FB014889B400000000,DestProtocolCallRef=null,TP=6009]],Task id=25000000041,Task com.cisco.app.impl.WFAppTaskWrapper,Exception=com.cisco.wf.subsystems.ged125.GED125RuntimeException

598431822: Nov 24 20:38:52.140 GMT %MIVR-APP_MGR-3-EXCEPTION:com.cisco.wf.subsystems.ged125.GED125RuntimeException

598431823: Nov 24 20:38:52.140 GMT %MIVR-APP_MGR-3-EXCEPTION:    at com.cisco.wf.subsystems.ged125.ICMApplicationTask.execute(ICMApplicationTask.java:2452)

598431824: Nov 24 20:38:52.140 GMT %MIVR-APP_MGR-3-EXCEPTION:    at com.cisco.app.impl.WFAppTaskWrapper.execute(WFAppTaskWrapper.java:291)

598431825: Nov 24 20:38:52.141 GMT %MIVR-APP_MGR-3-EXCEPTION:    at com.cisco.wfframework.engine.core.TaskManager.runTaskNormally(TaskManager.java:416)

598431826: Nov 24 20:38:52.142 GMT %MIVR-APP_MGR-3-EXCEPTION:    at com.cisco.wfframework.engine.core.TaskManager.runTask(TaskManager.java:371)

598431827: Nov 24 20:38:52.142 GMT %MIVR-APP_MGR-3-EXCEPTION:    at com.cisco.wfframework.engine.core.TaskManager$RunnableTask.run(TaskManager.java:589)

598431828: Nov 24 20:38:52.142 GMT %MIVR-APP_MGR-3-EXCEPTION:    at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.runCommand(ExecutorStubImpl.java:690)

598431829: Nov 24 20:38:52.142 GMT %MIVR-APP_MGR-3-EXCEPTION:    at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.run(ExecutorStubImpl.java:486)

598431830: Nov 24 20:38:52.143 GMT %MIVR-APP_MGR-3-EXCEPTION:    at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.run(ExecutorStubImpl.java:762)

598431831: Nov 24 20:38:52.144 GMT %MIVR-APP_MGR-3-EXCEPTION:    at EDU.oswego.cs.dl.util.concurrent.PooledExecutor$Worker.run(PooledExecutor.java:776)

598431832: Nov 24 20:38:52.144 GMT %MIVR-APP_MGR-3-EXCEPTION:    at com.cisco.executor.impl.PooledExecutorStubImpl$1$WorkerImpl.run(PooledExecutorStubImpl.java:99)

598431833: Nov 24 20:38:52.145 GMT %MIVR-APP_MGR-3-EXCEPTION:    at com.cisco.util.ThreadPoolFactory$ThreadImpl.run(ThreadPoolFactory.java:853)

598431834: Nov 24 20:38:52.146 GMT %MIVR-APP_MGR-6-ABORTING_CONTACT:Aborting contact: Application=IPIVR_TP,Task id=25000000041,Contact id=20,Contact implementation id=1019/1,Contact.cisco.call.CallContact,Contact Type=Cisco JTAPI Call,Exception=com.cisco.wf.subsystems.ged125.GED125RuntimeException

598431835: Nov 24 20:38:52.146 GMT %MIVR-APP_MGR-6-EXCEPTION:com.cisco.wf.subsystems.ged125.GED125RuntimeException

598431836: Nov 24 20:38:52.147 GMT %MIVR-APP_MGR-6-EXCEPTION:    at com.cisco.wf.subsystems.ged125.ICMApplicationTask.execute(ICMApplicationTask.java:2452)

598431837: Nov 24 20:38:52.147 GMT %MIVR-APP_MGR-6-EXCEPTION:    at com.cisco.app.impl.WFAppTaskWrapper.execute(WFAppTaskWrapper.java:291)

598431838: Nov 24 20:38:52.147 GMT %MIVR-APP_MGR-6-EXCEPTION:    at com.cisco.wfframework.engine.core.TaskManager.runTaskNormally(TaskManager.java:416)

598431839: Nov 24 20:38:52.148 GMT %MIVR-APP_MGR-6-EXCEPTION:    at com.cisco.wfframework.engine.core.TaskManager.runTask(TaskManager.java:371)

598431840: Nov 24 20:38:52.149 GMT %MIVR-APP_MGR-6-EXCEPTION:    at com.cisco.wfframework.engine.core.TaskManager$RunnableTask.run(TaskManager.java:589)

598431841: Nov 24 20:38:52.149 GMT %MIVR-APP_MGR-6-EXCEPTION:    at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.runCommand(ExecutorStubImpl.java:690)

598431842: Nov 24 20:38:52.150 GMT %MIVR-APP_MGR-6-EXCEPTION:    at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.run(ExecutorStubImpl.java:486)

598431843: Nov 24 20:38:52.151 GMT %MIVR-APP_MGR-6-EXCEPTION:    at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.run(ExecutorStubImpl.java:762)

598431844: Nov 24 20:38:52.152 GMT %MIVR-APP_MGR-6-EXCEPTION:    at EDU.oswego.cs.dl.util.concurrent.PooledExecutor$Worker.run(PooledExecutor.java:776)

598431845: Nov 24 20:38:52.152 GMT %MIVR-APP_MGR-6-EXCEPTION:    at com.cisco.executor.impl.PooledExecutorStubImpl$1$WorkerImpl.run(PooledExecutorStubImpl.java:99)

598431846: Nov 24 20:38:52.152 GMT %MIVR-APP_MGR-6-EXCEPTION:    at com.cisco.util.ThreadPoolFactory$ThreadImpl.run(ThreadPoolFactory.java:853)

Seems like the problem is the correlation ID, that is not presented from the IP IVR. But I'm not sure what can be the cause for this.

Could somebody let me know how to proceed here please?

Thanks a lot to everyone,

George,

2 REPLIES
New Member

I am having the same issue. 

I am having the same issue.  Did you ever get this resolved?

Hi,can you show us the IP IVR

Hi,

can you show us the IP IVR script you are trying to invoke, please?

G.

545
Views
0
Helpful
2
Replies
CreatePlease to create content