Genesys CTI User Forum

Genesys CTI User Forum => Genesys CTI Technical Discussion => Topic started by: jack41 on June 15, 2017, 09:31:05 AM

Title: genesys recording
Post by: jack41 on June 15, 2017, 09:31:05 AM

HI

i m trying to enable recording in genesys
for that i m using Call Recording—NETANN-Based and mcp as media server
i follewed the description in the documents and i created  this 3 DN as voip service


1 DN: Recording_service

[TServer]
contact=sip:192.168.1.15:5060
prefix=msml=
request-uri=sip:msml@192.168.1.15:5060
service-type=recorder

2 DN : I_DN_VOIP_SERVICE
[TServer]
contact-type=sip:196.168.1.15:5060
recovery-timeout=1
request-uri=sip:msml@192.168.1.15:5060
service-type=recorder

3 DN: I_MCP_AS_MS
[TServer]
contact-type=sip:196.168.1.15:5060
recovery-timeout=1
request-uri=sip:msml@192.168.1.15:5060
service-type=recorder

and also trunk named gcti::record with no configuration (as said in docs)

also i configured mcp :

[Netann]
annc.audiodefaultrepeat=forever
annc.basepath=$InstallationRoot$
annc.defaultaudioext=.war
annc.h263videoformat=QCIF=2
annc.h264videoformat=0a=2,0b=2,0c=2,0d=2,14=2,15=2,16=2,1e=2
annc.musicbasepath=$InstallationRoot$
conference.record.numchannels=2
conference.recordmode=mixed
record.basepath=/cti/record
record.maxrecordsilence=10
record.maxrecordtime=10000
sipinfonotifydtmf=auto

also  sip server

BUT the problem is that no file is created when, press the record button in IWS and i monitor the flux with wireshark is see that there is an RTP flow between agent and mcp


I stuck here for quit a while and  i need help 

Title: Re: genesys recording
Post by: jack41 on June 15, 2017, 01:10:50 PM

this is a section of log of mcp


2017-06-15 12:59:55.294 DBUG 00000000-00000000 2340167120 0B300000 VGRTPSocketObjects.cxx:2036 RTP 20068: Received unknown RTCP packet type 202
12:59:55.324 Trc 33009 INFO 00000000-00000000 2572389264 02800FA1 Response sent: SIP/2.0 200 OK
Via: SIP/2.0/UDP rmserver;branch=z9hG4bK24b5a26842845aabcdef09
Via: SIP/2.0/UDP sipserver:sip_port;branch=z9hG4bKFE7636F6-F50A-4D42-BB52-18AC2CE7C6D4-2094
From: <sip:Recording_service@sipserver:sip_port>;tag=704601B3-27CB-472B-BFB4-0AA674FCC7C1-55984
To: <sip:msml=5940fe530000002e@rmserver>;tag=4E290C00-1410-B85C-5D8C-80210F773FEC
CSeq: 1 INVITE
Call-ID: AAA1FB79-D22F-4514-B84F-2B9F94BE24FE-55864@192.168.1.12
Contact: sip:Genesys@mcpserver:port
Content-Length: 196
Content-Type: application/sdp
Record-Route: <sip:1ffb6bb0@rmserver;lr;gvp.rm.datanodes=1;confinstid=5940fe530000002e;idtag=00000075>
Min-SE: 90
X-Genesys-GVP-Session-Data: callsession=27290C00-DB6B-865E-E03C-4D0FE2062EC5;1;0;;;;Resources;IVRAppDefault
X-Genesys-GVP-Session-ID: 27290C00-DB6B-865E-E03C-4D0FE2062EC5;gvp.rm.datanodes=1;gvp.rm.tenant-id=101_IVRAppDefault
Session-Expires: 1800;refresher=uac
Require: timer

v=0
o=- 268450980 1 IN IP4 mcpserver
s=phone-call
c=IN IP4 mcpserver
t=0 0
m=audio 20070 RTP/AVP 0 8 2
a=rtpmap:0 pcmu/8000
a=rtpmap:8 pcma/8000
a=rtpmap:2 g726-32/8000
a=sendrecv

12:59:55.613 Trc 33009 INFO 00000000-00000000 2645818256 02800FA1 Request received: OPTIONS sip:mcpserver:port SIP/2.0
Via: SIP/2.0/UDP 192.168.1.15:5064;branch=z9hG4bK24ce6d8042847a
From: sip:GVP@192.168.1.15:5064;tag=27290C00-DB6B-262D-3130-3203463D3B54
To: sip:mcpserver:port
Max-Forwards: 70
CSeq: 222234 OPTIONS
Call-ID: 27290C00-DB6B-6440-959C-A16BBC2D6215-5064@192.168.1.15
Contact: <sip:GVP@192.168.1.15:5064>
Content-Length: 0
Supported: timer, uui


2017-06-15 12:59:55.613 DBUG  2645818256 08500000 MPCSDPNegotiation.cxx:480 MPCSDPNegotiation::NegotiateSDP - nSDPOfferAns=[0], bRemotePref=[true]
2017-06-15 12:59:55.613 DBUG  2645818256 08500000 MPCSDPNegotiation.cxx:512 Generating brand new SDP offer
2017-06-15 12:59:55.613 DBUG 00000000-00000000 2645818256 08500000 VGRTPTypes.cxx:1322 RTPMediaDescListToVGSdp
2017-06-15 12:59:55.613 DBUG 00000000-00000000 2645818256 08500000 VGRTPTypes.cxx:1491 For format [2], nOptions is [0]
2017-06-15 12:59:55.613 DBUG 00000000-00000000 2645818256 08500000 VGRTPTypes.cxx:1491 For format [3], nOptions is [0]
2017-06-15 12:59:55.613 DBUG 00000000-00000000 2645818256 08500000 VGRTPTypes.cxx:1491 For format [10], nOptions is [0]
2017-06-15 12:59:55.613 DBUG 00000000-00000000 2645818256 08500000 VGSIPTransportMgr.cxx:3205 VGSIPTransportMgr::ResolveDNS for 192.168.1.15:5064
12:59:55.613 Trc 33009 INFO 00000000-00000000 2645818256 02800FA1 Response sent: SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.15:5064;branch=z9hG4bK24ce6d8042847a
From: sip:GVP@192.168.1.15:5064;tag=27290C00-DB6B-262D-3130-3203463D3B54
To: sip:mcpserver:port
CSeq: 222234 OPTIONS
Call-ID: 27290C00-DB6B-6440-959C-A16BBC2D6215-5064@192.168.1.15
Content-Length: 192
Content-Type: application/sdp

v=0
o=- 268451044 1 IN IP4 mcpserver
s=phone-call
c=IN IP4 mcpserver
t=0 0
m=audio 0 RTP/AVP 0 8 2
a=rtpmap:0 pcmu/8000
a=rtpmap:8 pcma/8000
a=rtpmap:2 g726-32/8000
a=sendrecv

12:59:55.613 Trc 33009 INFO 00000000-00000000 2645818256 02800FA1 Request received: OPTIONS sips:mcpserver:5071 SIP/2.0
Via: SIP/2.0/TLS 192.168.1.15:5065;branch=z9hG4bK24cef83842847a
From: sips:GVP@192.168.1.15:5065;tag=27290C00-DB6B-6439-2F69-39EFF63C53D1
To: sips:mcpserver:5071
Max-Forwards: 70
CSeq: 222233 OPTIONS
Call-ID: 27290C00-DB6B-98B3-AB61-3C73EA6E8A3E-5064@192.168.1.15
Contact: <sips:GVP@192.168.1.15:5065>
Content-Length: 0
Supported: timer, uui


2017-06-15 12:59:55.613 DBUG  2645818256 08500000 MPCSDPNegotiation.cxx:480 MPCSDPNegotiation::NegotiateSDP - nSDPOfferAns=[0], bRemotePref=[true]
2017-06-15 12:59:55.613 DBUG  2645818256 08500000 MPCSDPNegotiation.cxx:512 Generating brand new SDP offer
2017-06-15 12:59:55.613 DBUG 00000000-00000000 2645818256 08500000 VGRTPTypes.cxx:1322 RTPMediaDescListToVGSdp
2017-06-15 12:59:55.613 DBUG 00000000-00000000 2645818256 08500000 VGRTPTypes.cxx:1491 For format [2], nOptions is [0]
2017-06-15 12:59:55.613 DBUG 00000000-00000000 2645818256 08500000 VGRTPTypes.cxx:1491 For format [3], nOptions is [0]
2017-06-15 12:59:55.613 DBUG 00000000-00000000 2645818256 08500000 VGRTPTypes.cxx:1491 For format [10], nOptions is [0]
2017-06-15 12:59:55.613 DBUG 00000000-00000000 2645818256 08500000 VGSIPTransportMgr.cxx:3205 VGSIPTransportMgr::ResolveDNS for 192.168.1.15:5065
12:59:55.613 Trc 33009 INFO 00000000-00000000 2645818256 02800FA1 Response sent: SIP/2.0 200 OK
Via: SIP/2.0/TLS 192.168.1.15:5065;branch=z9hG4bK24cef83842847a
From: sips:GVP@192.168.1.15:5065;tag=27290C00-DB6B-6439-2F69-39EFF63C53D1
To: sips:mcpserver:5071
CSeq: 222233 OPTIONS
Call-ID: 27290C00-DB6B-98B3-AB61-3C73EA6E8A3E-5064@192.168.1.15
Content-Length: 192
Content-Type: application/sdp

v=0
o=- 268451045 1 IN IP4 mcpserver
s=phone-call
c=IN IP4 mcpserver
t=0 0
m=audio 0 RTP/AVP 0 8 2
a=rtpmap:0 pcmu/8000
a=rtpmap:8 pcma/8000
a=rtpmap:2 g726-32/8000
a=sendrecv

2017-06-15 12:59:55.804 DBUG 00000000-00000000 2572389264 08500000 VGSIPTransportMgr.cxx:3205 VGSIPTransportMgr::ResolveDNS for rmserver
12:59:55.804 Trc 33009 INFO 00000000-00000000 2572389264 02800FA1 Request sent: BYE sip:Recording_service@sipserver:sip_port SIP/2.0
Via: SIP/2.0/UDP mcpserver:port;branch=z9hG4bK1e8b55504292db
From: <sip:msml=5940fe530000002e@rmserver>;tag=4E290C00-1410-B85C-5D8C-80210F773FEC
To: <sip:Recording_service@sipserver:sip_port>;tag=704601B3-27CB-472B-BFB4-0AA674FCC7C1-55984
Max-Forwards: 70
CSeq: 1 BYE
Call-ID: AAA1FB79-D22F-4514-B84F-2B9F94BE24FE-55864@192.168.1.12
Content-Length: 0
Route: <sip:1ffb6bb0@rmserver;lr;gvp.rm.datanodes=1;confinstid=5940fe530000002e;idtag=00000075>
Supported: timer, uui


2017-06-15 12:59:55.805 DBUG 00770194-10009D90 2656308112 02800000 LMCallSIPHandler.C:418 SIP session timeout event recv'd: IntfState 1 Error 408
2017-06-15 12:59:55.805 DBUG 00770194-10009D90 2656308112 02F00000 MPCWrapper.cxx:899 Processing Media Destroy on Session 10003CA4
2017-06-15 12:59:55.805 DBUG 00000000-00000000 2656308112 0B100000 MPCConnection.cxx:1192 MPCConnection::Destroy nLogID=00770194-10009D90 nConnID=10003CA4
2017-06-15 12:59:55.805 DBUG 00000000-00000000 2656308112 0B100000 MPCConnection.cxx:1531 MPCConnection::DisconnectRoute nLogID=00770194-10009D90 nConnID=10003                                  CA4 ControlSinkID=30003CA5
2017-06-15 12:59:55.805 DBUG 00000000-00000000 2656308112 0B100000 MPCConference.cxx:1041 MPCConference::GetFCRSink nConfID=30003CA5
2017-06-15 12:59:55.805 DBUG 00000000-00000000 2656308112 0B100000 MPCConference.cxx:999 MPCConference::GetSinks nConfID=30003CA5 pRoute=0x1ec302a8 ControlSink                                  ID=30003CA5
2017-06-15 12:59:55.805 DBUG 00000000-00000000 2656308112 0B100000 MPCControlObject.cxx:410 MPCControlObject::UnregisterSinkHelper LogID=00770194-10009D90 Obje                                  ctID=10003CA4 OperatorID=00010005 SinkID=00010011 pRoute=1EC302A8
2017-06-15 12:59:55.805 DBUG 00000000-00000000 2656308112 0B100000 MPCConference.cxx:937 MPCConference::UnregisterSink nConfID=30003CA5 pRoute=0x1ec302a8 Contr                                  olSinkID=30003CA5
2017-06-15 12:59:55.805 DBUG 00000000-00000000 2656308112 0B100000 MPCConference.cxx:730 MPCConference::DisconnectRoute nConfID=30003CA5 pRoute=0x1ec30300 Cont                                  rolSinkID=10003CA4
2017-06-15 12:59:55.805 DBUG 00000000-00000000 2656308112 0B100000 MPCConnection.cxx:1769 MPCConnection::GetSinks nLogID=00770194-10009D90 nConnID=10003CA4 Con                                  trolSourceID=30003CA5
2017-06-15 12:59:55.805 DBUG 00000000-00000000 2656308112 0B100000 MPCConnection.cxx:1783 MPCConnection::GetSink - Sinks.size()=[1]
2017-06-15 12:59:55.805 DBUG 00000000-00000000 2656308112 0B100000 MPCConnection.cxx:1795 MPCConnection::GetFCRSink nLogID=00770194-10009D90 nConnID=10003CA4
2017-06-15 12:59:55.805 DBUG 00000000-00000000 2656308112 0B100000 MPCControlObject.cxx:410 MPCControlObject::UnregisterSinkHelper LogID= ObjectID=30003CA5 Ope                                  ratorID=00010014 SinkID=00010004 pRoute=1EC30300
2017-06-15 12:59:55.805 DBUG 00000000-00000000 2656308112 0B100000 MPCConference.cxx:566 MPCConference::UnregisterForwardRoute nConfID=30003CA5 pRoute=0x1ec303                                  00
2017-06-15 12:59:55.805 DBUG 00000000-00000000 2656308112 0B100000 MPCControlObject.cxx:362 MPCControlObject::UnregisterSinkHelper LogID= ObjectID=30003CA5 Sou                                  rceID=00010013 SinkID=00010014 pRoute=1EC30300
2017-06-15 12:59:55.805 DBUG 00000000-00000000 2656308112 0B100000 MPCConnection.cxx:1748 MPCConnection::UnregisterReverseRoute nLogID=00770194-10009D90 nConnI                                  D=10003CA4 ControlSourceID=30003CA5
2017-06-15 12:59:55.805 DBUG 00000000-00000000 2656308112 0B100000 MPCControlObject.cxx:362 MPCControlObject::UnregisterSinkHelper LogID=00770194-10009D90 Obje                                  ctID=10003CA4 SourceID=00010004 SinkID=00010005 pRoute=00000000
12:59:55.815 Trc 49005 INFO 00000000-00000000 2340167120 0B300FA1 RTP 20070: Rx 0/0 lost 0 dropped 0 dec_err 0 jitter 0, Tx 1598/274856 enc_err 0
2017-06-15 12:59:55.815 DBUG 00000000-00000000 3012963216 0B100000 MPCConnection.cxx:2090 MPCConnection::ProcessRTPSocketClosed nLogID=00770194-10009D90 nConnI                                  D=10003CA4
2017-06-15 12:59:55.815 DBUG 00000000-00000000 3012963216 0B100000 MPCConnection.cxx:1928 MPCConnection::QueueDestroyedEvent nLogID=00770194-10009D90 nConnID=1                                  0003CA4
2017-06-15 12:59:55.815 DBUG 00770194-10009D90 3012963216 02F00000 MPCWrapper.cxx:3732 ConnDestroyed for Connection ID: 268450980
2017-06-15 12:59:55.815 DBUG 00000000-00000000 3012963216 0B100000 MPCConnection.cxx:106 MPCConnection::~MPCConnection nLogID=00770194-10009D90 nConnID=10003CA                                  4
2017-06-15 12:59:55.815 DBUG 00000000-00000000 62086608 01C00000 CMMsgBase.h:181 cmapi.msg:  CM_MSG_LMCC_DISCONNECT - 00000000-10009D90; Reason=15; Initiator=1                                  ; ProtocolCause=Session Timeout
2017-06-15 12:59:55.815 DBUG 00770194-10009D90 62086608 01C00000 CMCallBilling.C:813 REASON IS 15
2017-06-15 12:59:55.815 DBUG 00770194-10009D90 62086608 02100000 BillingMetricsLogger.C:479 Logging Billing RE
12:59:55.815 Int 50056 00770194-10009D90 62086608 call_reference AAA1FB79-D22F-4514-B84F-2B9F94BE24FE-55864@192.168.1.12|27290C00-DB6B-865E-E03C-4D0FE2062EC5|R                                  esources|IVRAppDefault
2017-06-15 12:59:55.815 DBUG 00770194-10009D90 62086608 02100000 BillingMetricsLogger.C:283 Logging Billing IR
12:59:55.815 Int 50002 00770194-10009D90 62086608 incall_reject sip:msml=5940fe530000002e@rmserver|sip:Recording_service@sipserver:sip_port|20170615535                                  195035|N/A|N/A|N/A|unknown
2017-06-15 12:59:55.815 DBUG 00000000-00000000 2361154448 01B00000 AppCallLegEvent.h:63 app.MSML AMEVENT_CALLLEG_CALLDISCONNECTED - CallLegID=00770194-10009D90                                  ,CallDur=0,DiscReason=15,DiscInit=1
2017-06-15 12:59:55.815 DBUG 00770194-10009D90 2361154448 01B00000 MSMLAppInstance.cxx:480 Received MSML CallLeg event AMEVENT_CALLLEG_CALLDISCONNECTED
2017-06-15 12:59:55.815 DBUG 00770194-10009D90 2361154448 01B00000 MSMLAppInstance.cxx:533 MSML Call Disconnected, unbind MSMLCallLeg
2017-06-15 12:59:55.815 DBUG 00770194-10009D90 2361154448 01B00000 MSMLSession.cxx:308 MSMLSession::DestroySession
2017-06-15 12:59:55.815 DBUG 00770194-10009D90 2361154448 01B00000 MSMLSession.cxx:312 MSMLSession::DestroySession, still have 0 dialogs
2017-06-15 12:59:55.815 DBUG 00770194-10009D90 2361154448 01B00000 MSMLSession.cxx:1039 MSMLSession::CanDelete() - m_bDestroyed=true, m_nReqState=0, m_VXMLDial                                  ogMap.size()=0, m_MSMLDialogSet.size()=0, m_setConfsClearHandler.size()=0
2017-06-15 12:59:55.815 DBUG 00770194-10009D90 2361154448 01B00000 AppCallLeg.h:102 Call Leg Unbind
2017-06-15 12:59:55.815 DBUG 00770194-10009D90 2361154448 01B00000 MSMLSession.cxx:136 MSMLSession::~MSMLSession
12:59:55.815 Trc 20001 INFO 00000000-00000000 2361154448 01B00000 STATUS: Current 2 Total 36
2017-06-15 12:59:55.815 DBUG 00000000-00000000 62086608 01C00000 CMMsgBase.h:181 cmapi.msg:  CM_MSG_CALLLEG_UNBIND - CallObjID == 00770194-10009D90; Binding St                                  ate == 1
2017-06-15 12:59:55.815 DBUG 00000000-00000000 62086608 01C00000 CMCallObjMgr.C:459 00000000-10009D90 CMCallObjMgr::ReleaseCallLeg
2017-06-15 12:59:55.815 DBUG 00000000-00000000 62086608 01C00000 CMCallManager.h:234 Releasing license 1E990158
2017-06-15 12:59:55.815 DBUG 00000000-00000000 62086608 02400000 GVPLicenseLogger.C:112 Release GVP License:Product=vggateway; Features=in; Current Use=2; Peak                                    Use=3
2017-06-15 12:59:55.815 DBUG 00000000-00000000 62086608 01C00000 CMCallManager.h:240 license usage: Product=vggateway; Features=in; Current Use=2; Peak Use=3

