Environment 8.1 setup with Resource Group with service type vxml & msml and added dedicated for a tenant.
Refered Proactive Soution Guide -- Configuring a Campaign Group object
Referred GVP integration guide -- Creating a Trunk Group DN for outbound calls
Referred SIP Server deployment gudier -- Creating & configuring MSML DN
***********************************************************
Analyzed the SIP log found the following error.
16:37:06.451: SIPTR: Received [0,UDP] 2079 bytes from 10.249.232.36:5060 <<<<<
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.249.232.56:5060;branch=z9hG4bK13137861-503D-486B-9420-87A3214320B1-3107939
From: <sip:900109342311012@10.249.232.56:5060>;tag=E98B187B-0BD9-4C5D-9441-8F62C910D2B9-730248
To: <sip:TCS@10.249.232.56:5060>;tag=91DC9BBA-CE40-4AD2-4EB7-3D951F5A8F03
CSeq: 2 INFO
Call-ID: B863A656-8AFA-4634-99AF-DE9D3AF8E10D-712795@10.249.232.56
Content-Length: 186
Content-Type: application/vnd.radisys.msml+xml
X-Genesys-gsw-session-dbid: 329
X-Genesys-gsw-predictive-call: on
X-Genesys-gsw-ivr-profile-id: 102
X-Genesys-,x-channelGSW_PHONE: 09342311012
X-Genesys-,x-channelGSW_TZ_OFFSET: 19800
X-Genesys-,x-channelGSW_CALLING_LIST: CL_GVPOB
X-Genesys-,x-channelGSW_CAMPAIGN_NAME: GVPOB
X-Genesys-,x-channelInteractionType: Outbound
X-Genesys-,x-channelInteractionSubtype: OutboundNew
X-Genesys-,x-channelGSW_RECORD_HANDLE: 28
X-Genesys-,x-channelGSW_APPLICATION_ID: 119
X-Genesys-,x-channelGSW_CAMPAIGN_GROUP_DBID: 329
X-Genesys-,x-channelGSW_CALLING_LIST_DBID: 322
X-Genesys-,x-channelGSW_SWITCH_DBID: 101
X-Genesys-,x-channelGSW_CAMPAIGN_GROUP_NAME: GVPOB@DummyPlace Group
X-Genesys-,x-channelGSW_CAMPAIGN_GROUP_DESCRIPTION:
X-Genesys-,x-channelGSW_CHAIN_ID: 4
X-Genesys-,x-channelGSW_ATTEMPTS: 1
X-Genesys-,x-channelGSW_AGENT_ID:
X-Genesys-,x-channelGSW_CALL_RESULT: 28
X-Genesys-,x-channelGSW_TZ_NAME: IST
X-Genesys-,x-channelGSW_CALL_ATTEMPT_GUID: UNSHR22O3H58F342AQPLMRK80S00000S
X-Genesys-,x-channelGSW_CONTACT_MEDIA_TYPE: voice
X-Genesys-,x-channelGSW_QUEUE_NAME: VTD
X-Genesys-,x-channelGSW_CALL_TYPE: REGULAR
X-Genesys-,x-channelGSW_QUEUE_DBID: 1594
X-Genesys-,x-channelGSW_SESSION_DBID: 329
Min-SE: 90
X-Genesys-GVP-Session-Data: callsession=4D932F69-6BA1-4219-41A3-412957A883CD;1;0;;;;TCS;GVP_IVRProfile;
X-Genesys-GVP-Session-ID: 4D932F69-6BA1-4219-41A3-412957A883CD;gvp.rm.datanodes=1;gvp.rm.tenant-id=101_GVP_IVRProfile
<?xml version="1.0" encoding="UTF-8"?>
<msml version="1.1">
<result response="423">
<description>[b]External document fetch error: Failed to prepare document[/b]</description>
</result>
</msml>
16:37:06.451: SipDialog: event CONNECTED_RESOK, t=2855004, s=7, r=5, m=00000000681d6068
16:37:06.451 SIPCONN(TCS): HandleSipDialogEvent(CONNECTED_RESOK)
16:37:06.451 SIPCONN(TCS): store remote content
16:37:06.451 SIPCONN(TCS): CtiRequest(3,33)
16:37:06.451 SIPCONN(TCS): CtiRequestProcessInfoResponse
16:37:06.451 SIPCONN(TCS): INFO transaction cleared
16:37:06.451: MSML initial request rejected
16:37:06.451 SIPCONN(TCS): set monitor 00000000681d5fb0, 0000000000000000
16:37:06.451 SIPCONN(TCS): Active transaction(2855002) discarded
16:37:06.451 SIPCONN(TCS): state e:1,p:1,s:0,c:19,rc:0,m:0
16:37:06.451: SipDialog: ClearCall(phone=0,state=7)
16:37:06.451: SipDialog::Terminate(state=7,reason=0)
*****************************************************************
-------------MCP log says------------------
: MSMLDialog is in TERMINATED state with: m_nFromDialogRouteState=0, m_nToDialogRouteState=0, m_nVXMLDialogRouteState=0, m_bDialogCreated=false
-----------------------
2013-11-04 14:38:26.236 DBUG 00CB0127-10002F2F 836 02800000 LMCallSIPHandler.C:153 LMCallSIP::HandleDerivedEvent - nEventType=0, m_nState=2, m_nIntfState=1
2013-11-04 14:38:26.236 DBUG 00CB0127-10002F2F 836 02800000 LMCallSIPHandler.C:2354 Received SIP INFO
2013-11-04 14:38:26.236 DBUG 00CB0127-10002F2F 836 02800000 LMCallSIPUtil.C:742 PushBackUnknownHeaders: Prefix=[Sip.Info.]
2013-11-04 14:38:26.236 DBUG 00000000-00000000 3752 01C00000 CMMsgBase.h:183 cmapi.msg: CM_MSG_LMNOTIFY_NETWORKEVENT - 00000000-10002F2F; EventType=0; ContentType=application/vnd.radisys.msml+xmlExtra Info=<?xml version="1.0" encoding="UTF-8"?>
<msml version="1.1">
<dialogprepare target="conn:BF58BB16-A742-4F4F-D391-814403C9903C" name="ivr_prepared_dialog" type="application/vxml+xml"/>
</msml>
2013-11-04 14:38:26.236 DBUG 00CB0127-10002F2F 3752 01C00000 CMCallLeg.C:1735 Call leg has received SIP INFO: application/vnd.radisys.msml+xml <?xml version="1.0" encoding="UTF-8"?>
<msml version="1.1">
<dialogprepare target="conn:BF58BB16-A742-4F4F-D391-814403C9903C" name="ivr_prepared_dialog" type="application/vxml+xml"/>
</msml>
2013-11-04 14:38:26.236 DBUG 00000000-00000000 2432 01B00000 AppCallLegEvent.h:64 app.MSML AMEVENT_CALLLEG_NETWORKEVENT - CallLegID=00CB0127-10002F2F,ContentType=application/vnd.radisys.msml+xml,INFO=<?xml version="1.0" encoding="UTF-8"?>
<msml version="1.1">
<dialogprepare target="conn:BF58BB16-A742-4F4F-D391-814403C9903C" name="ivr_prepared_dia
2013-11-04 14:38:26.236 DBUG 00CB0127-10002F2F 2432 01B00000 MSMLAppInstance.cxx:498 Received MSML CallLeg event AMEVENT_CALLLEG_NETWORKEVENT
2013-11-04 14:38:26.236 DBUG 00CB0127-10002F2F 2432 01B00000 MSMLAppInstance.cxx:576 NetworkEvent
2013-11-04 14:38:26.236 DBUG 00CB0127-10002F2F 2432 01B00000 MSMLSession.cxx:795 MSMLSession::ProcessSIPMsg with type = 0
2013-11-04 14:38:26.236 DBUG 00CB0127-10002F2F 2432 01B00000 MSMLSession.cxx:483 MSMLSession::ProcessRequests: enter
2013-11-04 14:38:26.236 DBUG 00CB0127-10002F2F 2432 01B00000 MSMLAppInstance.cxx:736 PrepareVXMLDialog http://10.249.232.33/HelloWorld/helloworld.vxml
2013-11-04 14:38:26.236 DBUG 00CB0127-10002F2F 2432 01B00000 MSMLSession.cxx:504 MSMLSession::ProcessRequests: element response 0
2013-11-04 14:38:26.239 DBUG 00000000-00000000 3752 01C00000 CMMsgBase.h:183 cmapi.msg: CM_MSG_APP_MGMT_APP_INVOKE - ReqID == 79; AppType == 1; ContextType == 2; CallID == 00CB0127-88002F2F; CallLegID == 00CB0127-10002F2F; AppModID == 3; CreatorAppID == 79; RootApp == 0; Url == http://10.249.232.33/HelloWorld/helloworld.vxml; ModuleType == VXML-NG; DefaultParamUrl == default; DNIS == sip:TCS@10.249.232.56:5060; ANI == sip:900109342311012@10.249.232.56:5060; CPAType == none
2013-11-04 14:38:26.239 DBUG 00000000-00000000 2432 01B00000 AppEventBase.h:61 app.MSML AMEVENT_APPINST_INVOKENOTIFY - ReqID=79,Result=5,AppID=79,DialogID=0
2013-11-04 14:38:26.239 DBUG 00CB0127-88002F2F 2432 01B00000 MSMLAppInstance.cxx:393 Received MSML AppInstance event AMEVENT_APPINST_INVOKENOTIFY
2013-11-04 14:38:26.239 DBUG 00CB0127-10002F2F 2432 01B00000 MSMLDialog.cxx:370 VXML dialog prepared
2013-11-04 14:38:26.239 DBUG 00CB0127-10002F2F 2432 01B00000 MSMLDialog.cxx:1729 MSMLDialog[000000001A6394B0]::NotifyProcessRequestDone - m_bRequestDoneNotified=false
2013-11-04 14:38:26.239 DBUG 00000000-00000000 2432 01B00000 AppEventBase.h:61 app.MSML AMEVENT_MSML_MSMLSESSIONEVENT -
2013-11-04 14:38:26.239 DBUG 00CB0127-10002F2F 2432 01B00000 MSMLAppInstance.cxx:682 Received MSML CallLeg event AMEVENT_MSML_MSMLSESSIONEVENT
2013-11-04 14:38:26.239 DBUG 00CB0127-10002F2F 2432 01B00000 MSMLSession.cxx:483 MSMLSession::ProcessRequests: enter
2013-11-04 14:38:26.239 DBUG 00CB0127-10002F2F 2432 01B00000 MSMLDialog.cxx:1803 MSMLDialog::Terminate, current state 14
2013-11-04 14:38:26.239 DBUG 00CB0127-10002F2F 2432 01B00000 MSMLDialog.cxx:1187 MSMLDialog is in TERMINATED state with: m_nFromDialogRouteState=0, m_nToDialogRouteState=0, m_nVXMLDialogRouteState=0, m_bDialogCreated=false
2013-11-04 14:38:26.239 DBUG 00CB0127-10002F2F 2432 01B00000 MSMLSession.cxx:284 MSMLSession::DialogDestroyed attempt to remove dialog conn:BF58BB16-A742-4F4F-D391-814403C9903C/dialog:ivr_prepared_dialog
2013-11-04 14:38:26.239 DBUG 00CB0127-10002F2F 2432 01B00000 MSMLSession.cxx:1089 MSMLSession::CanDelete() - m_bDestroyed=false, m_nReqState=2, m_VXMLDialogMap.size()=0, m_MSMLDialogSet.size()=0, m_setConfsClearHandler.size()=0
2013-11-04 14:38:26.239 DBUG 00CB0127-10002F2F 2432 01B00000 MSMLDialog.cxx:329 MSMLDialog::~MSMLDialog
2013-11-04 14:38:26.239 DBUG 00CB0127-10002F2F 2432 01B00000 MSMLSession.cxx:554 Send response: code=423, mark=, description=External document fetch error: Failed to prepare document
2013-11-04 14:38:26.239 DBUG 00CB0127-10002F2F 2432 01B00000 AppCallLeg.h:195 Call Leg send network event response
2013-11-04 14:38:26.239 DBUG 00CB0127-10002F2F 2432 01B00000 MSMLSession.cxx:1089 MSMLSession::CanDelete() - m_bDestroyed=false, m_nReqState=0, m_VXMLDialogMap.size()=0, m_MSMLDialogSet.size()=0, m_setConfsClearHandler.size()=0
2013-11-04 14:38:26.239 DBUG 00000000-00000000 3752 01C00000 CMMsgBase.h:183 cmapi.msg: CM_MSG_CALLLEG_NETWORKEVENTRESPONSE - CallObjID == 00CB0127-10002F2F; Binding State == 1
2013-11-04 14:38:26.239 DBUG 00CB0127-10002F2F 836 02800000 LMCallSIP.C:2724 NetworkEventResponse nResponse=200
2013-11-04 14:38:26.239 DBUG 00CB0127-10002F2F 836 02800000 LMCallSIPStack.C:203 LMCallSIP::SendResponse for ID Headers
2013-11-04 14:38:26.239 DBUG 00CB0127-10002F2F 836 02800000 LMCallSIPStack.C:225 LMCallSIP::SendResponse - X-Genesys-GVP-Session-ID: E22E2384-1DE1-4FF7-F2BC-BDE6BD8B5019;gvp.rm.datanodes=1;gvp.rm.tenant-id=101_GVP_IVRProfile
2013-11-04 14:38:26.239 DBUG 00000000-00000000 836 08500000 VGSIPTransportMgr.cxx:3443 VGSIPTransportMgr::ResolveDNS for 10.249.232.36:5060
2013-11-04T14:38:26.239 Trc 33009 INFO 00000000-00000000 836 02800FA1 Response sent: SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.249.232.36:5060;branch=z9hG4bK000000001BA0ABA077640aabcdef09
Via: SIP/2.0/UDP 10.249.232.56:5060;branch=z9hG4bK13137861-503D-486B-9420-87A3214320B1-3107307
From: <sip:900109342311012@10.249.232.56:5060>;tag=E98B187B-0BD9-4C5D-9441-8F62C910D2B9-729156
To: <sip:TCS@10.249.232.56:5060>;tag=BF58BB16-A742-4F4F-D391-814403C9903C
CSeq: 2 INFO
Call-ID: B863A656-8AFA-4634-99AF-DE9D3AF8E10D-712247@10.249.232.56
Content-Length: 186
Content-Type: application/vnd.radisys.msml+xml
X-Genesys-gsw-session-dbid: 329
X-Genesys-gsw-predictive-call: on
X-Genesys-gsw-ivr-profile-id: 102
X-Genesys-,x-channelGSW_PHONE: 09342311012
Any help is appreciated.
Regards,
Basha.