cancel
Showing results for 
Search instead for 
Did you mean: 
cancel
943
Views
0
Helpful
1
Replies

MediaSense all tracks have size as zero.

hi team

i have a headache situation with voice recording in mediasense 11.5. my CM is 11.0. 

in all condition that i try i get ERROR: Zero Size Tracks.

is any body that can help me !

i use BiB mode to deploy recording server.

here is RTMT log file 

====================================================================

OPTIONS sip:172.16.16.138:5060 SIP/2.0
Via: SIP/2.0/TCP 172.16.18.236:5060;branch=z9hG4bK26cb5a7f06494d
Max-Forwards: 0
To: <sip:172.16.16.138>
From: <sip:172.16.18.236>;tag=1781226672
Call-ID: 439f280-c101db02-25ab47-ec1210ac@172.16.18.236
CSeq: 101 OPTIONS
Content-Length: 0
Date: Wed, 12 Dec 2018 09:55:14 GMT
User-Agent: Cisco-CUCM11.0
Contact: <sip:172.16.18.236:5060;transport=tcp>


0000000373: 172.16.16.138: Dec 12 2018 13:25:14.010 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DATAI.2} -OptionsRequestInterface: sending
SIP/2.0 200 Ok
Via: SIP/2.0/TCP 172.16.18.236:5060;branch=z9hG4bK26cb5a7f06494d
To: <sip:172.16.16.138>
From: <sip:172.16.18.236>;tag=1781226672
Call-ID: 439f280-c101db02-25ab47-ec1210ac@172.16.18.236
CSeq: 101 OPTIONS
Content-Length: 0
Server: MediaSense/11.x

===================================================================