12:59:55.815 Trc 20001 INFO 00770194-10009D90 62086608 01C00000 CMCallLeg deleted 0x1ec84e18
2017-06-15 12:59:55.815 DBUG 00000000-00000000 2361154448 01B00000 AppCallLegEvent.h:63 app.MSML AMEVENT_CALLLEG_UNBINDNOTIFY - CallLegID=00770194-10009D90,
2017-06-15 12:59:55.815 DBUG 00770194-10009D90 2361154448 01B00000 MSMLAppInstance.cxx:480 Received MSML CallLeg event AMEVENT_CALLLEG_UNBINDNOTIFY
2017-06-15 12:59:55.815 DBUG 00770194-10009D90 2361154448 01B00000 MSMLAppInstance.cxx:496 MSMLCallLeg received UnbindNotify, unbind MSMLCall
2017-06-15 12:59:55.815 DBUG 00770194-88009D90 2361154448 01B00000 AppCall.h:134 Call Unbind
2017-06-15 12:59:55.815 DBUG 00000000-00000000 62086608 01C00000 CMMsgBase.h:181 cmapi.msg:  CM_MSG_CALL_UNBIND - CallObjID == 00770194-88009D90; Binding State                                    == 1
2017-06-15 12:59:55.815 DBUG 00770194-88009D90 62086608 01C00000 CMCall.C:630 Removing translator 36
2017-06-15 12:59:55.815 DBUG 00000000-00000000 62086608 01C00000 CMCallObjMgr.C:483 00000000-88009D90 CMCallObjMgr::ReleaseCall
12:59:55.815 Trc 20001 INFO 00770194-88009D90 62086608 01C00000 CMCall deleted 0x1eb70200
2017-06-15 12:59:55.815 DBUG 00770194-88009D90 2361154448 01B00000 AppCallEvent.h:58 app.MSML AMEVENT_CALL_UNBINDNOTIFY -
2017-06-15 12:59:55.815 DBUG 00770194-88009D90 2361154448 01B00000 MSMLAppInstance.cxx:457 Received MSML Call event AMEVENT_CALL_UNBINDNOTIFY
2017-06-15 12:59:55.815 DBUG 00000000-00000000 62086608 01C00000 CMMsgBase.h:181 cmapi.msg:  CM_MSG_APP_MGMT_APP_UNREGISTER - AppID == 36
2017-06-15 12:59:55.815 DBUG 00000000-00000000 62086608 01C00000 CMAppInstMgr.C:426 CMAppInstMgr::AppUnregister For App ID 36 found
2017-06-15 12:59:55.815 DBUG 00000000-00000000 62086608 01C00000 CMAppInstMgr.C:64 CMAppInstEntry::Uninitialize for App ID 36 with count 2
2017-06-15 12:59:55.815 DBUG 00000000-00000000 2361154448 01B00000 AppEventBase.h:60 app.MSML AMEVENT_APPINST_UNREGNOTIFY - Cause=2
2017-06-15 12:59:55.815 DBUG 00770194-88009D90 2361154448 01B00000 MSMLAppInstance.cxx:375 Received MSML AppInstance event AMEVENT_APPINST_UNREGNOTIFY
2017-06-15 12:59:55.815 DBUG 00770194-88009D90 2361154448 01B00000 MSMLAppInstance.cxx:289 delete MSMLAppInstance
2017-06-15 12:59:55.815 DBUG 00770194-88009D90 2361154448 01B00000 AppCall.h:83 Uninitialize m_pCallIntf->ReleaseReference();
2017-06-15 12:59:55.815 DBUG 00770194-88009D90 2361154448 01B00000 MSMLCall.cxx:33 delete MSMLCall
2017-06-15 12:59:55.815 DBUG 00770194-88009D90 2361154448 01B00000 AppCall.h:45 ~AppCall m_pCallHandler->ReleaseReference();
2017-06-15 12:59:55.815 DBUG 00770194-10009D90 2361154448 01B00000 AppCallLeg.h:69 Uninitialize
2017-06-15 12:59:55.815 DBUG 00770194-10009D90 2361154448 01B00000 AppCallLeg.h:74 Uninitialize m_pCallLegIntf->ReleaseReference();
2017-06-15 12:59:55.815 DBUG 00770194-10009D90 2361154448 01B00000 MSMLCallLeg.cxx:34 delete MSMLCallLeg
2017-06-15 12:59:55.815 DBUG 00770194-10009D90 2361154448 01B00000 AppCallLeg.h:44 ~AppCallLeg m_pCallLegHandler->ReleaseReference();
2017-06-15 12:59:55.816 DBUG 00000000-00000000 2361154448 02200000 AppInstBase.C:41 App Instance Destroy
12:59:55.827 Trc 33009 INFO 00000000-00000000 2645818256 02800FA1 Response received: SIP/2.0 200 OK
Via: SIP/2.0/UDP mcpserver:port;branch=z9hG4bK1e8b55504292db
From: <sip:msml=5940fe530000002e@rmserver>;tag=4E290C00-1410-B85C-5D8C-80210F773FEC
To: <sip:Recording_service@sipserver:sip_port>;tag=704601B3-27CB-472B-BFB4-0AA674FCC7C1-55984
CSeq: 1 BYE
Call-ID: AAA1FB79-D22F-4514-B84F-2B9F94BE24FE-55864@192.168.1.12
Contact: sip:Recording_service@sipserver:sip_port
Content-Length: 0
X-Genesys-CallUUID: V2D5BCVIML56T0R4KRBNA5EQMC000018
Allow: INVITE, ACK, PRACK, CANCEL, BYE, REFER, INFO, UPDATE, MESSAGE, NOTIFY, OPTIONS
Supported: uui


12:59:55.827 Trc 33009 INFO 00000000-00000000 2645818256 02800FA1 Request received: BYE sip:Genesys@mcpserver:port SIP/2.0
Via: SIP/2.0/UDP rmserver;branch=z9hG4bK1d9c204842847aabcdef09
Via: SIP/2.0/UDP sipserver:sip_port;branch=z9hG4bKFE7636F6-F50A-4D42-BB52-18AC2CE7C6D4-2097
From: sip:29166730@sipserver:sip_port;tag=704601B3-27CB-472B-BFB4-0AA674FCC7C1-55982
To: <sip:msml=5940fe530000002e@rmserver>;tag=4E290C00-1410-8D15-A240-D1066C2E582D
Max-Forwards: 68
CSeq: 2 BYE
Call-ID: AAA1FB79-D22F-4514-B84F-2B9F94BE24FE-55862@192.168.1.12
Content-Length: 0


12:59:55.827 Trc 33009 INFO 00000000-00000000 2645818256 02800FA1 Request received: BYE sip:Genesys@mcpserver:port SIP/2.0
Via: SIP/2.0/UDP rmserver;branch=z9hG4bK1d9d5a2842847aabcdef09
Via: SIP/2.0/UDP sipserver:sip_port;branch=z9hG4bKFE7636F6-F50A-4D42-BB52-18AC2CE7C6D4-2098
From: sip:3305@sipserver:sip_port;tag=704601B3-27CB-472B-BFB4-0AA674FCC7C1-55983
To: <sip:msml=5940fe530000002e@rmserver>;tag=4E290C00-1410-A1F9-CD85-31CAB5D93F45
Max-Forwards: 68
CSeq: 2 BYE
Call-ID: AAA1FB79-D22F-4514-B84F-2B9F94BE24FE-55863@192.168.1.12
Content-Length: 0


*************************************************************
AND THIS iS the sip log




12:57:50.109: SipDialog: event CONNECTED_RESOK, t=115585, s=7, r=5, m=03561f3c
12:57:50.109 SIPCONN(29166730): HandleSipDialogEvent(CONNECTED_RESOK)
12:57:50.109 SIPCONN(29166730): Trying Timer deleted...
12:57:50.109 SIPCONN(29166730): store remote content
12:57:50.109 SIPCONN(29166730): sdp state SDP_OFFER_SENT, event SDP_RECEIVED
12:57:50.109 SIPCONN(29166730): new sdp state SDP_STATE_NULL, event SDP_RECEIVED
12:57:50.109 SIPCONN(29166730): Connect(2,33)
12:57:50.109 SIPCONN(29166730): NotifyResponseOnAnswer
12:57:50.109 SIPCONN(I_DN_VoIP_ service): SendAnswer
Session value of the SDP is [3706516665]
Version values of the SDP is [3706516666]
12:57:50.109 SIPCONN(I_DN_VoIP_ service): SendAnswer::Ack
12:57:50.109 SIPCONN(I_DN_VoIP_ service): SendAck(115584)
12:57:50.109: Sending  [0,UDP] 841 bytes to rmserver >>>>>
ACK sip:Genesys@mcpserver:port SIP/2.0
From: sip:29166730@sipserver:sip_port;tag=704601B3-27CB-472B-BFB4-0AA674FCC7C1-55982
To: <sip:msml=5940fe530000002e@rmserver>;tag=4E290C00-1410-8D15-A240-D1066C2E582D
Call-ID: AAA1FB79-D22F-4514-B84F-2B9F94BE24FE-55862@192.168.1.12
CSeq: 1 ACK
Content-Length: 185
Content-Type: application/sdp
Via: SIP/2.0/UDP sipserver:sip_port;branch=z9hG4bKFE7636F6-F50A-4D42-BB52-18AC2CE7C6D4-2088
Route: <sip:1ffb6bb0@rmserver;lr;gvp.rm.datanodes=1;confinstid=5940fe530000002e;idtag=00000073>
Allow: INVITE, ACK, PRACK, CANCEL, BYE, REFER, INFO, UPDATE, MESSAGE, NOTIFY, OPTIONS
Max-Forwards: 69

v=0
o=- 1497433477 1 IN IP4 192.168.1.127
s=SJphone
c=IN IP4 192.168.1.127
t=0 0
m=audio 49210 RTP/AVP 0
c=IN IP4 192.168.1.127
a=setup:active
a=sendrecv
a=rtpmap:0 PCMU/8000

12:57:50.109: SipDialog: event CONNECTED_SEND_ACK, t=115584, s=7, r=5, m=03549b84
12:57:50.109 SIPCONN(I_DN_VoIP_ service): HandleSipDialogEvent(CONNECTED_SEND_ACK) - filtered
12:57:50.109 SIPCONN(I_DN_VoIP_ service): sdp state SDP_OFFER_RECEIVED, event SDP_ANSWER_SENT
12:57:50.109 SIPCONN(I_DN_VoIP_ service): new sdp state SDP_STATE_NULL, event SDP_ANSWER_SENT
12:57:50.109 SIPCONN(I_DN_VoIP_ service): TRCLR(0)
12:57:50.109 SIPCONN(I_DN_VoIP_ service): state e:3,p:0,s:3,c:2,rc:0,m:1
12:57:50.109: MCU channel: state changed
12:57:50.109 SIPCONN(I_DN_VoIP_ service): NotifyOnComplete
12:57:50.109 SIPCONN(29166730): state e:3,p:3,s:3,c:2,rc:0,m:1
12:57:50.109 SIPCONN(29166730): SetChargingState: true
12:57:50.109 SIPPARTY(29166730): 146 verify update of party-connection state C-C
12:57:50.109 SIPCONN(29166730): NotifyOnComplete
12:57:50.109 SIPCONN(29166730): Connect complete, other device 'I_DN_VoIP_ service',(03561ec8,03549b10)
12:57:50.109 SIPCONN(29166730): SendAck(115585)
12:57:50.109: Sending  [0,UDP] 467 bytes to 192.168.1.127:49157 >>>>>
ACK sip:29166730@192.168.1.127:49157 SIP/2.0
From: <sip:1112@192.168.1.12>;tag=704601B3-27CB-472B-BFB4-0AA674FCC7C1-55965
To: "unknown" <sip:29166730@192.168.1.12>;tag=23de20e9843
Call-ID: 772B109DCF184C48820975DE2430A61A0xc0a8017f
CSeq: 1 ACK
Content-Length: 0
Via: SIP/2.0/UDP sipserver:sip_port;branch=z9hG4bKFE7636F6-F50A-4D42-BB52-18AC2CE7C6D4-2089
Allow: INVITE, ACK, PRACK, CANCEL, BYE, REFER, INFO, UPDATE, MESSAGE, NOTIFY, OPTIONS
Max-Forwards: 70


