VoiceFlex sometime fails to connect-488 Not acceptable here

Discussion in '3CX Phone System - General' started by tkirke, May 10, 2010.

Thread Status:
Not open for further replies.
  1. tkirke

    Joined:
    May 6, 2010
    Messages:
    5
    Likes Received:
    0
    Our 3CX server sometimes starts reporting errors when trying to connect an outgoing or incoming call. We are using VoiceFlex and this problem occurs intermittently. Sometimes it fixes itself, sometimes I have to restart 3CX.

    Is the problem with 3CX or VoiceFlex? VoiceFlex haven't been able to find any problems at their end.

    This is an example of the log

    15:28:31.500 [CM503020]: Normal call termination. Reason: Server Failure 15:28:31.500 [CM503016]: Call(5): Attempt to reach <sip:90208541xxxx@193.255.1.27> failed. Reason: Not Implemented
    15:28:31.500 [CM503003]: Call(5): Call to sip:0208541xxxx@146.101.248.200:5060 has failed; Cause: 488 Not
    acceptable here; from IP:146.101.248.200:5060
    15:28:31.328 [CM503025]: Call(5): Calling oIPline:0208541xxxx@(Ln.10002@VoiceFlex)@[Dev:sip:xxxxxxxx@146.101.248.
    200:5060]
    15:28:31.328 [MS210002] C:5.2:Offer provided. Connection(transcoding mode): 89.145.219.71:13154(13155)
    15:28:31.235 [CM503004]: Call(5): Route 1: VoIPline:0208541xxxx@(Ln.10002@VoiceFlex)@[Dev:sip:xxxxxxxx@146.101.248.200:5060]
    15:28:31.235 [CM503010]: Making route(s) to <sip:90208541xxxx@193.255.1.27>
    15:28:31.235 [MS210000] C:5.1:Offer received. RTP connection:
    193.255.1.38:16444(16445)
    15:28:31.235 Remote SDP is set for legC:5.1
    15:28:31.235 [CM505001]: Ext.50: Device info: Device Identified: [Man:
    Cisco;Mod: SPA Series;Rev: General] Capabilities:[reinvite, replaces,
    unable-no-sdp, no-recvonly] UserAgent: [Cisco/SPA502G-7.4.4] PBX
    contact:
    [sip:50@193.255.1.27:5060]
    15:28:31.235 [CM503001]: Call(5): Incoming call from Ext.50 to
    <sip:90208541xxxx@193.255.1.27>
    15:28:31.235 [CM500002]: Info on incoming INVITE:
    INVITE sip:90208541xxxx@193.255.1.27:5060 SIP/2.0
    Via: SIP/2.0/UDP 193.255.1.38:5060;branch=z9hG4bK-f8292b06
    Max-Forwards: 70
    Contact: "Joe Bloggs"<sip:50@193.255.1.38:5060>
    To: <sip:90208541xxxx@193.255.1.27>
    From: "Joe Bloggs"<sip:50@193.255.1.27>;tag=88d29bc8970fdd42o0
    Call-ID: e45beac0-1fa21aaa@193.255.1.38
    CSeq: 102 INVITE
    Expires: 240
    Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER, UPDATE
    Proxy-Authorization: Digest
    username="50",realm="3CXPhoneSystem",nonce="414d535c01f8a90f01:c8896cb11
    3653be7dc64a69270168336",uri="sip:90208541xxxx@193.255.1.27:5060",algori
    thm=MD5,response="3506986248e48e3202182516bce66114"
    Supported: replaces
    User-Agent: Cisco/SPA502G-7.4.4
    Content-Length: 0
     
  2. SY

    SY Well-Known Member
    3CX Support

    Joined:
    Jan 26, 2007
    Messages:
    1,825
    Likes Received:
    2
    Re: 3CX sometime fails to connect - 488 Not acceptable here

    1. Please specify version of 3cx and license type
    2. Log of successful call (from console) AND 3CXMediaserver.trace.log (or just wireshark capture of the call)
    3. Log of unsuccessful call (from console) AND 3CXMediaserver.trace.log (or wireshark capture of the call)

    Thanks
     
    Stop hovering to collapse... Click to collapse... Hover to expand... Click to expand...
  3. tkirke

    Joined:
    May 6, 2010
    Messages:
    5
    Likes Received:
    0
    VoiceFlex. sometime fails to connect - 488 Not acceptable he

    The version that I have is the latest available on your web site - 8.0.10824.716. We are currently using the Free licence. We will consider purchasing a licence once we are confident that this system will work reliably. I have another outstand message thread regarding the daily 3CX crashes that we are getting.

    Here are the logs:

    Successfull call:

    3CXPhoneSystemLog

    INVITE sip:902085412746@193.255.1.27:5060 SIP/2.0
    Via: SIP/2.0/UDP 193.255.1.38:5060;branch=z9hG4bK-ce92e438
    Max-Forwards: 70
    Contact: "Tony Kirke"<sip:50@193.255.1.38:5060>
    To: <sip:902085412746@193.255.1.27>
    From: "Tony Kirke"<sip:50@193.255.1.27>;tag=cef3d4184ea4d0e0o0
    Call-ID: 1fda1e78-bd3c0a00@193.255.1.38
    CSeq: 102 INVITE
    Expires: 240
    Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER, UPDATE
    Proxy-Authorization: Digest username="50",realm="3CXPhoneSystem",nonce="414d535c01f9ac6985:3d75c4505c7caf65e827189692f2e0ba",uri="sip:902085412746@193.255.1.27:5060",algorithm=MD5,response="0c81e770c6d37f30f113999c6c1685f0"
    Supported: replaces
    User-Agent: Cisco/SPA502G-7.4.4
    Content-Length: 0

    <br>
    09:55:05.249|.\CallCtrl.cpp(161)|Log2||CallCtrl::eek:nIncomingCall:[CM503001]: Call(19): Incoming call from Ext.50 to <sip:902085412746@193.255.1.27><br>
    09:55:05.249|.\Extension.cpp(1067)|Log3||Extension::printEndpointInfo:[CM505001]: Ext.50: Device info: Device Identified: [Man: Cisco;Mod: SPA Series;Rev: General] Capabilities:[reinvite, replaces, unable-no-sdp, no-recvonly] UserAgent: [Cisco/SPA502G-7.4.4] PBX contact: [sip:50@193.255.1.27:5060]<br>
    09:55:05.249|.\CallLeg.cpp(951)|Log5||CallLeg::setRemoteSdp:Remote SDP is set for legC:19.1<br>
    09:55:05.249|.\SLServer.cpp(794)|Log5|MediaServer|MediaServerReporting::SetRemoteParty:[MS210000] C:19.1:Offer received. RTP connection: 193.255.1.38:16464(16465)<br>
    09:55:05.249|.\CallCtrl.cpp(331)|Log3||CallCtrl::eek:nSelectRouteReq:[CM503010]: Making route(s) to <sip:902085412746@193.255.1.27><br>
    09:55:05.249|.\CallCtrl.cpp(446)|Log2||CallCtrl::eek:nSelectRouteReq:[CM503004]: Call(19): Route 1: VoIPline:02085412746@(Ln.10002@VoiceFlex)@[Dev:sip:84417010@146.101.248.200:5060]<br>
    09:55:05.343|.\SLServer.cpp(794)|Log5|MediaServer|MediaServerReporting::SetRemoteParty:[MS210002] C:19.2:Offer provided. Connection(transcoding mode): 89.145.219.71:13422(13423)<br>
    09:55:05.343|.\Target.cpp(430)|Log2||Target::makeOneInvite:[CM503025]: Call(19): Calling VoIPline:02085412746@(Ln.10002@VoiceFlex)@[Dev:sip:84417010@146.101.248.200:5060]<br>



    3CXMedaServer.trace.log

    09:55:05.249|.\MSEndPoint.cpp(760)|Trace5||??:00000046@: RTP bind address 193.255.1.27:7078
    09:55:05.249|.\MSEndPoint.cpp(771)|Trace5||??:00000046@: RTCP bind address 193.255.1.27:7079
    09:55:05.249|.\MediaServer.cpp(815)|Trace5||??:EndPoint created: (destination=193.255.1.38)
    EndPoint: ID=00000046@(LOCAL)
    LOGID=C:19.1 Status: MSEP_LOCAL
    RTP:193.255.1.27:7078
    RTCP:193.255.1.27:7079
    STUN RTP:0.0.0.0:0
    STUN RTCP:0.0.0.0:0
    Coder:
    NOT SET
    101:telephony-event
    Party ptime:20
    Party RTP:0.0.0.0:0
    Party RTCP:0.0.0.0:0
    Decoders:
    <empty>

    09:55:05.249|.\MediaServer.cpp(1260)|Trace5||??:EP 00000046@ joined to call 19
    09:55:05.249|.\MediaServer.cpp(1269)|Trace5||??:starting send on new call 19
    09:55:05.249|.\MediaServer.cpp(912)|Trace5||??:Set Party EP:C:19.1SDP:v=0
    o=- 59450265 59450265 IN IP4 193.255.1.38
    s=-
    c=IN IP4 193.255.1.38
    t=0 0
    m=audio 16464 RTP/AVP 0 2 8 9 18 96 97 98 101
    a=rtpmap:0 PCMU/8000
    a=rtpmap:2 G726-32/8000
    a=rtpmap:8 PCMA/8000
    a=rtpmap:9 G722/8000
    a=rtpmap:18 G729a/8000
    a=rtpmap:96 G726-40/8000
    a=rtpmap:97 G726-24/8000
    a=rtpmap:98 G726-16/8000
    a=rtpmap:101 telephone-event/8000
    a=fmtp:101 0-15
    a=ptime:20
    a=sendrecv

    09:55:05.249|.\MSEndPoint.cpp(2949)|Trace5||??:New state00000046@ SILENCE
    09:55:05.249|.\MSEndPoint.cpp(1691)|Trace5||??:partyAddrRTP_ is set to 193.255.1.38:16464
    09:55:05.249|.\MSEndPoint.cpp(1692)|Trace5||??:partyAddrRTCP_ is set to 193.255.1.38:16465
    09:55:05.249|.\MSEndPoint.cpp(1914)|Log2||??:[MS210000] C:19.1:Offer received. RTP connection: 193.255.1.38:16464(16465)
    09:55:05.343|.\MSEndPoint.cpp(1007)|Trace5||??:Source ports: 9010 STUN RTP:89.145.219.71:13422 RTCP:89.145.219.71:13423 mapped to 89.145.219.71, ports 13422,13423
    09:55:05.343|.\MediaServer.cpp(815)|Trace5||??:EndPoint created: (destination=146.101.248.200)
    EndPoint: ID=00000047@(EXTERNAL)
    LOGID=C:19.2 Status: MSEP_STUN
    RTP:89.145.219.71:13422
    RTCP:89.145.219.71:13423
    STUN RTP:89.145.219.71:13422
    STUN RTCP:89.145.219.71:13423
    Coder:
    NOT SET
    101:telephony-event
    Party ptime:20
    Party RTP:0.0.0.0:0
    Party RTCP:0.0.0.0:0
    Decoders:
    <empty>

    09:55:05.343|.\MediaServer.cpp(1260)|Trace5||??:EP 00000047@ joined to call 19
    09:55:05.343|.\MediaServer.cpp(1305)|Trace5||??:EndPoint 00000047@ removed from call 19
    09:55:05.343|.\MediaServer.cpp(1260)|Trace5||??:EP 00000047@ joined to call 19
    09:55:05.343|.\MSEndPoint.cpp(1403)|Log2||??:[MS210002] C:19.2:Offer provided. Connection(transcoding mode): 89.145.219.71:13422(13423)
    09:55:05.343|.\MediaServer.cpp(850)|Trace5||??:Get Local SDP. EP:C:19.2SDP:v=0
    o=3cxPS 473872465920 108213043201 IN IP4 89.145.219.71
    s=3cxPS Audio call
    c=IN IP4 89.145.219.71
    t=0 0
    m=audio 13422 RTP/AVP 0 8 101
    c=IN IP4 89.145.219.71
    a=rtpmap:0 PCMU/8000
    a=rtpmap:8 PCMA/8000
    a=rtpmap:101 telephone-event/8000
    a=sendrecv

    09:55:05.343|.\MediaServer.cpp(1305)|Trace5||??:EndPoint 00000047@ removed from call 19
    09:55:06.232|.\MSEndPoint.cpp(1007)|Trace5||??:Source ports: 9012 STUN RTP:89.145.219.71:13424 RTCP:89.145.219.71:13425 mapped to 89.145.219.71, ports 13424,13425
    09:55:06.232|.\MediaServer.cpp(815)|Trace5||??:EndPoint created: (destination=146.101.248.200)
    EndPoint: ID=00000048@(EXTERNAL)
    LOGID=C:20.1 Status: MSEP_STUN
    RTP:89.145.219.71:13424
    RTCP:89.145.219.71:13425
    STUN RTP:89.145.219.71:13424
    STUN RTCP:89.145.219.71:13425
    Coder:
    NOT SET
    101:telephony-event
    Party ptime:20
    Party RTP:0.0.0.0:0
    Party RTCP:0.0.0.0:0
    Decoders:
    <empty>

    09:55:06.232|.\MediaServer.cpp(1260)|Trace5||??:EP 00000048@ joined to call 20
    09:55:06.232|.\MediaServer.cpp(1269)|Trace5||??:starting send on new call 20
    09:55:06.232|.\MediaServer.cpp(912)|Trace5||??:Set Party EP:C:20.1SDP:v=0
    o=root 14580 14580 IN IP4 146.101.248.200
    s=session
    c=IN IP4 146.101.248.200
    t=0 0
    m=audio 28052 RTP/AVP 0 8 18 101
    a=rtpmap:0 PCMU/8000
    a=rtpmap:8 PCMA/8000
    a=rtpmap:18 G729/8000
    a=fmtp:18 annexb=no
    a=rtpmap:101 telephone-event/8000
    a=fmtp:101 0-16
    a=silenceSupp:eek:ff - - - -
    a=ptime:20
    a=sendrecv

    09:55:06.232|.\MSEndPoint.cpp(2949)|Trace5||??:New state00000048@ SILENCE
    09:55:06.232|.\MSEndPoint.cpp(1691)|Trace5||??:partyAddrRTP_ is set to 146.101.248.200:28052
    09:55:06.232|.\MSEndPoint.cpp(1692)|Trace5||??:partyAddrRTCP_ is set to 146.101.248.200:28053
    09:55:06.232|.\MSEndPoint.cpp(1914)|Log2||??:[MS210000] C:20.1:Offer received. RTP connection: 146.101.248.200:28052(28053)
    09:55:06.263|.\MSEndPoint.cpp(760)|Trace5||??:00000049@: RTP bind address 193.255.1.27:7080
    09:55:06.263|.\MSEndPoint.cpp(771)|Trace5||??:00000049@: RTCP bind address 193.255.1.27:7081
    09:55:06.263|.\MediaServer.cpp(815)|Trace5||??:EndPoint created: (destination=193.255.1.39)
    EndPoint: ID=00000049@(LOCAL)
    LOGID=C:20.2 Status: MSEP_LOCAL
    RTP:193.255.1.27:7080
    RTCP:193.255.1.27:7081
    STUN RTP:0.0.0.0:0
    STUN RTCP:0.0.0.0:0
    Coder:
    NOT SET
    101:telephony-event
    Party ptime:20
    Party RTP:0.0.0.0:0
    Party RTCP:0.0.0.0:0
    Decoders:
    <empty>

    09:55:06.263|.\MediaServer.cpp(1260)|Trace5||??:EP 00000049@ joined to call 20
    09:55:06.263|.\MediaServer.cpp(1305)|Trace5||??:EndPoint 00000049@ removed from call 20
    09:55:06.263|.\MediaServer.cpp(1260)|Trace5||??:EP 00000049@ joined to call 20
    09:55:06.263|.\MSEndPoint.cpp(1403)|Log2||??:[MS210002] C:20.2:Offer provided. Connection(transcoding mode): 193.255.1.27:7080(7081)
    09:55:06.263|.\MediaServer.cpp(850)|Trace5||??:Get Local SDP. EP:C:20.2SDP:v=0
    o=3cxPS 526083162112 19931332609 IN IP4 193.255.1.27
    s=3cxPS Audio call
    c=IN IP4 193.255.1.27
    t=0 0
    m=audio 7080 RTP/AVP 0 8 3 13 110 99 101
    c=IN IP4 193.255.1.27
    a=rtpmap:0 PCMU/8000
    a=rtpmap:8 PCMA/8000
    a=rtpmap:3 GSM/8000
    a=rtpmap:13 CN/8000
    a=rtpmap:110 iLBC/8000
    a=rtpmap:99 SPEEX/8000
    a=rtpmap:101 telephone-event/8000
    a=sendrecv

    09:55:06.263|.\MediaServer.cpp(1305)|Trace5||??:EndPoint 00000049@ removed from call 20
    09:55:07.137|.\MediaServer.cpp(1305)|Trace5||??:EndPoint 00000046@ removed from call 19
    09:55:07.137|.\MediaServer.cpp(1065)|Trace5||??:references to EndPoint 00000046@ were removed
    09:55:07.262|.\MediaServer.cpp(1065)|Trace5||??:references to EndPoint 00000047@ were removed
    09:55:07.262|.\MediaServer.cpp(1383)|Trace5||??:references to call 19 were removed
    09:55:07.278|.\MSCallConf.cpp(36)|Trace5||??:Call: 19 destroyed
    09:55:07.294|.\MSEndPoint.cpp(847)|Trace5||??:EndPoint 00000047@ destroyed
    09:55:07.294|.\MSEndPoint.cpp(848)|Trace5||??:EndPoint 00000047@ destroyed statistics:
    Begin send:0
    LastSent:0
    TotalSent:0
    MaxSendInterval:0
    MinSendInterval:0
    AvgSendInterval:0
    SendDeviation:0
    Begin recv:0
    Last recv:0
    TotalRecv:0
    MaxRecvInterval:0
    MinRecvInterval:0
    AvgRecvInterval:0
    ReceiveDeviation:0

    09:55:07.481|.\MediaServer.cpp(1305)|Trace5||??:EndPoint 00000048@ removed from call 20
    09:55:07.481|.\MediaServer.cpp(1065)|Trace5||??:references to EndPoint 00000049@ were removed
    09:55:07.481|.\MediaServer.cpp(1065)|Trace5||??:references to EndPoint 00000048@ were removed
    09:55:07.481|.\MediaServer.cpp(1383)|Trace5||??:references to call 20 were removed
    09:55:07.496|.\MSCallConf.cpp(36)|Trace5||??:Call: 20 destroyed
    09:55:07.793|.\MSEndPoint.cpp(847)|Trace5||??:EndPoint 00000048@ destroyed
    09:55:07.793|.\MSEndPoint.cpp(848)|Trace5||??:EndPoint 00000048@ destroyed statistics:
    Begin send:0
    LastSent:0
    TotalSent:0
    MaxSendInterval:0
    MinSendInterval:0
    AvgSendInterval:0
    SendDeviation:0
    Begin recv:0
    Last recv:0
    TotalRecv:0
    MaxRecvInterval:0
    MinRecvInterval:0
    AvgRecvInterval:0
    ReceiveDeviation:0

    09:55:07.965|.\MSEndPoint.cpp(847)|Trace5||??:EndPoint 00000049@ destroyed
    09:55:07.965|.\MSEndPoint.cpp(848)|Trace5||??:EndPoint 00000049@ destroyed statistics:
    Begin send:0
    LastSent:0
    TotalSent:0
    MaxSendInterval:0
    MinSendInterval:0
    AvgSendInterval:0
    SendDeviation:0
    Begin recv:0
    Last recv:0
    TotalRecv:0
    MaxRecvInterval:0
    MinRecvInterval:0
    AvgRecvInterval:0
    ReceiveDeviation:0

    09:55:08.433|.\MSEndPoint.cpp(847)|Trace5||??:EndPoint 00000046@ destroyed
    09:55:08.433|.\MSEndPoint.cpp(848)|Trace5||??:EndPoint 00000046@ destroyed statistics:
    Begin send:0
    LastSent:0
    TotalSent:0
    MaxSendInterval:0
    MinSendInterval:0
    AvgSendInterval:0
    SendDeviation:0
    Begin recv:0
    Last recv:0
    TotalRecv:0
    MaxRecvInterval:0
    MinRecvInterval:0
    AvgRecvInterval:0
    ReceiveDeviation:0




    Failed Call

    3CXPhoneSystemLog

    08:39:18.711|.\CallLeg.cpp(123)|Log5||CallLeg::eek:nNewCall:[CM500002]: Info on incoming INVITE:
    INVITE sip:902085412746@193.255.1.27:5060 SIP/2.0
    Via: SIP/2.0/UDP 193.255.1.38:5060;branch=z9hG4bK-ca07f9fe
    Max-Forwards: 70
    Contact: "Tony Kirke"<sip:50@193.255.1.38:5060>
    To: <sip:902085412746@193.255.1.27>
    From: "Tony Kirke"<sip:50@193.255.1.27>;tag=ae58853e86117239o0
    Call-ID: 6eece162-cd4a2465@193.255.1.38
    CSeq: 102 INVITE
    Expires: 240
    Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER, UPDATE
    Proxy-Authorization: Digest username="50",realm="3CXPhoneSystem",nonce="414d535c01f99aa605:37127981c1a81f1547c610f9ac369a85",uri="sip:902085412746@193.255.1.27:5060",algorithm=MD5,response="893b482b52dff1e27f05450e16ea22d4"
    Supported: replaces
    User-Agent: Cisco/SPA502G-7.4.4
    Content-Length: 0

    <br>
    08:39:18.727|.\CallCtrl.cpp(161)|Log2||CallCtrl::eek:nIncomingCall:[CM503001]: Call(3): Incoming call from Ext.50 to <sip:902085412746@193.255.1.27><br>
    08:39:18.727|.\Extension.cpp(1067)|Log3||Extension::printEndpointInfo:[CM505001]: Ext.50: Device info: Device Identified: [Man: Cisco;Mod: SPA Series;Rev: General] Capabilities:[reinvite, replaces, unable-no-sdp, no-recvonly] UserAgent: [Cisco/SPA502G-7.4.4] PBX contact: [sip:50@193.255.1.27:5060]<br>
    08:39:18.727|.\CallLeg.cpp(951)|Log5||CallLeg::setRemoteSdp:Remote SDP is set for legC:3.1<br>
    08:39:18.727|.\SLServer.cpp(794)|Log5|MediaServer|MediaServerReporting::SetRemoteParty:[MS210000] C:3.1:Offer received. RTP connection: 193.255.1.38:16454(16455)<br>
    08:39:18.727|.\CallCtrl.cpp(331)|Log3||CallCtrl::eek:nSelectRouteReq:[CM503010]: Making route(s) to <sip:902085412746@193.255.1.27><br>
    08:39:18.727|.\CallCtrl.cpp(446)|Log2||CallCtrl::eek:nSelectRouteReq:[CM503004]: Call(3): Route 1: VoIPline:02085412746@(Ln.10002@VoiceFlex)@[Dev:sip:84417010@146.101.248.200:5060]<br>
    08:39:18.805|.\SLServer.cpp(794)|Log5|MediaServer|MediaServerReporting::SetRemoteParty:[MS210002] C:3.2:Offer provided. Connection(transcoding mode): 89.145.219.71:13364(13365)<br>
    08:39:18.805|.\Target.cpp(430)|Log2||Target::makeOneInvite:[CM503025]: Call(3): Calling VoIPline:02085412746@(Ln.10002@VoiceFlex)@[Dev:sip:84417010@146.101.248.200:5060]<br>
    08:39:18.883|.\CallLeg.cpp(268)|Log2||CallLeg::eek:nFailure:[CM503003]: Call(3): Call to sip:02085412746@146.101.248.200:5060 has failed; Cause: 488 Not acceptable here; from IP:146.101.248.200:5060<br>
    08:39:18.883|.\Call.cpp(774)|Log2||Call::RouteFailed:[CM503016]: Call(3): Attempt to reach <sip:902085412746@193.255.1.27> failed. Reason: Not Implemented<br>
    08:39:18.883|.\Call.cpp(433)|Log2||Call::DoEndCall:[CM503020]: Normal call termination. Reason: Server Failure<br>



    3CXMedaServer.trace.log

    08:39:18.711|.\MSEndPoint.cpp(760)|Trace5||??:00000025@: RTP bind address 193.255.1.27:7042
    08:39:18.711|.\MSEndPoint.cpp(771)|Trace5||??:00000025@: RTCP bind address 193.255.1.27:7043
    08:39:18.711|.\MediaServer.cpp(815)|Trace5||??:EndPoint created: (destination=193.255.1.38)
    EndPoint: ID=00000025@(LOCAL)
    LOGID=C:3.1 Status: MSEP_LOCAL
    RTP:193.255.1.27:7042
    RTCP:193.255.1.27:7043
    STUN RTP:0.0.0.0:0
    STUN RTCP:0.0.0.0:0
    Coder:
    NOT SET
    101:telephony-event
    Party ptime:20
    Party RTP:0.0.0.0:0
    Party RTCP:0.0.0.0:0
    Decoders:
    <empty>

    08:39:18.727|.\MediaServer.cpp(1260)|Trace5||??:EP 00000025@ joined to call 3
    08:39:18.727|.\MediaServer.cpp(1269)|Trace5||??:starting send on new call 3
    08:39:18.727|.\MediaServer.cpp(912)|Trace5||??:Set Party EP:C:3.1SDP:v=0
    o=- 58995680 58995680 IN IP4 193.255.1.38
    s=-
    c=IN IP4 193.255.1.38
    t=0 0
    m=audio 16454 RTP/AVP 0 2 8 9 18 96 97 98 101
    a=rtpmap:0 PCMU/8000
    a=rtpmap:2 G726-32/8000
    a=rtpmap:8 PCMA/8000
    a=rtpmap:9 G722/8000
    a=rtpmap:18 G729a/8000
    a=rtpmap:96 G726-40/8000
    a=rtpmap:97 G726-24/8000
    a=rtpmap:98 G726-16/8000
    a=rtpmap:101 telephone-event/8000
    a=fmtp:101 0-15
    a=ptime:20
    a=sendrecv

    08:39:18.727|.\MSEndPoint.cpp(2949)|Trace5||??:New state00000025@ SILENCE
    08:39:18.727|.\MSEndPoint.cpp(1691)|Trace5||??:partyAddrRTP_ is set to 193.255.1.38:16454
    08:39:18.727|.\MSEndPoint.cpp(1692)|Trace5||??:partyAddrRTCP_ is set to 193.255.1.38:16455
    08:39:18.727|.\MSEndPoint.cpp(1914)|Log2||??:[MS210000] C:3.1:Offer received. RTP connection: 193.255.1.38:16454(16455)
    08:39:18.805|.\MSEndPoint.cpp(1007)|Trace5||??:Source ports: 9030 STUN RTP:89.145.219.71:13364 RTCP:89.145.219.71:13365 mapped to 89.145.219.71, ports 13364,13365
    08:39:18.805|.\MediaServer.cpp(815)|Trace5||??:EndPoint created: (destination=146.101.248.200)
    EndPoint: ID=00000026@(EXTERNAL)
    LOGID=C:3.2 Status: MSEP_STUN
    RTP:89.145.219.71:13364
    RTCP:89.145.219.71:13365
    STUN RTP:89.145.219.71:13364
    STUN RTCP:89.145.219.71:13365
    Coder:
    NOT SET
    101:telephony-event
    Party ptime:20
    Party RTP:0.0.0.0:0
    Party RTCP:0.0.0.0:0
    Decoders:
    <empty>

    08:39:18.805|.\MediaServer.cpp(1260)|Trace5||??:EP 00000026@ joined to call 3
    08:39:18.805|.\MediaServer.cpp(1305)|Trace5||??:EndPoint 00000026@ removed from call 3
    08:39:18.805|.\MediaServer.cpp(1260)|Trace5||??:EP 00000026@ joined to call 3
    08:39:18.805|.\MSEndPoint.cpp(1403)|Log2||??:[MS210002] C:3.2:Offer provided. Connection(transcoding mode): 89.145.219.71:13364(13365)
    08:39:18.805|.\MediaServer.cpp(850)|Trace5||??:Get Local SDP. EP:C:3.2SDP:v=0
    o=3cxPS 404700004352 334839676929 IN IP4 89.145.219.71
    s=3cxPS Audio call
    c=IN IP4 89.145.219.71
    t=0 0
    m=audio 13364 RTP/AVP 0 8 101
    c=IN IP4 89.145.219.71
    a=rtpmap:0 PCMU/8000
    a=rtpmap:8 PCMA/8000
    a=rtpmap:101 telephone-event/8000
    a=sendrecv

    08:39:18.805|.\MediaServer.cpp(1305)|Trace5||??:EndPoint 00000026@ removed from call 3
    08:39:18.883|.\MediaServer.cpp(1065)|Trace5||??:references to EndPoint 00000026@ were removed
    08:39:18.945|.\MediaServer.cpp(1305)|Trace5||??:EndPoint 00000025@ removed from call 3
    08:39:18.945|.\MediaServer.cpp(1065)|Trace5||??:references to EndPoint 00000025@ were removed
    08:39:18.945|.\MediaServer.cpp(1383)|Trace5||??:references to call 3 were removed
    08:39:18.945|.\MSCallConf.cpp(36)|Trace5||??:Call: 3 destroyed
    08:39:20.412|.\MSEndPoint.cpp(847)|Trace5||??:EndPoint 00000026@ destroyed
    08:39:20.412|.\MSEndPoint.cpp(848)|Trace5||??:EndPoint 00000026@ destroyed statistics:
    Begin send:0
    LastSent:0
    TotalSent:0
    MaxSendInterval:0
    MinSendInterval:0
    AvgSendInterval:0
    SendDeviation:0
    Begin recv:0
    Last recv:0
    TotalRecv:0
    MaxRecvInterval:0
    MinRecvInterval:0
    AvgRecvInterval:0
    ReceiveDeviation:0

    08:39:20.475|.\MSEndPoint.cpp(847)|Trace5||??:EndPoint 00000025@ destroyed
    08:39:20.475|.\MSEndPoint.cpp(848)|Trace5||??:EndPoint 00000025@ destroyed statistics:
    Begin send:0
    LastSent:0
    TotalSent:0
    MaxSendInterval:0
    MinSendInterval:0
    AvgSendInterval:0
    SendDeviation:0
    Begin recv:0
    Last recv:0
    TotalRecv:0
    MaxRecvInterval:0
    MinRecvInterval:0
    AvgRecvInterval:0
    ReceiveDeviation:0
     
  4. SY

    SY Well-Known Member
    3CX Support

    Joined:
    Jan 26, 2007
    Messages:
    1,825
    Likes Received:
    2
    VoiceFlex sometime fails to connect - 488 Not acceptable her

    I think you need to ask VoIP provider for help to troubleshoot this issue.
    488 response means that the SDP which was offered by PBX is not acceptable by remote party(VoIP provider)

    But both offers are the same.

    Thanks for information
     
    Stop hovering to collapse... Click to collapse... Hover to expand... Click to expand...
Thread Status:
Not open for further replies.