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(a)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(a)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(a)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(a)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(a)vortex01.no-ip.info receiving invite from192.168.1.103:5060 <http://192.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(a)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(a)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(a)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(a)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(a)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(a)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(a)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(a)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(a)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(a)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(a)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(a)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(a)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(a)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(a)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(a)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(a)vortex01.no-ip.info parsing [public->unloop] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info parsing [public->outside_call] continue=true 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info Absolute Condition [outside_call] 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info Action set(outside_call=true) 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info parsing [public->call_debug] continue=true 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info parsing [public->public_extensions] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)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(a)vortex01.no-ip.info parsing [public->from_kamailio] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)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(a)vortex01.no-ip.info Regex (PASS) [from_kamailio] destination_number(3000) =~ /^(.+)$/ break=on-false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)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(a)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(a)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(a)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(a)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(a)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(a)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(a)vortex01.no-ip.info Standard EXECUTE 6e61a7b2-ce59-11e3-bc32-179817d66480 EXECUTE sofia/internal/1001(a)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(a)vortex01.no-ip.info SET [outside_call]=[true] 6e61a7b2-ce59-11e3-bc32-179817d66480 EXECUTE sofia/internal/1001(a)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(a)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(a)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(a)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(a)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(a)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(a)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(a)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(a)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(a)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(a)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(a)vortex01.no-ip.info parsing [default->unloop] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info parsing [default->tod_example] continue=true 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info Date/TimeMatch (FAIL) [tod_example] break=on-false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info parsing [default->holiday_example] continue=true 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info Date/TimeMatch (FAIL) [holiday_example] break=on-false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info parsing [default->global-intercept] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info Regex (FAIL) [global-intercept] destination_number(3000) =~ /^886$/ break=on-false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info parsing [default->group-intercept] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info Regex (FAIL) [group-intercept] destination_number(3000) =~ /^\*8$/ break=on-false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info parsing [default->intercept-ext] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info Regex (FAIL) [intercept-ext] destination_number(3000) =~ /^\*\*(\d+)$/ break=on-false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info parsing [default->redial] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info Regex (FAIL) [redial] destination_number(3000) =~ /^(redial|870)$/ break=on-false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info parsing [default->global] continue=true 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)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(a)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(a)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(a)vortex01.no-ip.info Action set(rtp_secure_media=true) 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info Absolute Condition [global] 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid}) 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)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(a)vortex01.no-ip.info Action hash(insert/${domain_name}-last_dial/global/${uuid}) 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info parsing [default->snom-demo-2] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)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(a)vortex01.no-ip.info parsing [default->snom-demo-1] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)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(a)vortex01.no-ip.info parsing [default->eavesdrop] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)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(a)vortex01.no-ip.info parsing [default->eavesdrop] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info Regex (FAIL) [eavesdrop] destination_number(3000) =~ /^779$/ break=on-false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info parsing [default->call_return] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)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(a)vortex01.no-ip.info parsing [default->del-group] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)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(a)vortex01.no-ip.info parsing [default->add-group] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)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(a)vortex01.no-ip.info parsing [default->call-group-simo] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)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(a)vortex01.no-ip.info parsing [default->call-group-order] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)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(a)vortex01.no-ip.info parsing [default->extension-intercom] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)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(a)vortex01.no-ip.info parsing [default->Local_Extension] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)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(a)vortex01.no-ip.info parsing [default->Local_Extension_Skinny] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)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(a)vortex01.no-ip.info parsing [default->group_dial_sales] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)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(a)vortex01.no-ip.info parsing [default->group_dial_support] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)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(a)vortex01.no-ip.info parsing [default->group_dial_billing] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)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(a)vortex01.no-ip.info parsing [default->operator] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info Regex (FAIL) [operator] destination_number(3000) =~ /^(operator|0)$/ break=on-false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info parsing [default->vmain] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)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(a)vortex01.no-ip.info parsing [default->sip_uri] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info Regex (FAIL) [sip_uri] destination_number(3000) =~ /^sip:(.*)$/ break=on-false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)vortex01.no-ip.info parsing [default->nb_conferences] continue=false 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)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(a)vortex01.no-ip.info Action answer() 6e61a7b2-ce59-11e3-bc32-179817d66480 Dialplan: sofia/internal/1001(a)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(a)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(a)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(a)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(a)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(a)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(a)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(a)vortex01.no-ip.info Standard EXECUTE 6e61a7b2-ce59-11e3-bc32-179817d66480 EXECUTE sofia/internal/1001(a)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(a)vortex01.no-ip.info SET [rtp_secure_media]=[true] 6e61a7b2-ce59-11e3-bc32-179817d66480 EXECUTE sofia/internal/1001(a)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(a)vortex01.no-ip.info hash(insert/192.168.1.103-last_dial/1001/3000) 6e61a7b2-ce59-11e3-bc32-179817d66480 EXECUTE sofia/internal/1001(a)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(a)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(a)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(a)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(a)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 <http://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 <http://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 <http://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 <http://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 <http://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 <http://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 <http://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 <http://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 <http://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 <http://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(a)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 <http://95.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 <http://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(a)vortex01.no-ip.info! 6e61a7b2-ce59-11e3-bc32-179817d66480 2014-04-28 00:15:25.048231 [DEBUG] switch_channel.c:3393 (sofia/internal/1001(a)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(a)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(a)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(a)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(a)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(a)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(a)vortex01.no-ip.info) Callstate Change EARLY -> ACTIVE 6e61a7b2-ce59-11e3-bc32-179817d66480 EXECUTE sofia/internal/1001(a)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(a)vortex01.no-ip.info Push codec L16:70 2014-04-28 00:15:25.048231 [INFO] mod_conference.c:9966 sofia/internal/1001(a)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(a)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(a)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(a)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(a)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(a)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(a)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(a)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(a)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: &lt;sr-users(a)lists.sip-router.org&gt; # # 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-s… #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