- sr-users - kamailio.org

SIPml5-->Kamailio-->FreeSWITCH: no audio issue
by Sasa Ivancev 29 Apr '14

29 Apr '14

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Ðæ˜hÇ³Ë3‚¦Ï)Ž»À}×Ù¤<Ú·Ï3ƒ½Ê<“±”eÔåmÓã›eÇåŽ)„¤ŽlÒä—dÒãjÒôŸdÕúŸkßúžsÖäž}×ôÚ$—ôÆ2” Ž:‚ºË/† Ç2‰ôžPíµ“>†ºÊ4ƒµÚ8ÝìlÔäšjÒìŽoÇ Í-Çå›mÞí›jÔã›}ÖíœsÖâ–s×úŸm×ôž}“Þ}»Ý)Ç³Ë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: <sr-users(a)lists.sip-router.org> # # Refer to the Core CookBook at http://www.kamailio.org/wiki/ # for an explanation of possible statements, functions and parameters. # # Several features can be enabled using '#!define WITH_FEATURE' directives: # # *** To run in debug mode: # - define WITH_DEBUG # # *** To enable mysql: # - define WITH_MYSQL # # *** To enable authentication execute: # - enable mysql # - define WITH_AUTH # - add users using 'kamctl' # # *** To enable IP authentication execute: # - enable mysql # - enable authentication # - define WITH_IPAUTH # - add IP addresses with group id '1' to 'address' table # # *** To enable persistent user location execute: # - enable mysql # - define WITH_USRLOCDB # # *** To enable presence server execute: # - enable mysql # - define WITH_PRESENCE # # *** To enable nat traversal execute: # - define WITH_NAT # - install RTPProxy: http://www.rtpproxy.org # - start RTPProxy: # rtpproxy -l _your_public_ip_ -s udp:localhost:7722 # # *** To enable PSTN gateway routing execute: # - define WITH_PSTN # - set the value of pstn.gw_ip # - check route[PSTN] for regexp routing condition # # *** To enable database aliases lookup execute: # - enable mysql # - define WITH_ALIASDB # # *** To enable speed dial lookup execute: # - enable mysql # - define WITH_SPEEDDIAL # # *** To enable multi-domain support execute: # - enable mysql # - define WITH_MULTIDOMAIN # # *** To enable TLS support execute: # - adjust CFGDIR/tls.cfg as needed # - define WITH_TLS # # *** To enable XMLRPC support execute: # - define WITH_XMLRPC # - adjust route[XMLRPC] for access policy # # *** To enable anti-flood detection execute: # - adjust pike and htable=>ipban settings as needed (default is # block if more than 16 requests in 2 seconds and ban for 300 seconds) # - define WITH_ANTIFLOOD # # *** To block 3XX redirect replies execute: # - define WITH_BLOCK3XX # # *** To enable VoiceMail routing execute: # - define WITH_VOICEMAIL # - set the value of voicemail.srv_ip # - adjust the value of voicemail.srv_port # # *** To enhance accounting execute: # - enable mysql # - define WITH_ACCDB # - add following columns to database #!ifdef ACCDB_COMMENT ALTER TABLE acc ADD COLUMN src_user VARCHAR(64) NOT NULL DEFAULT ''; ALTER TABLE acc ADD COLUMN src_domain VARCHAR(128) NOT NULL DEFAULT ''; ALTER TABLE acc ADD COLUMN src_ip varchar(64) NOT NULL default ''; ALTER TABLE acc ADD COLUMN dst_ouser VARCHAR(64) NOT NULL DEFAULT ''; ALTER TABLE acc ADD COLUMN dst_user VARCHAR(64) NOT NULL DEFAULT ''; ALTER TABLE acc ADD COLUMN dst_domain VARCHAR(128) NOT NULL DEFAULT ''; ALTER TABLE missed_calls ADD COLUMN src_user VARCHAR(64) NOT NULL DEFAULT ''; ALTER TABLE missed_calls ADD COLUMN src_domain VARCHAR(128) NOT NULL DEFAULT ''; ALTER TABLE missed_calls ADD COLUMN src_ip varchar(64) NOT NULL default ''; ALTER TABLE missed_calls ADD COLUMN dst_ouser VARCHAR(64) NOT NULL DEFAULT ''; ALTER TABLE missed_calls ADD COLUMN dst_user VARCHAR(64) NOT NULL DEFAULT ''; ALTER TABLE missed_calls ADD COLUMN dst_domain VARCHAR(128) NOT NULL DEFAULT ''; #!endif ####### Include Local Config If Exists ######### import_file "kamailio-local.cfg" ####### Defined Values ######### # FS-KM integration # this is original kamailio.cfg file for KM-FS integration from this link: http://kb.asipto.com/freeswitch:kamailio-3.3.x-freeswitch-1.2.x-sbc #!define WITH_MYSQL #!define WITH_AUTH #!define WITH_USRLOCDB #!define WITH_FREESWITCH #!define WITH_DEBUG #!substdef "!MY_IP_ADDR!192.168.1.103!g" #!substdef "!MY_DOMAIN!192.168.1.103!g" #!substdef "!MY_WS_PORT!5066!g" #!substdef "!MY_WSS_PORT!443!g" #!substdef "!MY_MSRP_PORT!9000!g" #!substdef "!MY_WS_ADDR!tcp:MY_IP_ADDR:MY_WS_PORT!g" #!substdef "!MY_WSS_ADDR!tls:MY_IP_ADDR:MY_WSS_PORT!g" #!substdef "!MY_MSRP_ADDR!tls:MY_IP_ADDR:MY_MSRP_PORT!g" #!substdef "!MSRP_MIN_EXPIRES!1800!g" #!substdef "!MSRP_MAX_EXPIRES!3600!g" ##!define LOCAL_TEST_RUN ##!define WITH_TLS #!define WITH_WEBSOCKETS ##!define WITH_MSRP # *** Value defines - IDs used later in config #!ifdef WITH_MYSQL # - database URL - used to connect to database server by modules such # as: auth_db, acc, usrloc, a.s.o. #!ifndef DBURL #!define DBURL "mysql://kamailio:kamailiorw@localhost/kamailio" #!endif #!endif #!ifdef WITH_MULTIDOMAIN # - the value for 'use_domain' parameters #!define MULTIDOMAIN 1 #!else #!define MULTIDOMAIN 0 #!endif # - flags # FLT_ - per transaction (message) flags # FLB_ - per branch flags #!define FLT_ACC 1 #!define FLT_ACCMISSED 2 #!define FLT_ACCFAILED 3 #!define FLT_NATS 5 #!define FLB_NATB 6 #!define FLB_NATSIPPING 7 ####### Global Parameters ######### ### LOG Levels: 3=DBG, 2=INFO, 1=NOTICE, 0=WARN, -1=ERR #!ifdef WITH_DEBUG debug=4 log_stderror=no #!else debug=2 log_stderror=no #!endif memdbg=5 memlog=5 log_facility=LOG_LOCAL0 fork=yes children=4 /* uncomment the next line to disable TCP (default on) */ #disable_tcp=yes /* uncomment the next line to disable the auto discovery of local aliases based on reverse DNS on IPs (default on) */ #auto_aliases=no /* add local domain aliases */ #alias="sip.mydomain.com" #CUSTIMIZE - 403 is returned without this parameter alias="vortex01.no-ip.info" alias="sivancev.no-ip.info" /* uncomment and configure the following line if you want Kamailio to bind on a specific interface/port/proto (default bind on all available) */ #listen=udp:10.0.0.10:5060 /* port to listen to * - can be specified more than once if needed to listen on many ports */ port=5060 #!ifdef WITH_TLS enable_tls=yes #!endif listen=MY_IP_ADDR #!ifdef WITH_WEBSOCKETS listen=MY_WS_ADDR #!ifdef WITH_TLS listen=MY_WSS_ADDR #!endif #!endif #!ifdef WITH_MSRP listen=MY_MSRP_ADDR #!endif tcp_connection_lifetime=3604 tcp_accept_no_cl=yes tcp_rd_buf_size=16384 #syn_branch=0 # life time of TCP connection when there is no traffic # - a bit higher than registration expires to cope with UA behind NAT # tcp_connection_lifetime=3605 ####### Custom Parameters ######### # These parameters can be modified runtime via RPC interface # - see the documentation of 'cfg_rpc' module. # # Format: group.id = value 'desc' description # Access: $sel(cfg_get.group.id) or @cfg_get.group.id # #!ifdef WITH_PSTN # PSTN GW Routing # # - pstn.gw_ip: valid IP or hostname as string value, example: # pstn.gw_ip = "10.0.0.101" desc "My PSTN GW Address" # # - by default is empty to avoid misrouting pstn.gw_ip = "" desc "PSTN GW Address" pstn.gw_port = "" desc "PSTN GW Port" #!endif #!ifdef WITH_VOICEMAIL # VoiceMail Routing on offline, busy or no answer # # - by default Voicemail server IP is empty to avoid misrouting voicemail.srv_ip = "" desc "VoiceMail IP Address" voicemail.srv_port = "5060" desc "VoiceMail Port" #!endif #!ifdef WITH_FREESWITCH freeswitch.bindip = "192.168.1.103" desc "FreeSWITCH IP Address" freeswitch.bindport = "5090" desc "FreeSWITCH Port" #!endif ####### Modules Section ######## # set paths to location of modules (to sources or installation folders) #!ifdef WITH_SRCPATH mpath="modules/" #!else #mpath="/usr/local/lib64/kamailio/modules/" mpath="/usr/local/kamailio/lib64/kamailio/modules/" #!endif #!ifdef WITH_MYSQL loadmodule "db_mysql.so" #!endif loadmodule "mi_fifo.so" loadmodule "kex.so" loadmodule "corex.so" loadmodule "tm.so" loadmodule "tmx.so" loadmodule "sl.so" loadmodule "rr.so" loadmodule "pv.so" loadmodule "maxfwd.so" loadmodule "usrloc.so" loadmodule "registrar.so" loadmodule "textops.so" loadmodule "siputils.so" loadmodule "xlog.so" loadmodule "sanity.so" loadmodule "ctl.so" loadmodule "cfg_rpc.so" loadmodule "mi_rpc.so" loadmodule "acc.so" #!ifdef WITH_AUTH loadmodule "auth.so" loadmodule "auth_db.so" #!ifdef WITH_IPAUTH loadmodule "permissions.so" #!endif #!endif #!ifdef WITH_ALIASDB loadmodule "alias_db.so" #!endif #!ifdef WITH_SPEEDDIAL loadmodule "speeddial.so" #!endif #!ifdef WITH_MULTIDOMAIN loadmodule "domain.so" #!endif #!ifdef WITH_PRESENCE loadmodule "presence.so" loadmodule "presence_xml.so" #!endif #!ifdef WITH_NAT loadmodule "nathelper.so" loadmodule "rtpproxy.so" #!endif #!ifdef WITH_TLS loadmodule "tls.so" #!endif #!ifdef WITH_MSRP loadmodule "msrp.so" loadmodule "htable.so" loadmodule "cfgutils.so" #!endif #!ifdef WITH_WEBSOCKETS loadmodule "xhttp.so" loadmodule "websocket.so" loadmodule "nathelper.so" #!endif #!ifdef WITH_ANTIFLOOD loadmodule "htable.so" loadmodule "pike.so" #!endif #!ifdef WITH_XMLRPC loadmodule "xmlrpc.so" #!endif #!ifdef WITH_DEBUG loadmodule "debugger.so" #!endif # ----------------- setting module-specific parameters --------------- # ----- mi_fifo params ----- modparam("mi_fifo", "fifo_name", "/tmp/kamailio_fifo") # ----- tm params ----- # auto-discard branches from previous serial forking leg modparam("tm", "failure_reply_mode", 3) # default retransmission timeout: 30sec modparam("tm", "fr_timer", 30000) # default invite retransmission timeout after 1xx: 120sec modparam("tm", "fr_inv_timer", 120000) # ----- rr params ----- # add value to ;lr param to cope with most of the UAs modparam("rr", "enable_full_lr", 1) # do not append from tag to the RR (no need for this script) modparam("rr", "append_fromtag", 0) # ----- registrar params ----- modparam("registrar", "method_filtering", 1) /* uncomment the next line to disable parallel forking via location */ # modparam("registrar", "append_branches", 0) /* uncomment the next line not to allow more than 10 contacts per AOR */ #modparam("registrar", "max_contacts", 10) # max value for expires of registrations modparam("registrar", "max_expires", 3600) # set it to 1 to enable GRUU modparam("registrar", "gruu_enabled", 0) # ----- acc params ----- /* what special events should be accounted ? */ modparam("acc", "early_media", 0) modparam("acc", "report_ack", 0) modparam("acc", "report_cancels", 0) /* by default ww do not adjust the direct of the sequential requests. if you enable this parameter, be sure the enable "append_fromtag" in "rr" module */ modparam("acc", "detect_direction", 0) /* account triggers (flags) */ modparam("acc", "log_flag", FLT_ACC) modparam("acc", "log_missed_flag", FLT_ACCMISSED) modparam("acc", "log_extra", "src_user=$fU;src_domain=$fd;src_ip=$si;" "dst_ouser=$tU;dst_user=$rU;dst_domain=$rd") modparam("acc", "failed_transaction_flag", FLT_ACCFAILED) /* enhanced DB accounting */ #!ifdef WITH_ACCDB modparam("acc", "db_flag", FLT_ACC) modparam("acc", "db_missed_flag", FLT_ACCMISSED) modparam("acc", "db_url", DBURL) modparam("acc", "db_extra", "src_user=$fU;src_domain=$fd;src_ip=$si;" "dst_ouser=$tU;dst_user=$rU;dst_domain=$rd") #!endif # ----- usrloc params ----- /* enable DB persistency for location entries */ #!ifdef WITH_USRLOCDB modparam("usrloc", "db_url", DBURL) modparam("usrloc", "db_mode", 2) modparam("usrloc", "use_domain", MULTIDOMAIN) #!endif # ----- auth_db params ----- #!ifdef WITH_AUTH modparam("auth_db", "db_url", DBURL) modparam("auth_db", "calculate_ha1", yes) modparam("auth_db", "password_column", "password") modparam("auth_db", "load_credentials", "") modparam("auth_db", "use_domain", MULTIDOMAIN) # ----- permissions params ----- #!ifdef WITH_IPAUTH modparam("permissions", "db_url", DBURL) modparam("permissions", "db_mode", 1) #!endif #!endif # ----- alias_db params ----- #!ifdef WITH_ALIASDB modparam("alias_db", "db_url", DBURL) modparam("alias_db", "use_domain", MULTIDOMAIN) #!endif # ----- speeddial params ----- #!ifdef WITH_SPEEDDIAL modparam("speeddial", "db_url", DBURL) modparam("speeddial", "use_domain", MULTIDOMAIN) #!endif # ----- domain params ----- #!ifdef WITH_MULTIDOMAIN modparam("domain", "db_url", DBURL) # register callback to match myself condition with domains list modparam("domain", "register_myself", 1) #!endif #!ifdef WITH_PRESENCE # ----- presence params ----- modparam("presence", "db_url", DBURL) # ----- presence_xml params ----- modparam("presence_xml", "db_url", DBURL) modparam("presence_xml", "force_active", 1) #!endif #!ifdef WITH_NAT # ----- rtpproxy params ----- modparam("rtpproxy", "rtpproxy_sock", "udp:127.0.0.1:7722") # ----- nathelper params ----- modparam("nathelper", "natping_interval", 30) modparam("nathelper", "ping_nated_only", 1) modparam("nathelper", "sipping_bflag", FLB_NATSIPPING) modparam("nathelper", "sipping_from", "sip:pinger@kamailio.org") # params needed for NAT traversal in other modules modparam("nathelper|registrar", "received_avp", "$avp(RECEIVED)") modparam("usrloc", "nat_bflag", FLB_NATB) #!endif #!ifdef WITH_TLS # ----- tls params ----- modparam("tls", "config", "/usr/local/etc/kamailio/tls.cfg") #!endif #!ifdef WITH_WEBSOCKETS # ----- nathelper params ----- modparam("nathelper|registrar", "received_avp", "$avp(RECEIVED)") # Note: leaving NAT pings turned off here as nathelper is _only_ being used for # WebSocket connections. NAT pings are not needed as WebSockets have # their own keep-alives. #!endif #!ifdef WITH_MSRP # ----- htable params ----- modparam("htable", "htable", "msrp=>size=8;autoexpire=MSRP_MAX_EXPIRES;") #!endif #!ifdef WITH_ANTIFLOOD # ----- pike params ----- modparam("pike", "sampling_time_unit", 2) modparam("pike", "reqs_density_per_unit", 16) modparam("pike", "remove_latency", 4) # ----- htable params ----- # ip ban htable with autoexpire after 5 minutes modparam("htable", "htable", "ipban=>size=8;autoexpire=300;") #!endif #!ifdef WITH_XMLRPC # ----- xmlrpc params ----- modparam("xmlrpc", "route", "XMLRPC"); modparam("xmlrpc", "url_match", "^/RPC") #!endif #!ifdef WITH_DEBUG # ----- debugger params ----- modparam("debugger", "cfgtrace", 1) #!endif ####### Routing Logic ######## # Main SIP request routing logic # - processing of any incoming SIP request starts with this route # - note: this is the same as route { ... } request_route { # per request initial checks route(REQINIT); #!ifdef WITH_WEBSOCKETS if (nat_uac_test(64)) { # Do NAT traversal stuff for requests from a WebSocket # connection - even if it is not behind a NAT! # This won't be needed in the future if Kamailio and the # WebSocket client support Outbound and Path. force_rport(); if (is_method("REGISTER")) { fix_nated_register(); } else { if (!add_contact_alias()) { xlog("L_ERR", "Error aliasing contact <$ct>\n"); sl_send_reply("400", "Bad Request"); exit; } } } #!endif # NAT detection route(NATDETECT); # CANCEL processing if (is_method("CANCEL")) { if (t_check_trans()) { route(RELAY); } exit; } # handle requests within SIP dialogs route(WITHINDLG); ### only initial requests (no To tag) t_check_trans(); # authentication route(AUTH); # record routing for dialog forming requests (in case they are routed) # - remove preloaded route headers remove_hf("Route"); if (is_method("INVITE|SUBSCRIBE")) record_route(); # account only INVITEs if (is_method("INVITE")) { setflag(FLT_ACC); # do accounting } # dispatch requests to foreign domains route(SIPOUT); ### requests for my local domains # handle presence related requests route(PRESENCE); # handle registrations route(REGISTRAR); if ($rU==$null) { # request with no Username in RURI sl_send_reply("484","Address Incomplete"); exit; } # dispatch destinations to PSTN route(PSTN); #!ifdef WITH_FREESWITCH # save callee ID $avp(callee) = $rU; route(FSDISPATCH); #!endif # user location service route(LOCATION); route(RELAY); } route[RELAY] { # enable additional event routes for forwarded requests # - serial forking, RTP relaying handling, a.s.o. if (is_method("INVITE|BYE|SUBSCRIBE|UPDATE")) { if(!t_is_set("branch_route")) t_on_branch("MANAGE_BRANCH"); } if (is_method("INVITE|SUBSCRIBE|UPDATE")) { if(!t_is_set("onreply_route")) t_on_reply("MANAGE_REPLY"); } if (is_method("INVITE")) { if(!t_is_set("failure_route")) t_on_failure("MANAGE_FAILURE"); } if (!t_relay()) { sl_reply_error(); } exit; } # Per SIP request initial checks route[REQINIT] { #!ifdef WITH_ANTIFLOOD # flood dection from same IP and traffic ban for a while # be sure you exclude checking trusted peers, such as pstn gateways # - local host excluded (e.g., loop to self) if(src_ip!=myself) { if($sht(ipban=>$si)!=$null) { # ip is already blocked xdbg("request from blocked IP - $rm from $fu (IP:$si:$sp)\n"); exit; } if (!pike_check_req()) { xlog("L_ALERT","ALERT: pike blocking $rm from $fu (IP:$si:$sp)\n"); $sht(ipban=>$si) = 1; exit; } } #!endif if (!mf_process_maxfwd_header("10")) { sl_send_reply("483","Too Many Hops"); exit; } if(!sanity_check("1511", "7")) { xlog("Malformed SIP message from $si:$sp\n"); exit; } } # Handle requests within SIP dialogs route[WITHINDLG] { if (has_totag()) { # sequential request withing a dialog should # take the path determined by record-routing if (loose_route()) { #!ifdef WITH_WEBSOCKETS if ($du == "") { if (!handle_ruri_alias()) { xlog("L_ERR", "Bad alias <$ru>\n"); sl_send_reply("400", "Bad Request"); exit; } } #!endif route(DLGURI); if (is_method("BYE")) { setflag(FLT_ACC); # do accounting ... setflag(FLT_ACCFAILED); # ... even if the transaction fails } else if ( is_method("ACK") ) { # ACK is forwarded statelessy route(NATMANAGE); } else if ( is_method("NOTIFY") ) { # Add Record-Route for in-dialog NOTIFY as per RFC 6665. record_route(); } route(RELAY); } else { if (is_method("SUBSCRIBE") && uri == myself) { # in-dialog subscribe requests route(PRESENCE); exit; } if ( is_method("ACK") ) { if ( t_check_trans() ) { # no loose-route, but stateful ACK; # must be an ACK after a 487 # or e.g. 404 from upstream server route(RELAY); exit; } else { # ACK without matching transaction ... ignore and discard exit; } } sl_send_reply("404","Not here"); } exit; } } # Handle SIP registrations route[REGISTRAR] { if (is_method("REGISTER")) { if(isflagset(FLT_NATS)) { setbflag(FLB_NATB); # uncomment next line to do SIP NAT pinging ## setbflag(FLB_NATSIPPING); } if (!save("location")) sl_reply_error(); exit; } } # USER location service route[LOCATION] { #!ifdef WITH_SPEEDDIAL # search for short dialing - 2-digit extension if($rU=~"^[0-9][0-9]$") if(sd_lookup("speed_dial")) route(SIPOUT); #!endif #!ifdef WITH_ALIASDB # search in DB-based aliases if(alias_db_lookup("dbaliases")) route(SIPOUT); #!endif $avp(oexten) = $rU; if (!lookup("location")) { $var(rc) = $rc; route(TOVOICEMAIL); t_newtran(); switch ($var(rc)) { case -1: case -3: send_reply("404", "Not Found"); exit; case -2: send_reply("405", "Method Not Allowed"); exit; } } # when routing via usrloc, log the missed calls also if (is_method("INVITE")) { setflag(FLT_ACCMISSED); } } # Presence server route route[PRESENCE] { if(!is_method("PUBLISH|SUBSCRIBE")) return; #!ifdef WITH_PRESENCE if (!t_newtran()) { sl_reply_error(); exit; }; if(is_method("PUBLISH")) { handle_publish(); t_release(); } else if( is_method("SUBSCRIBE")) { handle_subscribe(); t_release(); } exit; #!endif # if presence enabled, this part will not be executed if (is_method("PUBLISH") || $rU==$null) { sl_send_reply("404", "Not here"); exit; } return; } # Authentication route route[AUTH] { #!ifdef WITH_AUTH #!ifdef WITH_IPAUTH if((!is_method("REGISTER")) && allow_source_address()) { # source IP allowed return; } #!endif #!ifdef WITH_FREESWITCH if(route(FSINBOUND)) return; #!endif if (is_method("REGISTER") || from_uri==myself) { # authenticate requests if (!auth_check("$fd", "subscriber", "1")) { auth_challenge("$fd", "0"); exit; } # user authenticated - remove auth header if(!is_method("REGISTER|PUBLISH")) consume_credentials(); } # if caller is not local subscriber, then check if it calls # a local destination, otherwise deny, not an open relay here if (from_uri!=myself && uri!=myself) { sl_send_reply("403","Not relaying"); exit; } #!endif return; } # Caller NAT detection route route[NATDETECT] { #!ifdef WITH_NAT force_rport(); if (nat_uac_test("19")) { if (is_method("REGISTER")) { fix_nated_register(); } else { add_contact_alias(); } setflag(FLT_NATS); } #!endif return; } # RTPProxy control route[NATMANAGE] { #!ifdef WITH_NAT if (is_request()) { if(has_totag()) { if(check_route_param("nat=yes")) { setbflag(FLB_NATB); } } } if (!(isflagset(FLT_NATS) || isbflagset(FLB_NATB))) return; rtpproxy_manage(); if (is_request()) { if (!has_totag()) { add_rr_param(";nat=yes"); } } if (is_reply()) { if(isbflagset(FLB_NATB)) { add_contact_alias(); } } #!endif return; } # URI update for dialog requests route[DLGURI] { #!ifdef WITH_NAT if(!isdsturiset()) { handle_ruri_alias(); } #!endif return; } # Routing to foreign domains route[SIPOUT] { if (!uri==myself) { append_hf("P-hint: outbound\r\n"); route(RELAY); } } # PSTN GW routing route[PSTN] { #!ifdef WITH_PSTN # check if PSTN GW IP is defined if (strempty($sel(cfg_get.pstn.gw_ip))) { xlog("SCRIPT: PSTN rotuing enabled but pstn.gw_ip not defined\n"); return; } # route to PSTN dialed numbers starting with '+' or '00' # (international format) # - update the condition to match your dialing rules for PSTN routing if(!($rU=~"^(\+|00)[1-9][0-9]{3,20}$")) return; # only local users allowed to call if(from_uri!=myself) { sl_send_reply("403", "Not Allowed"); exit; } if (strempty($sel(cfg_get.pstn.gw_port))) { $ru = "sip:" + $rU + "@" + $sel(cfg_get.pstn.gw_ip); } else { $ru = "sip:" + $rU + "@" + $sel(cfg_get.pstn.gw_ip) + ":" + $sel(cfg_get.pstn.gw_port); } route(RELAY); exit; #!endif return; } # XMLRPC routing #!ifdef WITH_XMLRPC route[XMLRPC] { # allow XMLRPC from localhost if ((method=="POST" || method=="GET") && (src_ip==127.0.0.1)) { # close connection only for xmlrpclib user agents (there is a bug in # xmlrpclib: it waits for EOF before interpreting the response). if ($hdr(User-Agent) =~ "xmlrpclib") set_reply_close(); set_reply_no_connect(); dispatch_rpc(); exit; } send_reply("403", "Forbidden"); exit; } #!endif # route to voicemail server route[TOVOICEMAIL] { #!ifdef WITH_VOICEMAIL if(!is_method("INVITE")) return; # check if VoiceMail server IP is defined if (strempty($sel(cfg_get.voicemail.srv_ip))) { xlog("SCRIPT: VoiceMail rotuing enabled but IP not defined\n"); return; } if($avp(oexten)==$null) return; $ru = "sip:" + $avp(oexten) + "@" + $sel(cfg_get.voicemail.srv_ip) + ":" + $sel(cfg_get.voicemail.srv_port); route(RELAY); exit; #!endif return; } #!ifdef WITH_FREESWITCH # FreeSWITCH routing blocks route[FSINBOUND] { if($si== $sel(cfg_get.freeswitch.bindip) && $sp==$sel(cfg_get.freeswitch.bindport)) return 1; return -1; } route[FSDISPATCH] { if(!is_method("INVITE")) return; if(route(FSINBOUND)) return; # dial number selection switch($rU) { case /"^41$": # 41 - voicebox menu # allow only authenticated users if($au==$null) { sl_send_reply("403", "Not allowed"); exit; } $rU = "vm-" + $au; break; case /"^441[0-9][0-9]$": # starting with 44 folowed by 1XY - direct call to voice box strip(2); route(FSVBOX); break; case /"^433[0-9][0-9][0-9]$": # starting with 433 folowed by (0|1)XY - conference strip(2); break; case /"^45[0-9]+$": strip(2); break; default: # offline - send to voicebox if (!registered("location")) { route(FSVBOX); exit; } # online - do bridging prefix("kb-"); if(is_method("INVITE")) { # in case of failure - re-route to FreeSWITCH VoiceMail t_on_failure("FAIL_FSVBOX"); } } route(FSRELAY); exit; } route[FSVBOX] { if(!($rU=~"^1[0-9][0-9]+$")) return; prefix("vb-"); route(FSRELAY); } # Send to FreeSWITCH route[FSRELAY] { $du = "sip:" + $sel(cfg_get.freeswitch.bindip) + ":" + $sel(cfg_get.freeswitch.bindport); route(RELAY); exit; } #!endif # manage outgoing branches branch_route[MANAGE_BRANCH] { xdbg("new branch [$T_branch_idx] to $ru\n"); route(NATMANAGE); } # manage incoming replies onreply_route[MANAGE_REPLY] { xdbg("incoming reply\n"); if(status=~"[12][0-9][0-9]") route(NATMANAGE); } # manage failure routing cases failure_route[MANAGE_FAILURE] { route(NATMANAGE); if (t_is_canceled()) { exit; } #!ifdef WITH_BLOCK3XX # block call redirect based on 3xx replies. if (t_check_status("3[0-9][0-9]")) { t_reply("404","Not found"); exit; } #!endif #!ifdef WITH_VOICEMAIL # serial forking # - route to voicemail on busy or no answer (timeout) if (t_check_status("486|408")) { route(TOVOICEMAIL); exit; } #!endif } #!ifdef WITH_WEBSOCKETS onreply_route { if ((($Rp == MY_WS_PORT || $Rp == MY_WSS_PORT) && !(proto == WS || proto == WSS)) || $Rp == MY_MSRP_PORT) { xlog("L_WARN", "SIP response received on $Rp\n"); drop; exit; } if (nat_uac_test(64)) { # Do NAT traversal stuff for replies to a WebSocket connection # - even if it is not behind a NAT! # This won't be needed in the future if Kamailio and the # WebSocket client support Outbound and Path. add_contact_alias(); } } event_route[xhttp:request] { set_reply_close(); set_reply_no_connect(); if ($Rp != MY_WS_PORT #!ifdef WITH_TLS && $Rp != MY_WSS_PORT #!endif ) { xlog("L_WARN", "HTTP request received on $Rp\n"); xhttp_reply("403", "Forbidden", "", ""); exit; } xlog("L_DBG", "HTTP Request Received\n"); if ($hdr(Upgrade)=~"websocket" && $hdr(Connection)=~"Upgrade" && $rm=~"GET") { # Validate Host - make sure the client is using the correct # alias for WebSockets # Sasa: commented out, see http://sip-router.1086192.n5.nabble.com/Testing-the-Websocket-module-with-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

