Hi all,
I am using SIPml5 client and Kamailio server integrated with FreeSWITCH ( behind NAT box ), according to this tutorial: http://kb.asipto.com/freeswitch:kamailio-3.3.x-freeswitch-1.2.x-sbc ( let's say setup A )
In setup A where I have the issue, I use proxy via Kamailio:
SIPml5 ---(WS)---> Kamailio --(SIP)---> FreeSWITCH - NOT OK: no audio from some remote endpoint
Also, I have another setup at the same location, FS 1.5 only (setup B)
In setup B, I don't have Kamailio:
SIPml5 ---(WS)---> FS - OK: two-way-audio
Joining to the conference from some remote location to setup B is always OK - I am getting two-way-audio.
The issue is: when I try to join to the conference from the same remote location to setup A, I have no audio. From some other location, there is no issue even with setup A, I can get two-way-audio.
In the non-working case, I see 'ice not ready' alert message in FS logs.
I compared both working and non-working FS/Kamailio traces and couldn't figure out what is wrong.
Can someone take a look and give some guidance what I am missing here ?
P.S.
Below you can find all traces I have captured: Kamailio log, FreeSWITCH log Javascript console output from my SIPml5 client . Also, my kamailio.cfg file is provided at the bottom of this mail.
Here is the Kamailio log for non- working case (setup A - SIPml5 client is registered to Kamailio server which is integrated with FS as media bridge ):
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [tcp_read.c:1138]: ws_process_msg(): WebSocket Message: [[>>>#012þ#011‡•Ë. Ü…xiÁŽ#016Sü»#024#024¦ø#036#020¥‹XOç¿KX¥ú<<<]]
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: websocket [ws_frame.c:416]: decode_and_validate_ws_frame(): decoding WebSocket frame
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: websocket [ws_frame.c:466]: decode_and_validate_ws_frame(): supported non-control frame: 0x1
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: websocket [ws_frame.c:570]: decode_and_validate_ws_frame(): Rx (decoded): INVITE sip:433000@vortex01.no-ip.info SIP/2.0#015#012Via: SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKQSpSg19BFUmPZ729UreSaMctEhwdUTqs;rport#015#012From: "1001"<sip:1001@vortex01.no-ip.info>;tag=rCt6oAuZ6fw6EPxELT8r#015#012To: <sip:433000@vortex01.no-ip.info>#015#012Contact: "1001"<sip:1001@df7jal23ls0d.invalid;rtcweb-breaker=no;click2call=no;transport=ws>;+g.oma.sip-im;+sip.ice;language="en,fr"#015#012Call-ID: 5c230def-fd72-d5ac-c1a2-5fe5d60695d5#015#012CSeq: 63063 INVITE#015#012Content-Type: application/sdp#015#012Content-Length: 1848#015#012Max-Forwards: 70#015#012User-Agent: IM-client/OMA1.0 sipML5-v1.2014.01.27#015#012Organization: Vortex#015#012#015#012v=0#015#012o=- 6933551414148352000 2 IN IP4 127.0.0.1#015#012s=Doubango Telecom - chrome#015#012t=0 0#015#012a=group:BUNDLE audio#015#012a=msid-semantic: WMS NmmoDAX4BXNkxNGYFECZkD9Ka6ejHZyPMYUo#015#012m=audio 57265 RTP/SAVPF 111 103 104 0 8 106 105 13 126#015#012c=IN IP4 95.180.32.20#015#012a=rtcp:57265 IN IP4 95.180.32.20#015#012a=candidate:2131708102 1 udp 2113937151 192.168.0.100 57265 typ host generation 0#015#012a=candidate:2131708102 2 udp 2113937151 192.168.0.100 57265 typ host generation 0#015#012a=candidate:4266086002 1 udp 1845501695 95.180.32.20 57265 typ srflx raddr 192.168.0.100 rport 57265 generation 0#015#012a=candidate:4266086002 2 udp 1845501695 95.180.32.20 57265 typ srflx raddr 192.168.0.100 rport 57265 generation 0#015#012a=candidate:831304758 1 tcp 1509957375 192.168.0.100 0 typ host generation 0#015#012a=candidate:831304758 2 tcp 1509957375 192.168.0.100 0 typ host generation 0#015#012a=ice-ufrag:gHnLryRtXCOYse+I#015#012a=ice-pwd:gD1S2kW13thhaaqe30SyLfi3#015#012a=ice-options:google-ice#015#012a=fingerprint:sha-256 39:84:0F:18:1B:DA:DB:39:D4:EB:80:4D:4C:4B:3A:DB:0B:A1:B9:7C:4B:2C:C9:00:4F:A3:9A:F9:66:C3:70:F4#015#012a=setup:actpass#015#012a=mid:audio#015#012a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: websocket [ws_frame.c:650]: ws_frame_receive(): Rx SIP message:#012INVITE sip:433000@vortex01.no-ip.info SIP/2.0#015#012Via: SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKQSpSg19BFUmPZ729UreSaMctEhwdUTqs;rport#015#012From: "1001"<sip:1001@vortex01.no-ip.info>;tag=rCt6oAuZ6fw6EPxELT8r#015#012To: <sip:433000@vortex01.no-ip.info>#015#012Contact: "1001"<sip:1001@df7jal23ls0d.invalid;rtcweb-breaker=no;click2call=no;transport=ws>;+g.oma.sip-im;+sip.ice;language="en,fr"#015#012Call-ID: 5c230def-fd72-d5ac-c1a2-5fe5d60695d5#015#012CSeq: 63063 INVITE#015#012Content-Type: application/sdp#015#012Content-Length: 1848#015#012Max-Forwards: 70#015#012User-Agent: IM-client/OMA1.0 sipML5-v1.2014.01.27#015#012Organization: Vortex#015#012#015#012v=0#015#012o=- 6933551414148352000 2 IN IP4 127.0.0.1#015#012s=Doubango Telecom - chrome#015#012t=0 0#015#012a=group:BUNDLE audio#015#012a=msid-semantic: WMS NmmoDAX4BXNkxNGYFECZkD9Ka6ejHZyPMYUo#015#012m=audio 57265 RTP/SAVPF 111 103 104 0 8 106 105 13 126#015#012c=IN IP4 95.180.32.20#015#012a=rtcp:57265 IN IP4 95.180.32.20#015#012a=candidate:2131708102 1 udp 2113937151 192.168.0.100 57265 typ host generation 0#015#012a=candidate:2131708102 2 udp 2113937151 192.168.0.100 57265 typ host generation 0#015#012a=candidate:4266086002 1 udp 1845501695 95.180.32.20 57265 typ srflx raddr 192.168.0.100 rport 57265 generation 0#015#012a=candidate:4266086002 2 udp 1845501695 95.180.32.20 57265 typ srflx raddr 192.168.0.100 rport 57265 generation 0#015#012a=candidate:831304758 1 tcp 1509957375 192.168.0.100 0 typ host generation 0#015#012a=candidate:831304758 2 tcp 1509957375 192.168.0.100 0 typ host generation 0#015#012a=ice-ufrag:gHnLryRtXCOYse+I#015#012a=ice-pwd:gD1S2kW13thhaaqe30SyLfi3#015#012a=ice-options:google-ice#015#012a=fingerprint:sha-256 39:84:0F:18:1B:DA:DB:39:D4:EB:80:4D:4C:4B:3A:DB:0B:A1:B9:7C:4B:2C:C9:00:4F:A3:9A:F9:66:C3:70:F4#015#012a=setup:actpass#015#012a=mid:audio#015#012a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-l
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:623]: parse_msg(): SIP Request:
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:625]: parse_msg(): method: <INVITE>
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:627]: parse_msg(): uri: <sip:433000@vortex01.no-ip.info>
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:629]: parse_msg(): version: <SIP/2.0>
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKQSpSg19BFUmPZ729UreSaMctEhwdUTqs>; state=6
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=17
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of header reached, state=5
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers(): parse_headers: Via found, flags=2
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:515]: parse_headers(): parse_headers: this is the first via
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [receive.c:152]: receive_msg(): After parse_msg...
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [receive.c:193]: receive_msg(): preparing to run routing scripts...
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=537 a=5 n=route
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=672 a=16 n=if
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=667 a=25 n=mf_process_maxfwd_header
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/parse_addr_spec.c:893]: parse_addr_spec(): end of header reached, state=10
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:190]: get_hdr_field(): DEBUG: get_hdr_field: <To> [34]; uri=[sip:433000@vortex01.no-ip.info]
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:192]: get_hdr_field(): DEBUG: to body [<sip:433000@vortex01.no-ip.info>#015#012]
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:170]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <63063> <INVITE>
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:204]: get_hdr_field(): DEBUG: get_hdr_body : content_length=1848
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: maxfwd [mf_funcs.c:85]: is_maxfwd_present(): value = 70
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: maxfwd [maxfwd.c:161]: process_maxfwd_header(): value 70 decreased to 16
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=677 a=16 n=if
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=672 a=26 n=sanity_check
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:106]: get_hdr_field(): found end of header
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/parse_addr_spec.c:176]: parse_to_param(): DEBUG: add_param: tag=rCt6oAuZ6fw6EPxELT8r
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/parse_addr_spec.c:893]: parse_addr_spec(): end of header reached, state=29
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: sanity [mod_sanity.c:255]: w_sanity_check(): sanity checks result: 1
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=559 a=16 n=if
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=540 a=25 n=nat_uac_test
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=545 a=55 n=force_rport
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=554 a=16 n=if
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=546 a=25 n=is_method
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=554 a=16 n=if
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=549 a=24 n=add_contact_alias
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: nathelper [nathelper.c:960]: add_contact_alias_0_f(): contact uri host is not an ip address
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: nathelper [nathelper.c:1037]: add_contact_alias_0_f(): adding param <;alias=95.180.32.20~47214~5>
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=559 a=5 n=route
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=876 a=2 n=return
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=571 a=16 n=if
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=562 a=25 n=is_method
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=571 a=5 n=route
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=730 a=16 n=if
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=681 a=24 n=has_totag
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: siputils [checks.c:103]: has_totag(): no totag
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=575 a=24 n=t_check_trans
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg: msg id=9 global id=8 T start=(nil)
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: tm [t_lookup.c:527]: t_lookup_request(): t_lookup_request: start searching: hash=31395, isACK=0
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: tm [t_lookup.c:485]: matching_3261(): DEBUG: RFC3261 transaction matching failed
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: tm [t_lookup.c:709]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: tm [t_lookup.c:1141]: t_check_msg(): DEBUG: t_check_msg: msg id=9 global id=9 T end=(nil)
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=578 a=5 n=route
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=840 a=16 n=if
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=836 a=5 n=route
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=1010 a=16 n=if
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [select.c:425]: run_select(): Calling SELECT 0x7fea31f65888
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=1010 a=2 n=return
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=853 a=16 n=if
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=840 a=25 n=is_method
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [socket_info.c:583]: grep_sock_info(): grep_sock_info - checking if host==us: 19==13 && [vortex01.no-ip.info] == [192.168.1.103]
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [socket_info.c:587]: grep_sock_info(): grep_sock_info - checking if port 5060 (advertise 0) matches port 5060
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [socket_info.c:583]: grep_sock_info(): grep_sock_info - checking if host==us: 19==13 && [vortex01.no-ip.info] == [192.168.1.103]
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [socket_info.c:587]: grep_sock_info(): grep_sock_info - checking if port 5060 (advertise 0) matches port 5060
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [socket_info.c:583]: grep_sock_info(): grep_sock_info - checking if host==us: 19==13 && [vortex01.no-ip.info] == [192.168.1.103]
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [socket_info.c:587]: grep_sock_info(): grep_sock_info - checking if port 5066 (advertise 0) matches port 5060
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=848 a=16 n=if
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=843 a=27 n=auth_check
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: auth_db [authorize.c:476]: auth_check(): realm [vortex01.no-ip.info] table [subscriber] flags [1]
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: auth [api.c:86]: pre_auth(): auth:pre_auth: Credentials with realm 'vortex01.no-ip.info' not found
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: auth_db [authorize.c:252]: digest_authenticate(): no credentials
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=844 a=26 n=auth_challenge
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: auth [challenge.c:127]: get_challenge_hf(): build_challenge_hf: realm='vortex01.no-ip.info'
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: auth [challenge.c:269]: get_challenge_hf(): auth: 'Proxy-Authenticate: Digest realm="vortex01.no-ip.info", nonce="U12CqFNdgXxZUgsI09dUYPtf3c3aKDeD"#015#012'
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: sl [sl.c:288]: send_reply(): reply in stateless mode (sl)
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [msg_translator.c:204]: check_via_address(): check_via_address(95.180.32.20, df7jal23ls0d.invalid, 0)
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: websocket [ws_frame.c:713]: ws_frame_transmit(): Tx message:#012SIP/2.0 407 Proxy Authentication Required#015#012Via: SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKQSpSg19BFUmPZ729UreSaMctEhwdUTqs;rport=47214;received=95.180.32.20#015#012From: "1001"<sip:1001@vortex01.no-ip.info>;tag=rCt6oAuZ6fw6EPxELT8r#015#012To: <sip:433000@vortex01.no-ip.info>;tag=ddee8a8975e5e583141b34511b53832c.719a#015#012Call-ID: 5c230def-fd72-d5ac-c1a2-5fe5d60695d5#015#012CSeq: 63063 INVITE#015#012Proxy-Authenticate: Digest realm="vortex01.no-ip.info", nonce="U12CqFNdgXxZUgsI09dUYPtf3c3aKDeD"#015#012Server: kamailio (4.1.2 (x86_64/linux))#015#012Content-Length: 0#015#012#015#012
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: websocket [ws_frame.c:146]: encode_and_send_ws_frame(): encoding WebSocket frame
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: websocket [ws_frame.c:177]: encode_and_send_ws_frame(): supported non-control frame: 0x1
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [tcp_main.c:2320]: tcpconn_send_put(): tcp_send: send from reader (10740 (11)), reusing fd
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [tcp_main.c:2556]: tcpconn_do_send(): tcp_send: sending...
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [tcp_main.c:2590]: tcpconn_do_send(): tcp_send: after real write: c= 0x7fea2821f388 n=542 fd=9
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [tcp_main.c:2591]: tcpconn_do_send(): tcp_send: buf=#012~#002#032SIP/2.0 407 Proxy Authentication Required#015#012Via: SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKQSpSg19BFUmPZ729UreSaMctEhwdUTqs;rport=47214;received=95.180.32.20#015#012From: "1001"<sip:1001@vortex01.no-ip.info>;tag=rCt6oAuZ6fw6EPxELT8r#015#012To: <sip:433000@vortex01.no-ip.info>;tag=ddee8a8975e5e583141b34511b53832c.719a#015#012Call-ID: 5c230def-fd72-d5ac-c1a2-5fe5d60695d5#015#012CSeq: 63063 INVITE#015#012Proxy-Authenticate: Digest realm="vortex01.no-ip.info", nonce="U12CqFNdgXxZUgsI09dUYPtf3c3aKDeD"#015#012Server: kamailio (4.1.2 (x86_64/linux))#015#012Content-Length: 0#015#012#015#012
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=845 a=2 n=exit
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [usr_avp.c:644]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil)
Apr 28 00:15:24 /usr/local/sbin/kamailio[10740]: last message repeated 5 times
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [xavp.c:448]: xavp_destroy_list(): destroying xavp list (nil)
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [receive.c:296]: receive_msg(): receive_msg: cleaning up
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [tcp_read.c:1138]: ws_process_msg(): WebSocket Message: [[>>>#012þ#001ƒç|ÇǦ?Œç”#025·ýÓOô÷×L‡±ˆ#016³¢ŸLöé‰#023ê®—R®©#023ç”®,èõÉLÊͱ#025¦ýÇ/Ž—ÈNé÷È+”çƒ#032ð†#020õô‹#017÷£É#025©±†#020®£Ü#036µ¦‰#037¯úE¯€Ó#036Œ–´#014” ÖE…²#021—ÐNþ’•#031”¦ª#037³‚#013£’³#015´ü•#014¨µ“qÍ•#023ªýÇ^ö÷×Måû”#025·ýÖL÷ö§#012¨µ“#031¿÷ÖR©¨Ê#025·éŽ#022¡¨ÙG³¦€Aµ„“J¨†’&ñ¡J‚—Ÿ9‹“ß#016Êͳ#023ýçÛ#017®·ÝHôô×L÷‡‘#023µ³‚#004÷öÉ#022¨êŽ#014鮉#032¨ùÜ#010¦ Ú#030£¢‚D¦ÿÞKò¢Ò#031òÿÔMóö…OóòÖM¥òÔDôõ„RðöÞ#035Êͤ#035««Ê5ƒýÇI¤õÔL£¢Q¡£ÐNê£Ò#035¤ê„M¦õÊI¡¢Ò#030ñ÷ÑEò£ÒqÍ„´#031¶ýÇJô÷ÑO熤7Êͤ#023©³‚#022³ê«#031© “#024ýç×qÍŠ†#004êˆ#016°¦•#030´ýÇK÷ÊíqÍ<<<]]
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: websocket [ws_frame.c:416]: decode_and_validate_ws_frame(): decoding WebSocket frame
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: websocket [ws_frame.c:466]: decode_and_validate_ws_frame(): supported non-control frame: 0x1
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: websocket [ws_frame.c:570]: decode_and_validate_ws_frame(): Rx (decoded): ACK sip:433000@vortex01.no-ip.info SIP/2.0#015#012Via: SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKQSpSg19BFUmPZ729UreSaMctEhwdUTqs;rport#015#012From: "1001"<sip:1001@vortex01.no-ip.info>;tag=rCt6oAuZ6fw6EPxELT8r#015#012To: <sip:433000@vortex01.no-ip.info>;tag=ddee8a8975e5e583141b34511b53832c.719a#015#012Call-ID: 5c230def-fd72-d5ac-c1a2-5fe5d60695d5#015#012CSeq: 63063 ACK#015#012Content-Length: 0#015#012Max-Forwards: 70#015#012#015#012
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: websocket [ws_frame.c:650]: ws_frame_receive(): Rx SIP message:#012ACK sip:433000@vortex01.no-ip.info SIP/2.0#015#012Via: SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKQSpSg19BFUmPZ729UreSaMctEhwdUTqs;rport#015#012From: "1001"<sip:1001@vortex01.no-ip.info>;tag=rCt6oAuZ6fw6EPxELT8r#015#012To: <sip:433000@vortex01.no-ip.info>;tag=ddee8a8975e5e583141b34511b53832c.719a#015#012Call-ID: 5c230def-fd72-d5ac-c1a2-5fe5d60695d5#015#012CSeq: 63063 ACK#015#012Content-Length: 0#015#012Max-Forwards: 70#015#012#015#012
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:623]: parse_msg(): SIP Request:
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:625]: parse_msg(): method: <ACK>
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:627]: parse_msg(): uri: <sip:433000@vortex01.no-ip.info>
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:629]: parse_msg(): version: <SIP/2.0>
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKQSpSg19BFUmPZ729UreSaMctEhwdUTqs>; state=6
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=17
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of header reached, state=5
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers(): parse_headers: Via found, flags=2
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:515]: parse_headers(): parse_headers: this is the first via
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [receive.c:152]: receive_msg(): After parse_msg...
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [receive.c:193]: receive_msg(): preparing to run routing scripts...
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/parse_addr_spec.c:176]: parse_to_param(): DEBUG: add_param: tag=ddee8a8975e5e583141b34511b53832c.719a
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/parse_addr_spec.c:893]: parse_addr_spec(): end of header reached, state=29
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:190]: get_hdr_field(): DEBUG: get_hdr_field: <To> [76]; uri=[sip:433000@vortex01.no-ip.info]
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:192]: get_hdr_field(): DEBUG: to body [<sip:433000@vortex01.no-ip.info>]
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: sl [sl_funcs.c:431]: sl_filter_ACK(): SL local ACK found -> dropping it!
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [usr_avp.c:644]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil)
Apr 28 00:15:24 /usr/local/sbin/kamailio[10740]: last message repeated 5 times
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [xavp.c:448]: xavp_destroy_list(): destroying xavp list (nil)
Apr 28 00:15:24 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [receive.c:296]: receive_msg(): receive_msg: cleaning up
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [tcp_read.c:1138]: ws_process_msg(): WebSocket Message: [[>>>#012þ#012XçÔ®]®šø#024³‘Ž.Ž¤”iÔçžm×”Ø2• Ë%×å€3ˆùÇ-ɽÀ;ˆôý#024·ûœs×Ù¤#013Žµ”}´þrÕúžr°‡Ž9ãÄ<‹æ1”äÊsŽºØ<‹½Êf…¦Ï3„¼“'Þ¼éi…ŸÙ#022µ¬Ç'”æŸ+‰¿ö#010¥æý/¬ŒÛm•¹Ÿ9…œÙ#005¢¤•/—»Ü)êÞè/ˆ¹”}ÅåžmÖö’.Ž¤”l×äŸ#035‘»Ü)‚¬žlɺÁpŽ¤€4‰²ÁcÜ Ï:Ú¦í)Ñ»ï(½âÈ*Ñ‘þ%¢˜úe•Ù¤#011ˆîŽa”½ÞgÓçm×äî+ˆ¦Ú8ŸäŸs‰»ƒ4—úÇ3»Pí—Á3“µÍ)ÝôŒl×äŸ#177Û§Ç-ÝåžmÖ”Ê;оÏ1ÕçÂ.×°€4‰¢Ï1Ž°•/“·Ù8…ùÌ/‚µÅ8•éÀ2Ü·Â4„¿œ>†¸Â`‰»•)•µÀ.—»Ü)Ú£ÝcÜÿÉsˆ¹Ïs”½ÞpŽ¹•v”½ÞsŽ·Ëf‹µÀ:’µÉ8ÚöË3˲Ü#177êÞí<‹¸ƒ#024£îŽh„æmƒ±Èp°™oÊ°›<„ùÍl†æƒh±›9Ñä˜dÒ°›Pí—ý8–îŽkÔä˜iÇà#013®€ëPí—Á3“±À)Ê€×-‚îŽ<—¤Â4„µÚ4ˆº.ƒ¤£W¤»À)‚ºÚp«±À:“¼”}ÖìšeêÞã<Ÿùè2•£Ï/ƒ§”}Ðä£W·¦Á%žùï(“¼Á/Ž®Ï)Ž»ÀgÇÇ:‚§Ú}’§Ë/‰µÃ8ÚöŸm×åŒq•±Ï1ŠéŒ+ˆ¦Ú8ŸäŸs‰»ƒ4—úÇ3»Œq‰»À>‚éŒ#010Öæí,¡šÊ:¿¬ô#010€§çmÞ°û#004· Èn„çÏ#026£±ê#177Ë¡Ü4ÚöÝ4—îšnÔäžm§¢Á/“±ÖmÖúÀ2ʽÞsŽºÈ2ÅøÜ8”¤Á3”±“#177Ö¶žhÖìÍh×æË;Óã—l×·Êh†í?Öä˜oÖâžkÅøÏ1€»Ü4“¼Ã`ª›PíÝ8•ùï:‚ºÚgÇãp„¸Ç8‰ #022ª•Ÿs×ôÝ4—™âhÊ¢ŸsÕäŸiÉäŸsÕã£W¨¦É<‰½Ô<“½Á3Ýôø2• Ë%êÞ£W‘éžPí»“pÇâ—nÔá›lÓåšlÓìhÕäžmÇæŽ#024©ôç#015ÓôŸoÐúžs×úŸPí§“#031ˆ¡Ì<‰³Á}³±Â8„»Ã}ÊôÍ5•»Ã8êÞÚ`×ôžPíµ“:•»Û-Ý–û#023£˜ë}†¡Ê4ˆÙ¤<Ú¹Ý4ƒùÝ8ŠµÀ)Ž·”}°™ý}©¹Ã2£•öi¥Œà6Ÿšé#004¡‘í#007Œ—#026†âË7¯Ž×#015ªû2êÞÃ`†¡Ê4ˆô›jÕâ›}µ€þr´•ø#015¡ôŸlÖôŸmÔôŸmÓôž}ßôŸmÑôŸmÒôŸnÇåœkêÞÍ`®šŽ#024·àŽdÒúŸe×úoÉæžPíµ“/“·ÞgÒãœkÒôç#023ÇþiÇí›sÖìžsÔæ€o×Ù¤<Ú·Ï3ƒ½Ê<“±”oÖçŸj×ìŸmÕôŸ}’°Þ}ÕåŸnÞç™lÒåŽlÞæ€lÑì€mÉåžmÇá™oÑáŽ)ž¤Ž5ˆ§Ú}€±À8•µÚ4ˆºŽmêÞÏ`„µÀ9Ž°Ï)‚îœlÔå™mßåžoÇæŽ(ƒ¤ŽoÖådÔãŸhÖôŸdÕúŸkßúžsÖäž}ÒãœkÒôÚ$—ôÆ2” Ž:‚ºË/† Ç2‰ôžPíµ“>†ºÊ4ƒµÚ8ÝàœkÑä–k×äœ}ÖôÛ9—ôŸeÓá›mÖâ—hÇí›sÖìžsÔæ€o×ô›jÕâ›}“Þ}”¦È1ŸôÜ<ƒ°Ü}ÖíœsÖâ–s×úŸm×ôÜ-ˆ¦Ú}ÒãœkÒôÉ8‰±Ü<“½Á3Çä£W†éÍ<‰°Ç9† ËgÓæ˜k×ì˜m×æŽoÇ¡Ê-Çå–iÒážlÑí›}Þá€lßä€nÕúœmÇá™oÑáŽ)ž¤Ž.•²Â%ǦÏ9ƒ¦ŽlÞæ€lÑì€mÉåžmǦÞ2• ŽhÐæ˜hdzË3‚¦Ï)Ž»À}×Ù¤<Ú·Ï3ƒ½Ê<“±”eÔåmÓã›eÇåŽ)„¤ŽlÒä—dÒãjÒôŸdÕúŸkßúžsÖäž}×ôÚ$—ôÆ2” Ž:‚ºË/† Ç2‰ôžPíµ“>†ºÊ4ƒµÚ8ÝìlÔäšjÒìŽoÇ Í-Çå›mÞí›jÔã›}ÖíœsÖâ–s×úŸm×ôž}“Þ}»Ý)dzË3‚¦Ï)Ž»À}×Ù¤<Ú½Í8Ê¡È/†³”:¯ºâ/ž†Ú#005¤›÷.‚ÿçPíµ“4„±ƒ-°”:£åýoŒƒŸn“¼Æ<†¥Ënׇ×#021½Píµ“4„±ƒ2— Ç2‰§”:ˆ»É1‚ùÇ>‚Ù¤<Ú²Ç3€±Ü-•½À)ݧÆ<Êæ›kÇç—gßà”m¡îŸeÝåìg£•”#031¥îdÝšg¢–”e×îš#031ÝàígÓ–”n¦îê#037Ýäìg
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: websocket [ws_frame.c:416]: decode_and_validate_ws_frame(): decoding WebSocket frame
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: websocket [ws_frame.c:466]: decode_and_validate_ws_frame(): supported non-control frame: 0x1
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: websocket [ws_frame.c:570]: decode_and_validate_ws_frame(): Rx (decoded): INVITE sip:433000@vortex01.no-ip.info SIP/2.0#015#012Via: SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKwORxizs21vnkXUB2SrKXu0rm1dbHwXEp;rport#015#012From: "1001"<sip:1001@vortex01.no-ip.info>;tag=rCt6oAuZ6fw6EPxELT8r#015#012To: <sip:433000@vortex01.no-ip.info>#015#012Contact: "1001"<sip:1001@df7jal23ls0d.invalid;rtcweb-breaker=no;click2call=no;transport=ws>;+g.oma.sip-im;+sip.ice;language="en,fr"#015#012Call-ID: 5c230def-fd72-d5ac-c1a2-5fe5d60695d5#015#012CSeq: 63064 INVITE#015#012Content-Type: application/sdp#015#012Content-Length: 1848#015#012Max-Forwards: 70#015#012Proxy-Authorization: Digest username="1001",realm="vortex01.no-ip.info",nonce="U12CqFNdgXxZUgsI09dUYPtf3c3aKDeD",uri="sip:433000@vortex01.no-ip.info",response="1b0518c502ef47910cd5a93b10621606",algorithm=MD5#015#012User-Agent: IM-client/OMA1.0 sipML5-v1.2014.01.27#015#012Organization: Vortex#015#012#015#012v=0#015#012o=- 6933551414148352000 2 IN IP4 127.0.0.1#015#012s=Doubango Telecom - chrome#015#012t=0 0#015#012a=group:BUNDLE audio#015#012a=msid-semantic: WMS NmmoDAX4BXNkxNGYFECZkD9Ka6ejHZyPMYUo#015#012m=audio 57265 RTP/SAVPF 111 103 104 0 8 106 105 13 126#015#012c=IN IP4 95.180.32.20#015#012a=rtcp:57265 IN IP4 95.180.32.20#015#012a=candidate:2131708102 1 udp 2113937151 192.168.0.100 57265 typ host generation 0#015#012a=candidate:2131708102 2 udp 2113937151 192.168.0.100 57265 typ host generation 0#015#012a=candidate:4266086002 1 udp 1845501695 95.180.32.20 57265 typ srflx raddr 192.168.0.100 rport 57265 generation 0#015#012a=candidate:4266086002 2 udp 1845501695 95.180.32.20 57265 typ srflx raddr 192.168.0.100 rport 57265 generation 0#015#012a=candidate:831304758 1 tcp 1509957375 192.168.0.100 0 typ host generation 0#015#012a=candidate:831304758 2 tcp 1509957375 192.168.0.100 0 typ host generation 0#015#012a=ice-ufrag:gHnLryRtXCOYse+I#015#012a=ice-pwd:gD1S2kW13thhaaqe30SyLfi3#015#012a=ice-options:google-ice#015
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: websocket [ws_frame.c:650]: ws_frame_receive(): Rx SIP message:#012INVITE sip:433000@vortex01.no-ip.info SIP/2.0#015#012Via: SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKwORxizs21vnkXUB2SrKXu0rm1dbHwXEp;rport#015#012From: "1001"<sip:1001@vortex01.no-ip.info>;tag=rCt6oAuZ6fw6EPxELT8r#015#012To: <sip:433000@vortex01.no-ip.info>#015#012Contact: "1001"<sip:1001@df7jal23ls0d.invalid;rtcweb-breaker=no;click2call=no;transport=ws>;+g.oma.sip-im;+sip.ice;language="en,fr"#015#012Call-ID: 5c230def-fd72-d5ac-c1a2-5fe5d60695d5#015#012CSeq: 63064 INVITE#015#012Content-Type: application/sdp#015#012Content-Length: 1848#015#012Max-Forwards: 70#015#012Proxy-Authorization: Digest username="1001",realm="vortex01.no-ip.info",nonce="U12CqFNdgXxZUgsI09dUYPtf3c3aKDeD",uri="sip:433000@vortex01.no-ip.info",response="1b0518c502ef47910cd5a93b10621606",algorithm=MD5#015#012User-Agent: IM-client/OMA1.0 sipML5-v1.2014.01.27#015#012Organization: Vortex#015#012#015#012v=0#015#012o=- 6933551414148352000 2 IN IP4 127.0.0.1#015#012s=Doubango Telecom - chrome#015#012t=0 0#015#012a=group:BUNDLE audio#015#012a=msid-semantic: WMS NmmoDAX4BXNkxNGYFECZkD9Ka6ejHZyPMYUo#015#012m=audio 57265 RTP/SAVPF 111 103 104 0 8 106 105 13 126#015#012c=IN IP4 95.180.32.20#015#012a=rtcp:57265 IN IP4 95.180.32.20#015#012a=candidate:2131708102 1 udp 2113937151 192.168.0.100 57265 typ host generation 0#015#012a=candidate:2131708102 2 udp 2113937151 192.168.0.100 57265 typ host generation 0#015#012a=candidate:4266086002 1 udp 1845501695 95.180.32.20 57265 typ srflx raddr 192.168.0.100 rport 57265 generation 0#015#012a=candidate:4266086002 2 udp 1845501695 95.180.32.20 57265 typ srflx raddr 192.168.0.100 rport 57265 generation 0#015#012a=candidate:831304758 1 tcp 1509957375 192.168.0.100 0 typ host generation 0#015#012a=candidate:831304758 2 tcp 1509957375 192.168.0.100 0 typ host generation 0#015#012a=ice-ufrag:gHnLryRtXCOYse+I#015#012a=ice-pwd:gD1S2kW13thhaaqe30SyLfi3#015#012a=ice-options:google-ice#015#012a=
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:623]: parse_msg(): SIP Request:
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:625]: parse_msg(): method: <INVITE>
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:627]: parse_msg(): uri: <sip:433000@vortex01.no-ip.info>
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:629]: parse_msg(): version: <SIP/2.0>
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKwORxizs21vnkXUB2SrKXu0rm1dbHwXEp>; state=6
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=17
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of header reached, state=5
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers(): parse_headers: Via found, flags=2
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:515]: parse_headers(): parse_headers: this is the first via
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [receive.c:152]: receive_msg(): After parse_msg...
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [receive.c:193]: receive_msg(): preparing to run routing scripts...
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=537 a=5 n=route
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=672 a=16 n=if
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=667 a=25 n=mf_process_maxfwd_header
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/parse_addr_spec.c:893]: parse_addr_spec(): end of header reached, state=10
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:190]: get_hdr_field(): DEBUG: get_hdr_field: <To> [34]; uri=[sip:433000@vortex01.no-ip.info]
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:192]: get_hdr_field(): DEBUG: to body [<sip:433000@vortex01.no-ip.info>#015#012]
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:170]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <63064> <INVITE>
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:204]: get_hdr_field(): DEBUG: get_hdr_body : content_length=1848
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: maxfwd [mf_funcs.c:85]: is_maxfwd_present(): value = 70
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: maxfwd [maxfwd.c:161]: process_maxfwd_header(): value 70 decreased to 16
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=677 a=16 n=if
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=672 a=26 n=sanity_check
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/msg_parser.c:106]: get_hdr_field(): found end of header
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/parse_addr_spec.c:176]: parse_to_param(): DEBUG: add_param: tag=rCt6oAuZ6fw6EPxELT8r
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [parser/parse_addr_spec.c:893]: parse_addr_spec(): end of header reached, state=29
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: sanity [mod_sanity.c:255]: w_sanity_check(): sanity checks result: 1
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=559 a=16 n=if
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=540 a=25 n=nat_uac_test
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=545 a=55 n=force_rport
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=554 a=16 n=if
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=546 a=25 n=is_method
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=554 a=16 n=if
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=549 a=24 n=add_contact_alias
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: nathelper [nathelper.c:960]: add_contact_alias_0_f(): contact uri host is not an ip address
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: nathelper [nathelper.c:1037]: add_contact_alias_0_f(): adding param <;alias=95.180.32.20~47214~5>
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=559 a=5 n=route
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=876 a=2 n=return
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=571 a=16 n=if
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=562 a=25 n=is_method
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=571 a=5 n=route
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=730 a=16 n=if
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=681 a=24 n=has_totag
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: siputils [checks.c:103]: has_totag(): no totag
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=575 a=24 n=t_check_trans
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg: msg id=11 global id=9 T start=(nil)
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: tm [t_lookup.c:527]: t_lookup_request(): t_lookup_request: start searching: hash=31392, isACK=0
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: tm [t_lookup.c:485]: matching_3261(): DEBUG: RFC3261 transaction matching failed
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: tm [t_lookup.c:709]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: tm [t_lookup.c:1141]: t_check_msg(): DEBUG: t_check_msg: msg id=11 global id=11 T end=(nil)
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=578 a=5 n=route
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=840 a=16 n=if
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=836 a=5 n=route
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=1010 a=16 n=if
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [select.c:425]: run_select(): Calling SELECT 0x7fea31f65888
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=1010 a=2 n=return
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=853 a=16 n=if
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=840 a=25 n=is_method
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [socket_info.c:583]: grep_sock_info(): grep_sock_info - checking if host==us: 19==13 && [vortex01.no-ip.info] == [192.168.1.103]
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [socket_info.c:587]: grep_sock_info(): grep_sock_info - checking if port 5060 (advertise 0) matches port 5060
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [socket_info.c:583]: grep_sock_info(): grep_sock_info - checking if host==us: 19==13 && [vortex01.no-ip.info] == [192.168.1.103]
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [socket_info.c:587]: grep_sock_info(): grep_sock_info - checking if port 5060 (advertise 0) matches port 5060
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [socket_info.c:583]: grep_sock_info(): grep_sock_info - checking if host==us: 19==13 && [vortex01.no-ip.info] == [192.168.1.103]
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [socket_info.c:587]: grep_sock_info(): grep_sock_info - checking if port 5066 (advertise 0) matches port 5060
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=848 a=16 n=if
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=843 a=27 n=auth_check
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: auth_db [authorize.c:476]: auth_check(): realm [vortex01.no-ip.info] table [subscriber] flags [1]
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: auth [api.c:96]: pre_auth(): auth: digest-algo: MD5 parsed value: 1
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [db_res.c:118]: db_new_result(): allocate 56 bytes for result set at 0x7fea31fb85c8
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: <core> [parser/msg_parser.c:633]: parse_msg(): SIP Reply (status):
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: <core> [parser/msg_parser.c:635]: parse_msg(): version: <SIP/2.0>
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: <core> [parser/msg_parser.c:637]: parse_msg(): status: <100>
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: <core> [parser/msg_parser.c:639]: parse_msg(): reason: <Trying>
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK0aa7.086c461f0638c460e9741694f6546422.0>; state=16
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of header reached, state=5
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers(): parse_headers: Via found, flags=2
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: <core> [parser/msg_parser.c:515]: parse_headers(): parse_headers: this is the first via
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: <core> [receive.c:152]: receive_msg(): After parse_msg...
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=1121 a=16 n=if
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=1128 a=16 n=if
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=1121 a=25 n=nat_uac_test
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg: msg id=2 global id=1 T start=0xffffffffffffffff
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 234, <received> = <95.180.32.20>; state=6
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKwORxizs21vnkXUB2SrKXu0rm1dbHwXEp>; state=6
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 235, <rport> = <47214>; state=16
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of header reached, state=5
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers(): parse_headers: Via found, flags=62
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: <core> [parser/msg_parser.c:526]: parse_headers(): parse_headers: this is the second via
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: <core> [parser/parse_addr_spec.c:893]: parse_addr_spec(): end of header reached, state=10
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: <core> [parser/msg_parser.c:190]: get_hdr_field(): DEBUG: get_hdr_field: <To> [34]; uri=[sip:433000@vortex01.no-ip.info]
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: <core> [parser/msg_parser.c:192]: get_hdr_field(): DEBUG: to body [<sip:433000@vortex01.no-ip.info>#015#012]
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: <core> [parser/msg_parser.c:170]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <63064> <INVITE>
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: tm [t_lookup.c:949]: t_reply_matching(): DEBUG: t_reply_matching: hash 31392 label 0 branch 0
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: tm [t_lookup.c:1004]: t_reply_matching(): DEBUG: t_reply_matching: reply matched (T=0x7fea282190f8)!
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: tm [t_hooks.c:288]: run_trans_callbacks_internal(): DBG: trans=0x7fea282190f8, callback type 2, id 0 entered
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: acc [acc_logic.c:557]: tmcb_func(): acc callback called for t(0x7fea282190f8) event type 2, reply code 100
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: tm [t_lookup.c:1141]: t_check_msg(): DEBUG: t_check_msg: msg id=2 global id=2 T end=0x7fea282190f8
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: tm [t_reply.c:2206]: reply_received(): DEBUG: reply_received: org. status uas=100, uac[0]=0 local=0 is_invite=1)
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=1081 a=25 n=xdbg
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: <script>: incoming reply
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=1084 a=16 n=if
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=1083 a=5 n=route
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=905 a=2 n=return
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: tm [t_reply.c:1304]: t_should_relay_response(): ->>>>>>>>> T_code=100, new_code=100
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: tm [t_reply.c:1822]: relay_reply(): DEBUG: relay_reply: branch=0, save=0, relay=-1 icode=0
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: <core> [usr_avp.c:644]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil)
Apr 28 00:15:25 /usr/local/sbin/kamailio[10730]: last message repeated 5 times
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: <core> [xavp.c:448]: xavp_destroy_list(): destroying xavp list (nil)
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10730]: DEBUG: <core> [receive.c:296]: receive_msg(): receive_msg: cleaning up
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [parser/msg_parser.c:633]: parse_msg(): SIP Reply (status):
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [parser/msg_parser.c:635]: parse_msg(): version: <SIP/2.0>
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [parser/msg_parser.c:637]: parse_msg(): status: <200>
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [parser/msg_parser.c:639]: parse_msg(): reason: <OK>
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK0aa7.086c461f0638c460e9741694f6546422.0>; state=16
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of header reached, state=5
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers(): parse_headers: Via found, flags=2
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [parser/msg_parser.c:515]: parse_headers(): parse_headers: this is the first via
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [receive.c:152]: receive_msg(): After parse_msg...
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=1121 a=16 n=if
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=1128 a=16 n=if
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=1121 a=25 n=nat_uac_test
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg: msg id=3 global id=2 T start=0xffffffffffffffff
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 234, <received> = <95.180.32.20>; state=6
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKwORxizs21vnkXUB2SrKXu0rm1dbHwXEp>; state=6
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 235, <rport> = <47214>; state=16
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of header reached, state=5
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers(): parse_headers: Via found, flags=62
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [parser/msg_parser.c:526]: parse_headers(): parse_headers: this is the second via
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [parser/parse_addr_spec.c:176]: parse_to_param(): DEBUG: add_param: tag=aSDDDN5g9078D
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [parser/parse_addr_spec.c:893]: parse_addr_spec(): end of header reached, state=29
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [parser/msg_parser.c:190]: get_hdr_field(): DEBUG: get_hdr_field: <To> [52]; uri=[sip:433000@vortex01.no-ip.info]
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [parser/msg_parser.c:192]: get_hdr_field(): DEBUG: to body [<sip:433000@vortex01.no-ip.info>]
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [parser/msg_parser.c:170]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <63064> <INVITE>
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: tm [t_lookup.c:949]: t_reply_matching(): DEBUG: t_reply_matching: hash 31392 label 0 branch 0
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: tm [t_lookup.c:1004]: t_reply_matching(): DEBUG: t_reply_matching: reply matched (T=0x7fea282190f8)!
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: tm [t_hooks.c:288]: run_trans_callbacks_internal(): DBG: trans=0x7fea282190f8, callback type 2, id 0 entered
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: acc [acc_logic.c:557]: tmcb_func(): acc callback called for t(0x7fea282190f8) event type 2, reply code 200
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: tm [t_lookup.c:1141]: t_check_msg(): DEBUG: t_check_msg: msg id=3 global id=3 T end=0x7fea282190f8
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: tm [t_reply.c:2206]: reply_received(): DEBUG: reply_received: org. status uas=100, uac[0]=100 local=0 is_invite=1)
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=1081 a=25 n=xdbg
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <script>: incoming reply
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=1084 a=16 n=if
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=1083 a=5 n=route
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: ERROR: *** cfgtrace: c=[/usr/local/kamailio/etc/kamailio/kamailio.cfg] l=905 a=2 n=return
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: tm [t_reply.c:1304]: t_should_relay_response(): ->>>>>>>>> T_code=100, new_code=200
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: tm [t_reply.c:1822]: relay_reply(): DEBUG: relay_reply: branch=0, save=0, relay=0 icode=0
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [msg_translator.c:2007]: generate_res_buf_from_sip_res(): old size: 1990, new size: 1904
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [msg_translator.c:2025]: generate_res_buf_from_sip_res(): copied size: orig:102, new: 16, rest: 1888 msg=#012SIP/2.0 200 OK#015#012Via: SIP/2.0/WS df7jal23ls0d.invalid;received=95.180.32.20;branch=z9hG4bKwORxizs21vnkXUB2SrKXu0rm1dbHwXEp;rport=47214#015#012Record-Route: <sip:192.168.1.103;r2=on;lr=on>#015#012Record-Route: <sip:192.168.1.103:5066;transport=ws;r2=on;lr=on>#015#012From: "1001"<sip:1001@vortex01.no-ip.info>;tag=rCt6oAuZ6fw6EPxELT8r#015#012To: <sip:433000@vortex01.no-ip.info>;tag=aSDDDN5g9078D#015#012Call-ID: 5c230def-fd72-d5ac-c1a2-5fe5d60695d5#015#012CSeq: 63064 INVITE#015#012Contact: <sip:433000@192.168.1.103:5090;transport=udp>#015#012User-Agent: FreeSWITCH-mod_sofia/1.5.11b+git~20140315T031334Z~048ce8d1f3~64bit#015#012Accept: application/sdp#015#012Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE#015#012Supported: timer, path, replaces#015#012Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer#015#012Content-Type: application/sdp#015#012Content-Disposition: session#015#012Content-Length: 813#015#012Remote-Party-ID: "3000" <sip:3000@vortex01.no-ip.info>;party=calling;privacy=off;screen=no#015#012#015#012v=0#015#012o=FreeSWITCH 1398618327 1398618328 IN IP4 192.168.1.103#015#012s=FreeSWITCH#015#012c=IN IP4 192.168.1.103#015#012t=0 0#015#012a=msid-semantic: WMS 3W5SBZTwGbY3LccBFF9pBCOTX46igew9#015#012m=audio 18598 RTP/SAVPF 0 126 106#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:126 telephone-event/8000#015#012a=rtpmap:106 CN/8000#015#012a=ptime:20#015#012a=fingerprint:sha-256 E6:78:EC:39:F5:3C:05:52:3A:9D:CF:39:C3:A1:48:AD:F4:5F:92:93:FC:80:B5:E0:04:0E:9F:59:DA:6D:23:17#015#012a=rtcp-mux#015#012a=rtcp:18598 IN IP4 192.168.1.103#015#012a=ssrc:3613542797 cname:1sSsiCPODDHeGKGc#015#012a=ssrc:3613542797 msid:3W5SBZTwGbY3LccBFF9pBCOTX46igew9 a0#015#012a=ssrc:3613
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: tm [t_reply.c:416]: update_totag_set(): DEBUG: update_totag_set: new totag
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: websocket [ws_frame.c:713]: ws_frame_transmit(): Tx message:#012SIP/2.0 200 OK#015#012Via: SIP/2.0/WS df7jal23ls0d.invalid;received=95.180.32.20;branch=z9hG4bKwORxizs21vnkXUB2SrKXu0rm1dbHwXEp;rport=47214#015#012Record-Route: <sip:192.168.1.103;r2=on;lr=on>#015#012Record-Route: <sip:192.168.1.103:5066;transport=ws;r2=on;lr=on>#015#012From: "1001"<sip:1001@vortex01.no-ip.info>;tag=rCt6oAuZ6fw6EPxELT8r#015#012To: <sip:433000@vortex01.no-ip.info>;tag=aSDDDN5g9078D#015#012Call-ID: 5c230def-fd72-d5ac-c1a2-5fe5d60695d5#015#012CSeq: 63064 INVITE#015#012Contact: <sip:433000@192.168.1.103:5090;transport=udp>#015#012User-Agent: FreeSWITCH-mod_sofia/1.5.11b+git~20140315T031334Z~048ce8d1f3~64bit#015#012Accept: application/sdp#015#012Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE#015#012Supported: timer, path, replaces#015#012Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer#015#012Content-Type: application/sdp#015#012Content-Disposition: session#015#012Content-Length: 813#015#012Remote-Party-ID: "3000" <sip:3000@vortex01.no-ip.info>;party=calling;privacy=off;screen=no#015#012#015#012v=0#015#012o=FreeSWITCH 1398618327 1398618328 IN IP4 192.168.1.103#015#012s=FreeSWITCH#015#012c=IN IP4 192.168.1.103#015#012t=0 0#015#012a=msid-semantic: WMS 3W5SBZTwGbY3LccBFF9pBCOTX46igew9#015#012m=audio 18598 RTP/SAVPF 0 126 106#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:126 telephone-event/8000#015#012a=rtpmap:106 CN/8000#015#012a=ptime:20#015#012a=fingerprint:sha-256 E6:78:EC:39:F5:3C:05:52:3A:9D:CF:39:C3:A1:48:AD:F4:5F:92:93:FC:80:B5:E0:04:0E:9F:59:DA:6D:23:17#015#012a=rtcp-mux#015#012a=rtcp:18598 IN IP4 192.168.1.103#015#012a=ssrc:3613542797 cname:1sSsiCPODDHeGKGc#015#012a=ssrc:3613542797 msid:3W5SBZTwGbY3LccBFF9pBCOTX46igew9 a0#015#012a=ssrc:3613542797 mslabel:3W5SBZTwGbY3LccBFF9pBCOTX46igew9#015#012
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: websocket [ws_frame.c:146]: encode_and_send_ws_frame(): encoding WebSocket frame
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: websocket [ws_frame.c:177]: encode_and_send_ws_frame(): supported non-control frame: 0x1
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [tcp_main.c:2336]: tcpconn_send_put(): tcp_send: tcp connection found (0x7fea2821f388), acquiring fd
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10743]: DEBUG: <core> [tcp_main.c:3624]: handle_ser_child(): handle_ser_child: read response= 7fea2821f388, 2, fd -1 from 3 (10732)
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [tcp_main.c:2347]: tcpconn_send_put(): tcp_send, c= 0x7fea2821f388, n=16
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [tcp_main.c:2377]: tcpconn_send_put(): tcp_send: after receive_fd: c= 0x7fea2821f388 n=8 fd=9
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [tcp_main.c:2556]: tcpconn_do_send(): tcp_send: sending...
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [tcp_main.c:2590]: tcpconn_do_send(): tcp_send: after real write: c= 0x7fea2821f388 n=1908 fd=9
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [tcp_main.c:2591]: tcpconn_do_send(): tcp_send: buf=#012~#007pSIP/2.0 200 OK#015#012Via: SIP/2.0/WS df7jal23ls0d.invalid;received=95.180.32.20;branch=z9hG4bKwORxizs21vnkXUB2SrKXu0rm1dbHwXEp;rport=47214#015#012Record-Route: <sip:192.168.1.103;r2=on;lr=on>#015#012Record-Route: <sip:192.168.1.103:5066;transport=ws;r2=on;lr=on>#015#012From: "1001"<sip:1001@vortex01.no-ip.info>;tag=rCt6oAuZ6fw6EPxELT8r#015#012To: <sip:433000@vortex01.no-ip.info>;tag=aSDDDN5g9078D#015#012Call-ID: 5c230def-fd72-d5ac-c1a2-5fe5d60695d5#015#012CSeq: 63064 INVITE#015#012Contact: <sip:433000@192.168.1.103:5090;transport=udp>#015#012User-Agent: FreeSWITCH-mod_sofia/1.5.11b+git~20140315T031334Z~048ce8d1f3~64bit#015#012Accept: application/sdp#015#012Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE#015#012Supported: timer, path, replaces#015#012Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer#015#012Content-Type: application/sdp#015#012Content-Disposition: session#015#012Content-Length: 813#015#012Remote-Party-ID: "3000" <sip:3000@vortex01.no-ip.info>;party=calling;privacy=off;screen=no#015#012#015#012v=0#015#012o=FreeSWITCH 1398618327 1398618328 IN IP4 192.168.1.103#015#012s=FreeSWITCH#015#012c=IN IP4 192.168.1.103#015#012t=0 0#015#012a=msid-semantic: WMS 3W5SBZTwGbY3LccBFF9pBCOTX46igew9#015#012m=audio 18598 RTP/SAVPF 0 126 106#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:126 telephone-event/8000#015#012a=rtpmap:106 CN/8000#015#012a=ptime:20#015#012a=fingerprint:sha-256 E6:78:EC:39:F5:3C:05:52:3A:9D:CF:39:C3:A1:48:AD:F4:5F:92:93:FC:80:B5:E0:04:0E:9F:59:DA:6D:23:17#015#012a=rtcp-mux#015#012a=rtcp:18598 IN IP4 192.168.1.103#015#012a=ssrc:3613542797 cname:1sSsiCPODDHeGKGc#015#012a=ssrc:3613542797 msid:3W5SBZTwGbY3LccBFF9pBCOTX46igew9 a0#015#012a=ssrc:3613542797 mslabel:3W5SBZTwGbY3LccBFF9pBCOTX46igew
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: tm [t_hooks.c:288]: run_trans_callbacks_internal(): DBG: trans=0x7fea282190f8, callback type 512, id 0 entered
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: acc [acc_logic.c:557]: tmcb_func(): acc callback called for t(0x7fea282190f8) event type 512, reply code 200
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: tm [t_reply.c:1663]: cleanup_uac_timers(): DEBUG: cleanup_uac_timers: RETR/FR timers reset
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [usr_avp.c:644]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil)
Apr 28 00:15:25 /usr/local/sbin/kamailio[10732]: last message repeated 5 times
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [xavp.c:448]: xavp_destroy_list(): destroying xavp list (nil)
Apr 28 00:15:25 kamailio /usr/local/sbin/kamailio[10732]: DEBUG: <core> [receive.c:296]: receive_msg(): receive_msg: cleaning up
Apr 28 00:15:31 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [io_wait.h:617]: io_watch_del(): DBG: io_watch_del (0x8f3fe0, 9, -1, 0x10) fd_no=2 called
Apr 28 00:15:31 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [tcp_read.c:1437]: release_tcpconn(): releasing con 0x7fea2821f388, state 1, fd=9, id=4
Apr 28 00:15:31 kamailio /usr/local/sbin/kamailio[10740]: DEBUG: <core> [tcp_read.c:1438]: release_tcpconn(): extra_data (nil)
Apr 28 00:15:31 kamailio /usr/local/sbin/kamailio[10743]: DEBUG: <core> [tcp_main.c:3385]: handle_tcp_child(): handle_tcp_child: reader response= 7fea2821f388, 1 from 1
Apr 28 00:15:31 kamailio /usr/local/sbin/kamailio[10743]: DEBUG: <core> [io_wait.h:390]: io_watch_add(): DBG: io_watch_add(0x8afd40, 29, 2, 0x7fea2821f388), fd_no=20
Apr 28 00:15:31 kamailio /usr/local/sbin/kamailio[10743]: DEBUG: <core> [tcp_main.c:3515]: handle_tcp_child(): handle_tcp_child: CONN_RELEASE 0x7fea2821f388 refcnt= 1
Apr 28 00:15:48 kamailio /usr/local/sbin/kamailio[10734]: DEBUG: usrloc [ucontact.c:682]: db_update_ucontact_addr(): aor:1001
Apr 28 00:15:48 kamailio /usr/local/sbin/kamailio[10734]: DEBUG: usrloc [ucontact.c:689]: db_update_ucontact_addr(): contact:sip:1001@df7jal23ls0d.invalid;rtcweb-breaker=no;transport=ws
Apr 28 00:15:48 kamailio /usr/local/sbin/kamailio[10734]: DEBUG: usrloc [ucontact.c:696]: db_update_ucontact_addr(): callid:e55f613e-5595-76f9-c71e-c86e7f0bed39
Apr 28 00:15:48 kamailio /usr/local/sbin/kamailio[10734]: DEBUG: usrloc [ucontact.c:789]: db_update_ucontact_addr(): contact:sip:1001@df7jal23ls0d.invalid;rtcweb-breaker=no;transport=ws
Apr 28 00:16:07 kamailio /usr/local/sbin/kamailio[10738]: DEBUG: websocket [ws_frame.c:146]: encode_and_send_ws_frame(): encoding WebSocket frame
Apr 28 00:16:07 kamailio /usr/local/sbin/kamailio[10738]: DEBUG: websocket [ws_frame.c:183]: encode_and_send_ws_frame(): supported control frame: 0x9
Apr 28 00:16:07 kamailio /usr/local/sbin/kamailio[10738]: DEBUG: <core> [tcp_main.c:2333]: tcpconn_send_put(): tcp_send: found fd in cache ( 6, 0x7fea28214698, 2)
Apr 28 00:16:07 kamailio /usr/local/sbin/kamailio[10738]: DEBUG: <core> [tcp_main.c:2556]: tcpconn_do_send(): tcp_send: sending...
Apr 28 00:16:07 kamailio /usr/local/sbin/kamailio[10738]: DEBUG: <core> [tcp_main.c:2590]: tcpconn_do_send(): tcp_send: after real write: c= 0x7fea28214698 n=33 fd=6
Apr 28 00:16:07 kamailio /usr/local/sbin/kamailio[10738]: DEBUG: <core> [tcp_main.c:2591]: tcpconn_do_send(): tcp_send: buf=#012‰#037kamailio (4.1.2 (x86_64/linux))
Apr 28 00:16:07 kamailio /usr/local/sbin/kamailio[10743]: DEBUG: <core> [io_wait.h:617]: io_watch_del(): DBG: io_watch_del (0x8afd40, 27, -1, 0x0) fd_no=21 called
Apr 28 00:16:07 kamailio /usr/local/sbin/kamailio[10743]: DEBUG: <core> [tcp_main.c:4302]: handle_tcpconn_ev(): tcp: DBG: sending to child, events 1
Apr 28 00:16:07 kamailio /usr/local/sbin/kamailio[10743]: DEBUG: <core> [tcp_main.c:3973]: send2child(): selected tcp worker 2 12(10741) for activity on [tcp:192.168.1.103:5066], 0x7fea28214698
Apr 28 00:16:07 kamailio /usr/local/sbin/kamailio[10741]: DEBUG: <core> [tcp_read.c:1510]: handle_io(): received n=8 con=0x7fea28214698, fd=9
Apr 28 00:16:07 kamailio /usr/local/sbin/kamailio[10741]: DEBUG: <core> [tcp_read.c:1138]: ws_process_msg(): WebSocket Message: [[>>>#012ŠŸözJw#033'#026Ÿ#026##030ÖR~YÇTxWÞ#002rA©L~Xš#023$#002ŽSc<<<]]
Apr 28 00:16:07 kamailio /usr/local/sbin/kamailio[10741]: DEBUG: websocket [ws_frame.c:416]: decode_and_validate_ws_frame(): decoding WebSocket frame
Apr 28 00:16:07 kamailio /usr/local/sbin/kamailio[10741]: DEBUG: websocket [ws_frame.c:473]: decode_and_validate_ws_frame(): supported control frame: 0xa
Apr 28 00:16:07 kamailio /usr/local/sbin/kamailio[10741]: DEBUG: websocket [ws_frame.c:570]: decode_and_validate_ws_frame(): Rx (decoded): kamailio (4.1.2 (x86_64/linux))
Apr 28 00:16:07 kamailio /usr/local/sbin/kamailio[10741]: DEBUG: websocket [ws_frame.c:621]: handle_pong(): Rx Pong: kamailio (4.1.2 (x86_64/linux))
Apr 28 00:16:07 kamailio /usr/local/sbin/kamailio[10741]: DEBUG: <core> [io_wait.h:390]: io_watch_add(): DBG: io_watch_add(0x8f3fe0, 9, 2, 0x7fea28214698), fd_no=1
Also, here is the FS log for non- working case (setup A - SIPml5 client is registered to Kamailio server which is integrated with FS as media bridge ):
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [NOTICE] switch_channel.c:1053 New Channel sofia/internal/1001@vortex01.no-ip.info [6e61a7b2-ce59-11e3-bc32-179817d66480]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_session.c:1050 Send signal sofia/internal/1001@vortex01.no-ip.info [BREAK]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_session.c:1050 Send signal sofia/internal/1001@vortex01.no-ip.info [BREAK]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/1001@vortex01.no-ip.info) Running State Change CS_NEW
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] sofia.c:8264 sofia/internal/1001@vortex01.no-ip.info receiving invite from192.168.1.103:5060 version: 1.5.11b git 048ce8d 2014-03-15 03:13:34Z 64bit
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] sofia.c:6163 Channel sofia/internal/1001@vortex01.no-ip.info entering state [received][100]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] sofia.c:6173 Remote SDP:
6e61a7b2-ce59-11e3-bc32-179817d66480 v=0
6e61a7b2-ce59-11e3-bc32-179817d66480 o=- 6933551414148352000 2 IN IP4 127.0.0.1
6e61a7b2-ce59-11e3-bc32-179817d66480 s=Doubango Telecom - chrome
6e61a7b2-ce59-11e3-bc32-179817d66480 t=0 0
6e61a7b2-ce59-11e3-bc32-179817d66480 a=group:BUNDLE audio
6e61a7b2-ce59-11e3-bc32-179817d66480 a=msid-semantic: WMS NmmoDAX4BXNkxNGYFECZkD9Ka6ejHZyPMYUo
6e61a7b2-ce59-11e3-bc32-179817d66480 m=audio 57265 RTP/SAVPF 111 103 104 0 8 106 105 13 126
6e61a7b2-ce59-11e3-bc32-179817d66480 c=IN IP4 95.180.32.20
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtpmap:111 opus/48000/2
6e61a7b2-ce59-11e3-bc32-179817d66480 a=fmtp:111 minptime=10
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtpmap:103 ISAC/16000
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtpmap:104 ISAC/32000
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtpmap:0 PCMU/8000
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtpmap:8 PCMA/8000
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtpmap:106 CN/32000
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtpmap:105 CN/16000
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtpmap:13 CN/8000
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtpmap:126 telephone-event/8000
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtcp:57265 IN IP4 95.180.32.20
6e61a7b2-ce59-11e3-bc32-179817d66480 a=candidate:2131708102 1 udp 2113937151 192.168.0.100 57265 typ host generation 0
6e61a7b2-ce59-11e3-bc32-179817d66480 a=candidate:2131708102 2 udp 2113937151 192.168.0.100 57265 typ host generation 0
6e61a7b2-ce59-11e3-bc32-179817d66480 a=candidate:4266086002 1 udp 1845501695 95.180.32.20 57265 typ srflx raddr 192.168.0.100 rport 57265 generation 0
6e61a7b2-ce59-11e3-bc32-179817d66480 a=candidate:4266086002 2 udp 1845501695 95.180.32.20 57265 typ srflx raddr 192.168.0.100 rport 57265 generation 0
6e61a7b2-ce59-11e3-bc32-179817d66480 a=candidate:831304758 1 tcp 1509957375 192.168.0.100 0 typ host generation 0
6e61a7b2-ce59-11e3-bc32-179817d66480 a=candidate:831304758 2 tcp 1509957375 192.168.0.100 0 typ host generation 0
6e61a7b2-ce59-11e3-bc32-179817d66480 a=ice-ufrag:gHnLryRtXCOYse+I
6e61a7b2-ce59-11e3-bc32-179817d66480 a=ice-pwd:gD1S2kW13thhaaqe30SyLfi3
6e61a7b2-ce59-11e3-bc32-179817d66480 a=ice-options:google-ice
6e61a7b2-ce59-11e3-bc32-179817d66480 a=fingerprint:sha-256 39:84:0F:18:1B:DA:DB:39:D4:EB:80:4D:4C:4B:3A:DB:0B:A1:B9:7C:4B:2C:C9:00:4F:A3:9A:F9:66:C3:70:F4
6e61a7b2-ce59-11e3-bc32-179817d66480 a=setup:actpass
6e61a7b2-ce59-11e3-bc32-179817d66480 a=mid:audio
6e61a7b2-ce59-11e3-bc32-179817d66480 a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtcp-mux
6e61a7b2-ce59-11e3-bc32-179817d66480 a=crypto:0 AES_CM_128_HMAC_SHA1_32 inline:Cz/8x3EVJwmDLmLlp5EbgpSVH4sK52PZjT9uA9E5
6e61a7b2-ce59-11e3-bc32-179817d66480 a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:GqldZ39QV90ToD8lVZVcimBM+Qf422rD4FlZK0nV
6e61a7b2-ce59-11e3-bc32-179817d66480 a=maxptime:60
6e61a7b2-ce59-11e3-bc32-179817d66480 a=ssrc:1999392369 cname:S5DliNJMaHoIOHFf
6e61a7b2-ce59-11e3-bc32-179817d66480 a=ssrc:1999392369 msid:NmmoDAX4BXNkxNGYFECZkD9Ka6ejHZyPMYUo bceee12b-94e6-49e5-acab-bb334f96e7c6
6e61a7b2-ce59-11e3-bc32-179817d66480 a=ssrc:1999392369 mslabel:NmmoDAX4BXNkxNGYFECZkD9Ka6ejHZyPMYUo
6e61a7b2-ce59-11e3-bc32-179817d66480 a=ssrc:1999392369 label:bceee12b-94e6-49e5-acab-bb334f96e7c6
6e61a7b2-ce59-11e3-bc32-179817d66480
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] sofia.c:6428 (sofia/internal/1001@vortex01.no-ip.info) State Change CS_NEW -> CS_INIT
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_session.c:1385 Send signal sofia/internal/1001@vortex01.no-ip.info [BREAK]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_state_machine.c:486 (sofia/internal/1001@vortex01.no-ip.info) State NEW
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/1001@vortex01.no-ip.info) Running State Change CS_INIT
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_state_machine.c:507 (sofia/internal/1001@vortex01.no-ip.info) State INIT
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] mod_sofia.c:87 sofia/internal/1001@vortex01.no-ip.info SOFIA INIT
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_state_machine.c:40 sofia/internal/1001@vortex01.no-ip.info Standard INIT
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/1001@vortex01.no-ip.info) State Change CS_INIT -> CS_ROUTING
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_session.c:1385 Send signal sofia/internal/1001@vortex01.no-ip.info [BREAK]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_state_machine.c:507 (sofia/internal/1001@vortex01.no-ip.info) State INIT going to sleep
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/1001@vortex01.no-ip.info) Running State Change CS_ROUTING
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_channel.c:2177 (sofia/internal/1001@vortex01.no-ip.info) Callstate Change DOWN -> RINGING
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_state_machine.c:523 (sofia/internal/1001@vortex01.no-ip.info) State ROUTING
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] mod_sofia.c:123 sofia/internal/1001@vortex01.no-ip.info SOFIA ROUTING
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_state_machine.c:164 sofia/internal/1001@vortex01.no-ip.info Standard ROUTING
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [INFO] mod_dialplan_xml.c:558 Processing 1001 <1001>->3000 in context public
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [public->unloop] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [public->outside_call] continue=true
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Absolute Condition [outside_call]
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Action set(outside_call=true)
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [public->call_debug] continue=true
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [public->public_extensions] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [public_extensions] destination_number(3000) =~ /^(10[01][0-9])$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [public->from_kamailio] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (PASS) [from_kamailio] network_addr(192.168.1.103) =~ /^192\.168\.1\.103$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (PASS) [from_kamailio] destination_number(3000) =~ /^(.+)$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Action transfer(3000 XML default)
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_state_machine.c:214 (sofia/internal/1001@vortex01.no-ip.info) State Change CS_ROUTING -> CS_EXECUTE
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_session.c:1385 Send signal sofia/internal/1001@vortex01.no-ip.info [BREAK]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_state_machine.c:523 (sofia/internal/1001@vortex01.no-ip.info) State ROUTING going to sleep
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/1001@vortex01.no-ip.info) Running State Change CS_EXECUTE
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_state_machine.c:530 (sofia/internal/1001@vortex01.no-ip.info) State EXECUTE
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] mod_sofia.c:178 sofia/internal/1001@vortex01.no-ip.info SOFIA EXECUTE
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_state_machine.c:256 sofia/internal/1001@vortex01.no-ip.info Standard EXECUTE
6e61a7b2-ce59-11e3-bc32-179817d66480 EXECUTE sofia/internal/1001@vortex01.no-ip.info set(outside_call=true)
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] mod_dptools.c:1409 sofia/internal/1001@vortex01.no-ip.info SET [outside_call]=[true]
6e61a7b2-ce59-11e3-bc32-179817d66480 EXECUTE sofia/internal/1001@vortex01.no-ip.info export(RFC2822_DATE=Mon, 28 Apr 2014 00:15:25 +0200)
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_channel.c:1245 EXPORT (export_vars) [RFC2822_DATE]=[Mon, 28 Apr 2014 00:15:25 +0200]
6e61a7b2-ce59-11e3-bc32-179817d66480 EXECUTE sofia/internal/1001@vortex01.no-ip.info transfer(3000 XML default)
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_ivr.c:1831 (sofia/internal/1001@vortex01.no-ip.info) State Change CS_EXECUTE -> CS_ROUTING
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_session.c:1385 Send signal sofia/internal/1001@vortex01.no-ip.info [BREAK]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_session.c:905 Send signal sofia/internal/1001@vortex01.no-ip.info [BREAK]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [NOTICE] switch_ivr.c:1838 Transfer sofia/internal/1001@vortex01.no-ip.info to XML[3000@default]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_state_machine.c:530 (sofia/internal/1001@vortex01.no-ip.info) State EXECUTE going to sleep
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/1001@vortex01.no-ip.info) Running State Change CS_ROUTING
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_state_machine.c:523 (sofia/internal/1001@vortex01.no-ip.info) State ROUTING
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] mod_sofia.c:123 sofia/internal/1001@vortex01.no-ip.info SOFIA ROUTING
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_state_machine.c:164 sofia/internal/1001@vortex01.no-ip.info Standard ROUTING
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [INFO] mod_dialplan_xml.c:558 Processing 1001 <1001>->3000 in context default
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->unloop] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->tod_example] continue=true
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Date/TimeMatch (FAIL) [tod_example] break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->holiday_example] continue=true
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Date/TimeMatch (FAIL) [holiday_example] break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->global-intercept] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [global-intercept] destination_number(3000) =~ /^886$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->group-intercept] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [group-intercept] destination_number(3000) =~ /^\*8$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->intercept-ext] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [intercept-ext] destination_number(3000) =~ /^\*\*(\d+)$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->redial] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [redial] destination_number(3000) =~ /^(redial|870)$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->global] continue=true
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [global] ${rtp_has_crypto}() =~ /^(AEAD_AES_256_GCM_8|AEAD_AES_128_GCM_8|AES_CM_256_HMAC_SHA1_80|AES_CM_192_HMAC_SHA1_80|AES_CM_128_HMAC_SHA1_80|AES_CM_256_HMAC_SHA1_32|AES_CM_192_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_32|AES_CM_128_NULL_AUTH)$/ break=never
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (PASS) [global] ${endpoint_disposition}(DELAYED NEGOTIATION) =~ /^(DELAYED NEGOTIATION)/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (PASS) [global] ${switch_r_sdp}(v=0
6e61a7b2-ce59-11e3-bc32-179817d66480 o=- 6933551414148352000 2 IN IP4 127.0.0.1
6e61a7b2-ce59-11e3-bc32-179817d66480 s=Doubango Telecom - chrome
6e61a7b2-ce59-11e3-bc32-179817d66480 t=0 0
6e61a7b2-ce59-11e3-bc32-179817d66480 a=group:BUNDLE audio
6e61a7b2-ce59-11e3-bc32-179817d66480 a=msid-semantic: WMS NmmoDAX4BXNkxNGYFECZkD9Ka6ejHZyPMYUo
6e61a7b2-ce59-11e3-bc32-179817d66480 m=audio 57265 RTP/SAVPF 111 103 104 0 8 106 105 13 126
6e61a7b2-ce59-11e3-bc32-179817d66480 c=IN IP4 95.180.32.20
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtpmap:111 opus/48000/2
6e61a7b2-ce59-11e3-bc32-179817d66480 a=fmtp:111 minptime=10
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtpmap:103 ISAC/16000
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtpmap:104 ISAC/32000
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtpmap:0 PCMU/8000
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtpmap:8 PCMA/8000
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtpmap:106 CN/32000
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtpmap:105 CN/16000
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtpmap:13 CN/8000
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtpmap:126 telephone-event/8000
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtcp:57265 IN IP4 95.180.32.20
6e61a7b2-ce59-11e3-bc32-179817d66480 a=candidate:2131708102 1 udp 2113937151 192.168.0.100 57265 typ host generation 0
6e61a7b2-ce59-11e3-bc32-179817d66480 a=candidate:2131708102 2 udp 2113937151 192.168.0.100 57265 typ host generation 0
6e61a7b2-ce59-11e3-bc32-179817d66480 a=candidate:4266086002 1 udp 1845501695 95.180.32.20 57265 typ srflx raddr 192.168.0.100 rport 57265 generation 0
6e61a7b2-ce59-11e3-bc32-179817d66480 a=candidate:4266086002 2 udp 1845501695 95.180.32.20 57265 typ srflx raddr 192.168.0.100 rport 57265 generation 0
6e61a7b2-ce59-11e3-bc32-179817d66480 a=candidate:831304758 1 tcp 1509957375 192.168.0.100 0 typ host generation 0
6e61a7b2-ce59-11e3-bc32-179817d66480 a=candidate:831304758 2 tcp 1509957375 192.168.0.100 0 typ host generation 0
6e61a7b2-ce59-11e3-bc32-179817d66480 a=ice-ufrag:gHnLryRtXCOYse+I
6e61a7b2-ce59-11e3-bc32-179817d66480 a=ice-pwd:gD1S2kW13thhaaqe30SyLfi3
6e61a7b2-ce59-11e3-bc32-179817d66480 a=ice-options:google-ice
6e61a7b2-ce59-11e3-bc32-179817d66480 a=fingerprint:sha-256 39:84:0F:18:1B:DA:DB:39:D4:EB:80:4D:4C:4B:3A:DB:0B:A1:B9:7C:4B:2C:C9:00:4F:A3:9A:F9:66:C3:70:F4
6e61a7b2-ce59-11e3-bc32-179817d66480 a=setup:actpass
6e61a7b2-ce59-11e3-bc32-179817d66480 a=mid:audio
6e61a7b2-ce59-11e3-bc32-179817d66480 a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtcp-mux
6e61a7b2-ce59-11e3-bc32-179817d66480 a=crypto:0 AES_CM_128_HMAC_SHA1_32 inline:Cz/8x3EVJwmDLmLlp5EbgpSVH4sK52PZjT9uA9E5
6e61a7b2-ce59-11e3-bc32-179817d66480 a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:GqldZ39QV90ToD8lVZVcimBM+Qf422rD4FlZK0nV
6e61a7b2-ce59-11e3-bc32-179817d66480 a=maxptime:60
6e61a7b2-ce59-11e3-bc32-179817d66480 a=ssrc:1999392369 cname:S5DliNJMaHoIOHFf
6e61a7b2-ce59-11e3-bc32-179817d66480 a=ssrc:1999392369 msid:NmmoDAX4BXNkxNGYFECZkD9Ka6ejHZyPMYUo bceee12b-94e6-49e5-acab-bb334f96e7c6
6e61a7b2-ce59-11e3-bc32-179817d66480 a=ssrc:1999392369 mslabel:NmmoDAX4BXNkxNGYFECZkD9Ka6ejHZyPMYUo
6e61a7b2-ce59-11e3-bc32-179817d66480 a=ssrc:1999392369 label:bceee12b-94e6-49e5-acab-bb334f96e7c6
6e61a7b2-ce59-11e3-bc32-179817d66480 ) =~ /(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)/ break=never
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Action set(rtp_secure_media=true)
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Absolute Condition [global]
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid})
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Action hash(insert/${domain_name}-last_dial/global/${uuid})
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->snom-demo-2] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [snom-demo-2] destination_number(3000) =~ /^9001$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->snom-demo-1] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [snom-demo-1] destination_number(3000) =~ /^9000$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->eavesdrop] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [eavesdrop] destination_number(3000) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->eavesdrop] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [eavesdrop] destination_number(3000) =~ /^779$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->call_return] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [call_return] destination_number(3000) =~ /^\*69$|^869$|^lcr$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->del-group] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [del-group] destination_number(3000) =~ /^80(\d{2})$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->add-group] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [add-group] destination_number(3000) =~ /^81(\d{2})$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->call-group-simo] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [call-group-simo] destination_number(3000) =~ /^82(\d{2})$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->call-group-order] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [call-group-order] destination_number(3000) =~ /^83(\d{2})$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->extension-intercom] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [extension-intercom] destination_number(3000) =~ /^8(10[01][0-9])$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->Local_Extension] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [Local_Extension] destination_number(3000) =~ /^(10[01][0-9]|1500)$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->Local_Extension_Skinny] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [Local_Extension_Skinny] destination_number(3000) =~ /^(11[01][0-9])$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->group_dial_sales] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [group_dial_sales] destination_number(3000) =~ /^2000$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->group_dial_support] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [group_dial_support] destination_number(3000) =~ /^2001$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->group_dial_billing] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [group_dial_billing] destination_number(3000) =~ /^2002$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->operator] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [operator] destination_number(3000) =~ /^(operator|0)$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->vmain] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [vmain] destination_number(3000) =~ /^vmain$|^4000$|^\*98$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->sip_uri] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (FAIL) [sip_uri] destination_number(3000) =~ /^sip:(.*)$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info parsing [default->nb_conferences] continue=false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Regex (PASS) [nb_conferences] destination_number(3000) =~ /^(30\d{2})$/ break=on-false
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Action answer()
6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001@vortex01.no-ip.info Action conference(3000-${domain_name}@default)
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_state_machine.c:214 (sofia/internal/1001@vortex01.no-ip.info) State Change CS_ROUTING -> CS_EXECUTE
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_session.c:1385 Send signal sofia/internal/1001@vortex01.no-ip.info [BREAK]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_state_machine.c:523 (sofia/internal/1001@vortex01.no-ip.info) State ROUTING going to sleep
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/1001@vortex01.no-ip.info) Running State Change CS_EXECUTE
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_state_machine.c:530 (sofia/internal/1001@vortex01.no-ip.info) State EXECUTE
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] mod_sofia.c:178 sofia/internal/1001@vortex01.no-ip.info SOFIA EXECUTE
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_state_machine.c:256 sofia/internal/1001@vortex01.no-ip.info Standard EXECUTE
6e61a7b2-ce59-11e3-bc32-179817d66480 EXECUTE sofia/internal/1001@vortex01.no-ip.info set(rtp_secure_media=true)
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] mod_dptools.c:1409 sofia/internal/1001@vortex01.no-ip.info SET [rtp_secure_media]=[true]
6e61a7b2-ce59-11e3-bc32-179817d66480 EXECUTE sofia/internal/1001@vortex01.no-ip.info hash(insert/192.168.1.103-spymap/1001/6e61a7b2-ce59-11e3-bc32-179817d66480)
6e61a7b2-ce59-11e3-bc32-179817d66480 EXECUTE sofia/internal/1001@vortex01.no-ip.info hash(insert/192.168.1.103-last_dial/1001/3000)
6e61a7b2-ce59-11e3-bc32-179817d66480 EXECUTE sofia/internal/1001@vortex01.no-ip.info hash(insert/192.168.1.103-last_dial/global/6e61a7b2-ce59-11e3-bc32-179817d66480)
6e61a7b2-ce59-11e3-bc32-179817d66480 EXECUTE sofia/internal/1001@vortex01.no-ip.info export(RFC2822_DATE=Mon, 28 Apr 2014 00:15:25 +0200)
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_channel.c:1245 EXPORT (export_vars) [RFC2822_DATE]=[Mon, 28 Apr 2014 00:15:25 +0200]
6e61a7b2-ce59-11e3-bc32-179817d66480 EXECUTE sofia/internal/1001@vortex01.no-ip.info answer()
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [opus:111:48000:60:0]/[G722:9:8000:20:64000]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [opus:111:48000:60:0]/[PCMU:0:8000:20:64000]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [opus:111:48000:60:0]/[PCMA:8:8000:20:64000]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [opus:111:48000:60:0]/[GSM:3:8000:20:13200]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [ISAC:103:16000:30:32000]/[G722:9:8000:20:64000]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [ISAC:103:16000:30:32000]/[PCMU:0:8000:20:64000]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [ISAC:103:16000:30:32000]/[PCMA:8:8000:20:64000]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [ISAC:103:16000:30:32000]/[GSM:3:8000:20:13200]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [ISAC:104:32000:30:32000]/[G722:9:8000:20:64000]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [ISAC:104:32000:30:32000]/[PCMU:0:8000:20:64000]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [ISAC:104:32000:30:32000]/[PCMA:8:8000:20:64000]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [ISAC:104:32000:30:32000]/[GSM:3:8000:20:13200]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [PCMU:0:8000:60:64000]/[G722:9:8000:20:64000]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [PCMU:0:8000:60:64000]/[PCMU:0:8000:20:64000]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3439 Audio Codec Compare [PCMU:0:8000:20:64000] ++++ is saved as a match
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [PCMU:0:8000:60:64000]/[PCMA:8:8000:20:64000]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [PCMU:0:8000:60:64000]/[GSM:3:8000:20:13200]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [PCMA:8:8000:60:64000]/[G722:9:8000:20:64000]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [PCMA:8:8000:60:64000]/[PCMU:0:8000:20:64000]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [PCMA:8:8000:60:64000]/[PCMA:8:8000:20:64000]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3439 Audio Codec Compare [PCMA:8:8000:20:64000] ++++ is saved as a match
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [PCMA:8:8000:60:64000]/[GSM:3:8000:20:13200]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [CN:105:16000:60:0]/[G722:9:8000:20:64000]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [CN:105:16000:60:0]/[PCMU:0:8000:20:64000]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [CN:105:16000:60:0]/[PCMA:8:8000:20:64000]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [CN:105:16000:60:0]/[GSM:3:8000:20:13200]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [CN:13:8000:60:0]/[G722:9:8000:20:64000]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [CN:13:8000:60:0]/[PCMU:0:8000:20:64000]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [CN:13:8000:60:0]/[PCMA:8:8000:20:64000]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3385 Audio Codec Compare [CN:13:8000:60:0]/[GSM:3:8000:20:13200]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3311 Set telephone-event payload to 126
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:2343 Set Codec sofia/internal/1001@vortex01.no-ip.info PCMU/8000 20 ms 160 samples 64000 bits
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_codec.c:111 sofia/internal/1001@vortex01.no-ip.info Original read codec set to PCMU:0
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [WARNING] switch_core_media.c:2544 NO candidate ACL defined, Defaulting to wan.auto
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:2568 Checking Candidate cid: 1 proto: udp type: host addr:192.168.0.100:57265
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [NOTICE] switch_core_media.c:2582 Save audio Candidate cid: 1 proto: udp type: host addr:192.168.0.100:57265
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:2568 Checking Candidate cid: 2 proto: udp type: host addr:192.168.0.100:57265
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [NOTICE] switch_core_media.c:2582 Save audio Candidate cid: 2 proto: udp type: host addr:192.168.0.100:57265
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:2568 Checking Candidate cid: 1 proto: udp type: srflx addr:95.180.32.20:57265
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [NOTICE] switch_core_media.c:2577 Choose audio Candidate cid: 1 proto: udp type: srflx addr:95.180.32.20:57265
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:2568 Checking Candidate cid: 2 proto: udp type: srflx addr:95.180.32.20:57265
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [NOTICE] switch_core_media.c:2577 Choose audio Candidate cid: 2 proto: udp type: srflx addr:95.180.32.20:57265
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [NOTICE] switch_core_media.c:2706 setting remote audio ice addr to 95.180.32.20:57265 based on candidate
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [NOTICE] switch_core_media.c:2726 setting remote rtcp audio addr to 95.180.32.20:57265 based on candidate
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:3628 Set 2833 dtmf send/recv payload to 126
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:4843 AUDIO RTP [sofia/internal/1001@vortex01.no-ip.info] 192.168.1.103 port 18598 -> 95.180.32.20 port 57265 codec: 0 ms: 20
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_rtp.c:3334 Starting timer [soft] 160 bytes per 20ms
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [INFO] switch_core_media.c:5012 Activating Audio ICE
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [NOTICE] switch_rtp.c:3775 Activating RTP audio ICE: gHnLryRtXCOYse+I:fFrH85qVZn46sq5j95.180.32.20:57265
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [INFO] switch_core_media.c:5055 Activating RTCP PORT 57265
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_rtp.c:3680 RTCP send rate is: 10000 and packet rate is: 20000 Remote Port: 57265
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_rtp.c:2153 Setting RTCP remote addr to 95.180.32.20:57265
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [INFO] switch_core_media.c:5063 Skipping RTCP ICE (Same as RTP)
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [INFO] switch_rtp.c:2878 Activate RTP/RTCP audio DTLS client
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:5187 Set 2833 dtmf send payload to 126
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:5193 Set 2833 dtmf receive payload to 126
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_media.c:5221 Set comfort noise payload to 106
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [NOTICE] sofia_media.c:92 Pre-Answer sofia/internal/1001@vortex01.no-ip.info!
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_channel.c:3393 (sofia/internal/1001@vortex01.no-ip.info) Callstate Change RINGING -> EARLY
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] mod_sofia.c:775 Local SDP sofia/internal/1001@vortex01.no-ip.info:
6e61a7b2-ce59-11e3-bc32-179817d66480 v=0
6e61a7b2-ce59-11e3-bc32-179817d66480 o=FreeSWITCH 1398618327 1398618328 IN IP4 192.168.1.103
6e61a7b2-ce59-11e3-bc32-179817d66480 s=FreeSWITCH
6e61a7b2-ce59-11e3-bc32-179817d66480 c=IN IP4 192.168.1.103
6e61a7b2-ce59-11e3-bc32-179817d66480 t=0 0
6e61a7b2-ce59-11e3-bc32-179817d66480 a=msid-semantic: WMS 3W5SBZTwGbY3LccBFF9pBCOTX46igew9
6e61a7b2-ce59-11e3-bc32-179817d66480 m=audio 18598 RTP/SAVPF 0 126 106
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtpmap:0 PCMU/8000
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtpmap:126 telephone-event/8000
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtpmap:106 CN/8000
6e61a7b2-ce59-11e3-bc32-179817d66480 a=ptime:20
6e61a7b2-ce59-11e3-bc32-179817d66480 a=sendrecv
6e61a7b2-ce59-11e3-bc32-179817d66480 a=fingerprint:sha-256 E6:78:EC:39:F5:3C:05:52:3A:9D:CF:39:C3:A1:48:AD:F4:5F:92:93:FC:80:B5:E0:04:0E:9F:59:DA:6D:23:17
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtcp-mux
6e61a7b2-ce59-11e3-bc32-179817d66480 a=rtcp:18598 IN IP4 192.168.1.103
6e61a7b2-ce59-11e3-bc32-179817d66480 a=ssrc:3613542797 cname:1sSsiCPODDHeGKGc
6e61a7b2-ce59-11e3-bc32-179817d66480 a=ssrc:3613542797 msid:3W5SBZTwGbY3LccBFF9pBCOTX46igew9 a0
6e61a7b2-ce59-11e3-bc32-179817d66480 a=ssrc:3613542797 mslabel:3W5SBZTwGbY3LccBFF9pBCOTX46igew9
6e61a7b2-ce59-11e3-bc32-179817d66480 a=ssrc:3613542797 label:3W5SBZTwGbY3LccBFF9pBCOTX46igew9a0
6e61a7b2-ce59-11e3-bc32-179817d66480 a=ice-ufrag:fFrH85qVZn46sq5j
6e61a7b2-ce59-11e3-bc32-179817d66480 a=ice-pwd:JOCRghvKL3PhDlkJ
6e61a7b2-ce59-11e3-bc32-179817d66480 a=candidate:1860017488 1 udp 659136 192.168.1.103 18598 typ host generation 0
6e61a7b2-ce59-11e3-bc32-179817d66480
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_session.c:1050 Send signal sofia/internal/1001@vortex01.no-ip.info [BREAK]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] sofia.c:6163 Channel sofia/internal/1001@vortex01.no-ip.info entering state [completed][200]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_session.c:905 Send signal sofia/internal/1001@vortex01.no-ip.info [BREAK]
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [NOTICE] mod_dptools.c:1232 Channel [sofia/internal/1001@vortex01.no-ip.info] has been answered
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_channel.c:3680 (sofia/internal/1001@vortex01.no-ip.info) Callstate Change EARLY -> ACTIVE
6e61a7b2-ce59-11e3-bc32-179817d66480 EXECUTE sofia/internal/1001@vortex01.no-ip.info conference(3000-192.168.1.103@default)
2014-04-28 00:15:25.048231 [INFO] mod_conference.c:9366 using channel sound prefix: /usr/local/freeswitch_master/sounds/en/us/callie
2014-04-28 00:15:25.048231 [DEBUG] mod_conference.c:2526 Setup timer success interval: 20 samples: 160
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] mod_conference.c:8052 Raw Codec Activation Success L16@8000hz 1 channel 20ms
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] mod_conference.c:8097 Raw Codec Activation Success L16@8000hz 1 channel 20ms
6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_core_codec.c:221 sofia/internal/1001@vortex01.no-ip.info Push codec L16:70
2014-04-28 00:15:25.048231 [INFO] mod_conference.c:9966 sofia/internal/1001@vortex01.no-ip.info binding '0' to 'mute'
2014-04-28 00:15:25.048231 [INFO] switch_ivr_async.c:212 Digit parser mod_conference: Setting realm to 'conf'
2014-04-28 00:15:25.048231 [DEBUG] switch_ivr_async.c:321 Digit parser mod_conference: binding 0/conf/0 callback: 0x7f898a246050 data: 0x7f89940b5860
2014-04-28 00:15:25.048231 [INFO] mod_conference.c:9966 sofia/internal/1001@vortex01.no-ip.info binding '*' to 'deaf mute'
2014-04-28 00:15:25.048231 [DEBUG] switch_ivr_async.c:321 Digit parser mod_conference: binding */conf/0 callback: 0x7f898a246050 data: 0x7f89940b5890
2014-04-28 00:15:25.048231 [INFO] mod_conference.c:9966 sofia/internal/1001@vortex01.no-ip.info binding '9' to 'energy up'
2014-04-28 00:15:25.048231 [DEBUG] switch_ivr_async.c:321 Digit parser mod_conference: binding 9/conf/0 callback: 0x7f898a246050 data: 0x7f89940b58c0
2014-04-28 00:15:25.048231 [INFO] mod_conference.c:9966 sofia/internal/1001@vortex01.no-ip.info binding '8' to 'energy equ'
2014-04-28 00:15:25.048231 [DEBUG] switch_ivr_async.c:321 Digit parser mod_conference: binding 8/conf/0 callback: 0x7f898a246050 data: 0x7f89940b58f0
2014-04-28 00:15:25.048231 [INFO] mod_conference.c:9966 sofia/internal/1001@vortex01.no-ip.info binding '7' to 'energy dn'
2014-04-28 00:15:25.048231 [DEBUG] switch_ivr_async.c:321 Digit parser mod_conference: binding 7/conf/0 callback: 0x7f898a246050 data: 0x7f89940b5920
2014-04-28 00:15:25.048231 [INFO] mod_conference.c:9966 sofia/internal/1001@vortex01.no-ip.info binding '3' to 'vol talk up'
2014-04-28 00:15:25.048231 [DEBUG] switch_ivr_async.c:321 Digit parser mod_conference: binding 3/conf/0 callback: 0x7f898a246050 data: 0x7f89940b5950
2014-04-28 00:15:25.048231 [INFO] mod_conference.c:9966 sofia/internal/1001@vortex01.no-ip.info binding '2' to 'vol talk zero'
2014-04-28 00:15:25.048231 [DEBUG] switch_ivr_async.c:321 Digit parser mod_conference: binding 2/conf/0 callback: 0x7f898a246050 data: 0x7f89940b5980
2014-04-28 00:15:25.048231 [INFO] mod_conference.c:9966 sofia/internal/1001@vortex01.no-ip.info binding '1' to 'vol talk dn'
2014-04-28 00:15:25.048231 [DEBUG] switch_ivr_async.c:321 Digit parser mod_conference: binding 1/conf/0 callback: 0x7f898a246050 data: 0x7f89940b59b0
2014-04-28 00:15:25.048231 [INFO] mod_conference.c:9966 sofia/internal/1001@vortex01.no-ip.info binding '6' to 'vol listen up'
2014-04-28 00:15:25.048231 [DEBUG] switch_ivr_async.c:321 Digit parser mod_conference:
...
SIPml5 client: output from Javascript console:
State machine: c0000_Started_2_Outgoing_X_oINVITE SIPml-api.js?svn=179:1
PeerConnectionClass = function RTCPeerConnection() { [native code] } SessionDescriptionClass = function RTCSessionDescription() { [native code] } IceCandidateClass = function RTCIceCandidate() { [native code] } SIPml-api.js?svn=179:1
ICE servers:[{"url":"stun:stun.l.google.com:19302"},{"url":"stun:stun.counterpath.net:3478"},{"url":"stun:numb.viagenie.ca:3478"}] SIPml-api.js?svn=179:1
==stack event = m_permission_requested SIPml-api.js?svn=179:1
==session event = connecting SIPml-api.js?svn=179:1
onGetUserMediaSuccess SIPml-api.js?svn=179:1
createOffer SIPml-api.js?svn=179:1
==stack event = m_permission_accepted SIPml-api.js?svn=179:1
onCreateSdpSuccess SIPml-api.js?svn=179:1
==session event = m_stream_audio_local_added SIPml-api.js?svn=179:1
onSetLocalDescriptionSuccess SIPml-api.js?svn=179:1
onIceCandidate = undefined SIPml-api.js?svn=179:1
onIceCandidate = undefined SIPml-api.js?svn=179:1
onIceCandidate = undefined SIPml-api.js?svn=179:1
onIceCandidate = undefined SIPml-api.js?svn=179:1
onIceCandidate = undefined SIPml-api.js?svn=179:1
onIceCandidate = undefined SIPml-api.js?svn=179:1
onIceCandidate = undefined SIPml-api.js?svn=179:1
ICE GATHERING COMPLETED! SIPml-api.js?svn=179:1
onIceGatheringCompleted SIPml-api.js?svn=179:1
SEND: INVITE sip:433000@vortex01.no-ip.info SIP/2.0
Via: SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKQSpSg19BFUmPZ729UreSaMctEhwdUTqs;rport
From: "1001"<sip:1001@vortex01.no-ip.info>;tag=rCt6oAuZ6fw6EPxELT8r
To: <sip:433000@vortex01.no-ip.info>
Contact: "1001"<sip:1001@df7jal23ls0d.invalid;rtcweb-breaker=no;click2call=no;transport=ws>;+g.oma.sip-im;+sip.ice;language="en,fr"
Call-ID: 5c230def-fd72-d5ac-c1a2-5fe5d60695d5
CSeq: 63063 INVITE
Content-Type: application/sdp
Content-Length: 1848
Max-Forwards: 70
User-Agent: IM-client/OMA1.0 sipML5-v1.2014.01.27
Organization: Vortex
v=0
o=- 6933551414148352000 2 IN IP4 127.0.0.1
s=Doubango Telecom - chrome
t=0 0
a=group:BUNDLE audio
a=msid-semantic: WMS NmmoDAX4BXNkxNGYFECZkD9Ka6ejHZyPMYUo
m=audio 57265 RTP/SAVPF 111 103 104 0 8 106 105 13 126
c=IN IP4 95.180.32.20
a=rtcp:57265 IN IP4 95.180.32.20
a=candidate:2131708102 1 udp 2113937151 192.168.0.100 57265 typ host generation 0
a=candidate:2131708102 2 udp 2113937151 192.168.0.100 57265 typ host generation 0
a=candidate:4266086002 1 udp 1845501695 95.180.32.20 57265 typ srflx raddr 192.168.0.100 rport 57265 generation 0
a=candidate:4266086002 2 udp 1845501695 95.180.32.20 57265 typ srflx raddr 192.168.0.100 rport 57265 generation 0
a=candidate:831304758 1 tcp 1509957375 192.168.0.100 0 typ host generation 0
a=candidate:831304758 2 tcp 1509957375 192.168.0.100 0 typ host generation 0
a=ice-ufrag:gHnLryRtXCOYse+I
a=ice-pwd:gD1S2kW13thhaaqe30SyLfi3
a=ice-options:google-ice
a=fingerprint:sha-256 39:84:0F:18:1B:DA:DB:39:D4:EB:80:4D:4C:4B:3A:DB:0B:A1:B9:7C:4B:2C:C9:00:4F:A3:9A:F9:66:C3:70:F4
a=setup:actpass
a=mid:audio
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=sendrecv
a=rtcp-mux
a=crypto:0 AES_CM_128_HMAC_SHA1_32 inline:Cz/8x3EVJwmDLmLlp5EbgpSVH4sK52PZjT9uA9E5
a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:GqldZ39QV90ToD8lVZVcimBM+Qf422rD4FlZK0nV
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:126 telephone-event/8000
a=maxptime:60
a=ssrc:1999392369 cname:S5DliNJMaHoIOHFf
a=ssrc:1999392369 msid:NmmoDAX4BXNkxNGYFECZkD9Ka6ejHZyPMYUo bceee12b-94e6-49e5-acab-bb334f96e7c6
a=ssrc:1999392369 mslabel:NmmoDAX4BXNkxNGYFECZkD9Ka6ejHZyPMYUo
a=ssrc:1999392369 label:bceee12b-94e6-49e5-acab-bb334f96e7c6
SIPml-api.js?svn=179:1
__tsip_transport_ws_onmessage SIPml-api.js?svn=179:1
recv=SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/WS df7jal23ls0d.invalid;rport=47214;received=95.180.32.20;branch=z9hG4bKQSpSg19BFUmPZ729UreSaMctEhwdUTqs
From: "1001"<sip:1001@vortex01.no-ip.info>;tag=rCt6oAuZ6fw6EPxELT8r
To: <sip:433000@vortex01.no-ip.info>;tag=ddee8a8975e5e583141b34511b53832c.719a
Call-ID: 5c230def-fd72-d5ac-c1a2-5fe5d60695d5
CSeq: 63063 INVITE
Content-Length: 0
Proxy-Authenticate: Digest realm="vortex01.no-ip.info",nonce="U12CqFNdgXxZUgsI09dUYPtf3c3aKDeD",stale=FALSE
Server: kamailio (4.1.2 (x86_64/linux))
SIPml-api.js?svn=179:1
SEND: ACK sip:433000@vortex01.no-ip.info SIP/2.0
Via: SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKQSpSg19BFUmPZ729UreSaMctEhwdUTqs;rport
From: "1001"<sip:1001@vortex01.no-ip.info>;tag=rCt6oAuZ6fw6EPxELT8r
To: <sip:433000@vortex01.no-ip.info>;tag=ddee8a8975e5e583141b34511b53832c.719a
Call-ID: 5c230def-fd72-d5ac-c1a2-5fe5d60695d5
CSeq: 63063 ACK
Content-Length: 0
Max-Forwards: 70
SIPml-api.js?svn=179:1
State machine: x0000_Any_2_Any_X_i401_407_INVITE SIPml-api.js?svn=179:1
SEND: INVITE sip:433000@vortex01.no-ip.info SIP/2.0
Via: SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKwORxizs21vnkXUB2SrKXu0rm1dbHwXEp;rport
From: "1001"<sip:1001@vortex01.no-ip.info>;tag=rCt6oAuZ6fw6EPxELT8r
To: <sip:433000@vortex01.no-ip.info>
Contact: "1001"<sip:1001@df7jal23ls0d.invalid;rtcweb-breaker=no;click2call=no;transport=ws>;+g.oma.sip-im;+sip.ice;language="en,fr"
Call-ID: 5c230def-fd72-d5ac-c1a2-5fe5d60695d5
CSeq: 63064 INVITE
Content-Type: application/sdp
Content-Length: 1848
Max-Forwards: 70
Proxy-Authorization: Digest username="1001",realm="vortex01.no-ip.info",nonce="U12CqFNdgXxZUgsI09dUYPtf3c3aKDeD",uri="sip:433000@vortex01.no-ip.info",response="1b0518c502ef47910cd5a93b10621606",algorithm=MD5
User-Agent: IM-client/OMA1.0 sipML5-v1.2014.01.27
Organization: Vortex
v=0
o=- 6933551414148352000 2 IN IP4 127.0.0.1
s=Doubango Telecom - chrome
t=0 0
a=group:BUNDLE audio
a=msid-semantic: WMS NmmoDAX4BXNkxNGYFECZkD9Ka6ejHZyPMYUo
m=audio 57265 RTP/SAVPF 111 103 104 0 8 106 105 13 126
c=IN IP4 95.180.32.20
a=rtcp:57265 IN IP4 95.180.32.20
a=candidate:2131708102 1 udp 2113937151 192.168.0.100 57265 typ host generation 0
a=candidate:2131708102 2 udp 2113937151 192.168.0.100 57265 typ host generation 0
a=candidate:4266086002 1 udp 1845501695 95.180.32.20 57265 typ srflx raddr 192.168.0.100 rport 57265 generation 0
a=candidate:4266086002 2 udp 1845501695 95.180.32.20 57265 typ srflx raddr 192.168.0.100 rport 57265 generation 0
a=candidate:831304758 1 tcp 1509957375 192.168.0.100 0 typ host generation 0
a=candidate:831304758 2 tcp 1509957375 192.168.0.100 0 typ host generation 0
a=ice-ufrag:gHnLryRtXCOYse+I
a=ice-pwd:gD1S2kW13thhaaqe30SyLfi3
a=ice-options:google-ice
a=fingerprint:sha-256 39:84:0F:18:1B:DA:DB:39:D4:EB:80:4D:4C:4B:3A:DB:0B:A1:B9:7C:4B:2C:C9:00:4F:A3:9A:F9:66:C3:70:F4
a=setup:actpass
a=mid:audio
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=sendrecv
a=rtcp-mux
a=crypto:0 AES_CM_128_HMAC_SHA1_32 inline:Cz/8x3EVJwmDLmLlp5EbgpSVH4sK52PZjT9uA9E5
a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:GqldZ39QV90ToD8lVZVcimBM+Qf422rD4FlZK0nV
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:126 telephone-event/8000
a=maxptime:60
a=ssrc:1999392369 cname:S5DliNJMaHoIOHFf
a=ssrc:1999392369 msid:NmmoDAX4BXNkxNGYFECZkD9Ka6ejHZyPMYUo bceee12b-94e6-49e5-acab-bb334f96e7c6
a=ssrc:1999392369 mslabel:NmmoDAX4BXNkxNGYFECZkD9Ka6ejHZyPMYUo
a=ssrc:1999392369 label:bceee12b-94e6-49e5-acab-bb334f96e7c6
SIPml-api.js?svn=179:1
__tsip_transport_ws_onmessage SIPml-api.js?svn=179:1
recv=SIP/2.0 100 trying -- your call is important to us
Via: SIP/2.0/WS df7jal23ls0d.invalid;rport=47214;received=95.180.32.20;branch=z9hG4bKwORxizs21vnkXUB2SrKXu0rm1dbHwXEp
From: "1001"<sip:1001@vortex01.no-ip.info>;tag=rCt6oAuZ6fw6EPxELT8r
To: <sip:433000@vortex01.no-ip.info>
Call-ID: 5c230def-fd72-d5ac-c1a2-5fe5d60695d5
CSeq: 63064 INVITE
Content-Length: 0
Server: kamailio (4.1.2 (x86_64/linux))
SIPml-api.js?svn=179:1
State machine: x0000_Any_2_Any_X_i1xx SIPml-api.js?svn=179:1
__tsip_transport_ws_onmessage SIPml-api.js?svn=179:1
recv=SIP/2.0 200 OK
Via: SIP/2.0/WS df7jal23ls0d.invalid;rport=47214;received=95.180.32.20;branch=z9hG4bKwORxizs21vnkXUB2SrKXu0rm1dbHwXEp
From: "1001"<sip:1001@vortex01.no-ip.info>;tag=rCt6oAuZ6fw6EPxELT8r
To: <sip:433000@vortex01.no-ip.info>;tag=aSDDDN5g9078D
Contact: <sip:433000@192.168.1.103:5090;transport=udp>
Call-ID: 5c230def-fd72-d5ac-c1a2-5fe5d60695d5
CSeq: 63064 INVITE
Content-Type: application/sdp
Content-Length: 813
Record-Route: <sip:192.168.1.103;r2=on;lr=on>
Record-Route: <sip:192.168.1.103:5066;transport=ws;r2=on;lr=on>
User-Agent: FreeSWITCH-mod_sofia/1.5.11b+git~20140315T031334Z~048ce8d1f3~64bit
Accept: application/sdp
Allow: INVITE,ACK,BYE,CANCEL,OPTIONS,MESSAGE,INFO,UPDATE,REGISTER,REFER,NOTIFY,PUBLISH,SUBSCRIBE
Supported: timer,path,replaces
Allow-Events: talk,hold,conference,presence,as-feature-event,dialog,line-seize,call-info,sla,include-session-description,presence.winfo,message-summary,refer
Content-Disposition: session
Remote-Party-ID: screen=no;party=calling;privacy=off;screen=no
v=0
o=FreeSWITCH 1398618327 1398618328 IN IP4 192.168.1.103
s=FreeSWITCH
c=IN IP4 192.168.1.103
t=0 0
a=msid-semantic: WMS 3W5SBZTwGbY3LccBFF9pBCOTX46igew9
m=audio 18598 RTP/SAVPF 0 126 106
a=rtpmap:0 PCMU/8000
a=rtpmap:126 telephone-event/8000
a=rtpmap:106 CN/8000
a=ptime:20
a=fingerprint:sha-256 E6:78:EC:39:F5:3C:05:52:3A:9D:CF:39:C3:A1:48:AD:F4:5F:92:93:FC:80:B5:E0:04:0E:9F:59:DA:6D:23:17
a=rtcp-mux
a=rtcp:18598 IN IP4 192.168.1.103
a=ssrc:3613542797 cname:1sSsiCPODDHeGKGc
a=ssrc:3613542797 msid:3W5SBZTwGbY3LccBFF9pBCOTX46igew9 a0
a=ssrc:3613542797 mslabel:3W5SBZTwGbY3LccBFF9pBCOTX46igew9
a=ssrc:3613542797 label:3W5SBZTwGbY3LccBFF9pBCOTX46igew9a0
a=ice-ufrag:fFrH85qVZn46sq5j
a=ice-pwd:JOCRghvKL3PhDlkJ
a=candidate:1860017488 1 udp 659136 192.168.1.103 18598 typ host generation 0
SIPml-api.js?svn=179:1
State machine: c0000_Outgoing_2_Connected_X_i2xxINVITE SIPml-api.js?svn=179:1
setRemoteDescription(answer)
v=0
o=FreeSWITCH 1398618327 1398618328 IN IP4 192.168.1.103
s=FreeSWITCH
c=IN IP4 192.168.1.103
t=0 0
a=msid-semantic: WMS 3W5SBZTwGbY3LccBFF9pBCOTX46igew9
m=audio 18598 RTP/SAVPF 0 126 106
a=rtpmap:0 PCMU/8000
a=rtpmap:126 telephone-event/8000
a=rtpmap:106 CN/8000
a=ptime:20
a=fingerprint:sha-256 E6:78:EC:39:F5:3C:05:52:3A:9D:CF:39:C3:A1:48:AD:F4:5F:92:93:FC:80:B5:E0:04:0E:9F:59:DA:6D:23:17
a=rtcp-mux
a=rtcp:18598 IN IP4 192.168.1.103
a=ssrc:3613542797 cname:1sSsiCPODDHeGKGc
a=ssrc:3613542797 msid:3W5SBZTwGbY3LccBFF9pBCOTX46igew9 a0
a=ssrc:3613542797 mslabel:3W5SBZTwGbY3LccBFF9pBCOTX46igew9
a=ssrc:3613542797 label:3W5SBZTwGbY3LccBFF9pBCOTX46igew9a0
a=ice-ufrag:fFrH85qVZn46sq5j
a=ice-pwd:JOCRghvKL3PhDlkJ
a=candidate:1860017488 1 udp 659136 192.168.1.103 18598 typ host generation 0
SIPml-api.js?svn=179:1
SEND: ACK sip:433000@192.168.1.103:5090;transport=udp SIP/2.0
Via: SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKKaea0Dnu6OHERtnrNRnF;rport
From: "1001"<sip:1001@vortex01.no-ip.info>;tag=rCt6oAuZ6fw6EPxELT8r
To: <sip:433000@vortex01.no-ip.info>;tag=aSDDDN5g9078D
Contact: "1001"<sip:1001@df7jal23ls0d.invalid;rtcweb-breaker=no;click2call=no;transport=ws>;+g.oma.sip-im;+sip.ice;language="en,fr"
Call-ID: 5c230def-fd72-d5ac-c1a2-5fe5d60695d5
CSeq: 63064 ACK
Content-Length: 0
Max-Forwards: 70
Proxy-Authorization: Digest username="1001",realm="vortex01.no-ip.info",nonce="U12CqFNdgXxZUgsI09dUYPtf3c3aKDeD",uri="sip:433000@192.168.1.103:5090;transport=udp",response="e51a0ef649f131763147d3f565d68ad4",algorithm=MD5
Route: <sip:192.168.1.103:5066;transport=ws;r2=on;lr=on>
Route: <sip:192.168.1.103;r2=on;lr=on>
User-Agent: IM-client/OMA1.0 sipML5-v1.2014.01.27
Organization: Vortex
SIPml-api.js?svn=179:1
==session event = i_ao_request SIPml-api.js?svn=179:1
__on_add_stream SIPml-api.js?svn=179:1
==session event = m_early_media SIPml-api.js?svn=179:1
==session event = connected SIPml-api.js?svn=179:1
onSetRemoteDescriptionSuccess SIPml-api.js?svn=179:1
==session event = m_stream_audio_remote_added SIPml-api.js?svn=179:1
//
// kamailio.cfg
//
#!KAMAILIO
# https://gist.github.com/jesusprubio/4066845
# Kamailio (OpenSER) SIP Server v4.0 - default configuration script
# - web: http://www.kamailio.org
# - git: http://sip-router.org
#
# Direct your questions about this file to: <sr-users@lists.sip-router.org>
#
# Refer to the Core CookBook at http://www.kamailio.org/wiki/
# for an explanation of possible statements, functions and parameters.
#
# Several features can be enabled using '#!define WITH_FEATURE' directives:
#
# *** To run in debug mode:
# - define WITH_DEBUG
#
# *** To enable mysql:
# - define WITH_MYSQL
#
# *** To enable authentication execute:
# - enable mysql
# - define WITH_AUTH
# - add users using 'kamctl'
#
# *** To enable IP authentication execute:
# - enable mysql
# - enable authentication
# - define WITH_IPAUTH
# - add IP addresses with group id '1' to 'address' table
#
# *** To enable persistent user location execute:
# - enable mysql
# - define WITH_USRLOCDB
#
# *** To enable presence server execute:
# - enable mysql
# - define WITH_PRESENCE
#
# *** To enable nat traversal execute:
# - define WITH_NAT
# - install RTPProxy: http://www.rtpproxy.org
# - start RTPProxy:
# rtpproxy -l _your_public_ip_ -s udp:localhost:7722
#
# *** To enable PSTN gateway routing execute:
# - define WITH_PSTN
# - set the value of pstn.gw_ip
# - check route[PSTN] for regexp routing condition
#
# *** To enable database aliases lookup execute:
# - enable mysql
# - define WITH_ALIASDB
#
# *** To enable speed dial lookup execute:
# - enable mysql
# - define WITH_SPEEDDIAL
#
# *** To enable multi-domain support execute:
# - enable mysql
# - define WITH_MULTIDOMAIN
#
# *** To enable TLS support execute:
# - adjust CFGDIR/tls.cfg as needed
# - define WITH_TLS
#
# *** To enable XMLRPC support execute:
# - define WITH_XMLRPC
# - adjust route[XMLRPC] for access policy
#
# *** To enable anti-flood detection execute:
# - adjust pike and htable=>ipban settings as needed (default is
# block if more than 16 requests in 2 seconds and ban for 300 seconds)
# - define WITH_ANTIFLOOD
#
# *** To block 3XX redirect replies execute:
# - define WITH_BLOCK3XX
#
# *** To enable VoiceMail routing execute:
# - define WITH_VOICEMAIL
# - set the value of voicemail.srv_ip
# - adjust the value of voicemail.srv_port
#
# *** To enhance accounting execute:
# - enable mysql
# - define WITH_ACCDB
# - add following columns to database
#!ifdef ACCDB_COMMENT
ALTER TABLE acc ADD COLUMN src_user VARCHAR(64) NOT NULL DEFAULT '';
ALTER TABLE acc ADD COLUMN src_domain VARCHAR(128) NOT NULL DEFAULT '';
ALTER TABLE acc ADD COLUMN src_ip varchar(64) NOT NULL default '';
ALTER TABLE acc ADD COLUMN dst_ouser VARCHAR(64) NOT NULL DEFAULT '';
ALTER TABLE acc ADD COLUMN dst_user VARCHAR(64) NOT NULL DEFAULT '';
ALTER TABLE acc ADD COLUMN dst_domain VARCHAR(128) NOT NULL DEFAULT '';
ALTER TABLE missed_calls ADD COLUMN src_user VARCHAR(64) NOT NULL DEFAULT '';
ALTER TABLE missed_calls ADD COLUMN src_domain VARCHAR(128) NOT NULL DEFAULT '';
ALTER TABLE missed_calls ADD COLUMN src_ip varchar(64) NOT NULL default '';
ALTER TABLE missed_calls ADD COLUMN dst_ouser VARCHAR(64) NOT NULL DEFAULT '';
ALTER TABLE missed_calls ADD COLUMN dst_user VARCHAR(64) NOT NULL DEFAULT '';
ALTER TABLE missed_calls ADD COLUMN dst_domain VARCHAR(128) NOT NULL DEFAULT '';
#!endif
####### Include Local Config If Exists #########
import_file "kamailio-local.cfg"
####### Defined Values #########
# FS-KM integration
# this is original kamailio.cfg file for KM-FS integration from this link: http://kb.asipto.com/freeswitch:kamailio-3.3.x-freeswitch-1.2.x-sbc
#!define WITH_MYSQL
#!define WITH_AUTH
#!define WITH_USRLOCDB
#!define WITH_FREESWITCH
#!define WITH_DEBUG
#!substdef "!MY_IP_ADDR!192.168.1.103!g"
#!substdef "!MY_DOMAIN!192.168.1.103!g"
#!substdef "!MY_WS_PORT!5066!g"
#!substdef "!MY_WSS_PORT!443!g"
#!substdef "!MY_MSRP_PORT!9000!g"
#!substdef "!MY_WS_ADDR!tcp:MY_IP_ADDR:MY_WS_PORT!g"
#!substdef "!MY_WSS_ADDR!tls:MY_IP_ADDR:MY_WSS_PORT!g"
#!substdef "!MY_MSRP_ADDR!tls:MY_IP_ADDR:MY_MSRP_PORT!g"
#!substdef "!MSRP_MIN_EXPIRES!1800!g"
#!substdef "!MSRP_MAX_EXPIRES!3600!g"
##!define LOCAL_TEST_RUN
##!define WITH_TLS
#!define WITH_WEBSOCKETS
##!define WITH_MSRP
# *** Value defines - IDs used later in config
#!ifdef WITH_MYSQL
# - database URL - used to connect to database server by modules such
# as: auth_db, acc, usrloc, a.s.o.
#!ifndef DBURL
#!define DBURL "mysql://kamailio:kamailiorw@localhost/kamailio"
#!endif
#!endif
#!ifdef WITH_MULTIDOMAIN
# - the value for 'use_domain' parameters
#!define MULTIDOMAIN 1
#!else
#!define MULTIDOMAIN 0
#!endif
# - flags
# FLT_ - per transaction (message) flags
# FLB_ - per branch flags
#!define FLT_ACC 1
#!define FLT_ACCMISSED 2
#!define FLT_ACCFAILED 3
#!define FLT_NATS 5
#!define FLB_NATB 6
#!define FLB_NATSIPPING 7
####### Global Parameters #########
### LOG Levels: 3=DBG, 2=INFO, 1=NOTICE, 0=WARN, -1=ERR
#!ifdef WITH_DEBUG
debug=4
log_stderror=no
#!else
debug=2
log_stderror=no
#!endif
memdbg=5
memlog=5
log_facility=LOG_LOCAL0
fork=yes
children=4
/* uncomment the next line to disable TCP (default on) */
#disable_tcp=yes
/* uncomment the next line to disable the auto discovery of local aliases
based on reverse DNS on IPs (default on) */
#auto_aliases=no
/* add local domain aliases */
#alias="sip.mydomain.com"
#CUSTIMIZE - 403 is returned without this parameter
alias="vortex01.no-ip.info"
alias="sivancev.no-ip.info"
/* uncomment and configure the following line if you want Kamailio to
bind on a specific interface/port/proto (default bind on all available) */
#listen=udp:10.0.0.10:5060
/* port to listen to
* - can be specified more than once if needed to listen on many ports */
port=5060
#!ifdef WITH_TLS
enable_tls=yes
#!endif
listen=MY_IP_ADDR
#!ifdef WITH_WEBSOCKETS
listen=MY_WS_ADDR
#!ifdef WITH_TLS
listen=MY_WSS_ADDR
#!endif
#!endif
#!ifdef WITH_MSRP
listen=MY_MSRP_ADDR
#!endif
tcp_connection_lifetime=3604
tcp_accept_no_cl=yes
tcp_rd_buf_size=16384
#syn_branch=0
# life time of TCP connection when there is no traffic
# - a bit higher than registration expires to cope with UA behind NAT
# tcp_connection_lifetime=3605
####### Custom Parameters #########
# These parameters can be modified runtime via RPC interface
# - see the documentation of 'cfg_rpc' module.
#
# Format: group.id = value 'desc' description
# Access: $sel(cfg_get.group.id) or @cfg_get.group.id
#
#!ifdef WITH_PSTN
# PSTN GW Routing
#
# - pstn.gw_ip: valid IP or hostname as string value, example:
# pstn.gw_ip = "10.0.0.101" desc "My PSTN GW Address"
#
# - by default is empty to avoid misrouting
pstn.gw_ip = "" desc "PSTN GW Address"
pstn.gw_port = "" desc "PSTN GW Port"
#!endif
#!ifdef WITH_VOICEMAIL
# VoiceMail Routing on offline, busy or no answer
#
# - by default Voicemail server IP is empty to avoid misrouting
voicemail.srv_ip = "" desc "VoiceMail IP Address"
voicemail.srv_port = "5060" desc "VoiceMail Port"
#!endif
#!ifdef WITH_FREESWITCH
freeswitch.bindip = "192.168.1.103" desc "FreeSWITCH IP Address"
freeswitch.bindport = "5090" desc "FreeSWITCH Port"
#!endif
####### Modules Section ########
# set paths to location of modules (to sources or installation folders)
#!ifdef WITH_SRCPATH
mpath="modules/"
#!else
#mpath="/usr/local/lib64/kamailio/modules/"
mpath="/usr/local/kamailio/lib64/kamailio/modules/"
#!endif
#!ifdef WITH_MYSQL
loadmodule "db_mysql.so"
#!endif
loadmodule "mi_fifo.so"
loadmodule "kex.so"
loadmodule "corex.so"
loadmodule "tm.so"
loadmodule "tmx.so"
loadmodule "sl.so"
loadmodule "rr.so"
loadmodule "pv.so"
loadmodule "maxfwd.so"
loadmodule "usrloc.so"
loadmodule "registrar.so"
loadmodule "textops.so"
loadmodule "siputils.so"
loadmodule "xlog.so"
loadmodule "sanity.so"
loadmodule "ctl.so"
loadmodule "cfg_rpc.so"
loadmodule "mi_rpc.so"
loadmodule "acc.so"
#!ifdef WITH_AUTH
loadmodule "auth.so"
loadmodule "auth_db.so"
#!ifdef WITH_IPAUTH
loadmodule "permissions.so"
#!endif
#!endif
#!ifdef WITH_ALIASDB
loadmodule "alias_db.so"
#!endif
#!ifdef WITH_SPEEDDIAL
loadmodule "speeddial.so"
#!endif
#!ifdef WITH_MULTIDOMAIN
loadmodule "domain.so"
#!endif
#!ifdef WITH_PRESENCE
loadmodule "presence.so"
loadmodule "presence_xml.so"
#!endif
#!ifdef WITH_NAT
loadmodule "nathelper.so"
loadmodule "rtpproxy.so"
#!endif
#!ifdef WITH_TLS
loadmodule "tls.so"
#!endif
#!ifdef WITH_MSRP
loadmodule "msrp.so"
loadmodule "htable.so"
loadmodule "cfgutils.so"
#!endif
#!ifdef WITH_WEBSOCKETS
loadmodule "xhttp.so"
loadmodule "websocket.so"
loadmodule "nathelper.so"
#!endif
#!ifdef WITH_ANTIFLOOD
loadmodule "htable.so"
loadmodule "pike.so"
#!endif
#!ifdef WITH_XMLRPC
loadmodule "xmlrpc.so"
#!endif
#!ifdef WITH_DEBUG
loadmodule "debugger.so"
#!endif
# ----------------- setting module-specific parameters ---------------
# ----- mi_fifo params -----
modparam("mi_fifo", "fifo_name", "/tmp/kamailio_fifo")
# ----- tm params -----
# auto-discard branches from previous serial forking leg
modparam("tm", "failure_reply_mode", 3)
# default retransmission timeout: 30sec
modparam("tm", "fr_timer", 30000)
# default invite retransmission timeout after 1xx: 120sec
modparam("tm", "fr_inv_timer", 120000)
# ----- rr params -----
# add value to ;lr param to cope with most of the UAs
modparam("rr", "enable_full_lr", 1)
# do not append from tag to the RR (no need for this script)
modparam("rr", "append_fromtag", 0)
# ----- registrar params -----
modparam("registrar", "method_filtering", 1)
/* uncomment the next line to disable parallel forking via location */
# modparam("registrar", "append_branches", 0)
/* uncomment the next line not to allow more than 10 contacts per AOR */
#modparam("registrar", "max_contacts", 10)
# max value for expires of registrations
modparam("registrar", "max_expires", 3600)
# set it to 1 to enable GRUU
modparam("registrar", "gruu_enabled", 0)
# ----- acc params -----
/* what special events should be accounted ? */
modparam("acc", "early_media", 0)
modparam("acc", "report_ack", 0)
modparam("acc", "report_cancels", 0)
/* by default ww do not adjust the direct of the sequential requests.
if you enable this parameter, be sure the enable "append_fromtag"
in "rr" module */
modparam("acc", "detect_direction", 0)
/* account triggers (flags) */
modparam("acc", "log_flag", FLT_ACC)
modparam("acc", "log_missed_flag", FLT_ACCMISSED)
modparam("acc", "log_extra",
"src_user=$fU;src_domain=$fd;src_ip=$si;"
"dst_ouser=$tU;dst_user=$rU;dst_domain=$rd")
modparam("acc", "failed_transaction_flag", FLT_ACCFAILED)
/* enhanced DB accounting */
#!ifdef WITH_ACCDB
modparam("acc", "db_flag", FLT_ACC)
modparam("acc", "db_missed_flag", FLT_ACCMISSED)
modparam("acc", "db_url", DBURL)
modparam("acc", "db_extra",
"src_user=$fU;src_domain=$fd;src_ip=$si;"
"dst_ouser=$tU;dst_user=$rU;dst_domain=$rd")
#!endif
# ----- usrloc params -----
/* enable DB persistency for location entries */
#!ifdef WITH_USRLOCDB
modparam("usrloc", "db_url", DBURL)
modparam("usrloc", "db_mode", 2)
modparam("usrloc", "use_domain", MULTIDOMAIN)
#!endif
# ----- auth_db params -----
#!ifdef WITH_AUTH
modparam("auth_db", "db_url", DBURL)
modparam("auth_db", "calculate_ha1", yes)
modparam("auth_db", "password_column", "password")
modparam("auth_db", "load_credentials", "")
modparam("auth_db", "use_domain", MULTIDOMAIN)
# ----- permissions params -----
#!ifdef WITH_IPAUTH
modparam("permissions", "db_url", DBURL)
modparam("permissions", "db_mode", 1)
#!endif
#!endif
# ----- alias_db params -----
#!ifdef WITH_ALIASDB
modparam("alias_db", "db_url", DBURL)
modparam("alias_db", "use_domain", MULTIDOMAIN)
#!endif
# ----- speeddial params -----
#!ifdef WITH_SPEEDDIAL
modparam("speeddial", "db_url", DBURL)
modparam("speeddial", "use_domain", MULTIDOMAIN)
#!endif
# ----- domain params -----
#!ifdef WITH_MULTIDOMAIN
modparam("domain", "db_url", DBURL)
# register callback to match myself condition with domains list
modparam("domain", "register_myself", 1)
#!endif
#!ifdef WITH_PRESENCE
# ----- presence params -----
modparam("presence", "db_url", DBURL)
# ----- presence_xml params -----
modparam("presence_xml", "db_url", DBURL)
modparam("presence_xml", "force_active", 1)
#!endif
#!ifdef WITH_NAT
# ----- rtpproxy params -----
modparam("rtpproxy", "rtpproxy_sock", "udp:127.0.0.1:7722")
# ----- nathelper params -----
modparam("nathelper", "natping_interval", 30)
modparam("nathelper", "ping_nated_only", 1)
modparam("nathelper", "sipping_bflag", FLB_NATSIPPING)
modparam("nathelper", "sipping_from", "sip:pinger@kamailio.org")
# params needed for NAT traversal in other modules
modparam("nathelper|registrar", "received_avp", "$avp(RECEIVED)")
modparam("usrloc", "nat_bflag", FLB_NATB)
#!endif
#!ifdef WITH_TLS
# ----- tls params -----
modparam("tls", "config", "/usr/local/etc/kamailio/tls.cfg")
#!endif
#!ifdef WITH_WEBSOCKETS
# ----- nathelper params -----
modparam("nathelper|registrar", "received_avp", "$avp(RECEIVED)")
# Note: leaving NAT pings turned off here as nathelper is _only_ being used for
# WebSocket connections. NAT pings are not needed as WebSockets have
# their own keep-alives.
#!endif
#!ifdef WITH_MSRP
# ----- htable params -----
modparam("htable", "htable", "msrp=>size=8;autoexpire=MSRP_MAX_EXPIRES;")
#!endif
#!ifdef WITH_ANTIFLOOD
# ----- pike params -----
modparam("pike", "sampling_time_unit", 2)
modparam("pike", "reqs_density_per_unit", 16)
modparam("pike", "remove_latency", 4)
# ----- htable params -----
# ip ban htable with autoexpire after 5 minutes
modparam("htable", "htable", "ipban=>size=8;autoexpire=300;")
#!endif
#!ifdef WITH_XMLRPC
# ----- xmlrpc params -----
modparam("xmlrpc", "route", "XMLRPC");
modparam("xmlrpc", "url_match", "^/RPC")
#!endif
#!ifdef WITH_DEBUG
# ----- debugger params -----
modparam("debugger", "cfgtrace", 1)
#!endif
####### Routing Logic ########
# Main SIP request routing logic
# - processing of any incoming SIP request starts with this route
# - note: this is the same as route { ... }
request_route {
# per request initial checks
route(REQINIT);
#!ifdef WITH_WEBSOCKETS
if (nat_uac_test(64)) {
# Do NAT traversal stuff for requests from a WebSocket
# connection - even if it is not behind a NAT!
# This won't be needed in the future if Kamailio and the
# WebSocket client support Outbound and Path.
force_rport();
if (is_method("REGISTER")) {
fix_nated_register();
} else {
if (!add_contact_alias()) {
xlog("L_ERR", "Error aliasing contact <$ct>\n");
sl_send_reply("400", "Bad Request");
exit;
}
}
}
#!endif
# NAT detection
route(NATDETECT);
# CANCEL processing
if (is_method("CANCEL"))
{
if (t_check_trans()) {
route(RELAY);
}
exit;
}
# handle requests within SIP dialogs
route(WITHINDLG);
### only initial requests (no To tag)
t_check_trans();
# authentication
route(AUTH);
# record routing for dialog forming requests (in case they are routed)
# - remove preloaded route headers
remove_hf("Route");
if (is_method("INVITE|SUBSCRIBE"))
record_route();
# account only INVITEs
if (is_method("INVITE"))
{
setflag(FLT_ACC); # do accounting
}
# dispatch requests to foreign domains
route(SIPOUT);
### requests for my local domains
# handle presence related requests
route(PRESENCE);
# handle registrations
route(REGISTRAR);
if ($rU==$null)
{
# request with no Username in RURI
sl_send_reply("484","Address Incomplete");
exit;
}
# dispatch destinations to PSTN
route(PSTN);
#!ifdef WITH_FREESWITCH
# save callee ID
$avp(callee) = $rU;
route(FSDISPATCH);
#!endif
# user location service
route(LOCATION);
route(RELAY);
}
route[RELAY] {
# enable additional event routes for forwarded requests
# - serial forking, RTP relaying handling, a.s.o.
if (is_method("INVITE|BYE|SUBSCRIBE|UPDATE")) {
if(!t_is_set("branch_route")) t_on_branch("MANAGE_BRANCH");
}
if (is_method("INVITE|SUBSCRIBE|UPDATE")) {
if(!t_is_set("onreply_route")) t_on_reply("MANAGE_REPLY");
}
if (is_method("INVITE")) {
if(!t_is_set("failure_route")) t_on_failure("MANAGE_FAILURE");
}
if (!t_relay()) {
sl_reply_error();
}
exit;
}
# Per SIP request initial checks
route[REQINIT] {
#!ifdef WITH_ANTIFLOOD
# flood dection from same IP and traffic ban for a while
# be sure you exclude checking trusted peers, such as pstn gateways
# - local host excluded (e.g., loop to self)
if(src_ip!=myself)
{
if($sht(ipban=>$si)!=$null)
{
# ip is already blocked
xdbg("request from blocked IP - $rm from $fu (IP:$si:$sp)\n");
exit;
}
if (!pike_check_req())
{
xlog("L_ALERT","ALERT: pike blocking $rm from $fu (IP:$si:$sp)\n");
$sht(ipban=>$si) = 1;
exit;
}
}
#!endif
if (!mf_process_maxfwd_header("10")) {
sl_send_reply("483","Too Many Hops");
exit;
}
if(!sanity_check("1511", "7"))
{
xlog("Malformed SIP message from $si:$sp\n");
exit;
}
}
# Handle requests within SIP dialogs
route[WITHINDLG] {
if (has_totag()) {
# sequential request withing a dialog should
# take the path determined by record-routing
if (loose_route()) {
#!ifdef WITH_WEBSOCKETS
if ($du == "") {
if (!handle_ruri_alias()) {
xlog("L_ERR", "Bad alias <$ru>\n");
sl_send_reply("400", "Bad Request");
exit;
}
}
#!endif
route(DLGURI);
if (is_method("BYE")) {
setflag(FLT_ACC); # do accounting ...
setflag(FLT_ACCFAILED); # ... even if the transaction fails
}
else if ( is_method("ACK") ) {
# ACK is forwarded statelessy
route(NATMANAGE);
}
else if ( is_method("NOTIFY") ) {
# Add Record-Route for in-dialog NOTIFY as per RFC 6665.
record_route();
}
route(RELAY);
} else {
if (is_method("SUBSCRIBE") && uri == myself) {
# in-dialog subscribe requests
route(PRESENCE);
exit;
}
if ( is_method("ACK") ) {
if ( t_check_trans() ) {
# no loose-route, but stateful ACK;
# must be an ACK after a 487
# or e.g. 404 from upstream server
route(RELAY);
exit;
} else {
# ACK without matching transaction ... ignore and discard
exit;
}
}
sl_send_reply("404","Not here");
}
exit;
}
}
# Handle SIP registrations
route[REGISTRAR] {
if (is_method("REGISTER"))
{
if(isflagset(FLT_NATS))
{
setbflag(FLB_NATB);
# uncomment next line to do SIP NAT pinging
## setbflag(FLB_NATSIPPING);
}
if (!save("location"))
sl_reply_error();
exit;
}
}
# USER location service
route[LOCATION] {
#!ifdef WITH_SPEEDDIAL
# search for short dialing - 2-digit extension
if($rU=~"^[0-9][0-9]$")
if(sd_lookup("speed_dial"))
route(SIPOUT);
#!endif
#!ifdef WITH_ALIASDB
# search in DB-based aliases
if(alias_db_lookup("dbaliases"))
route(SIPOUT);
#!endif
$avp(oexten) = $rU;
if (!lookup("location")) {
$var(rc) = $rc;
route(TOVOICEMAIL);
t_newtran();
switch ($var(rc)) {
case -1:
case -3:
send_reply("404", "Not Found");
exit;
case -2:
send_reply("405", "Method Not Allowed");
exit;
}
}
# when routing via usrloc, log the missed calls also
if (is_method("INVITE"))
{
setflag(FLT_ACCMISSED);
}
}
# Presence server route
route[PRESENCE] {
if(!is_method("PUBLISH|SUBSCRIBE"))
return;
#!ifdef WITH_PRESENCE
if (!t_newtran())
{
sl_reply_error();
exit;
};
if(is_method("PUBLISH"))
{
handle_publish();
t_release();
}
else
if( is_method("SUBSCRIBE"))
{
handle_subscribe();
t_release();
}
exit;
#!endif
# if presence enabled, this part will not be executed
if (is_method("PUBLISH") || $rU==$null)
{
sl_send_reply("404", "Not here");
exit;
}
return;
}
# Authentication route
route[AUTH] {
#!ifdef WITH_AUTH
#!ifdef WITH_IPAUTH
if((!is_method("REGISTER")) && allow_source_address())
{
# source IP allowed
return;
}
#!endif
#!ifdef WITH_FREESWITCH
if(route(FSINBOUND))
return;
#!endif
if (is_method("REGISTER") || from_uri==myself)
{
# authenticate requests
if (!auth_check("$fd", "subscriber", "1")) {
auth_challenge("$fd", "0");
exit;
}
# user authenticated - remove auth header
if(!is_method("REGISTER|PUBLISH"))
consume_credentials();
}
# if caller is not local subscriber, then check if it calls
# a local destination, otherwise deny, not an open relay here
if (from_uri!=myself && uri!=myself)
{
sl_send_reply("403","Not relaying");
exit;
}
#!endif
return;
}
# Caller NAT detection route
route[NATDETECT] {
#!ifdef WITH_NAT
force_rport();
if (nat_uac_test("19")) {
if (is_method("REGISTER")) {
fix_nated_register();
} else {
add_contact_alias();
}
setflag(FLT_NATS);
}
#!endif
return;
}
# RTPProxy control
route[NATMANAGE] {
#!ifdef WITH_NAT
if (is_request()) {
if(has_totag()) {
if(check_route_param("nat=yes")) {
setbflag(FLB_NATB);
}
}
}
if (!(isflagset(FLT_NATS) || isbflagset(FLB_NATB)))
return;
rtpproxy_manage();
if (is_request()) {
if (!has_totag()) {
add_rr_param(";nat=yes");
}
}
if (is_reply()) {
if(isbflagset(FLB_NATB)) {
add_contact_alias();
}
}
#!endif
return;
}
# URI update for dialog requests
route[DLGURI] {
#!ifdef WITH_NAT
if(!isdsturiset()) {
handle_ruri_alias();
}
#!endif
return;
}
# Routing to foreign domains
route[SIPOUT] {
if (!uri==myself)
{
append_hf("P-hint: outbound\r\n");
route(RELAY);
}
}
# PSTN GW routing
route[PSTN] {
#!ifdef WITH_PSTN
# check if PSTN GW IP is defined
if (strempty($sel(cfg_get.pstn.gw_ip))) {
xlog("SCRIPT: PSTN rotuing enabled but pstn.gw_ip not defined\n");
return;
}
# route to PSTN dialed numbers starting with '+' or '00'
# (international format)
# - update the condition to match your dialing rules for PSTN routing
if(!($rU=~"^(\+|00)[1-9][0-9]{3,20}$"))
return;
# only local users allowed to call
if(from_uri!=myself) {
sl_send_reply("403", "Not Allowed");
exit;
}
if (strempty($sel(cfg_get.pstn.gw_port))) {
$ru = "sip:" + $rU + "@" + $sel(cfg_get.pstn.gw_ip);
} else {
$ru = "sip:" + $rU + "@" + $sel(cfg_get.pstn.gw_ip) + ":"
+ $sel(cfg_get.pstn.gw_port);
}
route(RELAY);
exit;
#!endif
return;
}
# XMLRPC routing
#!ifdef WITH_XMLRPC
route[XMLRPC] {
# allow XMLRPC from localhost
if ((method=="POST" || method=="GET")
&& (src_ip==127.0.0.1)) {
# close connection only for xmlrpclib user agents (there is a bug in
# xmlrpclib: it waits for EOF before interpreting the response).
if ($hdr(User-Agent) =~ "xmlrpclib")
set_reply_close();
set_reply_no_connect();
dispatch_rpc();
exit;
}
send_reply("403", "Forbidden");
exit;
}
#!endif
# route to voicemail server
route[TOVOICEMAIL] {
#!ifdef WITH_VOICEMAIL
if(!is_method("INVITE"))
return;
# check if VoiceMail server IP is defined
if (strempty($sel(cfg_get.voicemail.srv_ip))) {
xlog("SCRIPT: VoiceMail rotuing enabled but IP not defined\n");
return;
}
if($avp(oexten)==$null)
return;
$ru = "sip:" + $avp(oexten) + "@" + $sel(cfg_get.voicemail.srv_ip)
+ ":" + $sel(cfg_get.voicemail.srv_port);
route(RELAY);
exit;
#!endif
return;
}
#!ifdef WITH_FREESWITCH
# FreeSWITCH routing blocks
route[FSINBOUND] {
if($si== $sel(cfg_get.freeswitch.bindip)
&& $sp==$sel(cfg_get.freeswitch.bindport))
return 1;
return -1;
}
route[FSDISPATCH] {
if(!is_method("INVITE"))
return;
if(route(FSINBOUND))
return;
# dial number selection
switch($rU) {
case /"^41$":
# 41 - voicebox menu
# allow only authenticated users
if($au==$null)
{
sl_send_reply("403", "Not allowed");
exit;
}
$rU = "vm-" + $au;
break;
case /"^441[0-9][0-9]$":
# starting with 44 folowed by 1XY - direct call to voice box
strip(2);
route(FSVBOX);
break;
case /"^433[0-9][0-9][0-9]$":
# starting with 433 folowed by (0|1)XY - conference
strip(2);
break;
case /"^45[0-9]+$":
strip(2);
break;
default:
# offline - send to voicebox
if (!registered("location"))
{
route(FSVBOX);
exit;
}
# online - do bridging
prefix("kb-");
if(is_method("INVITE"))
{
# in case of failure - re-route to FreeSWITCH VoiceMail
t_on_failure("FAIL_FSVBOX");
}
}
route(FSRELAY);
exit;
}
route[FSVBOX] {
if(!($rU=~"^1[0-9][0-9]+$"))
return;
prefix("vb-");
route(FSRELAY);
}
# Send to FreeSWITCH
route[FSRELAY] {
$du = "sip:" + $sel(cfg_get.freeswitch.bindip) + ":"
+ $sel(cfg_get.freeswitch.bindport);
route(RELAY);
exit;
}
#!endif
# manage outgoing branches
branch_route[MANAGE_BRANCH] {
xdbg("new branch [$T_branch_idx] to $ru\n");
route(NATMANAGE);
}
# manage incoming replies
onreply_route[MANAGE_REPLY] {
xdbg("incoming reply\n");
if(status=~"[12][0-9][0-9]")
route(NATMANAGE);
}
# manage failure routing cases
failure_route[MANAGE_FAILURE] {
route(NATMANAGE);
if (t_is_canceled()) {
exit;
}
#!ifdef WITH_BLOCK3XX
# block call redirect based on 3xx replies.
if (t_check_status("3[0-9][0-9]")) {
t_reply("404","Not found");
exit;
}
#!endif
#!ifdef WITH_VOICEMAIL
# serial forking
# - route to voicemail on busy or no answer (timeout)
if (t_check_status("486|408")) {
route(TOVOICEMAIL);
exit;
}
#!endif
}
#!ifdef WITH_WEBSOCKETS
onreply_route {
if ((($Rp == MY_WS_PORT || $Rp == MY_WSS_PORT)
&& !(proto == WS || proto == WSS)) || $Rp == MY_MSRP_PORT) {
xlog("L_WARN", "SIP response received on $Rp\n");
drop;
exit;
}
if (nat_uac_test(64)) {
# Do NAT traversal stuff for replies to a WebSocket connection
# - even if it is not behind a NAT!
# This won't be needed in the future if Kamailio and the
# WebSocket client support Outbound and Path.
add_contact_alias();
}
}
event_route[xhttp:request] {
set_reply_close();
set_reply_no_connect();
if ($Rp != MY_WS_PORT
#!ifdef WITH_TLS
&& $Rp != MY_WSS_PORT
#!endif
) {
xlog("L_WARN", "HTTP request received on $Rp\n");
xhttp_reply("403", "Forbidden", "", "");
exit;
}
xlog("L_DBG", "HTTP Request Received\n");
if ($hdr(Upgrade)=~"websocket"
&& $hdr(Connection)=~"Upgrade"
&& $rm=~"GET") {
# Validate Host - make sure the client is using the correct
# alias for WebSockets
# Sasa: commented out, see http://sip-router.1086192.n5.nabble.com/Testing-the-Websocket-module-with-sipml5-org-td65069.html
#if ($hdr(Host) == $null || !is_myself("sip:" + $hdr(Host))) {
# xlog("L_WARN", "Bad host $hdr(Host)\n");
# xhttp_reply("403", "Forbidden", "", "");
# exit;
#}
# Optional... validate Origin - make sure the client is from an
# authorised website. For example,
#
# if ($hdr(Origin) != "http://communicator.MY_DOMAIN"
# && $hdr(Origin) != "https://communicator.MY_DOMAIN") {
# xlog("L_WARN", "Unauthorised client $hdr(Origin)\n");
# xhttp_reply("403", "Forbidden", "", "");
# exit;
# }
# Optional... perform HTTP authentication
# ws_handle_handshake() exits (no further configuration file
# processing of the request) when complete.
if (ws_handle_handshake())
{
# Optional... cache some information about the
# successful connection
exit;
}
}
xhttp_reply("404", "Not Found", "", "");
}
event_route[websocket:closed] {
xlog("L_INFO", "WebSocket connection from $si:$sp has closed\n");
}
#!endif
#!ifdef WITH_MSRP
event_route[msrp:frame-in] {
msrp_reply_flags("1");
if ((($Rp == MY_WS_PORT || $Rp == MY_WSS_PORT)
&& !(proto == WS || proto == WSS)) && $Rp != MY_MSRP_PORT) {
xlog("L_WARN", "MSRP request received on $Rp\n");
msrp_reply("403", "Action-not-allowed");
exit;
}
if (msrp_is_reply()) {
msrp_relay();
} else if($msrp(method)=="AUTH") {
if($msrp(nexthops)>0) {
msrp_relay();
exit;
}
if (!www_authenticate("MY_DOMAIN", "subscriber",
"$msrp(method)")) {
if (auth_get_www_authenticate("MY_DOMAIN", "1",
"$var(wauth)")) {
msrp_reply("401", "Unauthorized",
"$var(wauth)");
} else {
msrp_reply("500", "Server Error");
}
exit;
}
if ($hdr(Expires) != $null) {
$var(expires) = (int) $hdr(Expires);
if ($var(expires) < MSRP_MIN_EXPIRES) {
msrp_reply("423", "Interval Out-of-Bounds",
"Min-Expires: MSRP_MIN_EXPIRES\r\n");
exit;
} else if ($var(expires) > MSRP_MAX_EXPIRES) {
msrp_reply("423", "Interval Out-of-Bounds",
"Max-Expires: MSRP_MAX_EXPIRES\r\n");
exit;
}
} else {
$var(expires) = MSRP_MAX_EXPIRES;
}
$var(cnt) = $var(cnt) + 1;
pv_printf("$var(sessid)", "s.$(pp).$(var(cnt)).$(RANDOM)");
$sht(msrp=>$var(sessid)::srcaddr) = $msrp(srcaddr);
$sht(msrp=>$var(sessid)::srcsock) = $msrp(srcsock);
$shtex(msrp=>$var(sessid)) = $var(expires) + 5;
# - Use-Path: the MSRP address for server + session id
$var(hdrs) = "Use-Path: msrps://MY_IP_ADDR:MY_MSRP_PORT/"
+ $var(sessid) + ";tcp\r\n"
+ "Expires: " + $var(expires) + "\r\n";
msrp_reply("200", "OK", "$var(hdrs)");
} else if ($msrp(method)=="SEND" || $msrp(method)=="REPORT") {
if ($msrp(nexthops)>1) {
if ($msrp(method)!="REPORT") {
msrp_reply("200", "OK");
}
msrp_relay();
exit;
}
$var(sessid) = $msrp(sessid);
if ($sht(msrp=>$var(sessid)::srcaddr) == $null) {
# one more hop, but we don't have address in htable
msrp_reply("481", "Session-does-not-exist");
exit;
} else if ($msrp(method)!="REPORT") {
msrp_reply("200", "OK");
}
msrp_relay_flags("1");
msrp_set_dst("$sht(msrp=>$var(sessid)::srcaddr)",
"$sht(msrp=>$var(sessid)::srcsock)");
msrp_relay();
} else {
msrp_reply("501", "Request-method-not-understood");
}
}
#!endif
#!ifdef WITH_FREESWITCH
failure_route[FAIL_FSVBOX] {
#!ifdef WITH_NAT
if (is_method("INVITE")
&& (isbflagset(FLB_NATB) || isflagset(FLT_NATS))) {
unforce_rtp_proxy();
}
#!endif
if (t_is_canceled()) {
exit;
}
if (t_check_status("486|408")) {
# re-route to FreeSWITCH VoiceMail
$rU = $avp(callee);
route(FSVBOX);
}
}
#!endif
Thanks in advance,
Sasa