12:57:50.109: SipDialog: event CONNECTED_SEND_ACK, t=115585, s=7, r=8, m=03561f3c
12:57:50.109 SIPCONN(29166730): HandleSipDialogEvent(CONNECTED_SEND_ACK) - filtered
12:57:50.109 SIPCONN(I_DN_VoIP_ service): Connect complete, other device '29166730',(03549b10,03561ec8)
12:57:50.109: SIPTR(784): complete
12:57:50.109: SIPTR(782): Step 1 - SipTransactionConferenceParty(784) complete
12:57:50.109: SIPTR(782): Begin step 2 - SipTransactionConferenceParty(785)
12:57:50.109 SIPPARTY(3305): +mcu
12:57:50.109 SIPCONN(I_DN_VoIP_ service): set monitor 03568110, 034c90f0
12:57:50.109 SIPCONN(3305): re-invite-connected
12:57:50.109 SIPCONN(I_DN_VoIP_ service): re-invite-null
12:57:50.109 SIPCONN(I_DN_VoIP_ service): GetOffer
12:57:50.109 SIPCONN(I_DN_VoIP_ service): GetOffer::SendInvite
12:57:50.109: SipDialog: set monitor 03568184
12:57:50.109 SIPCONN(I_DN_VoIP_ service): main dialog 0 created
12:57:50.109 SIPCONN(I_DN_VoIP_ service): Local contact: '<sip:3305@sipserver:sip_port>'
12:57:50.109 SIPCONN(I_DN_VoIP_ service): InitiateDialog: preparing a 3pcc request
12:57:50.109: SIPDLG[297]: register TRN[115586]
12:57:50.109: SIPDLG[297]: TRN[115586] flags set to 0x6
12:57:50.109: Sending  [0,UDP] 656 bytes to rmserver >>>>>
INVITE sip:msml=5940fe530000002e@rmserver SIP/2.0
From: sip:3305@sipserver:sip_port;tag=704601B3-27CB-472B-BFB4-0AA674FCC7C1-55983
To: <sip:msml=5940fe530000002e@rmserver>
Call-ID: AAA1FB79-D22F-4514-B84F-2B9F94BE24FE-55863@192.168.1.12
CSeq: 1 INVITE
Content-Length: 0
Via: SIP/2.0/UDP sipserver:sip_port;branch=z9hG4bKFE7636F6-F50A-4D42-BB52-18AC2CE7C6D4-2090
Contact: <sip:3305@sipserver:sip_port>
Allow: ACK, BYE, CANCEL, INFO, INVITE, MESSAGE, NOTIFY, OPTIONS, PRACK, REFER, UPDATE
Max-Forwards: 69
X-Genesys-CallUUID: V2D5BCVIML56T0R4KRBNA5EQMC000018
Session-Expires: 1800;refresher=uac
Min-SE: 90
Supported: uui,timer


12:57:50.109: SipDialog: event SEND_INVITE, t=115586, s=2, r=6, m=03568184
12:57:50.109 SIPCONN(I_DN_VoIP_ service): HandleSipDialogEvent(SEND_INVITE) - filtered
12:57:50.109 SIPCONN(I_DN_VoIP_ service): sdp state SDP_STATE_NULL, event SDP_OFFER_REQUESTED
12:57:50.109 SIPCONN(I_DN_VoIP_ service): new sdp state SDP_OFFER_REQUESTED, event SDP_OFFER_REQUESTED
12:57:50.109: $-NET:SIP::0:741

12:57:50.109: $+NET:SIP::0:0
12:57:50.109: SIPTR: Received [0,UDP] 347 bytes from rmserver <<<<<
SIP/2.0 100 Trying
Via: SIP/2.0/UDP sipserver:sip_port;branch=z9hG4bKFE7636F6-F50A-4D42-BB52-18AC2CE7C6D4-2090
From: sip:3305@sipserver:sip_port;tag=704601B3-27CB-472B-BFB4-0AA674FCC7C1-55983
To: <sip:msml=5940fe530000002e@rmserver>
CSeq: 1 INVITE
Call-ID: AAA1FB79-D22F-4514-B84F-2B9F94BE24FE-55863@192.168.1.12
Content-Length: 0


12:57:50.109: SipDialog: event CALLING_RESPROV, t=115586, s=2, r=5, m=03568184
12:57:50.109 SIPCONN(I_DN_VoIP_ service): HandleSipDialogEvent(CALLING_RESPROV)
12:57:50.109 SIPCONN(I_DN_VoIP_ service): Capabilities 60013f
12:57:50.109 SIPCONN(I_DN_VoIP_ service): reliable=0
12:57:50.109 SIPCONN(I_DN_VoIP_ service): store remote content
12:57:50.109 SIPCONN(I_DN_VoIP_ service): store remote content - trying ignored
12:57:50.109 SIPCONN(I_DN_VoIP_ service): Trying Timer for 32000 mlsec started...
12:57:50.109 SIPCONN(I_DN_VoIP_ service): Connect(1,1)
12:57:50.109: $-NET:SIP::0:43

12:57:50.125: $+NET:SIP::0:0
12:57:50.125: SIPTR: Received [0,UDP] 1058 bytes from rmserver <<<<<
SIP/2.0 200 OK
Via: SIP/2.0/UDP sipserver:sip_port;branch=z9hG4bKFE7636F6-F50A-4D42-BB52-18AC2CE7C6D4-2090
From: sip:3305@sipserver:sip_port;tag=704601B3-27CB-472B-BFB4-0AA674FCC7C1-55983
To: <sip:msml=5940fe530000002e@rmserver>;tag=4E290C00-1410-A1F9-CD85-31CAB5D93F45
CSeq: 1 INVITE
Call-ID: AAA1FB79-D22F-4514-B84F-2B9F94BE24FE-55863@192.168.1.12
Contact: sip:Genesys@mcpserver:port
Content-Length: 196
Content-Type: application/sdp
Record-Route: <sip:1ffb6bb0@rmserver;lr;gvp.rm.datanodes=1;confinstid=5940fe530000002e;idtag=00000074>
Min-SE: 90
X-Genesys-GVP-Session-Data: callsession=27290C00-DB6B-EB70-F840-CD1B56935C20;1;0;;;;Resources;IVRAppDefault
X-Genesys-GVP-Session-ID: 27290C00-DB6B-EB70-F840-CD1B56935C20;gvp.rm.datanodes=1;gvp.rm.tenant-id=101_IVRAppDefault
Session-Expires: 1800;refresher=uac
Require: timer

v=0
o=- 268450979 1 IN IP4 mcpserver
s=phone-call
c=IN IP4 mcpserver
t=0 0
m=audio 20068 RTP/AVP 0 8 2
a=rtpmap:0 pcmu/8000
a=rtpmap:8 pcma/8000
a=rtpmap:2 g726-32/8000
a=sendrecv

12:57:50.125: SipDialog: event CALLING_RESOK, t=115586, s=7, r=5, m=03568184
12:57:50.125 SIPCONN(I_DN_VoIP_ service): HandleSipDialogEvent(CALLING_RESOK)
12:57:50.125 SIPCONN(I_DN_VoIP_ service): Trying Timer deleted...
12:57:50.125 SIPCONN(I_DN_VoIP_ service): store remote content
12:57:50.125 SIPCONN(I_DN_VoIP_ service): sdp state SDP_OFFER_REQUESTED, event SDP_RECEIVED
12:57:50.125 SIPCONN(I_DN_VoIP_ service): new sdp state SDP_OFFER_RECEIVED, event SDP_RECEIVED
12:57:50.125 SIPCONN(I_DN_VoIP_ service): Connect(1,4)
12:57:50.125 SIPCONN(I_DN_VoIP_ service): NotifyOnOffer
12:57:50.125 SIPCONN(3305): SendOffer
12:57:50.125 SIPCONN(3305): SendOffer::ReInvite
Session value of the SDP is [268450979]
Version values of the SDP is [1]
12:57:50.125: add party info '3305' state 3.
12:57:50.125: SIPDLG[295]: register TRN[115587]
12:57:50.125: SIPDLG[295]: TRN[115587] flags set to 0x6
12:57:50.125: Sending  [0,UDP] 919 bytes to 192.168.1.127:37132 >>>>>
INVITE sip:3305@192.168.1.127:37132;rinstance=c6603186c04d8529;transport=udp SIP/2.0
From: sip:29166730@sipserver:sip_port;tag=704601B3-27CB-472B-BFB4-0AA674FCC7C1-55969
To: <sip:1112@sipserver:sip_port>;tag=40fc62d5
Call-ID: AAA1FB79-D22F-4514-B84F-2B9F94BE24FE-55849@192.168.1.12
CSeq: 3 INVITE
Content-Length: 197
Content-Type: application/sdp
Via: SIP/2.0/UDP sipserver:sip_port;branch=z9hG4bKFE7636F6-F50A-4D42-BB52-18AC2CE7C6D4-2091
Contact: <sip:29166730@sipserver:sip_port>
Allow: INVITE, ACK, PRACK, CANCEL, BYE, REFER, INFO, UPDATE, MESSAGE, NOTIFY, OPTIONS
X-Genesys-CallUUID: V2D5BCVIML56T0R4KRBNA5EQMC000018
Max-Forwards: 69
Session-Expires: 1800;refresher=uac
Min-SE: 90
Supported: 100rel,timer

v=0
o=- 1497433464 2 IN IP4 mcpserver
s=phone-call
c=IN IP4 mcpserver
t=0 0
m=audio 20068 RTP/AVP 0 8 2
a=sendrecv
a=rtpmap:0 pcmu/8000
a=rtpmap:8 pcma/8000
a=rtpmap:2 g726-32/8000

12:57:50.125: SipDialog: event CONNECTED_SEND_REINVITE, t=115587, s=7, r=5, m=0356c9d4
12:57:50.125 SIPCONN(3305): HandleSipDialogEvent(CONNECTED_SEND_REINVITE) - filtered
12:57:50.125 SIPCONN(3305): sdp state SDP_STATE_NULL, event SDP_OFFER_SENT
12:57:50.125 SIPCONN(3305): new sdp state SDP_OFFER_SENT, event SDP_OFFER_SENT
12:57:50.125: $-NET:SIP::0:328

12:57:50.140: $+NET:SIP::0:0
12:57:50.140: SIPTR: Received [0,UDP] 920 bytes from 192.168.1.127:37132 <<<<<
SIP/2.0 200 OK
Via: SIP/2.0/UDP sipserver:sip_port;branch=z9hG4bKFE7636F6-F50A-4D42-BB52-18AC2CE7C6D4-2091
Contact: <sip:3305@192.168.1.127:37132;rinstance=c6603186c04d8529;transport=udp>
To: <sip:1112@sipserver:sip_port>;tag=40fc62d5
From: <sip:29166730@sipserver:sip_port>;tag=704601B3-27CB-472B-BFB4-0AA674FCC7C1-55969
Call-ID: AAA1FB79-D22F-4514-B84F-2B9F94BE24FE-55849@192.168.1.12
CSeq: 3 INVITE
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO
Content-Type: application/sdp
User-Agent: Genesyslab.Sip.Endpoint 8.1.0.1 F-production01.us.int.genesyslab.com-051911-210539  Genesyslab.Sip.Endpoint.Provider.CP 8.1.0.1 F-production01.us.int.genesyslab.com-051911-210539
Content-Length: 184

v=0
o=- 9 3 IN IP4 192.168.1.127
s=CounterPath eyeBeam 1.5
c=IN IP4 192.168.1.127
t=0 0
m=audio 2312 RTP/AVP 0 8
a=sendrecv
a=x-rtp-session-id:A3F9E33DEDF54173955FB950EEEACD76

12:57:50.140: SipDialog: event CONNECTED_RESOK, t=115587, s=7, r=5, m=0356c9d4
12:57:50.140 SIPCONN(3305): HandleSipDialogEvent(CONNECTED_RESOK)
12:57:50.140 SIPCONN(3305): store remote content
12:57:50.140 SIPCONN(3305): sdp state SDP_OFFER_SENT, event SDP_RECEIVED
12:57:50.140 SIPCONN(3305): new sdp state SDP_STATE_NULL, event SDP_RECEIVED
12:57:50.140 SIPCONN(3305): Connect(2,33)
12:57:50.140 SIPCONN(3305): NotifyResponseOnAnswer
12:57:50.140 SIPCONN(I_DN_VoIP_ service): SendAnswer
Session value of the SDP is [9]
Version values of the SDP is [3]
12:57:50.140 SIPCONN(I_DN_VoIP_ service): SendAnswer::Ack
12:57:50.140 SIPCONN(I_DN_VoIP_ service): SendAck(115586)
12:57:50.140: Sending  [0,UDP] 833 bytes to rmserver >>>>>
ACK sip:Genesys@mcpserver:port SIP/2.0
From: sip:3305@sipserver:sip_port;tag=704601B3-27CB-472B-BFB4-0AA674FCC7C1-55983
To: <sip:msml=5940fe530000002e@rmserver>;tag=4E290C00-1410-A1F9-CD85-31CAB5D93F45
Call-ID: AAA1FB79-D22F-4514-B84F-2B9F94BE24FE-55863@192.168.1.12
CSeq: 1 ACK
Content-Length: 181
Content-Type: application/sdp
Via: SIP/2.0/UDP sipserver:sip_port;branch=z9hG4bKFE7636F6-F50A-4D42-BB52-18AC2CE7C6D4-2092
Route: <sip:1ffb6bb0@rmserver;lr;gvp.rm.datanodes=1;confinstid=5940fe530000002e;idtag=00000074>
Allow: INVITE, ACK, PRACK, CANCEL, BYE, REFER, INFO, UPDATE, MESSAGE, NOTIFY, OPTIONS
Max-Forwards: 69

v=0
o=- 1497433485 1 IN IP4 192.168.1.127
s=CounterPath
c=IN IP4 192.168.1.127
t=0 0
m=audio 2312 RTP/AVP 0 8
a=sendrecv
a=x-rtp-session-id:A3F9E33DEDF54173955FB950EEEACD76

12:57:50.140: SipDialog: event CONNECTED_SEND_ACK, t=115586, s=7, r=5, m=03568184
12:57:50.140 SIPCONN(I_DN_VoIP_ service): HandleSipDialogEvent(CONNECTED_SEND_ACK) - filtered
12:57:50.140 SIPCONN(I_DN_VoIP_ service): sdp state SDP_OFFER_RECEIVED, event SDP_ANSWER_SENT
12:57:50.140 SIPCONN(I_DN_VoIP_ service): new sdp state SDP_STATE_NULL, event SDP_ANSWER_SENT
12:57:50.140 SIPCONN(I_DN_VoIP_ service): TRCLR(0)
12:57:50.140 SIPCONN(I_DN_VoIP_ service): state e:3,p:0,s:3,c:2,rc:0,m:1
12:57:50.140: MCU channel: state changed
12:57:50.140 SIPCONN(I_DN_VoIP_ service): NotifyOnComplete
12:57:50.140 SIPCONN(3305): state e:3,p:3,s:3,c:2,rc:0,m:1
12:57:50.140 SIPCONN(3305): SetChargingState: true
12:57:50.140 SIPPARTY(3305): 148 verify update of party-connection state C-C
12:57:50.140 SIPCONN(3305): NotifyOnComplete
12:57:50.140 SIPCONN(3305): Connect complete, other device 'I_DN_VoIP_ service',(0356c960,03568110)
12:57:50.140 SIPCONN(3305): SendAck(115587)
12:57:50.140: Sending  [0,UDP] 512 bytes to 192.168.1.127:37132 >>>>>
ACK sip:3305@192.168.1.127:37132;rinstance=c6603186c04d8529;transport=udp SIP/2.0
From: sip:29166730@sipserver:sip_port;tag=704601B3-27CB-472B-BFB4-0AA674FCC7C1-55969
To: <sip:1112@sipserver:sip_port>;tag=40fc62d5
Call-ID: AAA1FB79-D22F-4514-B84F-2B9F94BE24FE-55849@192.168.1.12
CSeq: 3 ACK
Content-Length: 0
Via: SIP/2.0/UDP sipserver:sip_port;branch=z9hG4bKFE7636F6-F50A-4D42-BB52-18AC2CE7C6D4-2093
Allow: INVITE, ACK, PRACK, CANCEL, BYE, REFER, INFO, UPDATE, MESSAGE, NOTIFY, OPTIONS
Max-Forwards: 69