1 0

Name of pseudo variable by which domain name is saved in Location List
by aawaise 29 Apr '14

29 Apr '14

Hello, I want to display the value from domain field of Location List in SER Monitor Menu. I extracted the value of $rd using xlog. It gave me the domain of callee but from invite packet. Not from the location list of SER Monitor Menu. If callee is logged in to same database with another kamailio server and hence another domain name. How can I pick domain name by which its logged in Thanks. Regards, Aawaise -- View this message in context: http://sip-router.1086192.n5.nabble.com/Name-of-pseudo-variable-by-which-do… Sent from the Users mailing list archive at Nabble.com.

2 5

drouting/LCR/dispatcher
by Keith 29 Apr '14

29 Apr '14

Hi all, I am having trouble deciding which one of these is best. I was going to start to use drouting but that doesn't seem to give me the probe efficiency of dispatcher. However I need to control calls based on destinations to different voice carriers. I'm looking for a combination of them to enable me to get the functionality required. Any ideas/pointers? Thanks Keith

2 1

OT: Excessive or fatal bounces for yahoo, hotmail, ...
by Daniel-Constantin Mierla 29 Apr '14

29 Apr '14

Hello, this morning were reported over 100 "excessive or fatal bounces" for delivery from mailing list to yahoo, hotmail/live (and few other that might be hosted) email addresses. This is unusual high and I spotted several addresses that were active recently and unlikely to have their email address gone. Is anyone here aware of similar issues and potential fixes? I guess yahoo/hotmail servers simply reject the emails sent by mailman of mailing lists. Any hint would be appreciated... Cheers, Daniel -- Daniel-Constantin Mierla - http://www.asipto.com http://twitter.com/#!/miconda - http://www.linkedin.com/in/miconda