0000000540: 172.16.16.138: Dec 12 2018 13:29:37.773 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SdpParser: c=IN IP4 192.168.71.13
0000000541: 172.16.16.138: Dec 12 2018 13:29:37.773 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SdpParser: m=audio 20014 RTP/AVP
0000000542: 172.16.16.138: Dec 12 2018 13:29:37.773 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SdpParser: a=9 G722/8000
0000000543: 172.16.16.138: Dec 12 2018 13:29:37.773 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SdpParser: at=null; attribute=sendonly
0000000544: 172.16.16.138: Dec 12 2018 13:29:37.773 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SdpParser: a=101 telephone-event/8000
0000000545: 172.16.16.138: Dec 12 2018 13:29:37.773 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SdpParser: ignore fmtp attribute 101 0-15
0000000546: 172.16.16.138: Dec 12 2018 13:29:37.773 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SdpParser: created AUDIO-MediaParameters: host=192.168.71.13, port=20014, RtpAttributes=[ payloadType=9 G722/8000 ], SENDONLY
0000000547: 172.16.16.138: Dec 12 2018 13:29:37.773 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SipCall-4, INBOUND_RECORDING, FAR_END, State=ALERTED process ACK AUDIO-MediaParameters: host=192.168.71.13, port=20014, RtpAttributes=[ payloadType=9 G722/8000 ], SENDONLY
0000000548: 172.16.16.138: Dec 12 2018 13:29:37.773 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SipCall-4, INBOUND_RECORDING, FAR_END, State=ALERTED process ACK supported audio codec payloadType=9 G722/8000
0000000549: 172.16.16.138: Dec 12 2018 13:29:37.773 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SipCall-4, INBOUND_RECORDING, FAR_END, State=ALERTED process ACK supported codec payloadType=9 G722/8000
0000000550: 172.16.16.138: Dec 12 2018 13:29:37.773 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -Session id - 280167a1db85871 sending updateSessionForReInvitation to VSMS
0000000551: 172.16.16.138: Dec 12 2018 13:29:37.774 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SipCall-4, INBOUND_RECORDING, FAR_END, State=ALERTED process SDP, audioTrackNumber= TRACK1 isSrtpCall= false
0000000552: 172.16.16.138: Dec 12 2018 13:29:37.774 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -Core: dispatch UpdateSessionRequestToVsmsEventEvent: SipRequestContextImpl-5, type=Sip, Session: 280167a1db85871, INITIALIZING, call=SipCall-4, INBOUND_RECORDING, FAR_END, State=ALERTED, firstCall=null to Recording Adapter to update session
0000000553: 172.16.16.138: Dec 12 2018 13:29:37.774 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -RecordingAdapterImpl processing UpdateSessionRequestToVsmsEventEvent: SipRequestContextImpl-5, type=Sip, Session: 280167a1db85871, INITIALIZING, call=SipCall-4, INBOUND_RECORDING, FAR_END, State=ALERTED, firstCall=null
0000000554: 172.16.16.138: Dec 12 2018 13:29:37.774 +0330: %CCBU_CALL_CONTROL-6-INFO_MESSAGE: {Thrd=DIALOG_CALLBACK.5} %[message_string=SipAdapterImpl: processing onAnswered for SipCall-4, INBOUND_RECORDING, FAR_END, State=ALERTED, CallId: a0fc9000-c101dc09-25ac1d-ec1210ac@172.16.18.236, Session: 280167a1db85871, INITIALIZING]: INFO MESSAGE
0000000555: 172.16.16.138: Dec 12 2018 13:29:37.774 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SipAdapterImpl: ignore onAnswered for SipCall-4, INBOUND_RECORDING, FAR_END, State=ALERTED: wait for 1 call[s] to complete.
0000000556: 172.16.16.138: Dec 12 2018 13:29:37.774 +0330: %CCBU_CALL_CONTROL-6-INFO_MESSAGE: {Thrd=Pool-capture-thread-6} %[message_string=HTTPClient-12: executing UpdateSession request for 280167a1db85871]: INFO MESSAGE
0000000557: 172.16.16.138: Dec 12 2018 13:29:37.775 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SipCall-4, INBOUND_RECORDING, FAR_END, State=ALERTED process ACK, hasBody=true, audioSdp=null
0000000300: 172.16.16.138: Dec 12 2018 13:29:37.775 +0330: %CCBU_COMMON-6-VSMS HTTP Info: {Thrd=Pool-capture-thread-6} %[HTTP Req Content Type=application/xml][HTTP Request Body=<?xml version="1.0"?><updateRequest><session>280167a1db85871</session><track>TRACK1</track><operation>nokeyshare</operation></updateRequest>][HTTP URL=https://localhost:9443/ums/UpdateSession][logId=update-12]: Sending HTTP Request to VSMS
0000000301: 172.16.16.138: Dec 12 2018 13:29:37.778 +0330: %CCBU_COMMON-6-VSMS HTTP Info: {Thrd=Pool-capture-thread-6} %[HTTP Response Body=Updated UmsDevice][HTTP Response Content Type=text/plain][HTTP Response Status Code=200][logId=update-12]: VSMS Received HTTP Response
0000000558: 172.16.16.138: Dec 12 2018 13:29:37.779 +0330: %CCBU_CALL_CONTROL-6-BORDER_MESSAGE: {Thrd=Pool-capture-thread-6} %[message_string=HTTPClient-12: UpdateSession request: for 280167a1db85871 returns response 200]: Border Message
0000000559: 172.16.16.138: Dec 12 2018 13:29:37.779 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=Pool-capture-thread-6} -com.cisco.ora.sipserver.adapter.recording.RecordingAdapterImpl$UpdateSessionRequestToVsmsTask@1347ee3 send update session request to VSMS for session: got response for 280167a1db85871 respose is: 200
0000000560: 172.16.16.138: Dec 12 2018 13:29:37.813 +0330: %CCBU_CALL_CONTROL-6-BORDER_MESSAGE: {Thrd=DIALOG_CALLBACK.5} %[message_string=SipCall-1, INBOUND_RECORDING, NEAR_END, State=ALERTED process ACK, hasBody=true
ACK sip:897@172.16.16.138:5060;transport=TCP SIP/2.0
Via: SIP/2.0/TCP 172.16.18.236:5060;branch=z9hG4bK26cc425a226a70
Max-Forwards: 69
To: <sip:897@172.16.16.138>;tag=ds8fad2861
From: <sip:551@172.16.18.236;x-nearend;x-refci=25576500;x-nearendclusterid=StandAloneCluster;x-nearenddevice=SEP00A3D1E68CF7;x-nearendaddr=551;x-farendrefci=25576499;x-farendclusterid=StandAloneCluster;x-farenddevice=SEPBCC49396FF25;x-farendaddr=206>;tag=3660592~1ceafc82-c7f4-4c16-8b4c-79f569c20b2a-25576510
Call-ID: a0fc9000-c101dc09-25ac1a-ec1210ac@172.16.18.236
CSeq: 101 ACK
Content-Length: 240
Date: Wed, 12 Dec 2018 09:59:37 GMT
User-Agent: Cisco-CUCM11.0
Allow-Events: presence, kpml
Session-ID: 0e7a13e700105000a00000a3d1e68cf7; remote=SipTrunkToCms-3660592
Content-Type: application/sdp

v=0
o=CiscoSystemsCCM-SIP 3660592 1 IN IP4 172.16.18.236
s=SIP Call
c=IN IP4 192.168.71.13
b=TIAS:64000
b=AS:64
t=0 0
m=audio 17164 RTP/AVP 9 101
a=rtpmap:9 G722/8000
a=sendonly
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
]: Border Message
0000000561: 172.16.16.138: Dec 12 2018 13:29:37.814 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SdpParser: c=IN IP4 192.168.71.13
0000000562: 172.16.16.138: Dec 12 2018 13:29:37.814 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SdpParser: m=audio 17164 RTP/AVP
0000000563: 172.16.16.138: Dec 12 2018 13:29:37.814 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SdpParser: a=9 G722/8000
0000000564: 172.16.16.138: Dec 12 2018 13:29:37.814 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SdpParser: at=null; attribute=sendonly
0000000565: 172.16.16.138: Dec 12 2018 13:29:37.814 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SdpParser: a=101 telephone-event/8000
0000000566: 172.16.16.138: Dec 12 2018 13:29:37.814 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SdpParser: ignore fmtp attribute 101 0-15
0000000567: 172.16.16.138: Dec 12 2018 13:29:37.814 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SdpParser: created AUDIO-MediaParameters: host=192.168.71.13, port=17164, RtpAttributes=[ payloadType=9 G722/8000 ], SENDONLY
0000000568: 172.16.16.138: Dec 12 2018 13:29:37.814 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SipCall-1, INBOUND_RECORDING, NEAR_END, State=ALERTED process ACK AUDIO-MediaParameters: host=192.168.71.13, port=17164, RtpAttributes=[ payloadType=9 G722/8000 ], SENDONLY
0000000569: 172.16.16.138: Dec 12 2018 13:29:37.815 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SipCall-1, INBOUND_RECORDING, NEAR_END, State=ALERTED process ACK supported audio codec payloadType=9 G722/8000
0000000570: 172.16.16.138: Dec 12 2018 13:29:37.815 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SipCall-1, INBOUND_RECORDING, NEAR_END, State=ALERTED process ACK supported codec payloadType=9 G722/8000
0000000571: 172.16.16.138: Dec 12 2018 13:29:37.815 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -Session id - 280167a1db85871 sending updateSessionForReInvitation to VSMS
0000000572: 172.16.16.138: Dec 12 2018 13:29:37.815 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SipCall-1, INBOUND_RECORDING, NEAR_END, State=ALERTED process SDP, audioTrackNumber= TRACK0 isSrtpCall= false
0000000573: 172.16.16.138: Dec 12 2018 13:29:37.815 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -Core: dispatch UpdateSessionRequestToVsmsEventEvent: SipRequestContextImpl-6, type=Sip, Session: 280167a1db85871, INITIALIZING, call=SipCall-1, INBOUND_RECORDING, NEAR_END, State=ALERTED, firstCall=null to Recording Adapter to update session
0000000574: 172.16.16.138: Dec 12 2018 13:29:37.815 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -RecordingAdapterImpl processing UpdateSessionRequestToVsmsEventEvent: SipRequestContextImpl-6, type=Sip, Session: 280167a1db85871, INITIALIZING, call=SipCall-1, INBOUND_RECORDING, NEAR_END, State=ALERTED, firstCall=null
0000000575: 172.16.16.138: Dec 12 2018 13:29:37.815 +0330: %CCBU_CALL_CONTROL-6-INFO_MESSAGE: {Thrd=DIALOG_CALLBACK.5} %[message_string=SipAdapterImpl: processing onAnswered for SipCall-1, INBOUND_RECORDING, NEAR_END, State=ALERTED, CallId: a0fc9000-c101dc09-25ac1a-ec1210ac@172.16.18.236, Session: 280167a1db85871, INITIALIZING]: INFO MESSAGE
0000000576: 172.16.16.138: Dec 12 2018 13:29:37.815 +0330: %CCBU_CALL_CONTROL-6-INFO_MESSAGE: {Thrd=Pool-capture-thread-7} %[message_string=HTTPClient-13: executing UpdateSession request for 280167a1db85871]: INFO MESSAGE
0000000577: 172.16.16.138: Dec 12 2018 13:29:37.815 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SessionManagerImpl: setSessionState Session: 280167a1db85871, INITIALIZING, previousState=INITIALIZING, newState=ACTIVE
0000000302: 172.16.16.138: Dec 12 2018 13:29:37.816 +0330: %CCBU_COMMON-6-VSMS HTTP Info: {Thrd=Pool-capture-thread-7} %[HTTP Req Content Type=application/xml][HTTP Request Body=<?xml version="1.0"?><updateRequest><session>280167a1db85871</session><track>TRACK0</track><operation>nokeyshare</operation></updateRequest>][HTTP URL=https://localhost:9443/ums/UpdateSession][logId=update-13]: Sending HTTP Request to VSMS
0000000578: 172.16.16.138: Dec 12 2018 13:29:37.816 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SessionManagerImpl: setSessionState to ACTIVE: Session: 280167a1db85871, INITIALIZING, dt=331
0000000579: 172.16.16.138: Dec 12 2018 13:29:37.816 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -Core: dispatch UpdateLocalDBNotificationOraSessionEvent: Session: 280167a1db85871, ACTIVE to DataBase Adapter
0000000580: 172.16.16.138: Dec 12 2018 13:29:37.816 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -InMemoryDataBaseAdapter: processing UpdateLocalDB
Session: 280167a1db85871, ACTIVE, sipServer=172.16.16.138, version=7, lastNotifiedVersion=0, fromDN=null, toDN=null, audioChannels=2, videoChannels=0, started: Wed Dec 12 13:29:37 IRST 2018, ended: null, duration=0sec, recordingServer=172.16.16.138, ccId=null, ccIp=172.16.18.236, type=PHONE, appType=null
CallEndPoint: type=NEAR_END, dn=551, xRefci=25576500, device=SEP00A3D1E68CF7, conf=false, {SipCall-1, INBOUND_RECORDING, NEAR_END, State=ALERTED, CallId: a0fc9000-c101dc09-25ac1a-ec1210ac@172.16.18.236}, Tracks=[TrackInfo: type=AUDIO, port=47948, trackNumber=0, repository=/common, size=-1, state=ACTIVE, stateChanged=false, codec=G722]
CallEndPoint: type=FAR_END, dn=206, xRefci=25576499, device=SEPBCC49396FF25, conf=false, {SipCall-4, INBOUND_RECORDING, FAR_END, State=ACTIVE, CallId: a0fc9000-c101dc09-25ac1d-ec1210ac@172.16.18.236}, Tracks=[TrackInfo: type=AUDIO, port=53734, trackNumber=1, repository=/common, size=-1, state=ACTIVE, stateChanged=false, codec=G722]
0000000581: 172.16.16.138: Dec 12 2018 13:29:37.816 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SessionManagerImpl: onUpdateSession Session: 280167a1db85871, ACTIVE prepare json for version=7
0000000582: 172.16.16.138: Dec 12 2018 13:29:37.816 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -Core: processing UpdateSessionInfoNotificationOraSessionEvent: Session: 280167a1db85871, ACTIVE, version=7
0000000583: 172.16.16.138: Dec 12 2018 13:29:37.817 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SipCall-1, INBOUND_RECORDING, NEAR_END, State=ALERTED process ACK, hasBody=true, audioSdp=null
0000000584: 172.16.16.138: Dec 12 2018 13:29:37.817 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=Pool-ams-thread-2} -AmsClientAdapterImpl.UpdateSessionInfoTask-2, Session: 280167a1db85871, ACTIVE: startIndex=0, trying i=0, http://172.16.16.138:8640
0000000585: 172.16.16.138: Dec 12 2018 13:29:37.817 +0330: %CCBU_CALL_CONTROL-6-BORDER_MESSAGE: {Thrd=Pool-ams-thread-2} %[message_string=HttpPostClient-2: executing POST http://172.16.16.138:8640/ora/SipAdaptorService/SipAdaptor/addOrUpdateSession HTTP/1.1
{"sessionData": {
"callControllerIP": "172.16.18.236",
"callControllerType": "Cisco-CUCM",
"endPoints": [
{
"clusterid": "StandAloneCluster",
"conference": false,
"device": "SEP00A3D1E68CF7",
"dn": "551",
"startDate": 1544608777815,
"tracks": [{
"codec": "G722",
"location": "/common",
"mediaState": "ACTIVE",
"startDate": 1544608777815,
"track": 0,
"type": "AUDIO"
}],
"type": "NEAR_END",
"xRefci": "25576500"
},
{
"clusterid": "StandAloneCluster",
"conference": false,
"device": "SEPBCC49396FF25",
"dn": "206",
"startDate": 1544608777815,
"tracks": [{
"codec": "G722",
"location": "/common",
"mediaState": "ACTIVE",
"startDate": 1544608777815,
"track": 1,
"type": "AUDIO"
}],
"type": "FAR_END",
"xRefci": "25576499"
}
],
"errorDetail": "null",
"operationType": "ADD",
"recordingServer": "172.16.16.138",
"rtspUrl": "rtsp://172.16.16.138/280167a1db85871",
"sessionName": "280167a1db85871",
"sipServer": "172.16.16.138",
"startDate": 1544608777815,
"state": "ACTIVE",
"version": 7
}}]: Border Message
0000000303: 172.16.16.138: Dec 12 2018 13:29:37.820 +0330: %CCBU_COMMON-6-VSMS HTTP Info: {Thrd=Pool-capture-thread-7} %[HTTP Response Body=Updated UmsDevice][HTTP Response Content Type=text/plain][HTTP Response Status Code=200][logId=update-13]: VSMS Received HTTP Response
0000000586: 172.16.16.138: Dec 12 2018 13:29:37.820 +0330: %CCBU_CALL_CONTROL-6-BORDER_MESSAGE: {Thrd=Pool-capture-thread-7} %[message_string=HTTPClient-13: UpdateSession request: for 280167a1db85871 returns response 200]: Border Message
0000000587: 172.16.16.138: Dec 12 2018 13:29:37.821 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=Pool-capture-thread-7} -com.cisco.ora.sipserver.adapter.recording.RecordingAdapterImpl$UpdateSessionRequestToVsmsTask@177b30 send update session request to VSMS for session: got response for 280167a1db85871 respose is: 200
0000000588: 172.16.16.138: Dec 12 2018 13:29:38.334 +0330: %CCBU_CALL_CONTROL-6-BORDER_MESSAGE: {Thrd=Pool-ams-thread-2} %[message_string=HttpPostClient-2: HTTP/1.1 200 OK, statusCode=200, phrase=OK]: Border Message
0000000589: 172.16.16.138: Dec 12 2018 13:29:38.334 +0330: %CCBU_CALL_CONTROL-6-BORDER_MESSAGE: {Thrd=Pool-ams-thread-1} %[message_string=HttpPostClient-1: HTTP/1.1 200 OK, statusCode=200, phrase=OK]: Border Message
0000000590: 172.16.16.138: Dec 12 2018 13:29:38.335 +0330: %CCBU_CALL_CONTROL-6-BORDER_MESSAGE: {Thrd=Pool-ams-thread-2} %[message_string=HttpPostClient-2: got Response: contentLength=-1, contentType=Content-Type: text/plain]: Border Message
0000000591: 172.16.16.138: Dec 12 2018 13:29:38.335 +0330: %CCBU_CALL_CONTROL-6-BORDER_MESSAGE: {Thrd=Pool-ams-thread-1} %[message_string=HttpPostClient-1: got Response: contentLength=-1, contentType=Content-Type: text/plain]: Border Message
0000000592: 172.16.16.138: Dec 12 2018 13:29:38.335 +0330: %CCBU_CALL_CONTROL-6-BORDER_MESSAGE: {Thrd=Pool-ams-thread-2} %[message_string=HttpPostClient-2: read 91 bytes from response
{"responseMessage":"Success: Your request was successfully completed.","responseCode":2000}]: Border Message
0000000593: 172.16.16.138: Dec 12 2018 13:29:38.335 +0330: %CCBU_CALL_CONTROL-6-BORDER_MESSAGE: {Thrd=Pool-ams-thread-1} %[message_string=HttpPostClient-1: read 91 bytes from response
{"responseMessage":"Success: Your request was successfully completed.","responseCode":2000}]: Border Message
0000000594: 172.16.16.138: Dec 12 2018 13:29:38.336 +0330: %CCBU_CALL_CONTROL-6-BORDER_MESSAGE: {Thrd=Pool-ams-thread-2} %[message_string=AmsClientAdapterImpl.UpdateSessionInfoTask-2, Session: 280167a1db85871, ACTIVE: got response from AMS: responseCode=2000, executionTime=519 mSec]: Border Message
0000000595: 172.16.16.138: Dec 12 2018 13:29:38.336 +0330: %CCBU_CALL_CONTROL-6-BORDER_MESSAGE: {Thrd=Pool-ams-thread-1} %[message_string=AmsClientAdapterImpl.UpdateSessionInfoTask-1, Session: 27f167a1db85311, ACTIVE: got response from AMS: responseCode=2000, executionTime=585 mSec]: Border Message
0000000304: 172.16.16.138: Dec 12 2018 13:29:51.872 +0330: %CCBU_COMMON-6-VSMS HTTP Info: {Thrd=Pool-capture-thread-1} %[HTTP Req Content Type=null][HTTP Request Body=null][HTTP URL=https://localhost:9443/ums/SessionStatus?inactive=true][logId=stat-14]: Sending HTTP Request to VSMS
0000000305: 172.16.16.138: Dec 12 2018 13:29:51.878 +0330: %CCBU_COMMON-6-VSMS HTTP Info: {Thrd=Pool-capture-thread-1} %[HTTP Response Body=<SessionStatus>
</SessionStatus>][HTTP Response Content Type=application/xml][HTTP Response Status Code=200][logId=stat-14]: VSMS Received HTTP Response
0000000596: 172.16.16.138: Dec 12 2018 13:29:51.881 +0330: %CCBU_CALL_CONTROL-6-BORDER_MESSAGE: {Thrd=Pool-capture-thread-1} %[message_string=SessionsStatus Client (14) got response VSMSSessionStatusResponse: []]: Border Message
0000000597: 172.16.16.138: Dec 12 2018 13:29:51.881 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=Pool-capture-thread-1} -MediaResourceImpl.procSessionStatusReport, size=0
0000000598: 172.16.16.138: Dec 12 2018 13:30:17.596 +0330: %CCBU_CALL_CONTROL-6-BORDER_MESSAGE: {Thrd=DIALOG_CALLBACK.5} %[message_string=processBye: SipCall-1, INBOUND_RECORDING, NEAR_END, State=ACTIVE processing
BYE sip:897@172.16.16.138:5060;transport=TCP SIP/2.0
Via: SIP/2.0/TCP 172.16.18.236:5060;branch=z9hG4bK26cc694b6597b
Max-Forwards: 69
To: <sip:897@172.16.16.138>;tag=ds8fad2861
From: <sip:551@172.16.18.236;x-nearend;x-refci=25576500;x-nearendclusterid=StandAloneCluster;x-nearenddevice=SEP00A3D1E68CF7;x-nearendaddr=551;x-farendrefci=25576499;x-farendclusterid=StandAloneCluster;x-farenddevice=SEPBCC49396FF25;x-farendaddr=206>;tag=3660592~1ceafc82-c7f4-4c16-8b4c-79f569c20b2a-25576510
Call-ID: a0fc9000-c101dc09-25ac1a-ec1210ac@172.16.18.236
CSeq: 102 BYE
Content-Length: 0
Date: Wed, 12 Dec 2018 09:59:37 GMT
User-Agent: Cisco-CUCM11.0
P-Asserted-Identity: <sip:551@172.16.18.236>
Reason: Q.850;cause=16
Session-ID: 0e7a13e700105000a00000a3d1e68cf7; remote=SipTrunkToCms-3660592

]: Border Message
0000000599: 172.16.16.138: Dec 12 2018 13:30:17.597 +0330: %CCBU_CALL_CONTROL-6-BORDER_MESSAGE: {Thrd=DIALOG_CALLBACK.6} %[message_string=processBye: SipCall-4, INBOUND_RECORDING, FAR_END, State=ACTIVE processing
BYE sip:897@172.16.16.138:5060;transport=TCP SIP/2.0
Via: SIP/2.0/TCP 172.16.18.236:5060;branch=z9hG4bK26cc6b1cac0fda
Max-Forwards: 69
To: <sip:897@172.16.16.138>;tag=dsf21028c9
From: <sip:551@172.16.18.236;x-farend;x-refci=25576500;x-nearendclusterid=StandAloneCluster;x-nearenddevice=SEP00A3D1E68CF7;x-nearendaddr=551;x-farendrefci=25576499;x-farendclusterid=StandAloneCluster;x-farenddevice=SEPBCC49396FF25;x-farendaddr=206>;tag=3660597~1ceafc82-c7f4-4c16-8b4c-79f569c20b2a-25576514
Call-ID: a0fc9000-c101dc09-25ac1d-ec1210ac@172.16.18.236
CSeq: 102 BYE
Content-Length: 0
Date: Wed, 12 Dec 2018 09:59:37 GMT
User-Agent: Cisco-CUCM11.0
P-Asserted-Identity: <sip:551@172.16.18.236>
Reason: Q.850;cause=16
Session-ID: 5257735800105000a00000a3d1e68cf7; remote=SipTrunkToCms-3660597

]: Border Message
0000000600: 172.16.16.138: Dec 12 2018 13:30:17.597 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -SipAdapterImpl: processing onDisconnected, localClose=false for SipCall-1, INBOUND_RECORDING, NEAR_END, State=DISCONNECTED, CallId: a0fc9000-c101dc09-25ac1a-ec1210ac@172.16.18.236, Session: 280167a1db85871, ACTIVE
0000000601: 172.16.16.138: Dec 12 2018 13:30:17.599 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.6} -SipAdapterImpl: processing onDisconnected, localClose=false for SipCall-4, INBOUND_RECORDING, FAR_END, State=DISCONNECTED, CallId: a0fc9000-c101dc09-25ac1d-ec1210ac@172.16.18.236, Session: 280167a1db85871, ACTIVE
0000000602: 172.16.16.138: Dec 12 2018 13:30:17.599 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -Core: dispatch StopRecordingRequestEvent: SipRequestContextImpl-7, type=Sip, Session: 280167a1db85871, ACTIVE, call=SipCall-1, INBOUND_RECORDING, NEAR_END, State=DISCONNECTED, firstCall=null to Recording Adapter
0000000603: 172.16.16.138: Dec 12 2018 13:30:17.599 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.6} -Core: dispatch StopRecordingRequestEvent: SipRequestContextImpl-8, type=Sip, Session: 280167a1db85871, ACTIVE, call=SipCall-4, INBOUND_RECORDING, FAR_END, State=DISCONNECTED, firstCall=null to Recording Adapter
0000000604: 172.16.16.138: Dec 12 2018 13:30:17.599 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.5} -RecordingAdapterImpl processing StopRecordingRequestEvent: SipRequestContextImpl-7, type=Sip, Session: 280167a1db85871, ACTIVE, call=SipCall-1, INBOUND_RECORDING, NEAR_END, State=DISCONNECTED, firstCall=null
0000000605: 172.16.16.138: Dec 12 2018 13:30:17.600 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.6} -RecordingAdapterImpl processing StopRecordingRequestEvent: SipRequestContextImpl-8, type=Sip, Session: 280167a1db85871, ACTIVE, call=SipCall-4, INBOUND_RECORDING, FAR_END, State=DISCONNECTED, firstCall=null
0000000606: 172.16.16.138: Dec 12 2018 13:30:17.601 +0330: %CCBU_CALL_CONTROL-6-BORDER_MESSAGE: {Thrd=Pool-capture-thread-8} %[message_string=HTTPClient-15: executing CloseSession request for 280167a1db85871]: Border Message
0000000306: 172.16.16.138: Dec 12 2018 13:30:17.601 +0330: %CCBU_COMMON-6-VSMS HTTP Info: {Thrd=Pool-capture-thread-8} %[HTTP Req Content Type=null][HTTP Request Body=null][HTTP URL=https://localhost:9443/ums/CloseSession?SessionName=280167a1db85871][logId=close-15]: Sending HTTP Request to VSMS
0000000607: 172.16.16.138: Dec 12 2018 13:30:17.727 +0330: %CCBU_CALL_CONTROL-6-BORDER_MESSAGE: {Thrd=DIALOG_CALLBACK.6} %[message_string=processBye: SipCall-2, INBOUND_RECORDING, NEAR_END, State=ACTIVE processing
BYE sip:897@172.16.16.138:5060;transport=TCP SIP/2.0
Via: SIP/2.0/TCP 172.16.18.236:5060;branch=z9hG4bK26cc6d40e66a3e
Max-Forwards: 69
To: <sip:897@172.16.16.138>;tag=ds50792861
From: "Post Bank" <sip:206@172.16.18.236;x-nearend;x-refci=25576499;x-nearendclusterid=StandAloneCluster;x-nearenddevice=SEPBCC49396FF25;x-nearendaddr=206;x-farendrefci=25576500;x-farendclusterid=StandAloneCluster;x-farenddevice=SEP00A3D1E68CF7;x-farendaddr=551>;tag=3660589~1ceafc82-c7f4-4c16-8b4c-79f569c20b2a-25576507
Call-ID: a0fc9000-c101dc09-25ac18-ec1210ac@172.16.18.236
CSeq: 102 BYE
Content-Length: 0
Date: Wed, 12 Dec 2018 09:59:37 GMT
User-Agent: Cisco-CUCM11.0
P-Asserted-Identity: "Post Bank" <sip:206@172.16.18.236>
Reason: Q.850;cause=16
Session-ID: d1a128d4-5362-4014-a37c--3660587; remote=SipTrunkToCms-3660589

]: Border Message
0000000608: 172.16.16.138: Dec 12 2018 13:30:17.728 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.6} -SipAdapterImpl: processing onDisconnected, localClose=false for SipCall-2, INBOUND_RECORDING, NEAR_END, State=DISCONNECTED, CallId: a0fc9000-c101dc09-25ac18-ec1210ac@172.16.18.236, Session: 27f167a1db85311, ACTIVE
0000000609: 172.16.16.138: Dec 12 2018 13:30:17.728 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.6} -Core: dispatch StopRecordingRequestEvent: SipRequestContextImpl-9, type=Sip, Session: 27f167a1db85311, ACTIVE, call=SipCall-2, INBOUND_RECORDING, NEAR_END, State=DISCONNECTED, firstCall=null to Recording Adapter
0000000610: 172.16.16.138: Dec 12 2018 13:30:17.728 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.6} -RecordingAdapterImpl processing StopRecordingRequestEvent: SipRequestContextImpl-9, type=Sip, Session: 27f167a1db85311, ACTIVE, call=SipCall-2, INBOUND_RECORDING, NEAR_END, State=DISCONNECTED, firstCall=null
0000000611: 172.16.16.138: Dec 12 2018 13:30:17.729 +0330: %CCBU_CALL_CONTROL-6-BORDER_MESSAGE: {Thrd=Pool-capture-thread-10} %[message_string=HTTPClient-17: executing CloseSession request for 27f167a1db85311]: Border Message
0000000612: 172.16.16.138: Dec 12 2018 13:30:17.729 +0330: %CCBU_CALL_CONTROL-6-BORDER_MESSAGE: {Thrd=DIALOG_CALLBACK.6} %[message_string=processBye: SipCall-3, INBOUND_RECORDING, FAR_END, State=ACTIVE processing
BYE sip:897@172.16.16.138:5060;transport=TCP SIP/2.0
Via: SIP/2.0/TCP 172.16.18.236:5060;branch=z9hG4bK26cc6f7445e0c0
Max-Forwards: 69
To: <sip:897@172.16.16.138>;tag=ds412f2872
From: "Post Bank" <sip:206@172.16.18.236;x-farend;x-refci=25576499;x-nearendclusterid=StandAloneCluster;x-nearenddevice=SEPBCC49396FF25;x-nearendaddr=206;x-farendrefci=25576500;x-farendclusterid=StandAloneCluster;x-farenddevice=SEP00A3D1E68CF7;x-farendaddr=551>;tag=3660595~1ceafc82-c7f4-4c16-8b4c-79f569c20b2a-25576513
Call-ID: a0fc9000-c101dc09-25ac1c-ec1210ac@172.16.18.236
CSeq: 102 BYE
Content-Length: 0
Date: Wed, 12 Dec 2018 09:59:37 GMT
User-Agent: Cisco-CUCM11.0
P-Asserted-Identity: "Post Bank" <sip:206@172.16.18.236>
Reason: Q.850;cause=16
Session-ID: d1a128d4-5362-4014-a37c--3660590; remote=SipTrunkToCms-3660595

]: Border Message
0000000307: 172.16.16.138: Dec 12 2018 13:30:17.730 +0330: %CCBU_COMMON-6-VSMS HTTP Info: {Thrd=Pool-capture-thread-10} %[HTTP Req Content Type=null][HTTP Request Body=null][HTTP URL=https://localhost:9443/ums/CloseSession?SessionName=27f167a1db85311][logId=close-17]: Sending HTTP Request to VSMS
0000000613: 172.16.16.138: Dec 12 2018 13:30:17.730 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.6} -SipAdapterImpl: processing onDisconnected, localClose=false for SipCall-3, INBOUND_RECORDING, FAR_END, State=DISCONNECTED, CallId: a0fc9000-c101dc09-25ac1c-ec1210ac@172.16.18.236, Session: 27f167a1db85311, ACTIVE
0000000614: 172.16.16.138: Dec 12 2018 13:30:17.730 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.6} -Core: dispatch StopRecordingRequestEvent: SipRequestContextImpl-10, type=Sip, Session: 27f167a1db85311, ACTIVE, call=SipCall-3, INBOUND_RECORDING, FAR_END, State=DISCONNECTED, firstCall=null to Recording Adapter
0000000615: 172.16.16.138: Dec 12 2018 13:30:17.730 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=DIALOG_CALLBACK.6} -RecordingAdapterImpl processing StopRecordingRequestEvent: SipRequestContextImpl-10, type=Sip, Session: 27f167a1db85311, ACTIVE, call=SipCall-3, INBOUND_RECORDING, FAR_END, State=DISCONNECTED, firstCall=null
0000000308: 172.16.16.138: Dec 12 2018 13:30:27.846 +0330: %CCBU_COMMON-6-VSMS HTTP Info: {Thrd=Pool-capture-thread-8} %[HTTP Response Body=<Session>
<diskusage>
<recording name="280167a1db85871-TRACK0" size="0" repository="/common" />
<recording name="280167a1db85871-TRACK1" size="0" repository="/common" />
</diskusage>
</Session>][HTTP Response Content Type=application/xml][HTTP Response Status Code=200][logId=close-15]: VSMS Received HTTP Response
0000000616: 172.16.16.138: Dec 12 2018 13:30:27.847 +0330: %CCBU_CALL_CONTROL-6-BORDER_MESSAGE: {Thrd=Pool-capture-thread-8} %[message_string=HTTPClient-15: got response VSMSSessionResponse: ERROR noMedia]: Border Message
0000000617: 172.16.16.138: Dec 12 2018 13:30:27.848 +0330: %CCBU_CALL_CONTROL-3-ERROR_MESSAGE: {Thrd=Pool-capture-thread-8} %[message_string=HTTPClient-15: error processing CloseSession request: for 280167a1db85871, noMedia]: ERROR MESSAGE
0000000618: 172.16.16.138: Dec 12 2018 13:30:27.848 +0330: %CCBU_CALL_CONTROL-3-ERROR_MESSAGE: {Thrd=Pool-capture-thread-8} %[message_string=HTTPClient-15: setSessionToFinalState
Session: 280167a1db85871, ACTIVE, sipServer=172.16.16.138, version=8, lastNotifiedVersion=7, fromDN=null, toDN=null, audioChannels=2, videoChannels=0, started: Wed Dec 12 13:29:37 IRST 2018, ended: Wed Dec 12 13:30:17 IRST 2018, duration=39sec, recordingServer=172.16.16.138, ccId=null, ccIp=172.16.18.236, type=PHONE, appType=null
CallEndPoint: type=NEAR_END, dn=551, xRefci=25576500, device=SEP00A3D1E68CF7, conf=false, {SipCall-1, INBOUND_RECORDING, NEAR_END, State=DISCONNECTED, CallId: a0fc9000-c101dc09-25ac1a-ec1210ac@172.16.18.236}, Tracks=[TrackInfo: type=AUDIO, port=47948, trackNumber=0, repository=/common, size=-1, state=ACTIVE, stateChanged=false, codec=G722]
CallEndPoint: type=FAR_END, dn=206, xRefci=25576499, device=SEPBCC49396FF25, conf=false, {SipCall-4, INBOUND_RECORDING, FAR_END, State=DISCONNECTED, CallId: a0fc9000-c101dc09-25ac1d-ec1210ac@172.16.18.236}, Tracks=[TrackInfo: type=AUDIO, port=53734, trackNumber=1, repository=/common, size=-1, state=ACTIVE, stateChanged=false, codec=G722]]: ERROR MESSAGE
0000000619: 172.16.16.138: Dec 12 2018 13:30:27.849 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=Pool-capture-thread-8} -SessionManagerImpl: setSessionState Session: 280167a1db85871, ACTIVE, previousState=ACTIVE, newState=ERROR
0000000620: 172.16.16.138: Dec 12 2018 13:30:27.849 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=Pool-capture-thread-8} -SessionManagerImpl: Session: 280167a1db85871, ERROR, NO_MEDIA_RECEIVED releasing [AUDIO-MediaResource-4: SipCall-4, INBOUND_RECORDING, FAR_END, State=ALERTED, weight=1, ip=172.16.18.236, AUDIO-MediaResource-2: SipCall-1, INBOUND_RECORDING, NEAR_END, State=ALERTED, weight=1, ip=172.16.18.236]
0000000621: 172.16.16.138: Dec 12 2018 13:30:27.849 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=Pool-capture-thread-8} -CapacityController: released [AUDIO-MediaResource-4: SipCall-4, INBOUND_RECORDING, FAR_END, State=ALERTED, weight=1, ip=172.16.18.236, AUDIO-MediaResource-2: SipCall-1, INBOUND_RECORDING, NEAR_END, State=ALERTED, weight=1, ip=172.16.18.236]
allocated=2, maxAlloc=4
0000000622: 172.16.16.138: Dec 12 2018 13:30:27.849 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=Pool-capture-thread-8} -SessionManagerImpl: disconnectAllCalls for Session: 280167a1db85871, ERROR, NO_MEDIA_RECEIVED
0000000623: 172.16.16.138: Dec 12 2018 13:30:27.849 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=Pool-capture-thread-8} -SipCall-4, INBOUND_RECORDING, FAR_END, State=DISCONNECTED incErrors: handle non-null Session: 280167a1db85871, ERROR, NO_MEDIA_RECEIVED, sipServer=172.16.16.138, version=10, lastNotifiedVersion=7, fromDN=null, toDN=null, audioChannels=2, videoChannels=0, started: Wed Dec 12 13:29:37 IRST 2018, ended: Wed Dec 12 13:30:17 IRST 2018, duration=39sec, recordingServer=172.16.16.138, ccId=null, ccIp=172.16.18.236, type=PHONE, appType=null, ErrorDetail =NO_MEDIA_RECEIVED
CallEndPoint: type=NEAR_END, dn=551, xRefci=25576500, device=SEP00A3D1E68CF7, conf=false, {SipCall-1, INBOUND_RECORDING, NEAR_END, State=DISCONNECTED, CallId: a0fc9000-c101dc09-25ac1a-ec1210ac@172.16.18.236}, Tracks=[TrackInfo: type=AUDIO, port=47948, trackNumber=0, repository=/common, size=-1, state=ACTIVE, stateChanged=false, codec=G722]
CallEndPoint: type=FAR_END, dn=206, xRefci=25576499, device=SEPBCC49396FF25, conf=false, {SipCall-4, INBOUND_RECORDING, FAR_END, State=DISCONNECTED, CallId: a0fc9000-c101dc09-25ac1d-ec1210ac@172.16.18.236}, Tracks=[TrackInfo: type=AUDIO, port=53734, trackNumber=1, repository=/common, size=-1, state=ACTIVE, stateChanged=false, codec=G722]
0000000624: 172.16.16.138: Dec 12 2018 13:30:27.849 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=Pool-capture-thread-8} -SipCall-1, INBOUND_RECORDING, NEAR_END, State=DISCONNECTED incErrors: handle non-null Session: 280167a1db85871, ERROR, NO_MEDIA_RECEIVED, sipServer=172.16.16.138, version=10, lastNotifiedVersion=7, fromDN=null, toDN=null, audioChannels=2, videoChannels=0, started: Wed Dec 12 13:29:37 IRST 2018, ended: Wed Dec 12 13:30:17 IRST 2018, duration=39sec, recordingServer=172.16.16.138, ccId=null, ccIp=172.16.18.236, type=PHONE, appType=null, ErrorDetail =NO_MEDIA_RECEIVED
CallEndPoint: type=NEAR_END, dn=551, xRefci=25576500, device=SEP00A3D1E68CF7, conf=false, {SipCall-1, INBOUND_RECORDING, NEAR_END, State=DISCONNECTED, CallId: a0fc9000-c101dc09-25ac1a-ec1210ac@172.16.18.236}, Tracks=[TrackInfo: type=AUDIO, port=47948, trackNumber=0, repository=/common, size=-1, state=ACTIVE, stateChanged=false, codec=G722]
CallEndPoint: type=FAR_END, dn=206, xRefci=25576499, device=SEPBCC49396FF25, conf=false, {SipCall-4, INBOUND_RECORDING, FAR_END, State=DISCONNECTED, CallId: a0fc9000-c101dc09-25ac1d-ec1210ac@172.16.18.236}, Tracks=[TrackInfo: type=AUDIO, port=53734, trackNumber=1, repository=/common, size=-1, state=ACTIVE, stateChanged=false, codec=G722]
0000000625: 172.16.16.138: Dec 12 2018 13:30:27.849 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=Pool-capture-thread-8} -class com.cisco.ora.sipserver.adapter.recording.MediaResourceImpl$OnMediaErrAct.excute() invoked for evtData=com.cisco.ora.sipserver.adapter.recording.MediaResourceImpl$EventData@10d5cfc
0000000626: 172.16.16.138: Dec 12 2018 13:30:27.850 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=Pool-capture-thread-8} -Core: dispatch StopRecordingResponseEvent: SipRequestContextImpl-7, type=Sip, status=RECORDING_ERROR, Session: 280167a1db85871, ERROR, NO_MEDIA_RECEIVED, call=SipCall-1, INBOUND_RECORDING, NEAR_END, State=DISCONNECTED, firstCall=null to Sip Adapter
0000000627: 172.16.16.138: Dec 12 2018 13:30:27.850 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=Pool-capture-thread-8} -InMemoryDataBaseAdapter: processing StopRecording
Session: 280167a1db85871, ERROR, NO_MEDIA_RECEIVED, sipServer=172.16.16.138, version=10, lastNotifiedVersion=7, fromDN=null, toDN=null, audioChannels=2, videoChannels=0, started: Wed Dec 12 13:29:37 IRST 2018, ended: Wed Dec 12 13:30:17 IRST 2018, duration=39sec, recordingServer=172.16.16.138, ccId=null, ccIp=172.16.18.236, type=PHONE, appType=null, ErrorDetail =NO_MEDIA_RECEIVED
CallEndPoint: type=NEAR_END, dn=551, xRefci=25576500, device=SEP00A3D1E68CF7, conf=false, {SipCall-1, INBOUND_RECORDING, NEAR_END, State=DISCONNECTED, CallId: a0fc9000-c101dc09-25ac1a-ec1210ac@172.16.18.236}, Tracks=[TrackInfo: type=AUDIO, port=47948, trackNumber=0, repository=/common, size=-1, state=ACTIVE, stateChanged=false, codec=G722]
CallEndPoint: type=FAR_END, dn=206, xRefci=25576499, device=SEPBCC49396FF25, conf=false, {SipCall-4, INBOUND_RECORDING, FAR_END, State=DISCONNECTED, CallId: a0fc9000-c101dc09-25ac1d-ec1210ac@172.16.18.236}, Tracks=[TrackInfo: type=AUDIO, port=53734, trackNumber=1, repository=/common, size=-1, state=ACTIVE, stateChanged=false, codec=G722]
0000000628: 172.16.16.138: Dec 12 2018 13:30:27.856 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=Pool-capture-thread-8} -InMemoryDataBaseAdapter: removing 21c167a16762f51
0000000629: 172.16.16.138: Dec 12 2018 13:30:27.856 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=Pool-capture-thread-8} -InMemoryDataBaseAdapter: removing 21b167a16368f31
0000000630: 172.16.16.138: Dec 12 2018 13:30:27.856 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=Pool-capture-thread-8} -SipAdapterImpl: processing StopRecordingResponseEvent: SipRequestContextImpl-7, type=Sip, status=RECORDING_ERROR, Session: 280167a1db85871, ERROR, NO_MEDIA_RECEIVED, call=SipCall-1, INBOUND_RECORDING, NEAR_END, State=DISCONNECTED, firstCall=null
0000000631: 172.16.16.138: Dec 12 2018 13:30:27.856 +0330: %CCBU_CALL_CONTROL-4-WARN_MESSAGE: {Thrd=Pool-capture-thread-8} %[message_string=SipCall-1, INBOUND_RECORDING, NEAR_END, State=DISCONNECTED incErrorsSetSessionStateError: handle non-null Session: 280167a1db85871, ERROR, NO_MEDIA_RECEIVED, sipServer=172.16.16.138, version=10, lastNotifiedVersion=7, fromDN=null, toDN=null, audioChannels=2, videoChannels=0, started: Wed Dec 12 13:29:37 IRST 2018, ended: Wed Dec 12 13:30:17 IRST 2018, duration=39sec, recordingServer=172.16.16.138, ccId=null, ccIp=172.16.18.236, type=PHONE, appType=null, ErrorDetail =NO_MEDIA_RECEIVED
CallEndPoint: type=NEAR_END, dn=551, xRefci=25576500, device=SEP00A3D1E68CF7, conf=false, {SipCall-1, INBOUND_RECORDING, NEAR_END, State=DISCONNECTED, CallId: a0fc9000-c101dc09-25ac1a-ec1210ac@172.16.18.236}, Tracks=[TrackInfo: type=AUDIO, port=47948, trackNumber=0, repository=/common, size=-1, state=ACTIVE, stateChanged=false, codec=G722]
CallEndPoint: type=FAR_END, dn=206, xRefci=25576499, device=SEPBCC49396FF25, conf=false, {SipCall-4, INBOUND_RECORDING, FAR_END, State=DISCONNECTED, CallId: a0fc9000-c101dc09-25ac1d-ec1210ac@172.16.18.236}, Tracks=[TrackInfo: type=AUDIO, port=53734, trackNumber=1, repository=/common, size=-1, state=ACTIVE, stateChanged=false, codec=G722]
errorName=closeRecording]: WARN MESSAGE
0000000632: 172.16.16.138: Dec 12 2018 13:30:27.856 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=Pool-capture-thread-8} -SipCall-1, INBOUND_RECORDING, NEAR_END, State=DISCONNECTED incErrors: handle non-null Session: 280167a1db85871, ERROR, NO_MEDIA_RECEIVED, sipServer=172.16.16.138, version=10, lastNotifiedVersion=7, fromDN=null, toDN=null, audioChannels=2, videoChannels=0, started: Wed Dec 12 13:29:37 IRST 2018, ended: Wed Dec 12 13:30:17 IRST 2018, duration=39sec, recordingServer=172.16.16.138, ccId=null, ccIp=172.16.18.236, type=PHONE, appType=null, ErrorDetail =NO_MEDIA_RECEIVED
CallEndPoint: type=NEAR_END, dn=551, xRefci=25576500, device=SEP00A3D1E68CF7, conf=false, {SipCall-1, INBOUND_RECORDING, NEAR_END, State=DISCONNECTED, CallId: a0fc9000-c101dc09-25ac1a-ec1210ac@172.16.18.236}, Tracks=[TrackInfo: type=AUDIO, port=47948, trackNumber=0, repository=/common, size=-1, state=ACTIVE, stateChanged=false, codec=G722]
CallEndPoint: type=FAR_END, dn=206, xRefci=25576499, device=SEPBCC49396FF25, conf=false, {SipCall-4, INBOUND_RECORDING, FAR_END, State=DISCONNECTED, CallId: a0fc9000-c101dc09-25ac1d-ec1210ac@172.16.18.236}, Tracks=[TrackInfo: type=AUDIO, port=53734, trackNumber=1, repository=/common, size=-1, state=ACTIVE, stateChanged=false, codec=G722]
0000000633: 172.16.16.138: Dec 12 2018 13:30:27.857 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=Pool-capture-thread-8} -SipAdapterImpl: error in processing Session: 280167a1db85871, ERROR, NO_MEDIA_RECEIVED, sipServer=172.16.16.138, version=10, lastNotifiedVersion=7, fromDN=null, toDN=null, audioChannels=2, videoChannels=0, started: Wed Dec 12 13:29:37 IRST 2018, ended: Wed Dec 12 13:30:17 IRST 2018, duration=39sec, recordingServer=172.16.16.138, ccId=null, ccIp=172.16.18.236, type=PHONE, appType=null, ErrorDetail =NO_MEDIA_RECEIVED
CallEndPoint: type=NEAR_END, dn=551, xRefci=25576500, device=SEP00A3D1E68CF7, conf=false, {SipCall-1, INBOUND_RECORDING, NEAR_END, State=DISCONNECTED, CallId: a0fc9000-c101dc09-25ac1a-ec1210ac@172.16.18.236}, Tracks=[TrackInfo: type=AUDIO, port=47948, trackNumber=0, repository=/common, size=-1, state=ACTIVE, stateChanged=false, codec=G722]
CallEndPoint: type=FAR_END, dn=206, xRefci=25576499, device=SEPBCC49396FF25, conf=false, {SipCall-4, INBOUND_RECORDING, FAR_END, State=DISCONNECTED, CallId: a0fc9000-c101dc09-25ac1d-ec1210ac@172.16.18.236}, Tracks=[TrackInfo: type=AUDIO, port=53734, trackNumber=1, repository=/common, size=-1, state=ACTIVE, stateChanged=false, codec=G722], SipCall-1, INBOUND_RECORDING, NEAR_END, State=DISCONNECTED
0000000634: 172.16.16.138: Dec 12 2018 13:30:27.857 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=Pool-capture-thread-8} -SessionManagerImpl: onUpdateSession Session: 280167a1db85871, ERROR, NO_MEDIA_RECEIVED prepare json for version=10
0000000635: 172.16.16.138: Dec 12 2018 13:30:27.857 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=Pool-capture-thread-8} -Core: processing UpdateSessionInfoNotificationOraSessionEvent: Session: 280167a1db85871, ERROR, NO_MEDIA_RECEIVED, version=10
0000000636: 172.16.16.138: Dec 12 2018 13:30:27.858 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=Pool-capture-thread-9} -Core: dispatch StopRecordingResponseEvent: SipRequestContextImpl-8, type=Sip, status=NOT_FOUND, Session: 280167a1db85871, ERROR, NO_MEDIA_RECEIVED, call=SipCall-4, INBOUND_RECORDING, FAR_END, State=DISCONNECTED, firstCall=null to Sip Adapter
0000000637: 172.16.16.138: Dec 12 2018 13:30:27.859 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=Pool-capture-thread-9} -SipAdapterImpl: processing StopRecordingResponseEvent: SipRequestContextImpl-8, type=Sip, status=NOT_FOUND, Session: 280167a1db85871, ERROR, NO_MEDIA_RECEIVED, call=SipCall-4, INBOUND_RECORDING, FAR_END, State=DISCONNECTED, firstCall=null
0000000638: 172.16.16.138: Dec 12 2018 13:30:27.859 +0330: %CCBU_CALL_CONTROL-7-TRACE: {Thrd=Pool-capture-thread-9} -SipAdapterImpl: do not send Update SessionInfo Notification Event for StopRecordingResponseEvent: SipRequestContextImpl-8, type=Sip, status=NOT_FOUND, Session: 280167a1db85871, ERROR, NO_MEDIA_RECEIVED, call=SipCall-4, INBOUND_RECORDING, FAR_END, State=DISCONNECTED, firstCall=null
0000000639: 172.16.16.138: Dec 12 2018 13:30:27.859 +0330: %CCBU_CALL_CONTROL-6-BORDER_MESSAGE: {Thrd=Pool-ams-thread-3} %[message_string=HttpPostClient-3: executing POST http://172.16.16.138:8640/ora/SipAdaptorService/SipAdaptor/addOrUpdateSession HTTP/1.1
{"sessionData": {
"callControllerIP": "172.16.18.236",
"callControllerType": "Cisco-CUCM",
"endDate": 1544608817597,
"endPoints": [
{
"clusterid": "StandAloneCluster",
"conference": false,
"device": "SEP00A3D1E68CF7",
"dn": "551",
"startDate": 1544608777815,
"tracks": [{
"codec": "G722",
"location": "/common",
"mediaState": "ACTIVE",
"startDate": 1544608777815,
"track": 0,
"type": "AUDIO"
}],
"type": "NEAR_END",
"xRefci": "25576500"
},
{
"clusterid": "StandAloneCluster",
"conference": false,
"device": "SEPBCC49396FF25",
"dn": "206",
"startDate": 1544608777815,
"tracks": [{
"codec": "G722",
"location": "/common",
"mediaState": "ACTIVE",
"startDate": 1544608777815,
"track": 1,
"type": "AUDIO"
}],
"type": "FAR_END",
"xRefci": "25576499"
}
],
"errorDetail": "NO_MEDIA_RECEIVED",
"operationType": "EXISTING",
"recordingServer": "172.16.16.138",
"sessionName": "280167a1db85871",
"sipServer": "172.16.16.138",
"startDate": 1544608777815,
"state": "ERROR",
"version": 10
}}]: Border Message
0000000309: 172.16.16.138: Dec 12 2018 13:30:27.964 +0330: %CCBU_COMMON-6-VSMS HTTP Info: {Thrd=Pool-capture-thread-10} %[HTTP Response Body=<Session>
<diskusage>
<recording name="27f167a1db85311-TRACK0" size="0" repository="/common" />
<recording name="27f167a1db85311-TRACK1" size="0" repository="/common" />
</diskusage>

====================================

thanks

1 Reply 1

i solved my issue.

i must use cisco storage recommendation to installing media sense.