12:57:50.140: SipDialog: event CONNECTED_SEND_ACK, t=115587, s=7, r=8, m=0356c9d4
12:57:50.140 SIPCONN(3305): HandleSipDialogEvent(CONNECTED_SEND_ACK) - filtered
12:57:50.140 SIPCONN(I_DN_VoIP_ service): Connect complete, other device '3305',(03568110,0356c960)
12:57:50.140: SIPTR(785): complete
12:57:50.140: SIPTR(782): Step 2 - SipTransactionConferenceParty(785) complete
12:57:50.140: SIPTR(782): Begin step 3 - SipTransactionGetOffer(786)
12:57:50.140 SIPPARTY(gcti::record): +mcu
12:57:50.140 SIPCONN(I_DN_VoIP_ service): set monitor 03544838, 03461820
12:57:50.140 SIPCONN(I_DN_VoIP_ service): re-invite-null
12:57:50.140 SIPCONN(I_DN_VoIP_ service): GetOffer
12:57:50.140 SIPCONN(I_DN_VoIP_ service): GetOffer::SendInvite
12:57:50.140: SipDialog: set monitor 035448ac
12:57:50.140 SIPCONN(I_DN_VoIP_ service): main dialog 0 created
12:57:50.140 SIPCONN(I_DN_VoIP_ service): Local contact: 'sip:Recording_service@sipserver:sip_port'
12:57:50.140 SIPCONN(I_DN_VoIP_ service): InitiateDialog: preparing a 3pcc request
12:57:50.140: SIPDLG[298]: register TRN[115588]
12:57:50.140: SIPDLG[298]: TRN[115588] flags set to 0x6
12:57:50.140: Sending  [0,UDP] 678 bytes to rmserver >>>>>
INVITE sip:msml=5940fe530000002e@rmserver SIP/2.0
From: <sip:Recording_service@sipserver:sip_port>;tag=704601B3-27CB-472B-BFB4-0AA674FCC7C1-55984
To: <sip:msml=5940fe530000002e@rmserver>
Call-ID: AAA1FB79-D22F-4514-B84F-2B9F94BE24FE-55864@192.168.1.12
CSeq: 1 INVITE
Content-Length: 0
Via: SIP/2.0/UDP sipserver:sip_port;branch=z9hG4bKFE7636F6-F50A-4D42-BB52-18AC2CE7C6D4-2094
Contact: sip:Recording_service@sipserver:sip_port
Allow: ACK, BYE, CANCEL, INFO, INVITE, MESSAGE, NOTIFY, OPTIONS, PRACK, REFER, UPDATE
Max-Forwards: 69
X-Genesys-CallUUID: V2D5BCVIML56T0R4KRBNA5EQMC000018
Session-Expires: 1800;refresher=uac
Min-SE: 90
Supported: timer


12:57:50.140: SipDialog: event SEND_INVITE, t=115588, s=2, r=6, m=035448ac
12:57:50.140 SIPCONN(I_DN_VoIP_ service): HandleSipDialogEvent(SEND_INVITE) - filtered
12:57:50.140 SIPCONN(I_DN_VoIP_ service): sdp state SDP_STATE_NULL, event SDP_OFFER_REQUESTED
12:57:50.140 SIPCONN(I_DN_VoIP_ service): new sdp state SDP_OFFER_REQUESTED, event SDP_OFFER_REQUESTED
12:57:50.140: $-NET:SIP::0:949

12:57:50.140: $+NET:SIP::0:0
12:57:50.140: SIPTR: Received [0,UDP] 362 bytes from rmserver <<<<<
SIP/2.0 100 Trying
Via: SIP/2.0/UDP sipserver:sip_port;branch=z9hG4bKFE7636F6-F50A-4D42-BB52-18AC2CE7C6D4-2094
From: <sip:Recording_service@sipserver:sip_port>;tag=704601B3-27CB-472B-BFB4-0AA674FCC7C1-55984
To: <sip:msml=5940fe530000002e@rmserver>
CSeq: 1 INVITE
Call-ID: AAA1FB79-D22F-4514-B84F-2B9F94BE24FE-55864@192.168.1.12
Content-Length: 0


12:57:50.140: SipDialog: event CALLING_RESPROV, t=115588, s=2, r=5, m=035448ac
12:57:50.140 SIPCONN(I_DN_VoIP_ service): HandleSipDialogEvent(CALLING_RESPROV)
12:57:50.140 SIPCONN(I_DN_VoIP_ service): Capabilities 20013f
12:57:50.140 SIPCONN(I_DN_VoIP_ service): reliable=0
12:57:50.140 SIPCONN(I_DN_VoIP_ service): store remote content
12:57:50.140 SIPCONN(I_DN_VoIP_ service): store remote content - trying ignored
12:57:50.140 SIPCONN(I_DN_VoIP_ service): Trying Timer for 32000 mlsec started...
12:57:50.140 SIPCONN(I_DN_VoIP_ service): Connect(1,1)
12:57:50.140: $-NET:SIP::0:48

12:57:50.156: $+NET:SIP::0:0
12:57:50.156: SIPTR: Received [0,UDP] 1073 bytes from rmserver <<<<<
SIP/2.0 200 OK
Via: SIP/2.0/UDP sipserver:sip_port;branch=z9hG4bKFE7636F6-F50A-4D42-BB52-18AC2CE7C6D4-2094
From: <sip:Recording_service@sipserver:sip_port>;tag=704601B3-27CB-472B-BFB4-0AA674FCC7C1-55984
To: <sip:msml=5940fe530000002e@rmserver>;tag=4E290C00-1410-B85C-5D8C-80210F773FEC
CSeq: 1 INVITE
Call-ID: AAA1FB79-D22F-4514-B84F-2B9F94BE24FE-55864@192.168.1.12
Contact: sip:Genesys@mcpserver:port
Content-Length: 196
Content-Type: application/sdp
Record-Route: <sip:1ffb6bb0@rmserver;lr;gvp.rm.datanodes=1;confinstid=5940fe530000002e;idtag=00000075>
Min-SE: 90
X-Genesys-GVP-Session-Data: callsession=27290C00-DB6B-865E-E03C-4D0FE2062EC5;1;0;;;;Resources;IVRAppDefault
X-Genesys-GVP-Session-ID: 27290C00-DB6B-865E-E03C-4D0FE2062EC5;gvp.rm.datanodes=1;gvp.rm.tenant-id=101_IVRAppDefault
Session-Expires: 1800;refresher=uac
Require: timer

v=0
o=- 268450980 1 IN IP4 mcpserver
s=phone-call
c=IN IP4 mcpserver
t=0 0
m=audio 20070 RTP/AVP 0 8 2
a=rtpmap:0 pcmu/8000
a=rtpmap:8 pcma/8000
a=rtpmap:2 g726-32/8000
a=sendrecv

12:57:50.156: SipDialog: event CALLING_RESOK, t=115588, s=7, r=5, m=035448ac
12:57:50.156 SIPCONN(I_DN_VoIP_ service): HandleSipDialogEvent(CALLING_RESOK)
12:57:50.156 SIPCONN(I_DN_VoIP_ service): Trying Timer deleted...
12:57:50.156 SIPCONN(I_DN_VoIP_ service): store remote content
12:57:50.156 SIPCONN(I_DN_VoIP_ service): sdp state SDP_OFFER_REQUESTED, event SDP_RECEIVED
12:57:50.156 SIPCONN(I_DN_VoIP_ service): new sdp state SDP_OFFER_RECEIVED, event SDP_RECEIVED
12:57:50.156 SIPCONN(I_DN_VoIP_ service): Connect(1,4)
12:57:50.156 SIPCONN(I_DN_VoIP_ service): NotifyOnOffer
12:57:50.156: SIPTR(786): complete
12:57:50.156: SIPTR(782): Step 3 - SipTransactionGetOffer(786) complete
12:57:50.156: SIPTR(782): Begin step 4 - SipTransactionProcessMsmlConf(787)
12:57:50.156 SIPCONN(I_DN_VoIP_ service): CtiRequest(3)
12:57:50.156: SIPDLG[298]: register TRN[115589]
12:57:50.156: Sending  [0,UDP] 1318 bytes to rmserver >>>>>
INFO sip:Genesys@mcpserver:port SIP/2.0
From: <sip:Recording_service@sipserver:sip_port>;tag=704601B3-27CB-472B-BFB4-0AA674FCC7C1-55984
To: <sip:msml=5940fe530000002e@rmserver>;tag=4E290C00-1410-B85C-5D8C-80210F773FEC
Call-ID: AAA1FB79-D22F-4514-B84F-2B9F94BE24FE-55864@192.168.1.12
CSeq: 2 INFO
Content-Length: 669
Content-Type: application/vnd.radisys.msml+xml
Via: SIP/2.0/UDP sipserver:sip_port;branch=z9hG4bKFE7636F6-F50A-4D42-BB52-18AC2CE7C6D4-2095
Contact: sip:Recording_service@sipserver:sip_port
Max-Forwards: 69
Route: <sip:1ffb6bb0@rmserver;lr;gvp.rm.datanodes=1;confinstid=5940fe530000002e;idtag=00000075>

<?xml version="1.0" encoding="UTF-8"?>
<msml version="1.1">
<createconference name="5940fe530000002e_ssc" term="false">
<audiomix/>
<videolayout>
<selector method="confrole"/>
</videolayout>
</createconference>
<join id1="conn:4E290C00-1410-8D15-A240-D1066C2E582D" id2="conf:5940fe530000002e_ssc">
<stream media="audio"/>
<stream media="video"/>
</join>
<join id1="conn:4E290C00-1410-A1F9-CD85-31CAB5D93F45" id2="conf:5940fe530000002e_ssc">
<stream media="audio"/>
<stream media="video"/>
</join>
<join id1="conn:4E290C00-1410-B85C-5D8C-80210F773FEC" id2="conf:5940fe530000002e_ssc">
<stream media="audio"/>
<stream media="video"/>
</join>
</msml>

12:57:50.156: SipDialog: event CONNECTED_SEND_REQUEST, t=115589, s=7, r=9, m=035448ac
12:57:50.156 SIPCONN(I_DN_VoIP_ service): HandleSipDialogEvent(CONNECTED_SEND_REQUEST) - filtered
12:57:50.156: $-NET:SIP::0:215

12:57:50.171: $+NET:SIP::0:0
12:57:50.171: SIPTR: Received [0,UDP] 777 bytes from rmserver <<<<<
SIP/2.0 200 OK
Via: SIP/2.0/UDP sipserver:sip_port;branch=z9hG4bKFE7636F6-F50A-4D42-BB52-18AC2CE7C6D4-2095
From: <sip:Recording_service@sipserver:sip_port>;tag=704601B3-27CB-472B-BFB4-0AA674FCC7C1-55984
To: <sip:msml=5940fe530000002e@rmserver>;tag=4E290C00-1410-B85C-5D8C-80210F773FEC
CSeq: 2 INFO
Call-ID: AAA1FB79-D22F-4514-B84F-2B9F94BE24FE-55864@192.168.1.12
Content-Length: 92
Content-Type: application/vnd.radisys.msml+xml
Min-SE: 90
X-Genesys-GVP-Session-Data: callsession=27290C00-DB6B-865E-E03C-4D0FE2062EC5;1;0;;;;Resources;IVRAppDefault
X-Genesys-GVP-Session-ID: 27290C00-DB6B-865E-E03C-4D0FE2062EC5;gvp.rm.datanodes=1;gvp.rm.tenant-id=101_IVRAppDefault

<?xml version="1.0" encoding="UTF-8"?>
<msml version="1.1">
<result response="200"/>
</msml>
12:57:50.171: SipDialog: event CONNECTED_RESOK, t=115589, s=7, r=5, m=035448ac
12:57:50.171 SIPCONN(I_DN_VoIP_ service): HandleSipDialogEvent(CONNECTED_RESOK)
12:57:50.171 SIPCONN(I_DN_VoIP_ service): store remote content
12:57:50.171 SIPCONN(I_DN_VoIP_ service): CtiRequest(3,33)
12:57:50.171 SIPCONN(I_DN_VoIP_ service): CtiRequestProcessInfoResponse
12:57:50.171 SIPCONN(I_DN_VoIP_ service): INFO transaction cleared
12:57:50.171: SIPTR(787): complete
12:57:50.171: SIPTR(782): Step 4 - SipTransactionProcessMsmlConf(787) complete
12:57:50.171: SIPTR(782): Begin step 5 - SipTransactionConnectNewParty(788)
Session value of the SDP is [268450980]
Version values of the SDP is [1]
12:57:50.171 SIPCONN(gcti::record): re-invite-null
12:57:50.171: SipDialog: set monitor 034e9f54
12:57:50.171 SIPCONN(gcti::record): main dialog 0 created
12:57:50.171 SIPCONN(gcti::record): Local contact: '<sip:I_DN_VoIP_ service@sipserver:sip_port>'
12:57:50.171 SIPCONN(gcti::record): InitiateDialog: preparing a 3pcc request
12:57:50.171: add party info 'gcti::record' state 0.
12:57:50.171: SIPDLG[299]: register TRN[115590]
12:57:50.171: SIPDLG[299]: TRN[115590] flags set to 0x6
12:57:50.171: Sending  [0,UDP] 1098 bytes to rmserver >>>>>
INVITE sip:msml@rmserveremergency-29166730-1112-2017-06-15-10-57-50-000102a3a9d4f026-V2D5BCVIML56T0R4KRBNA5EQMC000018-3305-3304 SIP/2.0
From: <sip:msml=5940fe530000002e@sipserver:sip_port>;tag=704601B3-27CB-472B-BFB4-0AA674FCC7C1-55985
To: <sip:msml@rmserveremergency-29166730-1112-2017-06-15-10-57-50-000102a3a9d4f026-V2D5BCVIML56T0R4KRBNA5EQMC000018-3305-3304>
Call-ID: AAA1FB79-D22F-4514-B84F-2B9F94BE24FE-55865@192.168.1.12
CSeq: 1 INVITE
Content-Length: 197
Content-Type: application/sdp
Via: SIP/2.0/UDP sipserver:sip_port;branch=z9hG4bKFE7636F6-F50A-4D42-BB52-18AC2CE7C6D4-2096
Contact: <sip:I_DN_VoIP_ service@sipserver:sip_port>
Allow: ACK, BYE, CANCEL, INFO, INVITE, MESSAGE, NOTIFY, OPTIONS, PRACK, REFER, UPDATE
Max-Forwards: 69
X-Genesys-CallUUID: V2D5BCVIML56T0R4KRBNA5EQMC000018
Session-Expires: 1800;refresher=uac
Min-SE: 90
Supported: uui,100rel,timer

v=0
o=- 1497433473 1 IN IP4 mcpserver
s=phone-call
c=IN IP4 mcpserver
t=0 0
m=audio 20070 RTP/AVP 0 8 2
a=sendrecv
a=rtpmap:0 pcmu/8000
a=rtpmap:8 pcma/8000
a=rtpmap:2 g726-32/8000

12:57:50.171: SipDialog: event SEND_INVITE, t=115590, s=2, r=7, m=034e9f54
12:57:50.171 SIPCONN(gcti::record): HandleSipDialogEvent(SEND_INVITE) - filtered
12:57:50.171 SIPCONN(gcti::record): sdp state SDP_STATE_NULL, event SDP_OFFER_SENT
12:57:50.171 SIPCONN(gcti::record): new sdp state SDP_OFFER_SENT, event SDP_OFFER_SENT
12:57:50.171: $-NET:SIP::0:392