4 5

Can Kamailio connect WebSocket user with SIP user?
by Patrik Kristel 29 Apr '14

29 Apr '14

Hello, I would like to ask, whether Kamailio does connect WebSocket user with SIP user. Because, I'm trying to do it regarding this code: http://git.sip-router.org/cgi-bin/gitweb.cgi?p=sip-router;a=blob_plain;f=ex… and when i'using X-lite i've got 1, Trying 2, 415 Unsupported Media Type and at Blink client I've got: 1, Trying 2, 488 Not Acceptable Here as WebSocket client i'm using JsSIP. Do you think I need to use media server(like Asterisk) to connect it? Thank you for help! Patrik

1 0

Re: [SR-Users] Drouting
by Keith 29 Apr '14

29 Apr '14

Hi all, So I moved away from LCR and dispatcher to use drouting but I can't see how to use probing. In OpenSIPS I can see this is built into the module but it's not in Kamailio. Any ideas how I can get round this? I want to use drouting for all my routing needs. Cheers Keith

2 1

Kamailio and Free switch - multi tenant
by Chirag Desai 29 Apr '14

29 Apr '14

Hi all, First time poster here. I had a freeswitch installation configured to allow users to register with different domains e.g. tenant1.mydomain.com tenant2.mydomain.com .. tenantN.my domain.com This worked fine. Users were able to call extensions in their own domain and access their voicemail. All tenants/domains shared the same diaplan (default). I followed the great tutorial at http://kb.asipto.com/freeswitch:kamailio-3.3.x-freeswitch-1.2.x-sbc I now have my users (using different domains as above) registering to Kamailio. It was a little tricky but I can now place calls between users on the same domain. For some reason the variable ${domain_name} (from the tutorial) seems to be empty so I had to replace it with a channel variable (I'm not in front of my dialplan now but it was something like ${sip_from_domain}. Was this the right thing to do? Why does the domain_name variable not populate with the domain of the user making the call? Another issue I have is to do with usernames. I want my users to have alphanumeric usernames e.g. user1(a)tenant1.example.com user2(a)tenant1.example.com But I'd also like them to be able to have an associated extension and mailbox. E.g. user1 may be extension 1001 and mailbox 1001 user2 may be extension 1002 and mailbox 1002. In Kamailio I've handled this by using aliasdb. So user1.tenant1.example.com has an alias of 1001.tenant1.example.com Scenario: User2 dials 1001. Kamailio evaluates this and determines we want user1. It passes the call to FS with a $rU of user1. However, even though user1 is registered and online...the call fails and diverts to voicemail - any ideas? Also I had to hack the above so that after the alias db lookup Kamailio sends an $rU of 1001@tenant1... If anyone has got FS and Kamailio running with multiple domains I would really love some feedback on routing and dialplan configuration. Thanks so much in advance, CD

