UCCX ASR problem

[Anton Rybak]

We have UCCX version 12 and ASR/TTS server VoiceNavigator. I m used standard script for testing ASR and TTS. I also created MRCP ASR provider, dialog and server, MRCP TTS server and provider. All services status "IN SERVICE". When i tried to test script, i used default dialog group in trigger configuration. Script is working and TTS too, but ASR not even starting. I tried to use MRCP ASR Dialog group in trigger configuration, but call not reaching script at all, so reactive debegging not working and when i try to call trigger number i hear only fast busy tones. Help please find solution with ASR, thank you.

[Jonathan Schulenberg]

Unfortunately, Nuance remains the only supported vendor: https://www.cisco.com/c/en/us/td/docs/voice_ip_comm/cust_contact/contact_center/crs/express_compatibility/matrix/uccxcompat12_0_1.html#ASR_and_TTS

Of course, you could try pulling logs from one or both platforms to see if you can spot an issue. Hopefully this is a lab scenario where you can tinker and learn; I would have heartburn about a production deployment knowing Cisco won’t support it.

[Anton Rybak]

Attached log with failed calls.

[Anton Rybak]

Jonathan,

please, could you check last log? Call even not reaching script with ASR and TTS on UCCX. Thank you.

[Anton Rybak]

4003072: Jun 27 17:19:17.181 GMT+300 %MIVR-SS_TEL-7-UNK: [MIVR_SS_TEL_TPG_ROUTE_EXE-41-878-ROUTE_CALL_EV] com.cisco.executor.impl.ExecutorStubImpl.RequestImpl Route Connection=[614050:Internal:1/(P1-cti_manager_new_1) GCID=(1,338156)->ACTIVE]->OFFERED, reason=1, Event= CallCtlConnOfferedEv 614050:Internal:1, cause=100, metacode=129, isMaster=true
4003073: Jun 27 17:19:17.181 GMT+300 %MIVR-SS_TEL-7-UNK: [MIVR_SS_TEL_TPG_ROUTE_EXE-41-878-ROUTE_CALL_EV] com.cisco.wf.subsystems.jtapi.TAPIPortGroup Just before getUniqueID
4003074: Jun 27 17:19:17.181 GMT+300 %MIVR-SS_TEL-7-UNK: [MIVR_SS_TEL_TPG_ROUTE_EXE-41-878-ROUTE_CALL_EV] com.cisco.wf.subsystems.jtapi.TAPIPortGroup Originator Protocol Call Ref = 00000000000528EC012346FD00000000
4003075: Jun 27 17:19:17.181 GMT+300 %MIVR-SS_CM-7-UNK: [MIVR_SS_TEL_TPG_ROUTE_EXE-41-878-ROUTE_CALL_EV] com.cisco.wf.subsystems.rmcm.CallContact RmCm contact -1[null] .setAppContact(1322) from null
4003076: Jun 27 17:19:17.181 GMT+300 %MIVR-SS_TEL-7-UNK: [MIVR_SS_TEL_TPG_ROUTE_EXE-41-878-ROUTE_CALL_EV] com.cisco.wf.subsystems.jtapi.CallImpl Call.received() JTAPICallContact[id=1322,implId=338156/1,state=STATE_RECEIVED_IDX,inbound=true,App name=VoiceNavigator,task=null,session=null,seq num=-1,cn=614050,dn=614050,cgn=5475,ani=null,dnis=null,clid=null,atype=DIRECT,lrd=null,ocn=614050,route=RP[num=614050],OrigProtocolCallRef=00000000000528EC012346FD00000000,DestProtocolCallRef=null,TP=null
4003077: Jun 27 17:19:17.182 GMT+300 %MIVR-SS_CM-7-UNK: [MIVR_SS_TEL_TPG_ROUTE_EXE-41-878-ROUTE_CALL_EV] com.cisco.wf.subsystems.rmcm.ICDContactAdapter ICDContactAdapter 1182 : ContactSessionChanged received for App FW contact 1322, iefSourceContact is 17115372 [338156/1] (988)
4003078: Jun 27 17:19:17.182 GMT+300 %MIVR-SS_CM-7-UNK: [MIVR_SS_TEL_TPG_ROUTE_EXE-41-878-ROUTE_CALL_EV] com.cisco.wf.subsystems.rmcm.ICDContactAdapter Ignoring contactSessionChanged because either the new or old session is null
4003079: Jun 27 17:19:17.183 GMT+300 %MIVR-SS_TEL-7-UNK: [MIVR_SS_RTR_EVENTS-37-0-CONTACT_RECEIVED] com.cisco.wf.subsystems.jtapi.CallImpl TAPIPortGroup::CallImpl:getReportingPropeorty - Get Property : 1
4003080: Jun 27 17:19:17.183 GMT+300 %MIVR-SS_TEL-7-UNK: [MIVR_SS_RTR_EVENTS-37-0-CONTACT_RECEIVED] com.cisco.wf.subsystems.jtapi.CallImpl TAPIPortGroup::CallImpl:getReportingPropeorty - IVR OB Call. Found "OBIVRCALL" in the contact context : false
4003081: Jun 27 17:19:17.730 GMT+300 %MIVR-SS_OB-7-UNK: [MIVR_SS_OB_OutboundMgrMsgProcessor-64-0-OutboundMgrMsgProcessor] com.cisco.wf.subsystems.outbound.OutboundMgrMsgProcessor OutboundMgrMsgProcessor:Processing msg: OutboundCSQIterationMsg: csqID: 3 ,dialerType: PREVIEW_DIALER
4003082: Jun 27 17:19:17.730 GMT+300 %MIVR-SS_OB-7-UNK: [MIVR_SS_OB_OutboundMgrMsgProcessor-64-0-OutboundMgrMsgProcessor] com.cisco.wf.subsystems.outbound.CSQPreviewOutboundInfo OutboundContactInfo:getNumberContactsToCall() for csqID:3 :0
4003083: Jun 27 17:19:17.730 GMT+300 %MIVR-SS_OB-7-UNK: [MIVR_SS_OB_OutboundMgrMsgProcessor-64-0-OutboundMgrMsgProcessor] com.cisco.wf.subsystems.outbound.PreviewDialer PreviewDialer:sendAgentReservationMsgToRMCM() csqid:3 ,#Total active resources in csq:0.0 ,#CSQ allocation %:100 ,#active:0.0, #active-working:0, #Number of Available resources:0, #lic_left:25, #contacts:0
4003084: Jun 27 17:19:18.687 GMT+300 %MIVR-SS_RM-7-UNK: [MIVR_SS_RM_RmMsgProcessor-107-0-RmMsgProcessor] com.cisco.wf.subsystems.rmcm.RsrcMgrMsgProcessor Processing msg: CTISnapshotDeviceReqMsg CTIMgrTPCCReqMsg Socket:Socket[addr=192.168.204.2,port=56630,localport=12028] invokeID:41692, peripheralID: 1, deviceIDType: 76, agentInstrument: 5618
4003085: Jun 27 17:19:18.688 GMT+300 %MIVR-ICD_CTI-7-UNK: [MIVR_ICD_CTI_SERVER-94-1-outboundMsgQ] com.cisco.wf.subsystems.ctiserver.CSOutboundMsgProcessor OutboundMsgProcessor: got message: { SNAPSHOT_DEVICE_CONF }
4003086: Jun 27 17:19:18.688 GMT+300 %MIVR-ICD_CTI-7-UNK: [MIVR_ICD_CTI_SERVER-94-1-outboundMsgQ] com.cisco.wf.subsystems.ctiserver.CSOutboundMsgProcessor OutboundMessageprocessor : sending msg : { length=-1 type=SNAPSHOT_DEVICE_CONF,invokeId=41692 numCalls=0 to socket: Socket[addr=192.168.204.2,port=56630,localport=12028]
4003087: Jun 27 17:19:18.688 GMT+300 %MIVR-ICD_CTI-7-UNK: [MIVR_ICD_CTI_SOCKET-145-54925-PROCESS_CTI_MGR_RESPONSE] com.cisco.wf.subsystems.ctiserver.MsgHandler MsgHandler : Sent : { SNAPSHOT_DEVICE_CONF to Socket[addr=192.168.204.2,port=56630,localport=12028] }
4003088: Jun 27 17:19:18.689 GMT+300 %MIVR-SS_RM-7-UNK: [MIVR_SS_RM_RmMsgProcessor-107-0-RmMsgProcessor] com.cisco.wf.subsystems.rmcm.RsrcMgrMsgProcessor Processing msg: CTISnapshotDeviceReqMsg CTIMgrTPCCReqMsg Socket:Socket[addr=192.168.204.11,port=50476,localport=12028] invokeID:48338, peripheralID: 1, deviceIDType: 76, agentInstrument: 5618
4003089: Jun 27 17:19:18.689 GMT+300 %MIVR-ICD_CTI-7-UNK: [MIVR_ICD_CTI_SERVER-94-1-outboundMsgQ] com.cisco.wf.subsystems.ctiserver.CSOutboundMsgProcessor OutboundMsgProcessor: got message: { SNAPSHOT_DEVICE_CONF }
4003090: Jun 27 17:19:18.689 GMT+300 %MIVR-ICD_CTI-7-UNK: [MIVR_ICD_CTI_SERVER-94-1-outboundMsgQ] com.cisco.wf.subsystems.ctiserver.CSOutboundMsgProcessor OutboundMessageprocessor : sending msg : { length=-1 type=SNAPSHOT_DEVICE_CONF,invokeId=48338 numCalls=0 to socket: Socket[addr=192.168.204.11,port=50476,localport=12028]
4003091: Jun 27 17:19:18.690 GMT+300 %MIVR-ICD_CTI-7-UNK: [MIVR_ICD_CTI_SOCKET-139-56594-PROCESS_CTI_MGR_RESPONSE] com.cisco.wf.subsystems.ctiserver.MsgHandler MsgHandler : Sent : { SNAPSHOT_DEVICE_CONF to Socket[addr=192.168.204.11,port=50476,localport=12028] }
4003092: Jun 27 17:19:18.730 GMT+300 %MIVR-SS_OB-7-UNK: [MIVR_SS_OB_OutboundMgrMsgProcessor-64-0-OutboundMgrMsgProcessor] com.cisco.wf.subsystems.outbound.OutboundMgrMsgProcessor OutboundMgrMsgProcessor:Processing msg: OutboundCSQIterationMsg: csqID: 3 ,dialerType: PREVIEW_DIALER
4003093: Jun 27 17:19:18.730 GMT+300 %MIVR-SS_OB-7-UNK: [MIVR_SS_OB_OutboundMgrMsgProcessor-64-0-OutboundMgrMsgProcessor] com.cisco.wf.subsystems.outbound.CSQPreviewOutboundInfo OutboundContactInfo:getNumberContactsToCall() for csqID:3 :0
4003094: Jun 27 17:19:18.730 GMT+300 %MIVR-SS_OB-7-UNK: [MIVR_SS_OB_OutboundMgrMsgProcessor-64-0-OutboundMgrMsgProcessor] com.cisco.wf.subsystems.outbound.PreviewDialer PreviewDialer:sendAgentReservationMsgToRMCM() csqid:3 ,#Total active resources in csq:0.0 ,#CSQ allocation %:100 ,#active:0.0, #active-working:0, #Number of Available resources:0, #lic_left:25, #contacts:0
4003095: Jun 27 17:19:19.730 GMT+300 %MIVR-SS_OB-7-UNK: [MIVR_SS_OB_OutboundMgrMsgProcessor-64-0-OutboundMgrMsgProcessor] com.cisco.wf.subsystems.outbound.OutboundMgrMsgProcessor OutboundMgrMsgProcessor:Processing msg: OutboundCSQIterationMsg: csqID: 3 ,dialerType: PREVIEW_DIALER
4003096: Jun 27 17:19:19.731 GMT+300 %MIVR-SS_OB-7-UNK: [MIVR_SS_OB_OutboundMgrMsgProcessor-64-0-OutboundMgrMsgProcessor] com.cisco.wf.subsystems.outbound.CSQPreviewOutboundInfo OutboundContactInfo:getNumberContactsToCall() for csqID:3 :0
4003097: Jun 27 17:19:19.731 GMT+300 %MIVR-SS_OB-7-UNK: [MIVR_SS_OB_OutboundMgrMsgProcessor-64-0-OutboundMgrMsgProcessor] com.cisco.wf.subsystems.outbound.PreviewDialer PreviewDialer:sendAgentReservationMsgToRMCM() csqid:3 ,#Total active resources in csq:0.0 ,#CSQ allocation %:100 ,#active:0.0, #active-working:0, #Number of Available resources:0, #lic_left:25, #contacts:0
4003098: Jun 27 17:19:20.731 GMT+300 %MIVR-SS_OB-7-UNK: [MIVR_SS_OB_OutboundMgrMsgProcessor-64-0-OutboundMgrMsgProcessor] com.cisco.wf.subsystems.outbound.OutboundMgrMsgProcessor OutboundMgrMsgProcessor:Processing msg: OutboundCSQIterationMsg: csqID: 3 ,dialerType: PREVIEW_DIALER
4003099: Jun 27 17:19:20.731 GMT+300 %MIVR-SS_OB-7-UNK: [MIVR_SS_OB_OutboundMgrMsgProcessor-64-0-OutboundMgrMsgProcessor] com.cisco.wf.subsystems.outbound.CSQPreviewOutboundInfo OutboundContactInfo:getNumberContactsToCall() for csqID:3 :0
4003100: Jun 27 17:19:20.731 GMT+300 %MIVR-SS_OB-7-UNK: [MIVR_SS_OB_OutboundMgrMsgProcessor-64-0-OutboundMgrMsgProcessor] com.cisco.wf.subsystems.outbound.PreviewDialer PreviewDialer:sendAgentReservationMsgToRMCM() csqid:3 ,#Total active resources in csq:0.0 ,#CSQ allocation %:100 ,#active:0.0, #active-working:0, #Number of Available resources:0, #lic_left:25, #contacts:0
4003101: Jun 27 17:19:20.777 GMT+300 %MIVR-SS_TEL-7-UNK: [MIVR_SS_TEL_RECOVERY_0_-44-0-RUN] com.cisco.wf.subsystems.jtapi.RecoveryThread Running CTI Port recovery 'MIVR_SS_TEL_RECOVERY_0_-44-0' @ 1561645160777
4003102: Jun 27 17:19:20.777 GMT+300 %MIVR-SS_TEL-7-UNK: [MIVR_SS_TEL_RECOVERY_0_-44-0-RUN] com.cisco.wf.subsystems.jtapi.RecoveryThread ... CTI Port recovery 'MIVR_SS_TEL_RECOVERY_0_-44-0' @ 1561645160777 done.
4003103: Jun 27 17:19:21.200 GMT+300 %MIVR-SS_TEL-7-UNK: [MIVR_SS_TEL_TPG_EXE-40-12318-CONN_DISCONNECTED] com.cisco.executor.impl.ExecutorStubImpl.RequestImpl RP[num=614050], conn=[614050:Internal:1/(P1-cti_manager_new_1) GCID=(1,338156)->INVALID]->DISCONNECTED, event=CallCtlConnDisconnectedEv 614050:Internal:1, cause=Other: 17[17], meta=META_CALL_ENDING[132]
4003104: Jun 27 17:19:21.200 GMT+300 %MIVR-SS_TEL-5-CTIPG_ROUTE_EVENT: [MIVR_SS_TEL_TPG_ROUTE_EXE-41-878-ROUTE_CALL_EV] com.cisco.executor.impl.ExecutorStubImpl.RequestImpl CTI Port Group route event: Route Session=[614050:Internal:1/(P1-cti_manager_new_1) GCID=(1,338156)->INVALID]->DISCONNECTED,Route Address=614050,Failure reason=CTI accept timer expires after 4019 ms, end route connection,Exception=com.cisco.lang.InterruptedException: No idle channels available in group 'VoiceNavigatorASR Group #2'; nested exception is:
com.cisco.lang.sync.AttemptInterruptedException: interrupted while allocating from [(('VoiceNavigatorASR Group #2' & ('Cisco Unified CCX Ports' & 'ASR Ports' & VoiceNavigatorASR))) & 'Cisco CTI Port Group #5']; nested exception is:
com.cisco.lang.sync.AttemptTimeoutException: timed out allocating from [(('VoiceNavigatorASR Group #2' & ('Cisco Unified CCX Ports' & 'ASR Ports' & VoiceNavigatorASR))) & 'Cisco CTI Port Group #5']; nested exception is:
com.cisco.lang.sync.AttemptTimeoutException: timed out allocating from [('VoiceNavigatorASR Group #2' & ('Cisco Unified CCX Ports' & 'ASR Ports' & VoiceNavigatorASR))]; nested exception is:
com.cisco.lang.sync.AttemptTimeoutException: timed out allocating from ['VoiceNavigatorASR Group #2' & ('Cisco Unified CCX Ports' & 'ASR Ports' & VoiceNavigatorASR)]; nested exception is:
com.cisco.lang.sync.AttemptTimeoutException: timed out allocating from ['VoiceNavigatorASR Group #2']
4003105: Jun 27 17:19:21.201 GMT+300 %MIVR-SS_TEL-5-EXCEPTION:com.cisco.lang.InterruptedException: No idle channels available in group 'VoiceNavigatorASR Group #2'; nested exception is:
4003106: Jun 27 17:19:21.201 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: com.cisco.lang.sync.AttemptInterruptedException: interrupted while allocating from [(('VoiceNavigatorASR Group #2' & ('Cisco Unified CCX Ports' & 'ASR Ports' & VoiceNavigatorASR))) & 'Cisco CTI Port Group #5']; nested exception is:
4003107: Jun 27 17:19:21.201 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: com.cisco.lang.sync.AttemptTimeoutException: timed out allocating from [(('VoiceNavigatorASR Group #2' & ('Cisco Unified CCX Ports' & 'ASR Ports' & VoiceNavigatorASR))) & 'Cisco CTI Port Group #5']; nested exception is:
4003108: Jun 27 17:19:21.201 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: com.cisco.lang.sync.AttemptTimeoutException: timed out allocating from [('VoiceNavigatorASR Group #2' & ('Cisco Unified CCX Ports' & 'ASR Ports' & VoiceNavigatorASR))]; nested exception is:
4003109: Jun 27 17:19:21.201 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: com.cisco.lang.sync.AttemptTimeoutException: timed out allocating from ['VoiceNavigatorASR Group #2' & ('Cisco Unified CCX Ports' & 'ASR Ports' & VoiceNavigatorASR)]; nested exception is:
4003110: Jun 27 17:19:21.201 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: com.cisco.lang.sync.AttemptTimeoutException: timed out allocating from ['VoiceNavigatorASR Group #2']
4003111: Jun 27 17:19:21.201 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.channel.impl.ChannelManagerImpl.getIdleChannels(ChannelManagerImpl.java:981)
4003112: Jun 27 17:19:21.201 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.channel.impl.ChannelManagerImpl.getIdleChannels(ChannelManagerImpl.java:706)
4003113: Jun 27 17:19:21.201 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.channel.Group.getIdleChannels(Group.java:400)
4003114: Jun 27 17:19:21.201 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.channel.Group.getIdleChannels(Group.java:354)
4003115: Jun 27 17:19:21.201 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.wf.subsystems.jtapi.RouteCallObserver$1.run(RouteCallObserver.java:427)
4003116: Jun 27 17:19:21.201 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.runCommand(ExecutorStubImpl.java:690)
4003117: Jun 27 17:19:21.201 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.run(ExecutorStubImpl.java:486)
4003118: Jun 27 17:19:21.201 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.run(ExecutorStubImpl.java:762)
4003119: Jun 27 17:19:21.201 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at EDU.oswego.cs.dl.util.concurrent.PooledExecutor$Worker.run(PooledExecutor.java:768)
4003120: Jun 27 17:19:21.201 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.executor.impl.PooledExecutorStubImpl$1$WorkerImpl.run(PooledExecutorStubImpl.java:99)
4003121: Jun 27 17:19:21.201 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.util.ThreadPoolFactory$ThreadImpl.run(ThreadPoolFactory.java:853)
4003122: Jun 27 17:19:21.201 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: nested stack trace is:
4003123: Jun 27 17:19:21.201 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: com.cisco.lang.sync.AttemptInterruptedException: interrupted while allocating from [(('VoiceNavigatorASR Group #2' & ('Cisco Unified CCX Ports' & 'ASR Ports' & VoiceNavigatorASR))) & 'Cisco CTI Port Group #5']; nested exception is:
4003124: Jun 27 17:19:21.201 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: com.cisco.lang.sync.AttemptTimeoutException: timed out allocating from [(('VoiceNavigatorASR Group #2' & ('Cisco Unified CCX Ports' & 'ASR Ports' & VoiceNavigatorASR))) & 'Cisco CTI Port Group #5']; nested exception is:
4003125: Jun 27 17:19:21.201 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: com.cisco.lang.sync.AttemptTimeoutException: timed out allocating from [('VoiceNavigatorASR Group #2' & ('Cisco Unified CCX Ports' & 'ASR Ports' & VoiceNavigatorASR))]; nested exception is:
4003126: Jun 27 17:19:21.201 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: com.cisco.lang.sync.AttemptTimeoutException: timed out allocating from ['VoiceNavigatorASR Group #2' & ('Cisco Unified CCX Ports' & 'ASR Ports' & VoiceNavigatorASR)]; nested exception is:
4003127: Jun 27 17:19:21.201 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: com.cisco.lang.sync.AttemptTimeoutException: timed out allocating from ['VoiceNavigatorASR Group #2']
4003128: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.MultiSync.attempt(MultiSync.java:401)
4003129: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.PermitCollection.attempt(PermitCollection.java:422)
4003130: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.channel.impl.ChannelManagerImpl.getIdleChannels(ChannelManagerImpl.java:941)
4003131: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.channel.impl.ChannelManagerImpl.getIdleChannels(ChannelManagerImpl.java:706)
4003132: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.channel.Group.getIdleChannels(Group.java:400)
4003133: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.channel.Group.getIdleChannels(Group.java:354)
4003134: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.wf.subsystems.jtapi.RouteCallObserver$1.run(RouteCallObserver.java:427)
4003135: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.runCommand(ExecutorStubImpl.java:690)
4003136: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.run(ExecutorStubImpl.java:486)
4003137: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.run(ExecutorStubImpl.java:762)
4003138: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at EDU.oswego.cs.dl.util.concurrent.PooledExecutor$Worker.run(PooledExecutor.java:768)
4003139: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.executor.impl.PooledExecutorStubImpl$1$WorkerImpl.run(PooledExecutorStubImpl.java:99)
4003140: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.util.ThreadPoolFactory$ThreadImpl.run(ThreadPoolFactory.java:853)
4003141: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: nested stack trace is:
4003142: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: com.cisco.lang.sync.AttemptTimeoutException: timed out allocating from [(('VoiceNavigatorASR Group #2' & ('Cisco Unified CCX Ports' & 'ASR Ports' & VoiceNavigatorASR))) & 'Cisco CTI Port Group #5']; nested exception is:
4003143: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: com.cisco.lang.sync.AttemptTimeoutException: timed out allocating from [('VoiceNavigatorASR Group #2' & ('Cisco Unified CCX Ports' & 'ASR Ports' & VoiceNavigatorASR))]; nested exception is:
4003144: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: com.cisco.lang.sync.AttemptTimeoutException: timed out allocating from ['VoiceNavigatorASR Group #2' & ('Cisco Unified CCX Ports' & 'ASR Ports' & VoiceNavigatorASR)]; nested exception is:
4003145: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: com.cisco.lang.sync.AttemptTimeoutException: timed out allocating from ['VoiceNavigatorASR Group #2']
4003146: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.MultiSync$RequesterImpl.unacquireAll(MultiSync.java:700)
4003147: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.MultiSync.attempt(MultiSync.java:381)
4003148: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.PermitCollection.attempt(PermitCollection.java:422)
4003149: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.channel.impl.ChannelManagerImpl.getIdleChannels(ChannelManagerImpl.java:941)
4003150: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.channel.impl.ChannelManagerImpl.getIdleChannels(ChannelManagerImpl.java:706)
4003151: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.channel.Group.getIdleChannels(Group.java:400)
4003152: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.channel.Group.getIdleChannels(Group.java:354)
4003153: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.wf.subsystems.jtapi.RouteCallObserver$1.run(RouteCallObserver.java:427)
4003154: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.runCommand(ExecutorStubImpl.java:690)
4003155: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.run(ExecutorStubImpl.java:486)
4003156: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.run(ExecutorStubImpl.java:762)
4003157: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at EDU.oswego.cs.dl.util.concurrent.PooledExecutor$Worker.run(PooledExecutor.java:768)
4003158: Jun 27 17:19:21.202 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.executor.impl.PooledExecutorStubImpl$1$WorkerImpl.run(PooledExecutorStubImpl.java:99)
4003159: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.util.ThreadPoolFactory$ThreadImpl.run(ThreadPoolFactory.java:853)
4003160: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: nested stack trace is:
4003161: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: com.cisco.lang.sync.AttemptTimeoutException: timed out allocating from [('VoiceNavigatorASR Group #2' & ('Cisco Unified CCX Ports' & 'ASR Ports' & VoiceNavigatorASR))]; nested exception is:
4003162: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: com.cisco.lang.sync.AttemptTimeoutException: timed out allocating from ['VoiceNavigatorASR Group #2' & ('Cisco Unified CCX Ports' & 'ASR Ports' & VoiceNavigatorASR)]; nested exception is:
4003163: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: com.cisco.lang.sync.AttemptTimeoutException: timed out allocating from ['VoiceNavigatorASR Group #2']
4003164: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.ExclusiveAsync$RequesterImpl.unacquireAll(ExclusiveAsync.java:689)
4003165: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.ExclusiveAsync.unacquire(ExclusiveAsync.java:331)
4003166: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.MultiSync$RequesterImpl.unacquireAll(MultiSync.java:677)
4003167: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.MultiSync.attempt(MultiSync.java:381)
4003168: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.PermitCollection.attempt(PermitCollection.java:422)
4003169: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.channel.impl.ChannelManagerImpl.getIdleChannels(ChannelManagerImpl.java:941)
4003170: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.channel.impl.ChannelManagerImpl.getIdleChannels(ChannelManagerImpl.java:706)
4003171: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.channel.Group.getIdleChannels(Group.java:400)
4003172: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.channel.Group.getIdleChannels(Group.java:354)
4003173: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.wf.subsystems.jtapi.RouteCallObserver$1.run(RouteCallObserver.java:427)
4003174: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.runCommand(ExecutorStubImpl.java:690)
4003175: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.run(ExecutorStubImpl.java:486)
4003176: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.run(ExecutorStubImpl.java:762)
4003177: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at EDU.oswego.cs.dl.util.concurrent.PooledExecutor$Worker.run(PooledExecutor.java:768)
4003178: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.executor.impl.PooledExecutorStubImpl$1$WorkerImpl.run(PooledExecutorStubImpl.java:99)
4003179: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.util.ThreadPoolFactory$ThreadImpl.run(ThreadPoolFactory.java:853)
4003180: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: nested stack trace is:
4003181: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: com.cisco.lang.sync.AttemptTimeoutException: timed out allocating from ['VoiceNavigatorASR Group #2' & ('Cisco Unified CCX Ports' & 'ASR Ports' & VoiceNavigatorASR)]; nested exception is:
4003182: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: com.cisco.lang.sync.AttemptTimeoutException: timed out allocating from ['VoiceNavigatorASR Group #2']
4003183: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.MultiAsync$RequesterImpl.unacquireAll(MultiAsync.java:672)
4003184: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.MultiAsync.unacquire(MultiAsync.java:338)
4003185: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.ExclusiveAsync$RequesterImpl.unacquireAll(ExclusiveAsync.java:659)
4003186: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.ExclusiveAsync.unacquire(ExclusiveAsync.java:331)
4003187: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.MultiSync$RequesterImpl.unacquireAll(MultiSync.java:677)
4003188: Jun 27 17:19:21.203 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.MultiSync.attempt(MultiSync.java:381)
4003189: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.PermitCollection.attempt(PermitCollection.java:422)
4003190: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.channel.impl.ChannelManagerImpl.getIdleChannels(ChannelManagerImpl.java:941)
4003191: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.channel.impl.ChannelManagerImpl.getIdleChannels(ChannelManagerImpl.java:706)
4003192: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.channel.Group.getIdleChannels(Group.java:400)
4003193: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.channel.Group.getIdleChannels(Group.java:354)
4003194: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.wf.subsystems.jtapi.RouteCallObserver$1.run(RouteCallObserver.java:427)
4003195: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.runCommand(ExecutorStubImpl.java:690)
4003196: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.run(ExecutorStubImpl.java:486)
4003197: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.run(ExecutorStubImpl.java:762)
4003198: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at EDU.oswego.cs.dl.util.concurrent.PooledExecutor$Worker.run(PooledExecutor.java:768)
4003199: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.executor.impl.PooledExecutorStubImpl$1$WorkerImpl.run(PooledExecutorStubImpl.java:99)
4003200: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.util.ThreadPoolFactory$ThreadImpl.run(ThreadPoolFactory.java:853)
4003201: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: nested stack trace is:
4003202: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: com.cisco.lang.sync.AttemptTimeoutException: timed out allocating from ['VoiceNavigatorASR Group #2']
4003203: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.AbstractAsync.unacquire(AbstractAsync.java:190)
4003204: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.PermitSet$RequesterWrapper.unacquire(PermitSet.java:659)
4003205: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.PermitSet.unacquire(PermitSet.java:220)
4003206: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.PermitCollection$Collector.unacquire(PermitCollection.java:202)
4003207: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.AbstractAsync.unacquire(AbstractAsync.java:176)
4003208: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.MultiAsync$RequesterImpl.unacquireAll(MultiAsync.java:649)
4003209: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.MultiAsync.unacquire(MultiAsync.java:338)
4003210: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.ExclusiveAsync$RequesterImpl.unacquireAll(ExclusiveAsync.java:659)
4003211: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.ExclusiveAsync.unacquire(ExclusiveAsync.java:331)
4003212: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.MultiSync$RequesterImpl.unacquireAll(MultiSync.java:677)
4003213: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.MultiSync.attempt(MultiSync.java:381)
4003214: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.lang.sync.PermitCollection.attempt(PermitCollection.java:422)
4003215: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.channel.impl.ChannelManagerImpl.getIdleChannels(ChannelManagerImpl.java:941)
4003216: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.channel.impl.ChannelManagerImpl.getIdleChannels(ChannelManagerImpl.java:706)
4003217: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.channel.Group.getIdleChannels(Group.java:400)
4003218: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.channel.Group.getIdleChannels(Group.java:354)
4003219: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.wf.subsystems.jtapi.RouteCallObserver$1.run(RouteCallObserver.java:427)
4003220: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.runCommand(ExecutorStubImpl.java:690)
4003221: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.run(ExecutorStubImpl.java:486)
4003222: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.run(ExecutorStubImpl.java:762)
4003223: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at EDU.oswego.cs.dl.util.concurrent.PooledExecutor$Worker.run(PooledExecutor.java:768)
4003224: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.executor.impl.PooledExecutorStubImpl$1$WorkerImpl.run(PooledExecutorStubImpl.java:99)
4003225: Jun 27 17:19:21.204 GMT+300 %MIVR-SS_TEL-5-EXCEPTION: at com.cisco.util.ThreadPoolFactory$ThreadImpl.run(ThreadPoolFactory.java:853)
4003226: Jun 27 17:19:21.205 GMT+300 %MIVR-SS_TEL-7-UNK: [MIVR_SS_TEL_TPG_ROUTE_EXE-41-878-ROUTE_CALL_EV] com.cisco.executor.impl.ExecutorStubImpl.RequestImpl Route Connection: [614050:Internal:1/(P1-cti_manager_new_1) GCID=(1,338156)->INVALID]->DISCONNECTED, Routing Exception: CTIERR_UNSPECIFIED=0x0::Unspecified error: Exception=com.cisco.jtapi.InvalidStateExceptionImpl: Did not meet pre-conditions.
4003227: Jun 27 17:19:21.205 GMT+300 %MIVR-SS_TEL-7-EXCEPTION:com.cisco.jtapi.InvalidStateExceptionImpl: Did not meet pre-conditions.
4003228: Jun 27 17:19:21.205 GMT+300 %MIVR-SS_TEL-7-EXCEPTION: at com.cisco.jtapi.ConnectionImpl.reject(CTQF)
4003229: Jun 27 17:19:21.205 GMT+300 %MIVR-SS_TEL-7-EXCEPTION: at com.cisco.wf.subsystems.jtapi.RouteCallObserver$1.run(RouteCallObserver.java:577)
4003230: Jun 27 17:19:21.205 GMT+300 %MIVR-SS_TEL-7-EXCEPTION: at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.runCommand(ExecutorStubImpl.java:690)
4003231: Jun 27 17:19:21.205 GMT+300 %MIVR-SS_TEL-7-EXCEPTION: at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.run(ExecutorStubImpl.java:486)
4003232: Jun 27 17:19:21.205 GMT+300 %MIVR-SS_TEL-7-EXCEPTION: at com.cisco.executor.impl.ExecutorStubImpl$RequestImpl.run(ExecutorStubImpl.java:762)
4003233: Jun 27 17:19:21.205 GMT+300 %MIVR-SS_TEL-7-EXCEPTION: at EDU.oswego.cs.dl.util.concurrent.PooledExecutor$Worker.run(PooledExecutor.java:768)
4003234: Jun 27 17:19:21.205 GMT+300 %MIVR-SS_TEL-7-EXCEPTION: at com.cisco.executor.impl.PooledExecutorStubImpl$1$WorkerImpl.run(PooledExecutorStubImpl.java:99)
4003235: Jun 27 17:19:21.205 GMT+300 %MIVR-SS_TEL-7-EXCEPTION: at com.cisco.util.ThreadPoolFactory$ThreadImpl.run(ThreadPoolFactory.java:853)
4003236: Jun 27 17:19:21.205 GMT+300 %MIVR-SS_TEL-7-UNK: [MIVR_SS_TEL_TPG_ROUTE_EXE-41-878-ROUTE_CALL_EV] com.cisco.wf.subsystems.jtapi.CallImpl CallID:1322 MediaId:338156/1 is removed from call session mapping in Session[id=001-0xaf16b1d74,parent=null,active=true,state=SESSION_IN_USE,time=1561645157181], result:true
4003237: Jun 27 17:19:21.207 GMT+300 %MIVR-SS_TEL-7-UNK: [MIVR_SS_TEL_TPG_ROUTE_EXE-41-878-ROUTE_CALL_EV] com.cisco.wf.subsystems.jtapi.CallImpl Call.rejected(REMOTE_TIMEOUT) JTAPICallContact[id=1322,implId=338156/1,state=STATE_REJECTED_IDX,inbound=true,App name=VoiceNavigator,task=null,session=47000001908,seq num=0,cn=614050,dn=614050,cgn=5475,ani=null,dnis=null,clid=null,atype=DIRECT,lrd=null,ocn=614050,route=RP[num=614050],OrigProtocolCallRef=00000000000528EC012346FD00000000,DestProtocolCallRef=null,TP=null
4003238: Jun 27 17:19:21.731 GMT+300 %MIVR-SS_OB-7-UNK: [MIVR_SS_OB_OutboundMgrMsgProcessor-64-0-OutboundMgrMsgProcessor] com.cisco.wf.subsystems.outbound.OutboundMgrMsgProcessor OutboundMgrMsgProcessor:Processing msg: OutboundCSQIterationMsg: csqID: 3 ,dialerType: PREVIEW_DIALER
4003239: Jun 27 17:19:21.731 GMT+300 %MIVR-SS_OB-7-UNK: [MIVR_SS_OB_OutboundMgrMsgProcessor-64-0-OutboundMgrMsgProcessor] com.cisco.wf.subsystems.outbound.CSQPreviewOutboundInfo OutboundContactInfo:getNumberContactsToCall() for csqID:3 :0
4003240: Jun 27 17:19:21.731 GMT+300 %MIVR-SS_OB-7-UNK: [MIVR_SS_OB_OutboundMgrMsgProcessor-64-0-OutboundMgrMsgProcessor] com.cisco.wf.subsystems.outbound.PreviewDialer PreviewDialer:sendAgentReservationMsgToRMCM() csqid:3 ,#Total active resources in csq:0.0 ,#CSQ allocation %:100 ,#active:0.0, #active-working:0, #Number of Available resources:0, #lic_left:25, #contacts:0
4003241: Jun 27 17:19:22.731 GMT+300 %MIVR-SS_OB-7-UNK: [MIVR_SS_OB_OutboundMgrMsgProcessor-64-0-OutboundMgrMsgProcessor] com.cisco.wf.subsystems.outbound.OutboundMgrMsgProcessor OutboundMgrMsgProcessor:Processing msg: OutboundCSQIterationMsg: csqID: 3 ,dialerType: PREVIEW_DIALER
4003242: Jun 27 17:19:22.731 GMT+300 %MIVR-SS_OB-7-UNK: [MIVR_SS_OB_OutboundMgrMsgProcessor-64-0-OutboundMgrMsgProcessor] com.cisco.wf.subsystems.outbound.CSQPreviewOutboundInfo OutboundContactInfo:getNumberContactsToCall() for csqID:3 :0
4003243: Jun 27 17:19:22.731 GMT+300 %MIVR-SS_OB-7-UNK: [MIVR_SS_OB_OutboundMgrMsgProcessor-64-0-OutboundMgrMsgProcessor] com.cisco.wf.subsystems.outbound.PreviewDialer PreviewDialer:sendAgentReservationMsgToRMCM() csqid:3 ,#Total active resources in csq:0.0 ,#CSQ allocation %:100 ,#active:0.0, #active-working:0, #Number of Available resources:0, #lic_left:25, #contacts:0
4003244: Jun 27 17:19:23.081 GMT+300 %MIVR-SS_OB-7-UNK: [MIVR_SS_OB_ReadContactsThread-142-0-ReadContactsThread] com.cisco.wf.subsystems.outbound.ReadContactsThread ReadContactsThread: # of active campaigns =1
4003245: Jun 27 17:19:23.081 GMT+300 %MIVR-SS_OB-7-UNK: [MIVR_SS_OB_ReadContactsThread-142-0-ReadContactsThread] com.cisco.wf.subsystems.outbound.ReadContactsThread ReadContactsThread: Campaigns without contacts in memory:[11]
4003246: Jun 27 17:19:23.081 GMT+300 %MIVR-CFG_MGR-7-UNK: [MIVR_SS_OB_ReadContactsThread-142-0-ReadContactsThread] com.cisco.config.impl.ConfigManagerImpl getAccessor(ConfigQuery):Try to get the default accessor
4003247: Jun 27 17:19:23.081 GMT+300 %MIVR-CFG_MGR-7-UNK: [MIVR_SS_OB_ReadContactsThread-142-0-ReadContactsThread] com.cisco.config.impl.dbaccessor.DBAccessor DBAccessor.get(query))