12:57:50.656: $+NET:SIP::0:0
12:57:50.656: SIPTR: Received [0,UDP] 1073 bytes from rmserver <<<<<
SIP/2.0 200 OK
Via: SIP/2.0/UDP sipserver:sip_port;branch=z9hG4bKFE7636F6-F50A-4D42-BB52-18AC2CE7C6D4-2094
From: <sip:Recording_service@sipserver:sip_port>;tag=704601B3-27CB-472B-BFB4-0AA674FCC7C1-55984
To: <sip:msml=5940fe530000002e@rmserver>;tag=4E290C00-1410-B85C-5D8C-80210F773FEC
CSeq: 1 INVITE
Call-ID: AAA1FB79-D22F-4514-B84F-2B9F94BE24FE-55864@192.168.1.12
Contact: sip:Genesys@mcpserver:port
Content-Length: 196
Content-Type: application/sdp
Record-Route: <sip:1ffb6bb0@rmserver;lr;gvp.rm.datanodes=1;confinstid=5940fe530000002e;idtag=00000075>
Min-SE: 90
X-Genesys-GVP-Session-Data: callsession=27290C00-DB6B-865E-E03C-4D0FE2062EC5;1;0;;;;Resources;IVRAppDefault
X-Genesys-GVP-Session-ID: 27290C00-DB6B-865E-E03C-4D0FE2062EC5;gvp.rm.datanodes=1;gvp.rm.tenant-id=101_IVRAppDefault
Session-Expires: 1800;refresher=uac
Require: timer

v=0
o=- 268450980 1 IN IP4 mcpserver
s=phone-call
c=IN IP4 mcpserver
t=0 0
m=audio 20070 RTP/AVP 0 8 2
a=rtpmap:0 pcmu/8000
a=rtpmap:8 pcma/8000
a=rtpmap:2 g726-32/8000
a=sendrecv

12:57:50.656: $-NET:SIP::0:22

12:57:50.671: Sending  [0,UDP] 1098 bytes to rmserver >>>>>
INVITE sip:msml@rmserveremergency-29166730-1112-2017-06-15-10-57-50-000102a3a9d4f026-V2D5BCVIML56T0R4KRBNA5EQMC000018-3305-3304 SIP/2.0
From: <sip:msml=5940fe530000002e@sipserver:sip_port>;tag=704601B3-27CB-472B-BFB4-0AA674FCC7C1-55985
To: <sip:msml@rmserveremergency-29166730-1112-2017-06-15-10-57-50-000102a3a9d4f026-V2D5BCVIML56T0R4KRBNA5EQMC000018-3305-3304>
Call-ID: AAA1FB79-D22F-4514-B84F-2B9F94BE24FE-55865@192.168.1.12
CSeq: 1 INVITE
Content-Length: 197
Content-Type: application/sdp
Via: SIP/2.0/UDP sipserver:sip_port;branch=z9hG4bKFE7636F6-F50A-4D42-BB52-18AC2CE7C6D4-2096
Contact: <sip:I_DN_VoIP_ service@sipserver:sip_port>
Allow: ACK, BYE, CANCEL, INFO, INVITE, MESSAGE, NOTIFY, OPTIONS, PRACK, REFER, UPDATE
Max-Forwards: 69
X-Genesys-CallUUID: V2D5BCVIML56T0R4KRBNA5EQMC000018
Session-Expires: 1800;refresher=uac
Min-SE: 90
Supported: uui,100rel,timer

v=0
o=- 1497433473 1 IN IP4 mcpserver
s=phone-call
c=IN IP4 mcpserver
t=0 0
m=audio 20070 RTP/AVP 0 8 2
a=sendrecv
a=rtpmap:0 pcmu/8000
a=rtpmap:8 pcma/8000
a=rtpmap:2 g726-32/8000

12:57:51.421: Sending  [0,UDP] 402 bytes to rmserver >>>>>
OPTIONS sip:msml@rmserver;gvp-tenant-id=Resources SIP/2.0
From: <sip:8989@sipserver:sip_port>;tag=704601B3-27CB-472B-BFB4-0AA674FCC7C1-55986
To: <sip:8989@sipserver:sip_port>
Call-ID: AAA1FB79-D22F-4514-B84F-2B9F94BE24FE-55866@192.168.1.12
CSeq: 1497524271 OPTIONS
Content-Length: 0
Via: SIP/2.0/UDP sipserver:sip_port;branch=z9hG4bKE09ECB08-392B-431B-B82C-11455DB185B6
Max-Forwards: 0


12:57:51.421: $+NET:SIP::0:0
12:57:51.421: SIPTR: Received [0,UDP] 374 bytes from rmserver <<<<<
SIP/2.0 200 OK
Via: SIP/2.0/UDP sipserver:sip_port;branch=z9hG4bKE09ECB08-392B-431B-B82C-11455DB185B6
From: <sip:8989@sipserver:sip_port>;tag=704601B3-27CB-472B-BFB4-0AA674FCC7C1-55986
To: <sip:8989@sipserver:sip_port>;tag=27290C00-DB6B-7AAA-303D-4DC98C5E47C5
CSeq: 1497524271 OPTIONS
Call-ID: AAA1FB79-D22F-4514-B84F-2B9F94BE24FE-55866@192.168.1.12
Content-Length: 0

Title: Re: genesys recording
Post by: Kubig on June 15, 2017, 02:33:45 PM

From my point of view, the configuration does not seem properly - NETANN and MSML are different type of protocol, also the DNs configuration on TServer section level does not follow the documentation. In general, for MSML recording you should just create one VoIP Service DN of type service-type MSML and also configure LRGP, MCP and IVR profile. This should be enough to start.

Title: Re: genesys recording
Post by: mcruli on June 16, 2017, 03:46:58 PM

recomendation : use msml

Title: Re: genesys recording
Post by: jack41 on June 19, 2017, 08:28:36 AM

does msml recording need a third party apllication or any other component other the  SIP Server ,MCP ,Ressource Manager  ???

Title: Re: genesys recording
Post by: Kubig on June 19, 2017, 08:36:43 AM

No, it does not need any other component as mandatory app/component - see available documentation

Title: Re: genesys recording
Post by: jack41 on June 20, 2017, 08:03:51 AM

Hello  i configured an msml recording
i configured the mcp  sipserver and rm as said in the docs
this is the configuration of the dn
[TServer]
contact=sip:rm:rm_sip_port
make-call-rfc3725-flow=1
prefix=msml=
refer-enabled=false
ring-tone-on-make-call=false
service-type=msml
subscription-id=Environment

but it didn't workhere is the log of mcp after the call can anyone help me figure out a solution




2017-06-19 14:52:56.129 DBUG  2666572688 08500000 MPCSDPNegotiation.cxx:480 MPCSDPNegotiation::NegotiateSDP - nSDPOfferAns=[0], bRemotePref=[true]
2017-06-19 14:52:56.129 DBUG  2666572688 08500000 MPCSDPNegotiation.cxx:512 Generating brand new SDP offer
2017-06-19 14:52:56.129 DBUG 00000000-00000000 2666572688 08500000 VGRTPTypes.cxx:1322 RTPMediaDescListToVGSdp
2017-06-19 14:52:56.129 DBUG 00000000-00000000 2666572688 08500000 VGRTPTypes.cxx:1491 For format [2], nOptions is [0]
2017-06-19 14:52:56.129 DBUG 00000000-00000000 2666572688 08500000 VGRTPTypes.cxx:1491 For format [3], nOptions is [0]
2017-06-19 14:52:56.129 DBUG 00000000-00000000 2666572688 08500000 VGRTPTypes.cxx:1491 For format [10], nOptions is [0]
2017-06-19 14:52:56.129 DBUG 00000000-00000000 2666572688 08500000 VGSIPTransportMgr.cxx:3205 VGSIPTransportMgr::ResolveDNS for 192.168.1.15:5064
14:52:56.129 Trc 33009 INFO 00000000-00000000 2666572688 02800FA1 Response sent: SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.15:5064;branch=z9hG4bK25b6091847f274
From: sip:GVP@192.168.1.15:5064;tag=27290C00-DB6B-3A44-55E0-E4A66B2F0288
To: sip:mcp:mcp_sip_port
CSeq: 2283 OPTIONS
Call-ID: 27290C00-DB6B-E8F0-07B4-77838DAF5FD1-5064@192.168.1.15
Content-Length: 192
Content-Type: application/sdp

v=0
o=- 268437410 1 IN IP4 192.168.1.16
s=phone-call
c=IN IP4 192.168.1.16
t=0 0
m=audio 0 RTP/AVP 0 8 2
a=rtpmap:0 pcmu/8000
a=rtpmap:8 pcma/8000
a=rtpmap:2 g726-32/8000
a=sendrecv

14:52:56.347 Trc 33009 INFO 00000000-00000000 2666572688 02800FA1 Request received: OPTIONS sips:192.168.1.16:5071 SIP/2.0
Via: SIP/2.0/TLS 192.168.1.15:5065;branch=z9hG4bK25b6e17847f274
From: sips:GVP@192.168.1.15:5065;tag=27290C00-DB6B-395B-B581-E62DD5E8F350
To: sips:192.168.1.16:5071
Max-Forwards: 70
CSeq: 2284 OPTIONS
Call-ID: 27290C00-DB6B-7E89-D707-BE3B5277923C-5064@192.168.1.15
Contact: <sips:GVP@192.168.1.15:5065>
Content-Length: 0
Supported: timer, uui


2017-06-19 14:52:56.347 DBUG  2666572688 08500000 MPCSDPNegotiation.cxx:480 MPCSDPNegotiation::NegotiateSDP - nSDPOfferAns=[0], bRemotePref=[true]
2017-06-19 14:52:56.347 DBUG  2666572688 08500000 MPCSDPNegotiation.cxx:512 Generating brand new SDP offer
2017-06-19 14:52:56.347 DBUG 00000000-00000000 2666572688 08500000 VGRTPTypes.cxx:1322 RTPMediaDescListToVGSdp
2017-06-19 14:52:56.347 DBUG 00000000-00000000 2666572688 08500000 VGRTPTypes.cxx:1491 For format [2], nOptions is [0]
2017-06-19 14:52:56.347 DBUG 00000000-00000000 2666572688 08500000 VGRTPTypes.cxx:1491 For format [3], nOptions is [0]
2017-06-19 14:52:56.347 DBUG 00000000-00000000 2666572688 08500000 VGRTPTypes.cxx:1491 For format [10], nOptions is [0]
2017-06-19 14:52:56.347 DBUG 00000000-00000000 2666572688 08500000 VGSIPTransportMgr.cxx:3205 VGSIPTransportMgr::ResolveDNS for 192.168.1.15:5065
14:52:56.347 Trc 33009 INFO 00000000-00000000 2666572688 02800FA1 Response sent: SIP/2.0 200 OK
Via: SIP/2.0/TLS 192.168.1.15:5065;branch=z9hG4bK25b6e17847f274
From: sips:GVP@192.168.1.15:5065;tag=27290C00-DB6B-395B-B581-E62DD5E8F350
To: sips:192.168.1.16:5071
CSeq: 2284 OPTIONS
Call-ID: 27290C00-DB6B-7E89-D707-BE3B5277923C-5064@192.168.1.15
Content-Length: 192
Content-Type: application/sdp

v=0
o=- 268437411 1 IN IP4 192.168.1.16
s=phone-call
c=IN IP4 192.168.1.16
t=0 0
m=audio 0 RTP/AVP 0 8 2
a=rtpmap:0 pcmu/8000
a=rtpmap:8 pcma/8000
a=rtpmap:2 g726-32/8000
a=sendrecv