1 0

kamctl not connect to dbserver
by Юрий Горличенко 28 Apr '14

28 Apr '14

Hello. I started configure Kamailio 3.3 server with mysql database, that running on the remote server. I customise settings at kamailio.cfg (for BDURL) and kamctlc file (for my db - changed user, password, dbhost and other settings, such as dbengine and etc.) Now, when I tried add new subscriber from kamctl util (kamctl add newuser@kamailioIP passwd). I see "access denied for <myuser>@<interface of kamailio server>", But as I aleady says I configured filew with other settings for db server. Where I must configure ip of dbhost to connect kamctl to my dbserver?

2 1

Dispatcher marks TLS destinations as Inactive when present in more than one set
by Giacomo Vacca 28 Apr '14

28 Apr '14

Hi all, I'm seeing a strange behaviour with dispatcher in these conditions: 1. A destination requires TLS (e.g. sips:10.0.0.1:5061) 2. The destination has flags 8 (i.e. in normal conditions we want AP, Active Probing) and dispatcher uses ds_probing_mode 1 (always probe) 3. The destination is present in more than one set The behaviour is that the destination is marked as IP (Inactive Probing) in the set with a lower set number. In other words at startup (or dispatcher reload): SET_NO:: 2 SET:: 2 URI:: sips:10.0.0.1:5061 flags=AP priority=0 attrs= SET:: 1 URI:: sips:10.0.0.1:5061 flags=AP priority=0 attrs= After some time (about 30", see below): SET_NO:: 2 SET:: 2 URI:: sips:10.0.0.1:5061 flags=AP priority=0 attrs= SET:: 1 URI:: sips:10.0.0.1:5061 flags=IP priority=0 attrs= So the same destination is marked as AP and IP at the same time. I've reproduced this with a brand new installation (4.1.3 on debian wheezy), but seen with 3.2.3 and 4.0.4 as well. debian wheezy VM (Linux debian7 3.2.0-4-amd64 #1 SMP Debian 3.2.54-2 x86_64 GNU/Linux) I can see (with either ssldump or asterisk's 'sip set debug on') the first OPTIONS/404 (related to set #2), but not the second (related to set #1). I haven't seen (with tcpdump) the attempt to create a second connection to the destination (which makes me think that it either fails or kamailio attempts to re-use the existing one). Probing for set #1 appears to time out (i.e. after 30" the response is considered a 408). It happens with either Asterisk or FreeSWITCH as servers. Extract from tls.cfg: [client:default] verify_certificate = no require_certificate = no Dispatcher configuration: loadmodule "dispatcher.so" [...] # ----- dispatcher params ----- modparam("dispatcher", "list_file", "/etc/kamailio/dispatcher.cfg") modparam("dispatcher", "ds_ping_reply_codes", "class=2;code=404") modparam("dispatcher", "ds_probing_mode", 1) modparam("dispatcher", "ds_ping_interval", 30) /etc/kamailio/dispatcher.cfg: 1 sips:10.0.0.1:5061 8 0 2 sips:10.0.0.1:5061 8 0 (I'm using 10.0.0.1 here for simplification only; the real IP address has been omitted). Server (Asterisk or FreeSWITCH) certs are self-signed. Relevant logs (level 4): Apr 24 15:54:19 debian7 /usr/sbin/kamailio[11169]: DEBUG: dispatcher [dispatch.c:2453]: ds_check_timer(): probing set #2, URI sips:10.0.0.1:5061 Apr 24 15:54:19 debian7 /usr/sbin/kamailio[11169]: DEBUG: tm [uac.c:243]: t_uac_prepare(): DEBUG:tm:t_uac: next_hop=<sips:10.0.0.1:5061> Apr 24 15:54:19 debian7 /usr/sbin/kamailio[11169]: DEBUG: tm [uac.c:182]: dlg2hash(): DEBUG: dlg2hash: 49688 Apr 24 15:54:19 debian7 /usr/sbin/kamailio[11169]: DEBUG: <core> [tcp_main.c:1849]: tcp_send(): tcp_send: no open tcp connection found, opening new one Apr 24 15:54:19 debian7 /usr/sbin/kamailio[11169]: DEBUG: <core> [ip_addr.c:243]: print_ip(): tcpconn_new: new tcp connection: 10.0.0.1 Apr 24 15:54:19 debian7 /usr/sbin/kamailio[11169]: DEBUG: <core> [tcp_main.c:1096]: tcpconn_new(): tcpconn_new: on port 5061, type 3 Apr 24 15:54:19 debian7 /usr/sbin/kamailio[11169]: DEBUG: <core> [tcp_main.c:1408]: tcpconn_add(): tcpconn_add: hashes: 1217:0:0, 1 Apr 24 15:54:19 debian7 /usr/sbin/kamailio[11169]: DEBUG: tls [tls_server.c:178]: tls_complete_init(): Using TLS domain TLSc<default> Apr 24 15:54:19 debian7 /usr/sbin/kamailio[11169]: DEBUG: tls [tls_domain.c:700]: sr_ssl_ctx_info_callback(): SSL handshake started Apr 24 15:54:19 debian7 /usr/sbin/kamailio[11169]: DEBUG: <core> [tcp_main.c:2737]: tcpconn_1st_send(): pending write on new connection 0x7fd4813cdb70 (-1/225 bytes written) Apr 24 15:54:19 debian7 /usr/sbin/kamailio[11177]: DEBUG: <core> [tcp_main.c:3624]: handle_ser_child(): handle_ser_child: read response= 7fd4813cdb70, 5, fd 32 from 9 (11169) Apr 24 15:54:19 debian7 /usr/sbin/kamailio[11177]: DEBUG: <core> [io_wait.h:390]: io_watch_add(): DBG: io_watch_add(0x89dc40, 32, 2, 0x7fd4813cdb70), fd_no=24 Apr 24 15:54:19 debian7 /usr/sbin/kamailio[11169]: DEBUG: dispatcher [dispatch.c:2453]: ds_check_timer(): probing set #1, URI sips:10.0.0.1:5061 Apr 24 15:54:19 debian7 /usr/sbin/kamailio[11169]: DEBUG: tm [uac.c:243]: t_uac_prepare(): DEBUG:tm:t_uac: next_hop=<sips:10.0.0.1:5061> Apr 24 15:54:19 debian7 /usr/sbin/kamailio[11169]: DEBUG: tm [uac.c:182]: dlg2hash(): DEBUG: dlg2hash: 49689 Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11177]: DEBUG: <core> [io_wait.h:796]: io_watch_chg(): DBG: io_watch_chg (0x89dc40, 32, 0x1, 0xffffffff) fd_no=25 called Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11177]: DEBUG: <core> [io_wait.h:617]: io_watch_del(): DBG: io_watch_del (0x89dc40, 32, -1, 0x0) fd_no=25 called Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11177]: DEBUG: <core> [tcp_main.c:4302]: handle_tcpconn_ev(): tcp: DBG: sending to child, events 1 Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11177]: DEBUG: <core> [tcp_main.c:3973]: send2child(): selected tcp worker 0 13(11173) for activity on [tls:192.168.142.170:5061], 0x7fd4813cdb70 Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [tcp_read.c:1510]: handle_io(): received n=8 con=0x7fd4813cdb70, fd=7 Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [io_wait.h:390]: io_watch_add(): DBG: io_watch_add(0x8e2040, 7, 2, 0x7fd4813cdb70), fd_no=1 Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [tcp_main.c:2556]: tcpconn_do_send(): tcp_send: sending... Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [tcp_main.c:2590]: tcpconn_do_send(): tcp_send: after real write: c= 0x7fd4813cdb70 n=198 fd=7 Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [tcp_main.c:2591]: tcpconn_do_send(): tcp_send: buf=#012#026#003#001 Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: tls [tls_domain.c:712]: sr_ssl_ctx_info_callback(): SSL handshake done Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: tls [tls_domain.c:715]: sr_ssl_ctx_info_callback(): SSL disable renegotiation Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: tls [tls_server.c:413]: tls_connect(): TLS connect successful Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: tls [tls_server.c:420]: tls_connect(): tls_connect: new connection to 10.0.0.1:5061 using TLSv1/SSLv3 AES256-SHA 256 Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: tls [tls_server.c:423]: tls_connect(): tls_connect: sending socket: 192.168.142.170:43914 Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: tls [tls_server.c:305]: tls_dump_cert_info(): tls_connect: server certificate subject:/CN=REMOVED/O=REMOVED Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: tls [tls_server.c:309]: tls_dump_cert_info(): tls_connect: server certificate issuer:/CN=REMOVED/O=REMOVED Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: tls [tls_server.c:429]: tls_connect(): WARNING: tls_connect: server certificate verification failed!!! Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: tls [tls_dump_vf.c:105]: tls_dump_verification_failure(): verification failure: self signed certificate in certificate chain Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [tcp_main.c:2556]: tcpconn_do_send(): tcp_send: sending... Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [tcp_main.c:2590]: tcpconn_do_send(): tcp_send: after real write: c= 0x7fd4813cdb70 n=805 fd=7 Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [tcp_main.c:2591]: tcpconn_do_send(): tcp_send: buf=[...REMOVED...] Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [tcp_read.c:1317]: tcp_read_req(): tcp_read_req: content-length= 0 Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [parser/msg_parser.c:633]: parse_msg(): SIP Reply (status): Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [parser/msg_parser.c:635]: parse_msg(): version: <SIP/2.0> Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [parser/msg_parser.c:637]: parse_msg(): status: <404> Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [parser/msg_parser.c:639]: parse_msg(): reason: <Not Found> Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK812c.b064d3e3000000000000000000000000.0>; state=6 Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 234, <received> = <REMOVED>; state=6 Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 235, <rport> = <59525>; state=16 Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of header reached, state=5 Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers(): parse_headers: Via found, flags=2 Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [parser/msg_parser.c:515]: parse_headers(): parse_headers: this is the first via Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [receive.c:152]: receive_msg(): After parse_msg... Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg: msg id=1 global id=0 T start=0xffffffffffffffff Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [parser/parse_addr_spec.c:176]: parse_to_param(): DEBUG: add_param: tag=as232959d2 Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [parser/parse_addr_spec.c:893]: parse_addr_spec(): end of header reached, state=29 Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [parser/msg_parser.c:190]: get_hdr_field(): DEBUG: get_hdr_field: <To> [43]; uri=[sips:10.0.0.1:5061] Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [parser/msg_parser.c:192]: get_hdr_field(): DEBUG: to body [<sips:10.0.0.1:5061>] Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [parser/msg_parser.c:170]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <10> <OPTIONS> Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: tm [t_lookup.c:949]: t_reply_matching(): DEBUG: t_reply_matching: hash 49688 label 0 branch 0 Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: tm [t_lookup.c:1004]: t_reply_matching(): DEBUG: t_reply_matching: reply matched (T=0x7fd4813cc530)! Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: tm [t_lookup.c:1141]: t_check_msg(): DEBUG: t_check_msg: msg id=1 global id=1 T end=0x7fd4813cc530 Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: tm [t_reply.c:2206]: reply_received(): DEBUG: reply_received: org. status uas=0, uac[0]=0 local=2 is_invite=0) Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: tm [t_reply.c:1304]: t_should_relay_response(): ->>>>>>>>> T_code=0, new_code=404 Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: tm [t_reply.c:2086]: local_reply(): DEBUG: local_reply: branch=0, save=0, winner=0 Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: tm [t_reply.c:2123]: local_reply(): DEBUG: local transaction completed Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: tm [t_hooks.c:288]: run_trans_callbacks_internal(): DBG: trans=0x7fd4813cc530, callback type 1024, id 0 entered Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: dispatcher [dispatch.c:2392]: ds_options_callback(): OPTIONS-Request was finished with code 404 (to sips:10.0.0.1:5061, group 2) Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: tm [t_reply.c:1663]: cleanup_uac_timers(): DEBUG: cleanup_uac_timers: RETR/FR timers reset Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [usr_avp.c:644]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil) Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [usr_avp.c:644]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil) Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [usr_avp.c:644]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil) Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [usr_avp.c:644]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil) Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [usr_avp.c:644]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil) Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [usr_avp.c:644]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil) Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [xavp.c:448]: xavp_destroy_list(): destroying xavp list (nil) Apr 24 15:54:20 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [receive.c:296]: receive_msg(): receive_msg: cleaning up Apr 24 15:54:26 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [io_wait.h:617]: io_watch_del(): DBG: io_watch_del (0x8e2040, 7, -1, 0x10) fd_no=2 called Apr 24 15:54:26 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [tcp_read.c:1437]: release_tcpconn(): releasing con 0x7fd4813cdb70, state 1, fd=7, id=1 Apr 24 15:54:26 debian7 /usr/sbin/kamailio[11173]: DEBUG: <core> [tcp_read.c:1438]: release_tcpconn(): extra_data 0x7fd4813b51f0 Apr 24 15:54:26 debian7 /usr/sbin/kamailio[11177]: DEBUG: <core> [tcp_main.c:3385]: handle_tcp_child(): handle_tcp_child: reader response= 7fd4813cdb70, 1 from 0 Apr 24 15:54:26 debian7 /usr/sbin/kamailio[11177]: DEBUG: <core> [io_wait.h:390]: io_watch_add(): DBG: io_watch_add(0x89dc40, 32, 2, 0x7fd4813cdb70), fd_no=24 Apr 24 15:54:26 debian7 /usr/sbin/kamailio[11177]: DEBUG: <core> [tcp_main.c:3515]: handle_tcp_child(): handle_tcp_child: CONN_RELEASE 0x7fd4813cdb70 refcnt= 1 Apr 24 15:54:49 debian7 /usr/sbin/kamailio[11169]: DEBUG: tm [t_reply.c:1304]: t_should_relay_response(): ->>>>>>>>> T_code=0, new_code=408 Apr 24 15:54:49 debian7 /usr/sbin/kamailio[11169]: DEBUG: tm [t_reply.c:2086]: local_reply(): DEBUG: local_reply: branch=0, save=0, winner=0 Apr 24 15:54:49 debian7 /usr/sbin/kamailio[11169]: DEBUG: tm [t_reply.c:2123]: local_reply(): DEBUG: local transaction completed Apr 24 15:54:49 debian7 /usr/sbin/kamailio[11169]: DEBUG: tm [t_hooks.c:288]: run_trans_callbacks_internal(): DBG: trans=0x7fd4813e5890, callback type 1024, id 0 entered Apr 24 15:54:49 debian7 /usr/sbin/kamailio[11169]: DEBUG: dispatcher [dispatch.c:2392]: ds_options_callback(): OPTIONS-Request was finished with code 408 (to sips:10.0.0.1:5061, group 1) Probing set #2 goes OK. Probing set #1: starts probing at 15:54:19, and times out 30" later at 15:54:49. Is this a bug, a misconfiguration, or perhaps a wrong way to manage dispatcher sets using TLS? Additional question: Is it not expected that a persistent TLS connection is established with a 'sips' dispatcher destination? Thanks in advance for the time to read through all this! Giacomo Truphone Limited, registered in England and Wales (registered company number: 04187081). Registered office: CityPoint, One Ropemaker Street, London EC2Y 9SS. VAT No. GB 851 5278 19 This e-mail, and any attachment(s), may contain information which is confidential and/or privileged, and is intended for the addressee only. If you are not the intended recipient, you may not use, disclose, copy or distribute this information in any manner whatsoever. If you have received this e-mail in error, please contact the sender immediately and delete it.

2 2

Early dialog
by Ivan Baques Garcia 28 Apr '14

28 Apr '14

Hi, I'm using modparam("dialog", "db_mode", 1), but only confirmed dialogs are shown in the database. How I can enable to show unconfirmed dialogs in the database? Now are only in-memory. Best regards

3 2

Large Content-Length crash with instant message
by Roberto Fichera 28 Apr '14

28 Apr '14

Hi All, I'm playing with instant messaging with a PJSIP client, but as soon as I send body with payload to about 100k I'm getting the error below: Apr 28 09:16:52 ip-10-227-0-26 /usr/sbin/kamailio[2909]: ERROR: <core> [tcp_main.c:715]: _wbufq_add(): ERROR: wbufq_add(40552 bytes): write queue full or timeout (0, total 0, last write 51946505 s ago) Apr 28 09:16:52 ip-10-227-0-26 /usr/sbin/kamailio[2909]: ERROR: tm [../../forward.h:240]: msg_send(): msg_send: ERROR: tcp_send failed Apr 28 09:16:52 ip-10-227-0-26 /usr/sbin/kamailio[2910]: ERROR: <core> [tcp_main.c:3638]: handle_ser_child(): handle_ser_child: ERROR: received CON_ERROR for 0xb30ddcd8 (id 352), refcnt 2, flags 0x5092 Apr 28 09:16:52 ip-10-227-0-26 /usr/sbin/kamailio[2909]: ERROR: tm [t_fwd.c:1609]: t_send_branch(): ERROR: t_send_branch: sending request on branch 0 failed Apr 28 09:16:52 ip-10-227-0-26 /usr/sbin/kamailio[2909]: ERROR: sl [sl_funcs.c:387]: sl_reply_error(): ERROR: sl_reply_error used: Unfortunately error on sending to next hop occurred (477/SL) And the app get SIP/2.0 477 Unfortunately error on sending to next hop occurred (477/SL) Via: SIP/2.0/TLS XX.XX.XX.XX:55859;rport=55859;branch=z9hG4bKPjkkazEy.XcjJkYDCEzwbwUVAONDzcCN8t;alias From: <sip:aaaaa@test.net>;tag=9gcb.Ay3wSCZNFgs8PNCbdkRq7jfxbDx To: <sip:bbbbb@test.net>;tag=9a285338e10af1c086406d08dc7f5d79.e457 Call-ID: v9JlsK1AEH4So8AIEfqiGuUOEx5Fub1C CSeq: 28450 MESSAGE Server: kamailio (4.1.3 (i386/linux)) Content-Length: 0 --end msg-- Kamailio is already set with tcp_rd_buf_size=204800 Does anyone can suggest how to fix this? Thanks in advance, Roberto Fichera.

2 4

LCR from_uri help
by Juha Heinanen 28 Apr '14

28 Apr '14

just to complete this thread, it turned out that from uri matching didn't happen because load_gws() was called without caller uri argument. -- juha

1 0

Presence request authentication
by Muhammad Shahzad 28 Apr '14

28 Apr '14

Hi, I have a complex setup consisting of two sip server, lets call them main server and presence server. The main server manages SIP register, calls, messages and so, however it does not support presence at all. It returns SIP response "405 Method Not Allowed" for any SIP PUBLISH, SUBSCRIBE or NOTIFY. The presence server is a Kamailio server, which unfortunately has no access to SIP subscriber database (so it can not do authentication), however it has access to User Location database. Now at presence server i want to put some kind of security for presence requests, since i can't do authentication, so i was thinking if i can verify if request has come from a location registered in location db. I found method "registered" in registrar module but unfortunately it checks if R-URI or any given URI is registered, while i want to do check against "received" address or contact address. Can you guys suggest any easy way to do it? I am thinking about using "reg_fetch_contacts" but not sure if it can serve the purpose. Thank you.

2 2

Kamailio and FHoSS integration
by Andrea Meroni 28 Apr '14

28 Apr '14

Hi all, i am testing a very basic IMS core Kamailio-based using as HSS FHoSS. However, while using SIPp to stress the system, i noticed that the VM hosting the FHoSS is overloaded (even with 2 registration scenarios per second), in particular using top i was able to see that the java process used almost 200% of the CPU (i run the VM using qemu with options -m 1024 -smp 4). Is it normal or have i misconfigured something? Someone else has the same problem? Andrea

4 7

$(hdr(name)[N]) question
by Juha Heinanen 28 Apr '14

28 Apr '14

wiki was this related to $(hdr(name)[N]): If [N] is omitted then the body of the first header is printed. The first header is got when N=0, for the second N=1, a.s.o. In case of a comma-separated multi-body headers, it returns all the bodies, comma-separated. i don't understand the last sentence. how can i get all bodies of all headers of name=x as a comma separated list? -- juha

2 8

jsSIP client disconnects after a while when using Kamailio websocket
by Alex Villacís Lasso 28 Apr '14

28 Apr '14

I am having this issue when using kamailio-4.1.2 (after patching the segfault bug). The kamailio is configurated as a frontend for asterisk. When using UDP for SIP, this works correctly. However, I am now setting up websockets (no TLS yet), and I am getting a disconnect after an interval. I am getting this on the logs: Apr 11 16:19:41 elx3 /usr/sbin/kamailio[4814]: WARNING: websocket [ws_frame.c:868]: ws_keepalive(): forcibly closing connection Tweaking with keepalive_mechanism=1 and keepalive_timeout does not change the situation, and does not even modify the interval before the disconnection. Is this keepalive something that should be visible on a SIP trace? I am only seeing REGISTER and its response from the jsSIP trace. I do not want to have to disable keepalives just to work around this issue.

2 1

480 Temporarily Unavailable
by David Giannetto 28 Apr '14

28 Apr '14

I get this error "480 Temporarily Unavailable" Every time I dial 206-456-1041 this is the information I have entered in the the filds: line 1 Username: optimized72 <optimized72(a)iptel.org> Password: Freek101@ Proxy: iptel.org -- *l <http://LEDSLEDSLEDS.COM>edslesdlesd.com <http://edslesdlesd.com>* David Giannetto VOIP COM 915 235 47 86 105 E San Antonio Ave Suit 303 El Paso, Texas, 79901 VOIP COM 625 106 6388 Lerdo y 19 # 986 CD. Cuauhtemoc, Chih.

2 1

Translate calling/called party based on username to telephone number base id.
by Helena Garcia-Nieto 28 Apr '14

28 Apr '14

Hi all. I want to thank you all for the great info and help that you provide in this mailing list. I am just starting to work with kamailio and still learning. I would like some help to point me on the right direction on our new challenge: We have a kamailio server acting basically as location server and call proxy. We are connected to a PSTN gw to reach the outside world. It is working fine but now the client requested some changes that may imply we work with username base subscribers (user1. Characters based) at kamailio side but we still need to convert these usernames to numbers when sending the call to the PSTN gw. Username-number should be fix and can be stored in a table on the db. We would need to lookup userpart of all the header (from, to, contact.) and substitute incoming username with the peer number for calls from the app to pstn. And translate numbers to usernames on the calls from pstn to the apps. I am reading uac module and the sqlops module to search in the db before the substitution but I am not sure if that is the best approach to the problem. Could anyone point me in the right direction or suggest a better way to do that? Have anyone already implemented this type of modifications? I am a bit worried for the dialog consistency although I've read the uac module should take care of it Thanks in advanced Helena From: Helena Garcia-Nieto [mailto:helena.gnieto@morodo.co.uk] Sent: martes, 10 de diciembre de 2013 16:19 To: 'Kamailio (SER) - Users Mailing List' Cc: helena.gnieto(a)morodo.co.uk Subject: 500 I'm terribly sorry error Hello, Thanks in advanced for the help. I am almost new with kamailio and still struggling through silly problems so please forgive me if the solution is so obvious. I have a network like Xlitle -- Kamailio -- GW The GW is more or less out of my reach for changing the behaivour. As devices I have xlitle Kamailio is on version 4.0.2 I've changed only few things from the default config file. Add mysql support, auth, userlocdb, pstngw. For this part, gw routing , I've defined gw ip and port inside the PSTN definition like: #!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" iskratel.gw_ip = "10.XX.XX.XX" iskratel.gw_port = "5060" #!endif I route the calls with: route(ISKRATEL); And defined a routing function route[ISKRATEL] { #!ifdef WITH_PSTN # check if ISKRATEL GW IP is defined if (strempty($sel(cfg_get.iskratel.gw_ip))) { xlog("SCRIPT: PSTN rotuing enabled but iskratel.gw_ip not defined\n"); return; } # only local users allowed to call if(from_uri!=myself) { sl_send_reply("403", "Not Allowed"); exit; } if (strempty($sel(cfg_get.iskratel.gw_port))) { $ru = "sip:" + $rU + "@" + $sel(cfg_get.iskratel.gw_ip); } else { $ru = "sip:" + $rU + "@" + $sel(cfg_get.iskratel.gw_ip) + ":" + $sel(cfg_get.iskratel.gw_port); } # Add profix to ISKRATEL: A99901 subst_uri('/^sip:(.*)/sip:A99901\1/i'); # add A99901 route(RELAY); exit; #!endif return; } I can see that the code goes all the way to the route(relay) but all I can see is the 500 I'm terribly sorry, server error occurred (7/SL) and a second response 500 I'm terribly sorry, server error occurred (7/TM) I've tried defining the IP as the given pstn.gw_ip and route(pstn) without changing anything on the pst default routing but the response of the server is the same. I cannot see any special error on the logs. I have the exact same config for this part, in another test server and the calls go to the gw without reporting any error. I'll appreciate any help from you! Thanks in advanced for your time Helena

2 1

test if record_route() has been called already?
by Juha Heinanen 28 Apr '14

28 Apr '14

is there any means to test if record_route() has been called already on the request? if it is called more than once, error message is issued. -- juha

2 1

Processing on Invite Packet
by aawaise 28 Apr '14

28 Apr '14

Hello, On arrival of INVITE packet to the Kamailio server, which module is used to take in response to Invite packet. Other than record_route, which records the route. And what to do if we want to add some actions in response to INVITE packet. Cheers. -- View this message in context: http://sip-router.1086192.n5.nabble.com/Processing-on-Invite-Packet-tp12709… Sent from the Users mailing list archive at Nabble.com.

2 1

DRouting, routeid is not triggered
by Maciej Bylica 28 Apr '14

28 Apr '14

Hello, I am working on version: kamailio 4.1.2 (x86_64/linux) and heaving troubles with drouting module. The problem i am facing is that kamailio cannot enter routeid that is provided inside dr_rule table. My last try was to use standard script file with placing following data before t_relay if (!do_routing("10")) { sl_send_reply("403", "No route for You"); exit; } additionaly i have added route definition route[1] { xlog("L_INFO","[INFO] Default route --- fn-$fn, fu-$fu, fU-$fU, ru-$ru, rU-$rU, sp-$sp, si-$si, tu-$tu, tU-$tU"); uac_replace_from("sip:$fU@10.10.10.5"); } My DB contains following data: +--------+---------+--------+---------+----------+---------+--------+--------------+ | ruleid | groupid | prefix | timerec | priority | routeid | gwlist | description | +--------+---------+--------+---------+----------+---------+--------+--------------+ | 1 | 10 | 43 | | 0 | 1 | 1 | test rule | +--------+---------+--------+---------+----------+---------+--------+--------------+ +------+------+---------------+-------+------------+-------+-------------+ | gwid | type | address | strip | pri_prefix | attrs | description | +------+------+---------------+-------+------------+-------+-------------+ | 1 | 10 | 10.10.10.9 | 0 | NULL | NULL | FirstGW | +------+------+---------------+-------+------------+-------+-------------+ The result is that script is omitting route[1] without any purpose (xlog is not shown, $fU is not modified). Could somebody help me to understand whats going on? Thanks in advanced, Mac

2 8

avpops question...
by arun Jayaprakash 28 Apr '14

28 Apr '14

Hello, I have a piece of code as follows: $avp(callfwdcount) = 0; $avp(dnumber) = $rU; $var(found) = 0; while($avp(callfwdcount) < 3) { if (avp_db_load("$avp(dnumber)", "$avp(callfwd_permanent)")) { ..... $avp(dst_number) = $avp(callfwd_permanent); # SET THE CALL FORWARD TO NUMBER .... } Now this works if this is a single domain set up. I am running a multidomain set up and need to check the domain part to ( $rd ) and if there is match in the database with $rU and $rd then the forward to number needs to be set. Can someone let me know how this can be done? Thank you, Arun

2 2

Dialog module and confirmed-unacked dialogs
by Alex Balashov 28 Apr '14

28 Apr '14

Hi, I am wondering if perhaps we ought to do something with regard to specific handling of confirmed-nonacked dialogs (CONFIRMED_NA state in dlg_hash.h) in the dialog module. These are dialogs where a 2xx reply is sent to the opening INVITE transaction, but no end-to-end ACK is seen[1] by Kamailio and thus the dialog is not recorded as transitioning to CONFIRMED state. This can happen for a variety of reasons, but the most common scenario I run into is the CANCEL-200 OK race, where the caller cancels the call just as the callee answers it, near-simultaneously. The 200 OK hasn't gotten back to the caller yet, so when it receives it, it has no effect, because from the caller's point of view, the dialog has already been CANCEL'd. Meanwhile, the CANCEL has no effect on the callee end either, since, from its point of view, the dialog has already transitioned into confirmed state. The problem I am running into a lot is that these dialogs stay tracked up until the dialog timeout period, which can be several hours away. In high-volume environments, they can clog up concurrent channel counts. The receiving UAS has, of course, disposed of these dialogs long ago, after 64*T1, but they remain "stuck" in Kamailio. I know that RFC 3261 Section 13.3.1.4 ("The INVITE is Accepted") says: If the server retransmits the 2xx response for 64*T1 seconds without receiving an ACK, the dialog is confirmed, but the session SHOULD be terminated. This is accomplished with a BYE, as described in Section 15. Now, I know that "SHOULD" != "MUST", and I would imagine that this is probably the main reason why the dialog module does not time out such dialogs according to the same timers as the callee UA might. Nevertheless, they present a problem. Right now, I deal with it by using a script that combs 'kamctl fifo dlg_list' for dialogs in 'state:: 3' for more than X seconds and manually ends them. But, when there's a problem that one runs into nearly ubiquitously in all deployments with nontrivial deployments, it seems to me it's time to consider an additional 'dialog' modparam or something of that ilk that can provide an expedited timeout for nonacked dialogs. I would be happy to write such a patch. The reason I am bringing it up to the community is because I am uncertain as to whether this might have any unforeseen consequences, or whether it's been discussed in various dialog_ng discussions in the past that I have not carefully monitored. Thanks! -- Alex (With apologies for cross-posting.) [1] Or correctly associated based on tight matching. -- Alex Balashov - Principal Evariste Systems LLC 235 E Ponce de Leon Ave Suite 106 Decatur, GA 30030 United States Tel: +1-678-954-0670 Web: http://www.evaristesys.com/, http://www.alexbalashov.com/

2 1

permanent 1.5 s timer interval in module pipelimit
by Julia 28 Apr '14

28 Apr '14

Hello all, Timer pl_timer in pipelimit.c is defined as MS_TO_TICKS(1500) instead of timer_interval (in versions 3.3 - 4.1). I found a patch that solves the same problem in the ratelimit module: Module: sip-router Branch: 3.1 Commit: f027ca95a2a1818cd40e4ed6d4358a76d18252ad URL: <http://git.sip-router.org/cgi-bin/gitweb.cgi/sip-router/?a=commit;h=f027ca9 5a2a1818cd40e4ed6d4358a76d18252ad> http://git.sip-router.org/cgi-bin/gitweb.cgi/... Author: Marius Zbihlei Committer: Marius Zbihlei Date: Mon Apr 11 13:45:10 2011 +0300 modules/ratelimit Timer was ran at a 1.5 s interval instead of timer_interval, thus rendering TAILDROP alg unusable (cherry picked from commit 3a06d7d3561f889c84249eaa5ec7a5b79a2a23bd) Regards, Julia

2 1

kamctl not connect to dbserver
by Юрий Горличенко 28 Apr '14

28 Apr '14

Hello. I started configure Kamailio 3.3 server with mysql database, that running on the remote server. I customise settings at kamailio.cfg (for BDURL) and kamctlc file (for my db - changed user, password, dbhost and other settings, such as dbengine and etc.) Now, when I tried add new subscriber from kamctl util (kamctl add newuser@kamailioIP passwd). I see "access denied for <myuser>@<interface of kamailio server>", But as I aleady says I configured filew with other settings for db server. Where I must configure ip of dbhost to connect kamctl to my dbserver?

2 1

2025

2024

2023

2022

2021

2020

2019

2018

2017

2016

2015

2014

2013

2012

2011

2010

2009

2008

2007

2006

2005

2004

2003

2002

sr-users