Зарегистрирован: 14 дек 2012 16:31 Сообщения: 86 Откуда: default/city
|
Приветствую всех. С медиантами сталкиваюсь часто, но данная проблема возникла в первые. Ситуация такая: Звоним с FreeSWITCH в город или на локальных абонентов станции LG CS1000 (еще вcтречается название Starex1000) через Mediant 600. Вызов устанавливается нормально, но только на 4-5 секунд, затем происходит разъединение. смущает эта строчка (лог ниже ) Код: 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdex)(8806 ) pstn recv <-- CALL_DISCONNECTED Trunk:0 Conn:0 RetCause:104 NetCause:16 коды отбоя не помгают, так как не дают понять кто разрывает соединение Есть подозрение на неправильные setаp ask на медианте, но вроде у всех остальных работает корректно. Может кто то сталкивался с такой проблемой? лог на медианте такой Код: 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8849 ) SIPCall(#420) changes state from Disconnected to Idle 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8848 ) | | TransactionUserMngr::ReturnSIPCall - #420 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8847 ) Resource SIPMessage deleted - #17 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8846 ) New SIPMessage created - #17 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8845 ) EndPoint channel# 46 ::Active DSP ChannelsCounter (D|A)= 0|0 21.10.2013 13:52,Notice,10.1.59.15,(lgr_media_service)(8844 ) MscmlSignalFeature Returned to Pool ResourceID: 98 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdif)(8843 ) #46:CloseChannel: ChannelNum=46 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdif)(8842 ) #46:cpDigitMapHndlr_Stop - Stoped (0) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8841 ) | #46:LOCAL_CALL_RELEASED_EV 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8840 ) #46:LOCAL_CALL_RELEASED_EV(Trunk:0 Conn:0 Bchannel:17 TpEv=68) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdex)(8839 ) pstn recv <-- CALL_RELEASED Trunk:0 Conn:0 RetCause:104 NetCause:16 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8838 ) Resource SIPMessage deleted - #18 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8837 ) | |(SIPTU#420)200 OK State:Disconnected(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8836 ) UdpRtxMngr::Remove 1 BYE 21.10.2013 13:52,Notice,10.1.59.15,SIP/2.0 200 OK\0x0D\0x0AVia: SIP/2.0/UDP 10.1.59.15;branch=z9hG4bKac984069935\0x0D\0x0AFrom: <sip:984957757575@10.1.59.15:5060>;tag=1c774090402\0x0D\0x0ATo: ""6205060"" <sip:6205060@10.0.2.53>;tag=gyj62H2ZjF39c\0x0D\0x0ACall-ID: e1384be0-b4d8-1231-6a98-b11f18687bc7\0x0D\0x0ACSeq: 1 BYE\0x0D\0x0AUser-Agent: FreeSWITCH-mod_sofia/1.1.beta1-git-\0x0D\0x0AAllow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE\0x0D\0x0ASupported: timer, precondition, path, replaces\0x0D\0x0AContent-Length: 0 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8834 ) ---- Incoming SIP Message from 10.0.2.53:5080 to SIPInterface #0 ---- 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8833 ) New SIPMessage created - #18 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdif)(8832 ) pstn send --> psPSTNReleaseCall() Trunk:0 Conn:0 BChannel:17 Reason:16 rc:0 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8831 ) Resource SIPMessage deleted - #19 21.10.2013 13:52,Notice,10.1.59.15,( lgr_stk_mngr)(8830 ) Resource StackSession <#2> Deleted 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8829 ) Setting ApplicationCall of AcSIPCall 133254452 to NULL 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8828 ) AcSIPStackAPI::FreeCallAPI - #2 21.10.2013 13:52,Notice,10.1.59.15,( lgr_call)(8827 ) delete GW call current active is: 1 21.10.2013 13:52,Notice,10.1.59.15,( lgr_call)(8826 ) (#2) Call DeAllocated. 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8825 ) | | #2:RELEASE_ACK_EV:(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_stk_ses)(8824 ) <SESSION #2> SendToCall - event: RELEASE_ACK_EV m_Call#2 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8823 ) SIPCall(#420) changes state from Connected to Disconnected 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8822 ) \0x0AUdpRtxMngr::Transmit 1 BYE Rtx Left: 6 Dest: 10.0.2.53:5080 CallID: (e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,BYE sip:mod_sofia@10.0.2.53:5080 SIP/2.0\0x0D\0x0AVia: SIP/2.0/UDP 10.1.59.15;branch=z9hG4bKac984069935\0x0D\0x0AMax-Forwards: 70\0x0D\0x0AFrom: <sip:984957757575@10.1.59.15:5060>;tag=1c774090402\0x0D\0x0ATo: ""6205060"" <sip:6205060@10.0.2.53>;tag=gyj62H2ZjF39c\0x0D\0x0ACall-ID: e1384be0-b4d8-1231-6a98-b11f18687bc7\0x0D\0x0ACSeq: 1 BYE\0x0D\0x0ASupported: em,timer,replaces,path,resource-priority\0x0D\0x0AAllow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE\0x0D\0x0AUser-Agent: Audiocodes-Sip-Gateway-Mediant 600/v.6.40A.029.008\0x0D\0x0AReason: Q.850 ;cause=16\0x0D\0x0AContent-Length: 0 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8820 ) ---- Outgoing SIP Message to 10.0.2.53:5080 from SIPInterface #0 ---- 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8819 ) | |(SIPTU#420)DISCONNECT_REQ State:Connected(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8818 ) New SIPMessage created - #19 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8817 ) | | | #2:RELEASE_EV(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8816 ) EndPoint::MediaResourceList::FreeMediaIpPorts Perform dellocation of Media ports for RealmIndex(0) port(6510) current allocations are:(0) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8815 ) | | #2:RELEASE_ACK_EV:(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Info,10.1.59.15,|CALL_END |46 |774278408 |0 |17 |0 |1 |ISDN |RMT |10.0.2.53 |10.1.59.15 |0 |0 |6205060 |6205060 |0 |0 |984957757575 |984957757575 |4 |g711Alaw64k |20 |10.0.2.53 |12040|LCL |GWAPP_NORMAL_CALL_CLEAR |0 |222 |223 |0 |0 |e1384be0-b4d8-1231-6a98-b11f18687bc7 |04:09:11.375 UTC Fri Feb 13 2010 |04:09:19.475 UTC Fri Feb 13 2010 |04:09:24.100 UTC Fri Feb 13 2010 |0 |36 |1274369138 |-1 |-1 |0 |0 | |0 |10.0.2.53 |10.0.2.53 |10.1.59.15 |10.1.59.15 |0 () |10.1.59.15 |6510 | | |NORMAL_CALL_CLEAR| |0 (DefaultSRD) |0 |0 |1 (1) |0 (DefaultRealm) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8813 ) | | #2:Call changing states from:ConnectedState to:DisconnectingState 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8812 ) | | #2:RELEASE_EV:(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8811 ) | #46:RELEASE_EV (send) GWAPP_NORMAL_CALL_CLEAR : (e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdif)(8810 ) #46:StopRTP_RTCP on channel 46 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8809 ) | #46:Close voice Channel 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8808 ) | #46:LOCAL_CALL_DISCONNECTED_EV 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8807 ) #46:LOCAL_CALL_DISCONNECTED_EV(Trunk:0 Conn:0 Bchannel:17 TpEv=67) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdex)(8806 ) pstn recv <-- CALL_DISCONNECTED Trunk:0 Conn:0 RetCause:104 NetCause:16 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8805 ) Resource SIPMessage deleted - #16 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8804 ) | #46:CONNECT_ACK_EV : (e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8803 ) | | #2:CONNECT_ACK_EV:(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_stk_ses)(8802 ) <SESSION #2> SendToCall - event: CONNECT_ACK_EV m_Call#2 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8801 ) | | | #2:SIP_ACK_EV(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8800 ) SIPCall(#420) changes state from LocalAccepted to Connected 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8799 ) | |(SIPTU#420)ACK State:LocalAccepted(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8798 ) UdpRtxMngr::Remove 200 Response 50838411 INVITE 21.10.2013 13:52,Notice,10.1.59.15,ACK sip:1045@10.1.59.15:5060 SIP/2.0\0x0D\0x0AVia: SIP/2.0/UDP 10.0.2.53:5080;rport;branch=z9hG4bKv06jmaj14jcNH\0x0D\0x0AMax-Forwards: 70\0x0D\0x0AFrom: ""6205060"" <sip:6205060@10.0.2.53>;tag=gyj62H2ZjF39c\0x0D\0x0ATo: <sip:984957757575@10.1.59.15:5060>;tag=1c774090402\0x0D\0x0ACall-ID: e1384be0-b4d8-1231-6a98-b11f18687bc7\0x0D\0x0ACSeq: 50838411 ACK\0x0D\0x0AContact: <sip:mod_sofia@10.0.2.53:5080>\0x0D\0x0AContent-Length: 0 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8796 ) ---- Incoming SIP Message from 10.0.2.53:5080 to SIPInterface #0 ---- 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8795 ) New SIPMessage created - #16 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8794 ) Resource SIPMessage deleted - #20 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdif)(8793 ) #46:ActivateChannel:RtpPayload: 8 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdif)(8792 ) Setting ActivateRTP_RTCPCmd.Cmd.IpTosFieldInUdpPacket to 184 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdif)(8791 ) #46:Channel will be open WITH DSP 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdif)(8790 ) Detectors: Amd:On=0,Direction=0, Ans:On=0,Direction=0 En:On=0,Direction=0 Board IBScmd:0xa1 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdif)(8789 ) #46:ConfigFaxModemChannelParams NSEMode=0, CNGDetMode=0, FAXTranType=0, VxxTranType=0, VoiceVol= 0, DTMFVol=-11, InGain=0, RTPRedDepth=0, ECE=1,ECEType=0 SCE=1, ECNlpMode=0, DJBufMinDelay=10, DJBufOptFac=10, Result=1) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdif)(8788 ) ConfigureVbdAndT38:FAXTransportType 0 T38Version:0 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdif)(8787 ) #46:FAXTransportType = 0 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdif)(8786 ) OpenChannel, CoderType = 0, Interval = 3, M = 1 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdif)(8785 ) RFC2833RTPPayloadType: Rx=101 Tx=101 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdif)(8784 ) #46:OpenChannel VoiceVolume= 0, DTMFVolume = -11, InputGain = 0, RTPRedundancyDepth = 0 FlashHookPeriod = 700 AgcCmd = 0x13180000 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdif)(8783 ) #46:OpenChannel:on Trunk 0 BChannel:17 CID=46 with VoiceCoder: g711Alaw64k20 VbdCoder: InvalidCoder255 DetectorSide: 0 FaxModemDet NO_FAX_MODEM_DETECTED 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdif)(8782 ) Open channel: IsVoiceOn: 1, IsT38On: 0, IsVbdOn: 0, IsVideoOn: 0 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdif)(8781 ) #46:ActivateChannel: Socks=13 CID=46 Trunk:0 BChannel:17 RemoteIP=10.0.2.53 RemotePort=12040 RemoteT38IP= RemoteT38Port=0 RemoteRTCPIP= RemoteRTCPPort=0 FaxModemDet=NO_FAX_MODEM_DETECTED T38FaxSessionImmediateStart=0 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdif)(8780 ) activate channel local rtp port:6510, port=12040, BChannel:17, local ip:10.1.59.15, ip=10.0.2.53 (Voice:1,Vbd:0,T38:0,Video:0) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8779 ) | #46:OPEN_VOICE (IP:10.0.2.53, RTP:12040, RTCP:0, VoiceCoder:g711Alaw64k20, VbdCoder: InvalidCoder255, Dtmf:gwRFC2833RalayDTMF,Rx payload:101,Tx payload:101 ,RTPmode:1, FaxTransportType: 0, AVoIPMediaType: gwMediaTypeAudioOnly, T38Version:N/A, FaxMaxBR:0) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8778 ) | #46:OPEN_LOGICAL_CHANNEL_ACK_EV : (e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8777 ) | | #2:OPEN_LOGICAL_CHANNEL_ACK_EV:(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_stk_ses)(8776 ) <SESSION #2> SendToCall - event: OPEN_LOGICAL_CHANNEL_ACK_EV m_Call#2 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8775 ) | | #2:DTMF_CONTROL_EV:(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_stk_ses)(8774 ) <SESSION #2> SendToCall - event: DTMF_CONTROL_EV m_Call#2 21.10.2013 13:52,Notice,10.1.59.15,( lgr_stk_ses)(8773 ) DtmfCapNegotiationAlgorithm :: TxRtpRfc2833Payload = 101 21.10.2013 13:52,Notice,10.1.59.15,( lgr_stk_ses)(8772 ) DtmfCapNegotiationAlgorithm :: TxDtmfMethod = DTMF_RFC2833_SUPPORTED 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8771 ) SIPCall(#420) changes state from Invited to LocalAccepted 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8770 ) \0x0AUdpRtxMngr::Transmit 200 Response 50838411 INVITE Rtx Left: 6 Dest: 10.0.2.53:5080 CallID: (e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,SIP/2.0 200 OK\0x0D\0x0AVia: SIP/2.0/UDP 10.0.2.53:5080;rport;branch=z9hG4bKUQDtjF1X79N2N\0x0D\0x0AFrom: ""6205060"" <sip:6205060@10.0.2.53>;tag=gyj62H2ZjF39c\0x0D\0x0ATo: <sip:984957757575@10.1.59.15:5060>;tag=1c774090402\0x0D\0x0ACall-ID: e1384be0-b4d8-1231-6a98-b11f18687bc7\0x0D\0x0ACSeq: 50838411 INVITE\0x0D\0x0AContact: <sip:1045@10.1.59.15:5060>\0x0D\0x0ASupported: em,timer,replaces,path,resource-priority\0x0D\0x0AAllow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE\0x0D\0x0AServer: Audiocodes-Sip-Gateway-Mediant 600/v.6.40A.029.008\0x0D\0x0AContent-Type: application/sdp\0x0D\0x0AContent-Length: 230\0x0D\0x0A\0x0D\0x0Av=0\0x0D\0x0Ao=AudiocodesGW 774213576 774213236 IN IP4 10.1.59.15\0x0D\0x0As=Phone-Call\0x0D\0x0Ac=IN IP4 10.1.59.15\0x0D\0x0At=0 0\0x0D\0x0Am=audio 6510 RTP/AVP 8 13 101\0x0D\0x0Aa=rtpmap:8 PCMA/8000\0x0D\0x0Aa=rtpmap:101 telephone-event/8000\0x0D\0x0Aa=fmtp:101 0-15\0x0D\0x0Aa=ptime:20\0x0D\0x0Aa=sendrecv 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8768 ) ---- Outgoing SIP Message to 10.0.2.53:5080 from SIPInterface #0 ---- 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8767 ) | |(SIPTU#420)CONNECT_REQ State:Invited(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8766 ) SIPSDPSession#2 - Changing state from SIP_MEDIA_OFFERED to SIP_MEDIA_COMPLETED 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8765 ) New SIPMessage created - #20 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8764 ) | | | #2:CONNECT_EV(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8763 ) | | #2:Call changing states from:AlertingState_IP2Tel to:ConnectedState 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8762 ) | | #2:CONNECT_EV:(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8761 ) | #46:CONNECT_EV (send) : (e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdif)(8760 ) #46:PSOSBoardInterface::StopPlayTone- Called 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8759 ) | #46:OPEN_VOICE-NOT_READY (MS:0, HS:0, Ready:1) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8758 ) | #46:LOCAL_CALL_CONNECTED_EV 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8757 ) #46:LOCAL_CALL_CONNECTED_EV(Trunk:0 Conn:0 Bchannel:17 TpEv=65) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdex)(8756 ) pstn recv <-- CALL_CONNECTED Trunk:0 Conn:0 BChannel:17 Number: 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8747 ) | | #2:PROGRESS_INDICATOR_EV(PI=8)(PC=-1):(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8755 ) Resource SIPMessage deleted - #24 21.10.2013 13:52,Notice,10.1.59.15,SIP/2.0 183 Session Progress\0x0D\0x0AVia: SIP/2.0/UDP 10.0.2.53:5080;rport;branch=z9hG4bKUQDtjF1X79N2N\0x0D\0x0AFrom: ""6205060"" <sip:6205060@10.0.2.53>;tag=gyj62H2ZjF39c\0x0D\0x0ATo: <sip:984957757575@10.1.59.15:5060>;tag=1c774090402\0x0D\0x0ACall-ID: e1384be0-b4d8-1231-6a98-b11f18687bc7\0x0D\0x0ACSeq: 50838411 INVITE\0x0D\0x0AContact: <sip:1045@10.1.59.15:5060>\0x0D\0x0ASupported: em,timer,replaces,path,resource-priority\0x0D\0x0AAllow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE\0x0D\0x0AServer: Audiocodes-Sip-Gateway-Mediant 600/v.6.40A.029.008\0x0D\0x0AContent-Length: 0 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8753 ) ---- Outgoing SIP Message to 10.0.2.53:5080 from SIPInterface #0 ---- 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8752 ) | |(SIPTU#420)ALERT_REQ State:Invited(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8751 ) New SIPMessage created - #24 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8750 ) | | | #2:PROGRESS_EV(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8749 ) | | #2:PROGRESS_EV:(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8748 ) | #46:PROGRESS_EV (send) : (e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8746 ) | #46:PROGRESS_INDICATOR_EV (send) : (e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8745 ) | #46:LOCAL_PROGRESS_INDICATION_EV 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8744 ) #46:LOCAL_PROGRESS_INDICATION_EV(Trunk:0 Conn:0 Bchannel:17 TpEv=72) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdex)(8743 ) recv <-- EV_ISDN_PROGRESS_INDICATION Trunk:0 Conn:0 ProgressInd:8 Cause:255 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8742 ) Resource SIPMessage deleted - #22 21.10.2013 13:52,Notice,10.1.59.15,SIP/2.0 180 Ringing\0x0D\0x0AVia: SIP/2.0/UDP 10.0.2.53:5080;rport;branch=z9hG4bKUQDtjF1X79N2N\0x0D\0x0AFrom: ""6205060"" <sip:6205060@10.0.2.53>;tag=gyj62H2ZjF39c\0x0D\0x0ATo: <sip:984957757575@10.1.59.15:5060>;tag=1c774090402\0x0D\0x0ACall-ID: e1384be0-b4d8-1231-6a98-b11f18687bc7\0x0D\0x0ACSeq: 50838411 INVITE\0x0D\0x0AContact: <sip:1045@10.1.59.15:5060>\0x0D\0x0ASupported: em,timer,replaces,path,resource-priority\0x0D\0x0AAllow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE\0x0D\0x0AServer: Audiocodes-Sip-Gateway-Mediant 600/v.6.40A.029.008\0x0D\0x0AContent-Length: 0 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8740 ) ---- Outgoing SIP Message to 10.0.2.53:5080 from SIPInterface #0 ---- 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8739 ) | |(SIPTU#420)ALERT_REQ State:Invited(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8738 ) New SIPMessage created - #22 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8737 ) | | | #2:ALERT_EV(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8736 ) | | #2:Call changing states from:InitiatedState_IP2Tel to:AlertingState_IP2Tel 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8735 ) | | #2:ALERT_EV:(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8734 ) | #46:ALERT_EV (send) : (e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8733 ) | | #2:PROGRESS_INDICATOR_EV(PI=8)(PC=-1):(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8732 ) | #46:PROGRESS_INDICATOR_EV (send) : (e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8731 ) | #46:LOCAL_ALERTING_EV 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8730 ) #46:LOCAL_ALERTING_EV(Trunk:0 Conn:0 Bchannel:17 TpEv=69) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdex)(8729 ) pstn recv <-- CALL_ALERTING Trunk:0 Conn:0 BChannel:17 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8728 ) Resource SIPMessage deleted - #23 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8727 ) New SIPMessage created - #23 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8726 ) | | | #2:PROCEEDING_EV(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8725 ) | | #2:PROCEEDING_EV:(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8724 ) | #46:PROCEEDING_EV (send) : (e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8723 ) | | #2:PROGRESS_INDICATOR_EV(PI=8)(PC=-1):(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8722 ) | #46:PROGRESS_INDICATOR_EV (send) : (e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8721 ) | #46:LOCAL_CALL_PROCEEDING_EV 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8720 ) #46:LOCAL_CALL_PROCEEDING_EV(Trunk:0 Conn:0 Bchannel:17 TpEv=73) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdex)(8719 ) pstn recv <-- CALL_PROCEEDING Trunk:0 Conn:0 BChannel:17 callhndl:0 Loc:8 Des:0 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8718 ) Resource SIPMessage deleted - #25 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdif)(8717 ) pstn send --> PlaceCall: Trunk:0 BChannel:17 ConnID:0 SrcPN=6205060 SrcSN= DstPN=984957757575 DstSN= SrcNT=0 SrcNP=0 SrcPres=0 SrcScrn=1 DstNT=0 DstNP=0 ServiceCap=M RdrctNum= RdNT=0 RdNP=0 RdPres=0 RdScrn=0 RdRsn=-1 Excl=1 Display=6205060 IE= UUIE=0, RawData:0 CLIRReason:-1 OrigPN= OLI=-1 OffhookInd=0 21.10.2013 13:52,Notice,10.1.59.15,(lgr_media_service)(8716 ) #46:SignalSubscribtionState changing states from:SUBSCRIBTION_STATE_IDLE to:SUBSCRIBTION_STATE_READY 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8715 ) | #46:SETUP_EV : (e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8714 ) | | #2:Call changing states from:NewCallState_IP2Tel to:InitiatedState_IP2Tel 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8713 ) | | #2:SETUP (TO:984957757575, FROM:6205060):(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_stk_ses)(8712 ) <SESSION #2> SendToCall - event: SETUP_EV m_Call#2 21.10.2013 13:52,Notice,10.1.59.15,( lgr_stk_ses)(8711 ) SIPStackSession::HandleStackSetupEV - SETUP: SrcPN=0 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8710 ) Resource SIPMessage deleted - #21 21.10.2013 13:52,Notice,10.1.59.15,SIP/2.0 100 Trying\0x0D\0x0AVia: SIP/2.0/UDP 10.0.2.53:5080;rport;branch=z9hG4bKUQDtjF1X79N2N\0x0D\0x0AFrom: ""6205060"" <sip:6205060@10.0.2.53>;tag=gyj62H2ZjF39c\0x0D\0x0ATo: <sip:984957757575@10.1.59.15:5060>;tag=1c774090402\0x0D\0x0ACall-ID: e1384be0-b4d8-1231-6a98-b11f18687bc7\0x0D\0x0ACSeq: 50838411 INVITE\0x0D\0x0ASupported: em,timer,replaces,path,resource-priority\0x0D\0x0AAllow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,UPDATE\0x0D\0x0AServer: Audiocodes-Sip-Gateway-Mediant 600/v.6.40A.029.008\0x0D\0x0AContent-Length: 0 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8708 ) ---- Outgoing SIP Message to 10.0.2.53:5080 from SIPInterface #0 ---- 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8707 ) New SIPMessage created - #21 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8706 ) | |(SIPTU#420)TRYING_REQ State:Invited(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8705 ) <BaseSIP SDPSESSION #2> UpdateChosenMediaByCN - Force silence suppression on chosen coder, because remote & local support CN 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8704 ) <BaseSIP SDPSESSION #2> UpdateChosenMediaByCN - CN as Remote 1 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8703 ) SIPSDPSession#2 - Changing state from SIP_MEDIA_IDLE to SIP_MEDIA_OFFERED 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8702 ) EndPoint::MediaResourceList::AllocateMediaIpPortsByMediaRealmID Perform NEW allocation of Media ports for RealmIndex(0) port(6510) current allocations are:(1) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8701 ) EndPoint channel# 46 ::Active DSP ChannelsCounter (D|A)= 1|0 21.10.2013 13:52,Notice,10.1.59.15,(lgr_media_service)(8700 ) MscmlSignalFeature Allocated ResourceID: 98 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8699 ) | #46:NEW_CALL_EV : (e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_call)(8698 ) | | #2GetNextUI:GlobalUI=744312814 21.10.2013 13:52,Notice,10.1.59.15,( lgr_call)(8697 ) | | #2GetNextUI:GlobalUI=744312813, mACAddrLsb=4124423 21.10.2013 13:52,Notice,10.1.59.15,( lgr_profiling)(8696 ) <Call 2> Profiled<Tel=1,Ip=1>: JBMinDel=10 JBOptF=10 EEarlyM=0 FaxTM=0 IPDS=46 IsFaxU=0 PI2IP=-1 SigIPDF=40 CNGMode=0 DTMFUsed=0 NSEMode=0 PlayRBTone2IP=0 RBUdpPort=0 RTPRD=0 SCE=0 VxxTT=0 Dst2Rdrt=0 DTMFVol=20 ECE=1 ECurDis=0 EDigDel=0 ERevP=0 FHPer=700 InG=32 MWIA=0 MWID=0 VVol=32 ReorderTime=255 DIDWink=0 2StageDial=1 DiscOnBusyT=1 DiscOnBrok=1 DPInd=-1 AGC=0 NLP=0 21.10.2013 13:52,Notice,10.1.59.15,( lgr_call)(8695 ) <Call #2> Coder g711Ulaw64k20 : 20 21.10.2013 13:52,Notice,10.1.59.15,( lgr_call)(8694 ) <Call #2> Coder g711Alaw64k20 : 20 21.10.2013 13:52,Notice,10.1.59.15,( lgr_call)(8693 ) Call::SetCoderListForCall #2 Found 2 Common Coders For Call 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdif)(8692 ) Current trunks status: 1 21.10.2013 13:52,Notice,10.1.59.15,( lgr_psbrdif)(8691 ) GetTrunkGroupId- TrunkGroup:1 Trunk:-1 found DstNum:984957757575 DstPfx:* SrcNum:6205060 SrcPfx:* SrcIp:a000235 SrcIpPfx:* 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8690 ) ServicesMngr::GetEndPoint PhoneNum = 984957757575 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8689 ) | | #2:Call changing states from:IdleState to:NewCallState_IP2Tel 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8688 ) | | #2:NEW_CALL_EV:(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( lgr_stk_ses)(8687 ) <SESSION #2> SendToCall - event: NEW_CALL_EV m_Call#2 21.10.2013 13:52,Notice,10.1.59.15,( lgr_stk_ses)(8686 ) SIPStackSession::HandleStackSetupEV - NEWCALL: SrcPN=0 21.10.2013 13:52,Notice,10.1.59.15,( lgr_call)(8685 ) (#2) Call Allocated. 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8684 ) | | | #2:SIP_SETUP_EV(e1384be0-b4d8-1231-6a98-b11f18687bc7) 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8683 ) SIPCall(#420) changes state from Idle to Invited 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8682 ) | |(SIPTU#420)INVITE State:Idle() 21.10.2013 13:52,Notice,10.1.59.15,( lgr_stk_mngr)(8681 ) Resource StackSession <#2> Allocated 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8680 ) | | new GetNewSIPCall created - #420 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8679 ) new AcSIPCallAPI created - #2 21.10.2013 13:52,Notice,10.1.59.15,INVITE sip:984957757575@10.1.59.15:5060 SIP/2.0\0x0D\0x0AVia: SIP/2.0/UDP 10.0.2.53:5080;rport;branch=z9hG4bKUQDtjF1X79N2N\0x0D\0x0AMax-Forwards: 68\0x0D\0x0AFrom: ""6205060"" <sip:6205060@10.0.2.53>;tag=gyj62H2ZjF39c\0x0D\0x0ATo: <sip:984957757575@10.1.59.15:5060>\0x0D\0x0ACall-ID: e1384be0-b4d8-1231-6a98-b11f18687bc7\0x0D\0x0ACSeq: 50838411 INVITE\0x0D\0x0AContact: <sip:mod_sofia@10.0.2.53:5080>\0x0D\0x0AUser-Agent: FreeSWITCH-mod_sofia/1.1.beta1-git-\0x0D\0x0AAllow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE\0x0D\0x0ASupported: timer, precondition, path, replaces\0x0D\0x0AAllow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer\0x0D\0x0AContent-Type: application/sdp\0x0D\0x0AContent-Disposition: session\0x0D\0x0AContent-Length: 197\0x0D\0x0AX-FS-Support: update_display,send_info\0x0D\0x0ARemote-Party-ID: ""6205060"" <sip:6205060@10.0.2.53>;party=calling;screen=yes;privacy=off\0x0D\0x0A\0x0D\0x0Av=0\0x0D\0x0Ao=FreeSWITCH 1382336911 1382336912 IN IP4 10.0.2.53\0x0D\0x0As=FreeSWITCH\0x0D\0x0Ac=IN IP4 10.0.2.53\0x0D\0x0At=0 0\0x0D\0x0Am=audio 12040 R 21.10.2013 13:52,Notice,10.1.59.15,( lgr_flow)(8677 ) ---- Incoming SIP Message from 10.0.2.53:5080 to SIPInterface #0 ---- 21.10.2013 13:52,Notice,10.1.59.15,( sip_stack)(8676 ) New SIPMessage created - #25
На FS я вижу что отбой приходит от медианта, но пока считаю что это не показатель.
|
|