2017-06-19 14:52:56.560 DBUG 00770194-1000A685 2719021968 0B200000 MPCPlayer.cxx:2172 MPCPlayer::NotifyPlayDone: m_nStopReason=4 m_nState=7 m_nFlushDur=0 m_nLocalBargeinOffset=0; Last prompt info: Orig URI [/cti/mcp/audio/alaw/default_audio/sorry_there_has_been_an_error.vox]; Media URI [smm://0000006D]
14:52:56.560 Trc 21004 INFO 00770194-1000A685 2719021968 02B00FAD prompt_stop
2017-06-19 14:52:56.560 DBUG 00000000-00000000 3033717648 0B100000 MPCDialog.cxx:1352 MPCDialog::ProcessPlayDone, LogID=00770194-1000A685 DialogID=2000073D nPlaydoneReason=4 nBargeinLocalDur=0 nMarkDur=0
2017-06-19 14:52:56.560 DBUG 00000000-00000000 3033717648 0B100000 MPCDialog.cxx:1357 MPCDialog::ProcessPlayDone, LogID=00770194-1000A685 DialogID=2000073D nMarkIndex=-1 nTotalPlayedBytes=16616 nTotalPlayedDur=2077
2017-06-19 14:52:56.560 DBUG 00770194-1000A685 3033717648 02F00000 MPCWrapper.cxx:3253 DialogPlayDone DialogID 2000073D nPlayDoneReason 4nBargeinLocalDur 0 nMarkDur 0 nMarkIndex -1
2017-06-19 14:52:56.560 DBUG 00770194-1000A685 3033717648 02F00000 MPCWrapper.cxx:3257 DialogPlayDone DialogID 2000073D nTotalPlayedBytes 16616 nTotalPlayedDur 2077
2017-06-19 14:52:56.561 DBUG 00000000-00000000 153349584 01C00000 CMMsgBase.h:181 cmapi.msg:  CM_MSG_LMMEDIA_PLAYDONE - 00000000-1000A685; PlayDoneReason == 4; BargeinLocalDur == 0; MarkDur == 0; MarkIndex == -1; TotalPlayedBytes == 16616; TotalPlayedDur == 2077
2017-06-19 14:52:56.561 DBUG 00770194-1000A685 153349584 01C00000 CMDialog.C:90 CMDialog::CanDelete - m_nDialogID=2000073D, m_bDestroying=false, m_pMediaState=true
2017-06-19 14:52:56.561 DBUG 00770194-1000A685 99950032 0C000000 AppDialogEvent.h:66 app.VXML-NG AMEVENT_DIALOG_MEDIAPLAYDONE - CallLegID=1000A685 DialogID=2000073D,ReqID=22,BargeinDur=-1,TotalPlayedBytes=16616,TotalPlayedDur=2077TotalMediaPlayed=0,Result=1,ErrCode=0,MarkTag=,Encoding=
2017-06-19 14:52:56.561 DBUG 00770194-1000A685 99950032 0C000000 PromptSession.cxx:1070 PromptDone() for MediaPlayDoneEvent
2017-06-19 14:52:56.561 DBUG 00770194-1000A685 99950032 0C000000 VXMLFetchObject.cxx:37 ~VXMLFetchObject() Delete VXMLFetchObject 0x1f600500
2017-06-19 14:52:56.561 DBUG 00770194-1000A685 99950032 0C000000 PromptSession.cxx:151 StepThroughPromptList() Stepping Through PromptList
2017-06-19 14:52:56.561 DBUG 00770194-1000A685 99950032 0C000000 PromptSession.cxx:1149 PromptDone() PlayDone:Completed
2017-06-19 14:52:56.561 DBUG 00770194-1000A685 99950032 0C000000 PromptSession.cxx:1174 PromptDone() result 1, state 1, bargein 0
2017-06-19 14:52:56.561 DBUG 00770194-1000A685 99950032 0C000000 PromptSession.cxx:1230 PromptDone() state 1
14:52:56.561 Int 50019 00770194-1000A685 99950032 prompt_end done
2017-06-19 14:52:56.561 DBUG 00000000-00000000 99950032 0C000000 VXMLUtils.h:252 PlatformPromptDoneInfo() Create PlatformPromptDoneInfo 0x1f3c2298
2017-06-19 14:52:56.561 DBUG 00770194-1000A685 99950032 0C000000 VXMLCallLeg.cxx:5064 Entered delete noinput timeout timer.
2017-06-19 14:52:56.561 DBUG 00770194-1000A685 99950032 0C000000 VXMLCallLeg.cxx:2684 VXMLCallLeg::HandlePromptDone: nStatus = 0
2017-06-19 14:52:56.561 DBUG 00000000-00000000 99950032 0C000000 VXMLUtils.h:253 ~PlatformPromptDoneInfo() Delete PlatformPromptDoneInfo 0x1f3c2298
2017-06-19 14:52:56.561 DBUG 00000000-00000000 13622736 01F00000 main.C:299 00770194-1000A685-0000006D FMThreadQueue.cxx:1162 Processing ReleaseRequest
2017-06-19 14:52:56.561 DBUG 00000000-00000000 13622736 01F00000 main.C:299 00770194-1000A685-0000006D FMUserRequest.cxx:111 Deleting Request
2017-06-19 14:52:56.561 DBUG 00770194-1000A685 2380283344 0C000000 VXMLSession.cxx:1859 ProcessEvents() Started
2017-06-19 14:52:56.561 DBUG 00770194-1000A685 2380283344 0C000000 VXMLSession.cxx:1876 ProcessEvents() Event type [4], session id: [00770194-1000A685]
2017-06-19 14:52:56.561 DBUG 00770194-1000A685 2380283344 0C000000 VXMLSession.cxx:1906 ProcessEvents(): Play transition prompts done
2017-06-19 14:52:56.561 DBUG 00770194-1000A685 2380283344 0C000000 VxmlRuntimeRoot.cxx:213 Execute() Started, event type: 4
2017-06-19 14:52:56.561 DBUG 00770194-1000A685 2380283344 0C000000 VxmlRuntimeDoc.cxx:162 Execute() Started, event type: 4
2017-06-19 14:52:56.561 DBUG 00770194-1000A685 2380283344 0C000000 InputItemRuntime.cxx:127 Execute() Started
2017-06-19 14:52:56.561 DBUG 00770194-1000A685 2380283344 0C000000 InputItemRuntime.cxx:1662 HandleIncomingEventForCatch() Started
2017-06-19 14:52:56.561 DBUG 00770194-1000A685 2380283344 0C000000 CatchRuntime.cxx:131 Execute() Started, event type: 4
2017-06-19 14:52:56.561 DBUG 00770194-1000A685 2380283344 0C000000 CatchRuntime.cxx:153 Execute(): Resuming
2017-06-19 14:52:56.561 DBUG 00770194-1000A685 2380283344 0C000000 ExitRuntime.cxx:52 Execute() Started, event type: 4
2017-06-19 14:52:56.561 DBUG 00770194-1000A685 2380283344 0C000000 PropertyStore.cxx:1323 HandleSaveTempFileSettings() Get property; Name [__.savetmpfiles], value [none]
2017-06-19 14:52:56.562 DBUG 00770194-1000A685 2380283344 0C000000 PropertyStore.cxx:1329 HandleSaveTempFileSettings() Get property; Name [__.savetmpfilesmode], value [immediate]
14:52:56.562 Int 50081 00770194-1000A685 2380283344 event_handler_exit :error .
14:52:56.562 Int 50030 00770194-1000A685 2380283344 form_exit normal
2017-06-19 14:52:56.562 DBUG 00770194-1000A685 2380283344 0C000000 PropertyStore.cxx:1323 HandleSaveTempFileSettings() Get property; Name [__.savetmpfiles], value [none]
2017-06-19 14:52:56.562 DBUG 00770194-1000A685 2380283344 0C000000 PropertyStore.cxx:1329 HandleSaveTempFileSettings() Get property; Name [__.savetmpfilesmode], value [immediate]
2017-06-19 14:52:56.562 DBUG 00770194-1000A685 2380283344 0C000000 PropertyStore.cxx:1323 HandleSaveTempFileSettings() Get property; Name [__.savetmpfiles], value [none]
2017-06-19 14:52:56.562 DBUG 00770194-1000A685 2380283344 0C000000 PropertyStore.cxx:1329 HandleSaveTempFileSettings() Get property; Name [__.savetmpfilesmode], value [immediate]
2017-06-19 14:52:56.562 DBUG 00770194-1000A685 2380283344 0C000000 VXMLSession.cxx:3577 SendSessionDestroyed() Started, term_reason: 0
14:52:56.562 Int 50036 00770194-1000A685 2380283344 appl_end
2017-06-19 14:52:56.562 DBUG 00000000-00000000 99950032 0C000000 AppEventBase.h:60 app.VXML-NG AMEVENT_VXML_HANDLER_DONE -
2017-06-19 14:52:56.562 DBUG 00770194-1000A685 99950032 0C000000 VXMLInstance.cxx:1630 HandleHandlerDone called
2017-06-19 14:52:56.562 DBUG 00770194-1000A685 99950032 0C000000 VXMLInstance.cxx:1689 AMEVENT_VXML_HANDLER_DONE: strContentType=[application/x-www-form-urlencoded;charset=utf-8], strContent=[__reason=exit]
2017-06-19 14:52:56.562 DBUG 00770194-1000A685 99950032 0C000000 VXMLInstance.cxx:1701 AMEVENT_VXML_HANDLER_DONE
2017-06-19 14:52:56.562 DBUG 00770194-1000A685 99950032 0C000000 VXMLCallLeg.cxx:5064 Entered delete noinput timeout timer.
2017-06-19 14:52:56.562 DBUG 00770194-1000A685 99950032 0C000000 VXMLCallLeg.cxx:5064 Entered delete noinput timeout timer.
2017-06-19 14:52:56.562 DBUG 00770194-1000A685 99950032 0C000000 VXMLCallLeg.cxx:4645 Calling UserDisconnected on interpreter
2017-06-19 14:52:56.562 DBUG 00770194-1000A685 99950032 0C000000 VXMLInstance.cxx:1416 FinalCleanup() App 0x1a6e0b80
2017-06-19 14:52:56.562 DBUG 00770194-1000A685 99950032 0C000000 VXMLInstance.cxx:1420 FinalCleanup() must wait for all CallLegs to unbind first
2017-06-19 14:52:56.563 DBUG 00000000-00000000 153349584 01C00000 CMMsgBase.h:181 cmapi.msg:  CM_MSG_DIALOG_APP_TERMINATE -
2017-06-19 14:52:56.563 DBUG 00770194-1000A685 153349584 01C00000 CMDialog.C:256 Received TerminateDialog request
2017-06-19 14:52:56.563 DBUG 00000000-00000000 2677062544 02F00000 MPCWrapper.cxx:700 MPCWrapper::DialogDestroy - nSessID=268437308, nDialogID=536872765
2017-06-19 14:52:56.563 DBUG 00000000-00000000 2677062544 0B100000 MPCDialog.cxx:740 MPCDialog::Destroy, LogID=00770194-1000A685 DialogID=2000073D
2017-06-19 14:52:56.563 DBUG 00000000-00000000 2677062544 0B100000 MPCDialog.cxx:920 MPCDialog::DisconnectRoute, LogID=00770194-1000A685 DialogID=2000073D ControlSinkID=1000073C
2017-06-19 14:52:56.563 DBUG 00000000-00000000 2677062544 0B100000 MPCConnection.cxx:1769 MPCConnection::GetSinks nLogID=00770194-1000A685 nConnID=1000073C ControlSourceID=2000073D
2017-06-19 14:52:56.563 DBUG 00000000-00000000 2677062544 0B100000 MPCConnection.cxx:1783 MPCConnection::GetSink - Sinks.size()=[1]
2017-06-19 14:52:56.563 DBUG 00000000-00000000 2677062544 0B100000 MPCConnection.cxx:1795 MPCConnection::GetFCRSink nLogID=00770194-1000A685 nConnID=1000073C
2017-06-19 14:52:56.563 DBUG 00000000-00000000 2677062544 0B100000 MPCControlObject.cxx:410 MPCControlObject::UnregisterSinkHelper LogID=00770194-1000A685 ObjectID=2000073D OperatorID=00010012 SinkID=0001000F pRoute=1F4A06C8
2017-06-19 14:52:56.563 DBUG 00000000-00000000 2677062544 0B100000 MPCConnection.cxx:1748 MPCConnection::UnregisterReverseRoute nLogID=00770194-1000A685 nConnID=1000073C ControlSourceID=2000073D
2017-06-19 14:52:56.563 DBUG 00000000-00000000 2677062544 0B100000 MPCConnection.cxx:1531 MPCConnection::DisconnectRoute nLogID=00770194-1000A685 nConnID=1000073C ControlSinkID=2000073D
2017-06-19 14:52:56.563 DBUG 00000000-00000000 2677062544 0B100000 MPCDialog.cxx:1110 MPCDialog::GetSinks, LogID=00770194-1000A685 DialogID=2000073D ControlSourceID=1000073C
2017-06-19 14:52:56.563 DBUG 00000000-00000000 2677062544 0B100000 MPCControlObject.cxx:410 MPCControlObject::UnregisterSinkHelper LogID=00770194-1000A685 ObjectID=1000073C OperatorID=00010010 SinkID=00010013 pRoute=1F4A0408
2017-06-19 14:52:56.563 DBUG 00000000-00000000 2677062544 0B100000 MPCDialog.cxx:1068 MPCDialog::UnregisterReverseRoute, LogID=00770194-1000A685 DialogID=2000073D ControlSourceID=1000073C
2017-06-19 14:52:56.563 DBUG 00770194-1000A685 2677062544 0B200000 MPCPlayer.cxx:515 MPCPlayer::Stop: m_State=0 nStopReason=10
2017-06-19 14:52:56.563 DBUG 00000000-00000000 2677062544 0B100000 MPCControlObject.cxx:362 MPCControlObject::UnregisterSinkHelper LogID=00770194-1000A685 ObjectID=2000073D SourceID=00010011 SinkID=00010012 pRoute=00000000
2017-06-19 14:52:56.563 DBUG 00770194-1000A685 2677062544 0B200000 MPCPlayer.cxx:515 MPCPlayer::Stop: m_State=0 nStopReason=10
2017-06-19 14:52:56.563 DBUG 00000000-00000000 2677062544 0B100000 MPCDialog.cxx:1233 MPCDialog::QueueDestroyedEvent, LogID=00770194-1000A685 DialogID=2000073D
2017-06-19 14:52:56.563 DBUG 00000000-00000000 3033717648 02F00000 MPCWrapper.cxx:3592 Inside Route Destroyed From: 2000073D To: 1000073C  Route: 00000003, obtained route mutex
2017-06-19 14:52:56.563 DBUG 00000000-00000000 3033717648 02F00000 MPCWrapper.cxx:2837 Processing Call Term.  From: 536872765, To: 268437308
2017-06-19 14:52:56.563 DBUG 00000000-00000000 3033717648 02F00000 MPCWrapper.cxx:3592 Inside Route Destroyed From: 1000073C To: 2000073D  Route: 00000004, obtained route mutex
2017-06-19 14:52:56.563 DBUG 00000000-00000000 3033717648 02F00000 MPCWrapper.cxx:2837 Processing Call Term.  From: 268437308, To: 536872765
2017-06-19 14:52:56.563 DBUG 00770194-1000A685 3033717648 02F00000 MPCWrapper.cxx:3064 DialogDestroyed for Dialog ID: 536872765
2017-06-19 14:52:56.563 DBUG 00000000-00000000 153349584 01C00000 CMMsgBase.h:181 cmapi.msg:  CM_MSG_LMDIALOG_DESTROYED - 00000000-1000A685; DialogID == 536872765; DiscReason == 0
2017-06-19 14:52:56.563 DBUG 00770194-1000A685 153349584 01C00000 CMDialog.C:90 CMDialog::CanDelete - m_nDialogID=2000073D, m_bDestroying=true, m_pMediaState=true
2017-06-19 14:52:56.563 DBUG 00770194-1000A685 153349584 01C00000 CMCallLeg.C:440 CMCallLeg::DeleteDialog - nDialogID=2000073D
2017-06-19 14:52:56.563 DBUG 00770194-1000A685 99950032 0C000000 AppDialogEvent.h:66 app.VXML-NG AMEVENT_DIALOG_TERMINATED - CallLegID=1000A685 DialogID=2000073D,
2017-06-19 14:52:56.563 DBUG 00770194-1000A685 99950032 0C000000 VXMLCallLeg.cxx:1651 Dialog terminated
2017-06-19 14:52:56.563 DBUG 00770194-1000A685 99950032 0C000000 AppCallLeg.h:102 Call Leg Unbind
2017-06-19 14:52:56.563 DBUG 00000000-00000000 99950032 0C000000 AppCallLegEvent.h:63 app.VXML-NG AMEVENT_CALLLEG_DIALOGDESTROYED - CallLegID=00770194-1000A685,
2017-06-19 14:52:56.563 DBUG 00000000-00000000 153349584 01C00000 CMMsgBase.h:181 cmapi.msg:  CM_MSG_CALLLEG_UNBIND - CallObjID == 00770194-1000A685; Binding State == 1
2017-06-19 14:52:56.563 DBUG 00000000-00000000 99950032 0C000000 AppCallLegEvent.h:63 app.VXML-NG AMEVENT_CALLLEG_UNBINDNOTIFY - CallLegID=00770194-1000A685,
2017-06-19 14:52:56.563 DBUG 00770194-1000A685 99950032 0C000000 VXMLCallLeg.cxx:5064 Entered delete noinput timeout timer.
2017-06-19 14:52:56.563 DBUG 00770194-1000A685 99950032 0C000000 AppCallLeg.h:69 Uninitialize
2017-06-19 14:52:56.563 DBUG 00770194-1000A685 99950032 0C000000 AppCallLeg.h:74 Uninitialize m_pCallLegIntf->ReleaseReference();
2017-06-19 14:52:56.563 DBUG 00770194-1000A685 99950032 0C000000 VXMLCallLeg.cxx:4656 Calling DeleteDTMFAppSession 27
2017-06-19 14:52:56.563 DBUG 00770194-1000A685 99950032 08500000 VGDTMFRecognitionThread.C:302 DeleteAppSession(): Session ID: 27
2017-06-19 14:52:56.563 DBUG 00770194-1000A685 2378276304 08500000 VGDTMFRecognitionThread.C:902 HandleDeleteSession(): Session ID: 27
2017-06-19 14:52:56.564 DBUG 00000000-00000000 99950032 0C000000 AppEventBase.h:60 app.VXML-NG AMEVENT_VXML_DTMF_SESSION_DONE -
2017-06-19 14:52:56.564 DBUG 00770194-1000A685 99950032 0C000000 VXMLCallLeg.cxx:278 Delete Call Leg 00770194-1000A685
2017-06-19 14:52:56.564 DBUG 00770194-1000A685 99950032 0C000000 VXMLCallLeg.cxx:5064 Entered delete noinput timeout timer.
2017-06-19 14:52:56.564 DBUG 00770194-1000A685 99950032 0C000000 VXMLCallLeg.cxx:5064 Entered delete noinput timeout timer.
2017-06-19 14:52:56.564 DBUG 00770194-1000A685 99950032 0C000000 AppCallLeg.h:44 ~AppCallLeg m_pCallLegHandler->ReleaseReference();
2017-06-19 14:52:56.564 DBUG 00770194-1000A685 99950032 0C000000 VXMLInstance.cxx:1416 FinalCleanup() App 0x1a6e0b80
2017-06-19 14:52:56.564 DBUG 00770194-8800A685 99950032 0C000000 AppCall.h:134 Call Unbind
2017-06-19 14:52:56.564 DBUG 00770194-1000A685 99950032 0C000000 VXMLInstance.cxx:1427 FinalCleanup() all CallLegs have been unbound, now unbind Call
2017-06-19 14:52:56.564 DBUG 00000000-00000000 153349584 01C00000 CMMsgBase.h:181 cmapi.msg:  CM_MSG_CALL_UNBIND - CallObjID == 00770194-8800A685; Binding State == 1
2017-06-19 14:52:56.564 DBUG 00770194-8800A685 153349584 01C00000 CMCall.C:630 Removing translator 56
2017-06-19 14:52:56.564 DBUG 00770194-8800A685 99950032 0C000000 AppCallEvent.h:58 app.VXML-NG AMEVENT_CALL_UNBINDNOTIFY -
2017-06-19 14:52:56.564 DBUG 00000000-00000000 99950032 0C000000 VXMLCall.cxx:92 ProcessCallEvent() Call 00770194-8800A685 Event 0
2017-06-19 14:52:56.564 DBUG 00770194-8800A685 99950032 0C000000 AppCall.h:83 Uninitialize m_pCallIntf->ReleaseReference();
14:52:56.564 Trc 20001 INFO 00000000-00000000 99950032 0C000000 ~VXMLCall() 0x1f760110 Delete VXMLCall 00770194-8800A685
2017-06-19 14:52:56.564 DBUG 00770194-8800A685 99950032 0C000000 AppCall.h:45 ~AppCall m_pCallHandler->ReleaseReference();
2017-06-19 14:52:56.564 DBUG 00770194-1000A685 99950032 0C000000 VXMLInstance.cxx:1416 FinalCleanup() App 0x1a6e0b80
2017-06-19 14:52:56.564 DBUG 00000000-00000000 153349584 01C00000 CMMsgBase.h:181 cmapi.msg:  CM_MSG_APP_MGMT_APP_UNREGISTER - AppID == 56
2017-06-19 14:52:56.564 DBUG 00000000-00000000 153349584 01C00000 CMAppInstMgr.C:426 CMAppInstMgr::AppUnregister For App ID 56 found
2017-06-19 14:52:56.564 DBUG 00000000-00000000 153349584 01C00000 CMAppInstMgr.C:64 CMAppInstEntry::Uninitialize for App ID 56 with count 2
2017-06-19 14:52:56.564 DBUG 00000000-00000000 99950032 0C000000 AppEventBase.h:60 app.VXML-NG AMEVENT_APPINST_UNREGNOTIFY - Cause=2
2017-06-19 14:52:56.564 DBUG 00770194-1000A685 99950032 0C000000 VXMLInstance.cxx:147 Delete VXMLInstance 0x1f752898
2017-06-19 14:52:56.564 DBUG 00770194-1000A685 99950032 0C000000 VXMLInstance.cxx:154 Delete VXMLInstance parent 0x1f752898
2017-06-19 14:52:56.564 DBUG 00000000-00000000 99950032 02200000 AppInstBase.C:41 App Instance Destroy
2017-06-19 14:52:56.564 DBUG 00000000-00000000 2373880720 01B00000 AppEventBase.h:60 app.MSML AMEVENT_APPINST_EXITNOTIFY - ExitAppID=56,Reason=1
2017-06-19 14:52:56.564 DBUG 00770194-8800A685 2373880720 01B00000 MSMLAppInstance.cxx:375 Received MSML AppInstance event AMEVENT_APPINST_EXITNOTIFY
2017-06-19 14:52:56.564 DBUG 00770194-1000A685 2373880720 01B00000 MSMLAppInstance.cxx:417 Child VXML application terminated (exit notify event).
2017-06-19 14:52:56.564 DBUG 00770194-1000A685 2373880720 01B00000 MSMLSession.cxx:264 MSMLSession::DialogDestroyed attempt to remove dialog conn:4E290C00-1410-13AB-CA24-F48D0D7A5AB2/dialog:ivr_application
2017-06-19 14:52:56.565 DBUG 00770194-1000A685 2373880720 01B00000 AppCallLeg.h:174 Call Leg Application Event
2017-06-19 14:52:56.565 DBUG 00000000-00000000 153349584 01C00000 CMMsgBase.h:181 cmapi.msg:  CM_MSG_CALLLEG_APP_EVENT - StrEventInfo == <?xml version="1.0" encoding="UTF-8"?>
<msml version="1.1">
<event name="msml.dialo
2017-06-19 14:52:56.571 DBUG 00770194-1000A685 2677062544 02800000 LMCallSIP.C:2439 Sending INFO: <?xml version="1.0" encoding="UTF-8"?>
<msml version="1.1">
<event name="msml.dialog.exit" id="conn:4E290C00-1410-13AB-CA24-F48D0D7A5AB2/dialog:ivr_application">
<name>__reason</name>
<value>exit</value>
</event>
</msml>
2017-06-19 14:52:56.571 DBUG 00770194-1000A685 2677062544 02800000 LMCallSIP.C:2441 ApplicationEvent - m_nState=9
2017-06-19 14:52:56.571 DBUG 00770194-1000A685 2677062544 02800000 LMCallSIPStack.C:165 LMCallSIP::SendRequest for X-Genesys-GVP-Session-ID
2017-06-19 14:52:56.571 DBUG 00770194-1000A685 2677062544 02800000 LMCallSIPStack.C:188 LMCallSIP::SendRequest - X-Genesys-GVP-Session-ID: 27290C00-DB6B-3877-E581-46E8FF017923;gvp.rm.datanodes=1;gvp.rm.tenant-id=101_IVRAppDefault
2017-06-19 14:52:56.571 DBUG 00000000-00000000 2677062544 08500000 VGSIPTransportMgr.cxx:3205 VGSIPTransportMgr::ResolveDNS for rm:rm_sip_port
2017-06-19 14:52:56.571 DBUG 00000000-00000000 153349584 01C00000 CMMsgBase.h:181 cmapi.msg:  CM_MSG_LMNOTIFY_APPLICATIONEVENT - 00000000-1000A685; RequestID=0, Status = 0 - Send data successful.
2017-06-19 14:52:56.571 DBUG 00770194-1000A685 153349584 01C00000 CMCallLeg.C:1729 Call leg has received SIP INFO notification: RequestID=0, Status=0 - Send data successful.
2017-06-19 14:52:56.571 DBUG 00770194-1000A685 2373880720 01B00000 MSMLDialog.cxx:318 MSMLDialog::~MSMLDialog
2017-06-19 14:52:56.571 DBUG 00770194-1000A685 2373880720 01B00000 MSMLSession.cxx:1039 MSMLSession::CanDelete() - m_bDestroyed=false, m_nReqState=0, m_VXMLDialogMap.size()=0, m_MSMLDialogSet.size()=0, m_setConfsClearHandler.size()=0
2017-06-19 14:52:56.572 DBUG 00000000-00000000 2380283344 08500500 VGDocumentManager.cxx:364 Deleting document, uri: http://192.168.1.13:8080/IVRCheckSolde/src-gen/Main.vxml?session.connection.callidref=FA74470D-7192-4610-A730-FF73078A8189-616%40192.168.1.12&session.connection.local.uri=sip%3AMSML_DN%40192.168.1.12%3A5060&session.connection.originator=remote&session.connection.remote.uri=sip%3A29166730%40192.168.1.12%3A5060&session.connection.uuid=HLAE79SQO50PF745HIOSU562CS00000K
2017-06-19 14:52:56.572 DBUG 00000000-00000000 13622736 01F00000 main.C:299 00770194-1000A685-00000044 FMThreadQueue.cxx:1162 Processing ReleaseRequest
2017-06-19 14:52:56.572 DBUG 00000000-00000000 13622736 01F00000 main.C:299 00770194-1000A685-00000044 FMUserRequest.cxx:111 Deleting Request
2017-06-19 14:52:56.572 DBUG 00000000-00000000 2380283344 08500500 VGDocumentManager.cxx:364 Deleting document, uri: file:///cti/mcp/config/defaults-ng.vxml
2017-06-19 14:52:56.572 DBUG 00000000-00000000 13622736 01F00000 main.C:299 00770194-1000A685-00000045 FMThreadQueue.cxx:1162 Processing ReleaseRequest
2017-06-19 14:52:56.572 DBUG 00000000-00000000 13622736 01F00000 main.C:299 00770194-1000A685-00000045 FMUserRequest.cxx:111 Deleting Request
2017-06-19 14:52:56.572 DBUG 00000000-00000000 13622736 01F00000 main.C:299 FMThreadQueue.cxx:1181 Removing session 00770194-1000A685 from session map
2017-06-19 14:52:56.572 DBUG 00770194-1000A685 2380283344 08500500 VGSessionManager.cxx:275 Removing session 00770194-1000A685 at 0
14:52:56.602 Trc 33009 INFO 00000000-00000000 2666572688 02800FA1 Request sent: INFO sip:29166730@sipserver:sip_port SIP/2.0
Via: SIP/2.0/TCP mcp:mcp_sip_port;branch=z9hG4bK1f77cf5047f358
From: <sip:MSML_DN@sipserver:sip_port>;tag=4E290C00-1410-13AB-CA24-F48D0D7A5AB2
To: sip:29166730@sipserver:sip_port;tag=7186F589-8651-4AFC-8804-63A923A80688-643
Max-Forwards: 70
CSeq: 1 INFO
Call-ID: FA74470D-7192-4610-A730-FF73078A8189-616@192.168.1.12
Content-Length: 220
Content-Type: application/vnd.radisys.msml+xml
Route: <sip:20ec6bb0@rm:rm_sip_port;transport=TCP;lr;gvp.rm.datanodes=1;idtag=0000001D>
X-Genesys-GVP-Session-ID: 27290C00-DB6B-3877-E581-46E8FF017923;gvp.rm.datanodes=1;gvp.rm.tenant-id=101_IVRAppDefault
User-Agent: SJphone/1.65.377a (SJ Labs)
Min-SE: 90
X-Genesys-GVP-Session-Data: callsession=27290C00-DB6B-3877-E581-46E8FF017923;1;0;;;;Resources;IVRAppDefault
Supported: timer, uui

<?xml version="1.0" encoding="UTF-8"?>
<msml version="1.1">
<event name="msml.dialog.exit" id="conn:4E290C00-1410-13AB-CA24-F48D0D7A5AB2/dialog:ivr_application">
<name>__reason</name>
<value>exit</value>
</event>
</msml>
14:52:56.616 Trc 33009 INFO 00000000-00000000 2666572688 02800FA1 Response received: SIP/2.0 200 OK
Via: SIP/2.0/TCP mcp:mcp_sip_port;branch=z9hG4bK1f77cf5047f358
From: <sip:MSML_DN@sipserver:sip_port>;tag=4E290C00-1410-13AB-CA24-F48D0D7A5AB2
To: sip:29166730@sipserver:sip_port;tag=7186F589-8651-4AFC-8804-63A923A80688-643
CSeq: 1 INFO
Call-ID: FA74470D-7192-4610-A730-FF73078A8189-616@192.168.1.12
Contact: <sip:29166730@sipserver:sip_port>
Content-Length: 0
X-Genesys-CallUUID: HLAE79SQO50PF745HIOSU562CS00000K
Allow: INVITE, ACK, PRACK, CANCEL, BYE, REFER, INFO, UPDATE, MESSAGE, NOTIFY, OPTIONS
Supported: uui


2017-06-19 14:52:56.676 DBUG 00000000-00000000 3033717648 0B100000 MPCDialog.cxx:99 MPCDialog::~MPCDialog LogID=00770194-1000A685 DialogID=2000073D
14:52:56.703 Trc 33009 INFO 00000000-00000000 2666572688 02800FA1 Request received: BYE sip:Genesys@mcp:mcp_sip_port SIP/2.0
Via: SIP/2.0/UDP rm:rm_sip_port;branch=z9hG4bK25a6f9f047f275abcdef09
Via: SIP/2.0/UDP sipserver:sip_port;branch=z9hG4bKEBF40064-4534-47A8-B1D7-12A9A1725A8C-178
From: sip:29166730@sipserver:sip_port;tag=7186F589-8651-4AFC-8804-63A923A80688-643
To: <sip:MSML_DN@sipserver:sip_port>;tag=4E290C00-1410-13AB-CA24-F48D0D7A5AB2
Max-Forwards: 68
CSeq: 3 BYE
Call-ID: FA74470D-7192-4610-A730-FF73078A8189-616@192.168.1.12
Content-Length: 0


2017-06-19 14:52:56.703 DBUG 00770194-1000A685 2677062544 02800000 LMCallSIPStack.C:201 LMCallSIP::SendResponse for ID Headers
2017-06-19 14:52:56.703 DBUG 00770194-1000A685 2677062544 02800000 LMCallSIPStack.C:223 LMCallSIP::SendResponse - X-Genesys-GVP-Session-ID: 27290C00-DB6B-3877-E581-46E8FF017923;gvp.rm.datanodes=1;gvp.rm.tenant-id=101_IVRAppDefault
2017-06-19 14:52:56.703 DBUG 00000000-00000000 2677062544 08500000 VGSIPTransportMgr.cxx:3205 VGSIPTransportMgr::ResolveDNS for rm:rm_sip_port
14:52:56.703 Trc 33009 INFO 00000000-00000000 2677062544 02800FA1 Response sent: SIP/2.0 200 OK
Via: SIP/2.0/UDP rm:rm_sip_port;branch=z9hG4bK25a6f9f047f275abcdef09
Via: SIP/2.0/UDP sipserver:sip_port;branch=z9hG4bKEBF40064-4534-47A8-B1D7-12A9A1725A8C-178
From: sip:29166730@sipserver:sip_port;tag=7186F589-8651-4AFC-8804-63A923A80688-643
To: <sip:MSML_DN@sipserver:sip_port>;tag=4E290C00-1410-13AB-CA24-F48D0D7A5AB2
CSeq: 3 BYE
Call-ID: FA74470D-7192-4610-A730-FF73078A8189-616@192.168.1.12
Content-Length: 0
User-Agent: SJphone/1.65.377a (SJ Labs)
Min-SE: 90
X-Genesys-GVP-Session-Data: callsession=27290C00-DB6B-3877-E581-46E8FF017923;1;0;;;;Resources;IVRAppDefault
X-Genesys-GVP-Session-ID: 27290C00-DB6B-3877-E581-46E8FF017923;gvp.rm.datanodes=1;gvp.rm.tenant-id=101_IVRAppDefault


2017-06-19 14:52:56.703 DBUG 00770194-1000A685 2677062544 02800000 LMCallSIPHandler.C:2156 Received BYE on main call leg; ending call
2017-06-19 14:52:56.703 DBUG 00770194-1000A685 2677062544 02F00000 MPCWrapper.cxx:899 Processing Media Destroy on Session 1000073C
2017-06-19 14:52:56.703 DBUG 00000000-00000000 2677062544 0B100000 MPCConnection.cxx:1192 MPCConnection::Destroy nLogID=00770194-1000A685 nConnID=1000073C
2017-06-19 14:52:56.703 DBUG 00000000-00000000 2677062544 0B100000 MPCControlObject.cxx:362 MPCControlObject::UnregisterSinkHelper LogID=00770194-1000A685 ObjectID=1000073C SourceID=0001000F SinkID=00010010 pRoute=00000000
2017-06-19 14:52:56.703 DBUG 00770194-1000A685 2677062544 02800000 LMCallSIPHandler.C:2213 LMCallSIP::HandleSipBye - m_nIntfState=7
14:52:56.706 Trc 49005 INFO 00000000-00000000 2352897488 0B300FA1 RTP 20056: Rx 2206/379432 lost 0 dropped 0 dec_err 0 jitter 85, Tx 104/17888 enc_err 0
2017-06-19 14:52:56.706 DBUG 00000000-00000000 3033717648 0B100000 MPCConnection.cxx:2090 MPCConnection::ProcessRTPSocketClosed nLogID=00770194-1000A685 nConnID=1000073C
2017-06-19 14:52:56.706 DBUG 00000000-00000000 3033717648 0B100000 MPCConnection.cxx:1928 MPCConnection::QueueDestroyedEvent nLogID=00770194-1000A685 nConnID=1000073C
2017-06-19 14:52:56.706 DBUG 00770194-1000A685 3033717648 02F00000 MPCWrapper.cxx:3732 ConnDestroyed for Connection ID: 268437308
2017-06-19 14:52:56.706 DBUG 00000000-00000000 153349584 01C00000 CMMsgBase.h:181 cmapi.msg:  CM_MSG_LMCC_DISCONNECT - 00000000-1000A685; Reason=11; Initiator=2; ProtocolCause=SIP BYE recv'd
2017-06-19 14:52:56.706 DBUG 00770194-1000A685 153349584 01C00000 CMCallBilling.C:764 REASON IS 11
2017-06-19 14:52:56.706 DBUG 00770194-1000A685 153349584 02100000 BillingMetricsLogger.C:306 Logging Billing IE
14:52:56.706 Int 50001 00770194-1000A685 153349584 incall_end usrend
2017-06-19 14:52:56.706 DBUG 00000000-00000000 2373880720 01B00000 AppCallLegEvent.h:63 app.MSML AMEVENT_CALLLEG_CALLDISCONNECTED - CallLegID=00770194-1000A685,CallDur=51,DiscReason=11,DiscInit=2
2017-06-19 14:52:56.706 DBUG 00770194-1000A685 2373880720 01B00000 MSMLAppInstance.cxx:480 Received MSML CallLeg event AMEVENT_CALLLEG_CALLDISCONNECTED
2017-06-19 14:52:56.706 DBUG 00770194-1000A685 2373880720 01B00000 MSMLAppInstance.cxx:533 MSML Call Disconnected, unbind MSMLCallLeg
2017-06-19 14:52:56.706 DBUG 00770194-1000A685 2373880720 01B00000 MSMLSession.cxx:308 MSMLSession::DestroySession
2017-06-19 14:52:56.706 DBUG 00770194-1000A685 2373880720 01B00000 MSMLSession.cxx:312 MSMLSession::DestroySession, still have 0 dialogs
2017-06-19 14:52:56.706 DBUG 00770194-1000A685 2373880720 01B00000 MSMLSession.cxx:1039 MSMLSession::CanDelete() - m_bDestroyed=true, m_nReqState=0, m_VXMLDialogMap.size()=0, m_MSMLDialogSet.size()=0, m_setConfsClearHandler.size()=0
2017-06-19 14:52:56.706 DBUG 00770194-1000A685 2373880720 01B00000 AppCallLeg.h:102 Call Leg Unbind
2017-06-19 14:52:56.706 DBUG 00000000-00000000 153349584 01C00000 CMMsgBase.h:181 cmapi.msg:  CM_MSG_CALLLEG_UNBIND - CallObjID == 00770194-1000A685; Binding State == 1
2017-06-19 14:52:56.706 DBUG 00000000-00000000 153349584 01C00000 CMCallObjMgr.C:459 00000000-1000A685 CMCallObjMgr::ReleaseCallLeg
2017-06-19 14:52:56.706 DBUG 00000000-00000000 153349584 01C00000 CMCallManager.h:234 Releasing license A260888
2017-06-19 14:52:56.707 DBUG 00000000-00000000 153349584 02400000 GVPLicenseLogger.C:112 Release GVP License:Product=vggateway; Features=in; Current Use=2; Peak Use=4
2017-06-19 14:52:56.707 DBUG 00000000-00000000 153349584 01C00000 CMCallManager.h:240 license usage: Product=vggateway; Features=in; Current Use=2; Peak Use=4

14:52:56.707 Trc 20001 INFO 00770194-1000A685 153349584 01C00000 CMCallLeg deleted 0x1faeb938
2017-06-19 14:52:56.707 DBUG 00770194-1000A685 2373880720 01B00000 MSMLSession.cxx:136 MSMLSession::~MSMLSession
14:52:56.707 Trc 20001 INFO 00000000-00000000 2373880720 01B00000 STATUS: Current 2 Total 29
2017-06-19 14:52:56.707 DBUG 00000000-00000000 2373880720 01B00000 AppCallLegEvent.h:63 app.MSML AMEVENT_CALLLEG_UNBINDNOTIFY - CallLegID=00770194-1000A685,
2017-06-19 14:52:56.707 DBUG 00770194-1000A685 2373880720 01B00000 MSMLAppInstance.cxx:480 Received MSML CallLeg event AMEVENT_CALLLEG_UNBINDNOTIFY
2017-06-19 14:52:56.707 DBUG 00770194-1000A685 2373880720 01B00000 MSMLAppInstance.cxx:496 MSMLCallLeg received UnbindNotify, unbind MSMLCall
2017-06-19 14:52:56.707 DBUG 00770194-8800A685 2373880720 01B00000 AppCall.h:134 Call Unbind
2017-06-19 14:52:56.707 DBUG 00000000-00000000 153349584 01C00000 CMMsgBase.h:181 cmapi.msg:  CM_MSG_CALL_UNBIND - CallObjID == 00770194-8800A685; Binding State == 1
2017-06-19 14:52:56.707 DBUG 00770194-8800A685 153349584 01C00000 CMCall.C:630 Removing translator 55
2017-06-19 14:52:56.707 DBUG 00000000-00000000 153349584 01C00000 CMCallObjMgr.C:483 00000000-8800A685 CMCallObjMgr::ReleaseCall
14:52:56.707 Trc 20001 INFO 00770194-8800A685 153349584 01C00000 CMCall deleted 0x1f630200
2017-06-19 14:52:56.707 DBUG 00770194-8800A685 2373880720 01B00000 AppCallEvent.h:58 app.MSML AMEVENT_CALL_UNBINDNOTIFY -
2017-06-19 14:52:56.707 DBUG 00770194-8800A685 2373880720 01B00000 MSMLAppInstance.cxx:457 Received MSML Call event AMEVENT_CALL_UNBINDNOTIFY
2017-06-19 14:52:56.707 DBUG 00000000-00000000 153349584 01C00000 CMMsgBase.h:181 cmapi.msg:  CM_MSG_APP_MGMT_APP_UNREGISTER - AppID == 55
2017-06-19 14:52:56.707 DBUG 00000000-00000000 153349584 01C00000 CMAppInstMgr.C:426 CMAppInstMgr::AppUnregister For App ID 55 found
2017-06-19 14:52:56.707 DBUG 00000000-00000000 153349584 01C00000 CMAppInstMgr.C:64 CMAppInstEntry::Uninitialize for App ID 55 with count 2
2017-06-19 14:52:56.708 DBUG 00000000-00000000 2373880720 01B00000 AppEventBase.h:60 app.MSML AMEVENT_APPINST_UNREGNOTIFY - Cause=2
2017-06-19 14:52:56.708 DBUG 00770194-8800A685 2373880720 01B00000 MSMLAppInstance.cxx:375 Received MSML AppInstance event AMEVENT_APPINST_UNREGNOTIFY
2017-06-19 14:52:56.708 DBUG 00770194-8800A685 2373880720 01B00000 MSMLAppInstance.cxx:289 delete MSMLAppInstance
2017-06-19 14:52:56.708 DBUG 00770194-8800A685 2373880720 01B00000 AppCall.h:83 Uninitialize m_pCallIntf->ReleaseReference();
2017-06-19 14:52:56.708 DBUG 00770194-8800A685 2373880720 01B00000 MSMLCall.cxx:33 delete MSMLCall
2017-06-19 14:52:56.708 DBUG 00770194-8800A685 2373880720 01B00000 AppCall.h:45 ~AppCall m_pCallHandler->ReleaseReference();
2017-06-19 14:52:56.708 DBUG 00770194-1000A685 2373880720 01B00000 AppCallLeg.h:69 Uninitialize
2017-06-19 14:52:56.708 DBUG 00770194-1000A685 2373880720 01B00000 AppCallLeg.h:74 Uninitialize m_pCallLegIntf->ReleaseReference();
2017-06-19 14:52:56.708 DBUG 00770194-1000A685 2373880720 01B00000 MSMLCallLeg.cxx:34 delete MSMLCallLeg
2017-06-19 14:52:56.708 DBUG 00770194-1000A685 2373880720 01B00000 AppCallLeg.h:44 ~AppCallLeg m_pCallLegHandler->ReleaseReference();
2017-06-19 14:52:56.708 DBUG 00000000-00000000 2373880720 02200000 AppInstBase.C:41 App Instance Destroy
2017-06-19 14:52:56.794 DBUG 00000000-00000000 3033717648 0B100000 MPCConnection.cxx:106 MPCConnection::~MPCConnection nLogID=00770194-1000A685 nConnID=1000073C
14:52:57.139 Trc 33009 INFO 00000000-00000000 2666572688 02800FA1 Request received: OPTIONS sip:mcp:mcp_sip_port SIP/2.0
Via: SIP/2.0/UDP 192.168.1.15:5064;branch=z9hG4bK25c5125847f275
From: sip:GVP@192.168.1.15:5064;tag=27290C00-DB6B-7878-693D-82535C8D5EA6
To: sip:mcp:mcp_sip_port
Max-Forwards: 70
CSeq: 2287 OPTIONS
Call-ID: 27290C00-DB6B-71A6-3A95-2601CCD22FE2-5064@192.168.1.15
Contact: <sip:GVP@192.168.1.15:5064>
Content-Length: 0
Supported: timer, uui


2017-06-19 14:52:57.139 DBUG  2666572688 08500000 MPCSDPNegotiation.cxx:480 MPCSDPNegotiation::NegotiateSDP - nSDPOfferAns=[0], bRemotePref=[true]
2017-06-19 14:52:57.139 DBUG  2666572688 08500000 MPCSDPNegotiation.cxx:512 Generating brand new SDP offer
2017-06-19 14:52:57.139 DBUG 00000000-00000000 2666572688 08500000 VGRTPTypes.cxx:1322 RTPMediaDescListToVGSdp
2017-06-19 14:52:57.139 DBUG 00000000-00000000 2666572688 08500000 VGRTPTypes.cxx:1491 For format [2], nOptions is [0]
2017-06-19 14:52:57.139 DBUG 00000000-00000000 2666572688 08500000 VGRTPTypes.cxx:1491 For format [3], nOptions is [0]
2017-06-19 14:52:57.139 DBUG 00000000-00000000 2666572688 08500000 VGRTPTypes.cxx:1491 For format [10], nOptions is [0]
2017-06-19 14:52:57.139 DBUG 00000000-00000000 2666572688 08500000 VGSIPTransportMgr.cxx:3205 VGSIPTransportMgr::ResolveDNS for 192.168.1.15:5064
14:52:57.139 Trc 33009 INFO 00000000-00000000 2666572688 02800FA1 Response sent: SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.15:5064;branch=z9hG4bK25c5125847f275
From: sip:GVP@192.168.1.15:5064;tag=27290C00-DB6B-7878-693D-82535C8D5EA6
To: sip:mcp:mcp_sip_port
CSeq: 2287 OPTIONS
Call-ID: 27290C00-DB6B-71A6-3A95-2601CCD22FE2-5064@192.168.1.15
Content-Length: 192
Content-Type: application/sdp

v=0
o=- 268437412 1 IN IP4 192.168.1.16
s=phone-call
c=IN IP4 192.168.1.16
t=0 0
m=audio 0 RTP/AVP 0 8 2
a=rtpmap:0 pcmu/8000
a=rtpmap:8 pcma/8000
a=rtpmap:2 g726-32/8000
a=sendrecv

14:52:57.355 Trc 33009 INFO 00000000-00000000 2666572688 02800FA1 Request received: OPTIONS sips:192.168.1.16:5071 SIP/2.0
Via: SIP/2.0/TLS 192.168.1.15:5065;branch=z9hG4bK25c510b847f275
From: sips:GVP@192.168.1.15:5065;tag=27290C00-DB6B-5EA4-A6EF-D3230EC49B33
To: sips:192.168.1.16:5071
Max-Forwards: 70
CSeq: 2288 OPTIONS
Call-ID: 27290C00-DB6B-583B-B5DB-42D77717AD05-5064@192.168.1.15
Contact: <sips:GVP@192.168.1.15:5065>
Content-Length: 0
Supported: timer, uui


2017-06-19 14:52:57.355 DBUG  2666572688 08500000 MPCSDPNegotiation.cxx:480 MPCSDPNegotiation::NegotiateSDP - nSDPOfferAns=[0], bRemotePref=[true]
2017-06-19 14:52:57.355 DBUG  2666572688 08500000 MPCSDPNegotiation.cxx:512 Generating brand new SDP offer
2017-06-19 14:52:57.355 DBUG 00000000-00000000 2666572688 08500000 VGRTPTypes.cxx:1322 RTPMediaDescListToVGSdp
2017-06-19 14:52:57.355 DBUG 00000000-00000000 2666572688 08500000 VGRTPTypes.cxx:1491 For format [2], nOptions is [0]
2017-06-19 14:52:57.355 DBUG 00000000-00000000 2666572688 08500000 VGRTPTypes.cxx:1491 For format [3], nOptions is [0]
2017-06-19 14:52:57.355 DBUG 00000000-00000000 2666572688 08500000 VGRTPTypes.cxx:1491 For format [10], nOptions is [0]
2017-06-19 14:52:57.355 DBUG 00000000-00000000 2666572688 08500000 VGSIPTransportMgr.cxx:3205 VGSIPTransportMgr::ResolveDNS for 192.168.1.15:5065
14:52:57.355 Trc 33009 INFO 00000000-00000000 2666572688 02800FA1 Response sent: SIP/2.0 200 OK
Via: SIP/2.0/TLS 192.168.1.15:5065;branch=z9hG4bK25c510b847f275
From: sips:GVP@192.168.1.15:5065;tag=27290C00-DB6B-5EA4-A6EF-D3230EC49B33
To: sips:192.168.1.16:5071
CSeq: 2288 OPTIONS
Call-ID: 27290C00-DB6B-583B-B5DB-42D77717AD05-5064@192.168.1.15
Content-Length: 192
Content-Type: application/sdp

v=0
o=- 268437413 1 IN IP4 192.168.1.16
s=phone-call
c=IN IP4 192.168.1.16
t=0 0
m=audio 0 RTP/AVP 0 8 2
a=rtpmap:0 pcmu/8000
a=rtpmap:8 pcma/8000
a=rtpmap:2 g726-32/8000
a=sendrecv

2017-06-19 14:52:57.426 DBUG 00000000-00000000 2352897488 0B300000 VGRTPSocketObjects.cxx:2036 RTP 20046: Received unknown RTCP packet type 202
14:52:58.148 Trc 33009 INFO 00000000-00000000 2666572688 02800FA1 Request received: OPTIONS sip:mcp:mcp_sip_port SIP/2.0
Via: SIP/2.0/UDP 192.168.1.15:5064;branch=z9hG4bK25c561d847f276
From: sip:GVP@192.168.1.15:5064;tag=27290C00-DB6B-7DEB-D447-9670814CC0C2
To: sip:mcp:mcp_sip_port
Max-Forwards: 70
CSeq: 2289 OPTIONS
Call-ID: 27290C00-DB6B-F9B8-81EE-215EE0947C0B-5064@192.168.1.15
Contact: <sip:GVP@192.168.1.15:5064>
Content-Length: 0
Supported: timer, uui


2017-06-19 14:52:58.148 DBUG  2666572688 08500000 MPCSDPNegotiation.cxx:480 MPCSDPNegotiation::NegotiateSDP - nSDPOfferAns=[0], bRemotePref=[true]
2017-06-19 14:52:58.148 DBUG  2666572688 08500000 MPCSDPNegotiation.cxx:512 Generating brand new SDP offer
2017-06-19 14:52:58.148 DBUG 00000000-00000000 2666572688 08500000 VGRTPTypes.cxx:1322 RTPMediaDescListToVGSdp
2017-06-19 14:52:58.148 DBUG 00000000-00000000 2666572688 08500000 VGRTPTypes.cxx:1491 For format [2], nOptions is [0]
2017-06-19 14:52:58.148 DBUG 00000000-00000000 2666572688 08500000 VGRTPTypes.cxx:1491 For format [3], nOptions is [0]
2017-06-19 14:52:58.148 DBUG 00000000-00000000 2666572688 08500000 VGRTPTypes.cxx:1491 For format [10], nOptions is [0]
2017-06-19 14:52:58.148 DBUG 00000000-00000000 2666572688 08500000 VGSIPTransportMgr.cxx:3205 VGSIPTransportMgr::ResolveDNS for 192.168.1.15:5064
14:52:58.148 Trc 33009 INFO 00000000-00000000 2666572688 02800FA1 Response sent: SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.1.15:5064;branch=z9hG4bK25c561d847f276
From: sip:GVP@192.168.1.15:5064;tag=27290C00-DB6B-7DEB-D447-9670814CC0C2
To: sip:mcp:mcp_sip_port
CSeq: 2289 OPTIONS
Call-ID: 27290C00-DB6B-F9B8-81EE-215EE0947C0B-5064@192.168.1.15
Content-Length: 192
Content-Type: application/sdp

v=0
o=- 268437414 1 IN IP4 192.168.1.16
s=phone-call
c=IN IP4 192.168.1.16
t=0 0
m=audio 0 RTP/AVP 0 8 2
a=rtpmap:0 pcmu/8000
a=rtpmap:8 pcma/8000
a=rtpmap:2 g726-32/8000
a=sendrecv