[prev in list] [next in list] [prev in thread] [next in thread]
List: sr-users
Subject: Re: [SR-Users] Error with ACK from SIPML5
From: Tais Plougmann Hansen <taisph () osd ! dk>
Date: 2013-09-25 16:04:49
Message-ID: CALant3Dc62Lo1fsZVSymYJF5=s-N5AO2vYDoWXHePNNd=n4fnw () mail ! gmail ! com
[Download RAW message or body]
[Attachment #2 (multipart/alternative)]
I found out that when a subscriber has multiple contacts (ie. by stopping
and starting the WS client), kamailio either fails matching the connection
or matches the wrong one. Setting registrar max_contacts to 1 and using
save("location", "0x04") solved this problem for me.
On Wed, Sep 25, 2013 at 12:01 PM, Tais Plougmann Hansen <taisph@osd.dk>wrote:
> I am getting this error when trying to call from an ip phone -> kamailio
> -> freeswitch -> kamailio -> jssip. It looks like it can't match the
> invited subscriber to a WS connection. Calls from jssip to ip phone works
> (although it hangs up after 3-4 seconds for some reason).
>
>
> On Mon, Jun 24, 2013 at 5:11 PM, Daniel-Constantin Mierla <
> miconda@gmail.com> wrote:
>
> > Can you get the ngrep on the server from the initial invite to the ack.
> > It seems that record route is not properly mirrored, so one client might
> > mess the route path.
> >
> > Cheers,
> > Daniel
> >
> >
> > On 6/23/13 8:58 PM, Jayesh Nambiar wrote:
> >
> > I did do debug=3 and saw the logs but couldn't figure out much. Here is
> > the log for the appropriate ACK received on websocket port. I've
> > highlighted a few lines I felt might be problematic:
> >
> > DEBUG: <core> [tcp_read.c:1146]: ws_process_msg(): WebSocket Message:
> > [[>>>#012<81>þ#003ø #037<8a>õõT Çßo <85><84>, ô<84>. <9a><87>- \
> > <9a><8e>) <8c><8c>* <82><83>$þÆ×qùÄÙmþ<89>Ã{ú<94>åVÚ<9b><84>1 \
> > IãÕ<8c>?Ùýæ0 \
> > <9a><86>0Ýç<96>{ì<83>Ü~æ<86><85>sù<84>Ò1ãÚÀ~æÝÒ$èÆ×qéÜ<8b>e \
> > Üñ+èÿ<8e>pÛÓÔjçñ<86>iÛ<8c>äKûöä+ ú<8d>múÛÄk<87> ðmåÙ<8c>? \
> > þ×fïÇÞ= Çßo <85><86>/ <84><86>. \
> > <84><87>_íÜ×qþÝ<98>|åÙ<88>$þÕÑ" \
> > ñýVÙÿ÷~áòñ-Ûî<84>UüÄòP<87> âp <94><8a>lãÄ<8c>. \
> > <87><82>_íÜ×qþÝ<98>|åÙ<88>$þÕÑ" ö<85>Y <8c><81>T ÿÀzç \
> > \åÚÂ~éÀ<8c>? þ×fïÇÞ= Çßo <85><86>/ <84><86>. <84><87>_à \
> > �Ò<81>uëØ<84>,æÇ<86>{ ÝØiëØß{ \
> > ÆÂ|ýÑÔ2èÆÓ~áÑÄ"äÛ<8d>|æÝÕt ××sæ<89>Øp \
> > ÀÄ~äÇÆpøÀ<8b>hù<8a><8d>4í<9a>Ùrë<9a>Åvú<99>ßr \
> > <9f>Åvú<9a>ß|ï<8f>Ú~äÓÃ~íÑ<8b>=ïÚ<9a>yø<96> #025ÉÕÚs ýò% \
> > <86><87>/ ÕÔ' <99><80>& <82><9b>&è×<87>2 <86><8e>z Ö<87>'èÐ<8f>{ \
> > Ö<85>.é \ÙÑÇ% <80><8e>' õõT<87> õpäÀÓqþ<99>úzäÓÂw \
> > <94><86>#022<80>æÙjþÑ<8c>? Çßo <86><87>) <85><84>' <8c><80>1 \
> > <8e><83>/ <84><8d>sø<8f>ÅvúÙÚ* \
> > ÛÃkèÛÃqî<8f>ÂmëÚÅoåÆÂ"ÿÐÆ!<87> û~ò<99>ðpøÃ×mîÇ<8c>? \
> > <84> #025ÚÆÙgó<99>÷jþÜÙmãÎ×kãÛØ% ðßxïÇÂ?ÿÇÓmäÕÛz \
> > <96> <87>/ <84><86>/ <84><86>. <98>ÄzëØÛ" ÓÞ~äÀß1éÛÛ= \
> > ÚÙqéÑ<8b>=ß×Ò[ìØþWÛØúYÿÝþHÇ<84>ØI í<86>'þ ÐFÆÓÁV \
> > <98>Ãmã<89><94>lãÄ<8c>. <87><82>_ <85><80>1 <86><8e>1 <82><98>' \
> > <81><86>) <8f>ÂmëÚÅoåÆÂ"ÿÐÆ= ÆÓlúÛØlï<89><94>{é<82><85>~ \
> > <83><81>y <82><8e>{ <81>×& <8d>Ð)ëÕ<87>*ì<80>×z <82><83>= \
> > ÕÚxåÆßkâÙ<8b>RÎ<81> #025ØÛÃkï<8e><96>#ùÝÆ% <85><80>1 <86><8e>1 \
> > <82><98>& <8c><86>' <8f>ÂmëÚÅoåÆÂ"ýÇ<8d>m <89>Ùq \
> > ØÄ"åÚ<8d>yþÕÑ" ñýVÙÿ÷~áòñ-Ûî<84>UüÄòP Ú×k ÍÓl \
> > MåÁÂz <94><8a>lãÄ<8c>- <82><98>. <8c
> > > <98>' <9a><8f>$ø<86><8b>pä<8f>Úm ÛØ$ìÀ×x <83>óTÃçý^ëßðX \
> > > åì-ÀÂÆ[Å<8f>Ø~þ<89>Ïzù<8a> #025ßÇÓm \
> > > õÑzäÀ<8c>?Ãù<9b>|æÝÓqþ<9b>ùRË<85><98>/ ÇßoÇø<83>2ü<85><98>- \
> > > <85><85>1 <87><98>- PøÓ×qãÎ×kãÛØ% \
> > > ðÙjèÕØxå<94>âzæÑÕpç #022<80><<<]]
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > websocket [ws_frame.c:346]: decode_and_validate_ws_frame(): decoding
> > WebSocket frame
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > websocket [ws_frame.c:396]: decode_and_validate_ws_frame(): supported
> > non-control frame: 0x1
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > websocket [ws_frame.c:500]: decode_and_validate_ws_frame(): Rx (decoded):
> > ACK sip:1234@126.128.68.8:5065;transport=udp SIP/2.0#015#012Via:
> > SIP/2.0/WS
> > df7jal23ls0d.invalid;branch=z9hG4bK8oQgbumE0vQ8RTqBR44N;rport#015#012From:
> > "Jayesh"<sip:1000001001@ghanti.com>;tag=7EKISKAakFG2QZ2JvpDO#015#012To: <
> > sip:1234@ghanti.com>;tag=8B3F887K7Kvem#015#012Contact: "Jayesh"
> > <sip:1000001001@df7jal23ls0d.invalid;rtcweb-breaker=no;click2call=no;transport=ws>;+g.oma.sip-im;+sip.ice;language="en,fr"#015#012Call-ID:
> > 2104ab89-6956-9bc1-528e-b18bd9d4b31c#015#012CSeq: 488
> > ACK#015#012Content-Length: 0#015#012Route:
> > <sip:126.128.68.9:5060;lr;sipml5-outbound;transport=udp>#015#012Max-Forwards:
> > 70#015#012Proxy-Authorization: Digest username="1000001001",realm="
> > ghanti.com",nonce="UcdDflHHQlLFuiHWM0nV+Y08tTfYLgwI",uri=
> > "sip:1234@126.128.68.8:5065;transport=udp",response="dc63a077f468d55a949f6aa15f4ae665",algorithm=MD5#015#012Route:
> >
> > <sip:126.128.68.9:8080;transport=ws;r2=on;lr=on;ftag=7EKISKAakFG2QZ2JvpDO;nat=yes>#015#012Route:
> > <sip:126.128.68.9;r2=on;lr=on;ftag=7EKISKAakFG2QZ2JvpDO;nat=yes>#015#012User-Agent:
> > IM-client/OMA1.0 sipML5-v1.2013.03.27#015#012Organization: Doubango
> > Telecom#015#012#015#012
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > websocket [ws_frame.c:580]: ws_frame_receive(): Rx SIP message:#012ACK
> > sip:1234@126.128.68.8:5065;transport=udp SIP/2.0#015#012Via: SIP/2.0/WS
> > df7jal23ls0d.invalid;branch=z9hG4bK8oQgbumE0vQ8RTqBR44N;rport#015#012From:
> > "Jayesh"<sip:1000001001@ghanti.com>;tag=7EKISKAakFG2QZ2JvpDO#015#012To: <
> > sip:1234@ghanti.com>;tag=8B3F887K7Kvem#015#012Contact: "Jayesh"
> > <sip:1000001001@df7jal23ls0d.invalid;rtcweb-breaker=no;click2call=no;transport=ws>;+g.oma.sip-im;+sip.ice;language="en,fr"#015#012Call-ID:
> > 2104ab89-6956-9bc1-528e-b18bd9d4b31c#015#012CSeq: 488
> > ACK#015#012Content-Length: 0#015#012Route:
> > <sip:126.128.68.9≈:5060;lr;sipml5-outbound;transport=udp>#015#012Max-Forwards:
> > 70#015#012Proxy-Authorization: Digest username="1000001001",realm="
> > ghanti.com",nonce="UcdDflHHQlLFuiHWM0nV+Y08tTfYLgwI",uri=
> > "sip:1234@126.128.68.8:5065;transport=udp",response="dc63a077f468d55a949f6aa15f4ae665",algorithm=MD5#015#012Route:
> >
> > <sip:126.128.68.9:8080;transport=ws;r2=on;lr=on;ftag=7EKISKAakFG2QZ2JvpDO;nat=yes>#015#012Route:
> > <sip:126.128.68.9;r2=on;lr=on;ftag=7EKISKAakFG2QZ2JvpDO;nat=yes>#015#012User-Agent:
> > IM-client/OMA1.0 sipML5-v1.2013.03.27#015#012Organization: Doubango
> > Telecom#015#012#015#012
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [parser/msg_parser.c:623]: parse_msg(): SIP Request:
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [parser/msg_parser.c:625]: parse_msg(): method: <ACK>
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [parser/msg_parser.c:627]: parse_msg(): uri:
> > <sip:1234@126.128.68.8:5065;transport=udp>
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [parser/msg_parser.c:629]: parse_msg(): version: <SIP/2.0>
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 232,
> > <branch> = <z9hG4bK8oQgbumE0vQ8RTqBR44N>; state=6
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 235,
> > <rport> = <n/a>; state=17
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [parser/parse_via.c:2672]: parse_via(): end of header reached,
> > state=5
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [parser/msg_parser.c:513]: parse_headers(): parse_headers: Via
> > found, flags=2
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [parser/msg_parser.c:515]: parse_headers(): parse_headers: this is
> > the first via
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [receive.c:149]: receive_msg(): After parse_msg...
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [receive.c:190]: receive_msg(): preparing to run routing scripts...
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: sl
> > [sl_funcs.c:396]: sl_filter_ACK(): DEBUG : sl_filter_ACK: to late to be a
> > local ACK!
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [parser/parse_to.c:176]: parse_to_param(): DEBUG: add_param:
> > tag=8B3F887K7Kvem
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [parser/parse_to.c:799]: parse_to(): end of header reached, state=29
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [parser/msg_parser.c:190]: get_hdr_field(): DEBUG: get_hdr_field:
> > <To> [41]; uri=[sip:1234@ghanti.com]
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [parser/msg_parser.c:192]: get_hdr_field(): DEBUG: to body [<
> > sip:1234@ghanti.com>]
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [parser/msg_parser.c:170]: get_hdr_field(): get_hdr_field: cseq
> > <CSeq>: <488> <ACK>
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [parser/msg_parser.c:204]: get_hdr_field(): DEBUG: get_hdr_body :
> > content_length=0
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > maxfwd [mf_funcs.c:85]: is_maxfwd_present(): value = 70
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > maxfwd [maxfwd.c:161]: process_maxfwd_header(): value 70 decreased to 16
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [parser/msg_parser.c:106]: get_hdr_field(): found end of header
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [parser/parse_to.c:176]: parse_to_param(): DEBUG: add_param:
> > tag=7EKISKAakFG2QZ2JvpDO
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [parser/parse_to.c:799]: parse_to(): end of header reached, state=29
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > sanity [mod_sanity.c:255]: w_sanity_check(): sanity checks result: 1
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: INFO:
> > <script>: Request Method is ACK
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > nathelper [nathelper.c:888]: add_contact_alias_0_f(): contact uri host is
> > not an ip address
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > nathelper [nathelper.c:965]: add_contact_alias_0_f(): adding param
> > <;alias=203.153.53.166~59841~5>
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: INFO:
> > <script>: Inside NATDETECT
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > nathelper [nathelper.c:888]: add_contact_alias_0_f(): contact uri host is
> > not an ip address
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > nathelper [nathelper.c:965]: add_contact_alias_0_f(): adding param
> > <;alias=203.153.53.166~59841~5>
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > siputils [checks.c:106]: has_totag(): totag found
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: rr
> > [loose.c:89]: is_preloaded(): is_preloaded: No
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [socket_info.c:589]: grep_sock_info(): grep_sock_info - checking if
> > host==us: 12==12 && [126.128.68.8] == [126.128.68.9]
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [socket_info.c:593]: grep_sock_info(): grep_sock_info - checking if
> > port 5060 (advertise 0) matches port 5065
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [socket_info.c:589]: grep_sock_info(): grep_sock_info - checking if
> > host==us: 12==12 && [126.128.68.8] == [126.128.68.9]
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [socket_info.c:593]: grep_sock_info(): grep_sock_info - checking if
> > port 5060 (advertise 0) matches port 5065
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [socket_info.c:589]: grep_sock_info(): grep_sock_info - checking if
> > host==us: 12==12 && [126.128.68.8] == [126.128.68.9]
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [socket_info.c:593]: grep_sock_info(): grep_sock_info - checking if
> > port 8080 (advertise 0) matches port 5065
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [forward.c:462]: check_self(): check_self: host != me
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [socket_info.c:589]: grep_sock_info(): grep_sock_info - checking if
> > host==us: 12==12 && [126.128.68.9] == [126.128.68.9]
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [socket_info.c:593]: grep_sock_info(): grep_sock_info - checking if
> > port 5060 (advertise 0) matches port 5060
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: rr
> > [loose.c:778]: after_loose(): Topmost route URI: '
> > sip:126.128.68.9:5060;lr;sipml5-outbound;transport=udp' is me
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: rr
> > [loose.c:862]: after_loose(): URI to be processed: '
> > sip:126.128.68.9:8080;transport=ws;r2=on;lr=on;ftag=7EKISKAakFG2QZ2JvpDO;nat=yes
> > '
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: rr
> > [loose.c:871]: after_loose(): Next URI is a loose router
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > siputils [checks.c:106]: has_totag(): totag found
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: rr
> > [loose.c:974]: check_route_param(): params are
> > <;lr;sipml5-outbound;transport=udp>
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: INFO:
> > <script>: Inside Natmanage ACK
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > siputils [checks.c:106]: has_totag(): totag found
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: tm
> > [t_lookup.c:1395]: t_newtran(): DEBUG: t_newtran: msg id=8 , global msg
> > id=7 , T on entrance=(nil)
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: tm
> > [t_lookup.c:534]: t_lookup_request(): t_lookup_request: start searching:
> > hash=60000, isACK=1
> > un 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: tm
> > [t_lookup.c:492]: matching_3261(): *DEBUG: RFC3261 transaction matching
> > failed*
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: tm
> > [t_lookup.c:716]: t_lookup_request(): *DEBUG: t_lookup_request: no
> > transaction found*
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: tm
> > [t_funcs.c:311]: t_relay_to(): SER: forwarding ACK statelessly
> > *Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: WARNING:
> > <core> [msg_translator.c:2499]: via_builder(): TCP/TLS connection (id: 0)
> > for WebSocket could not be found*
> > *Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: ERROR:
> > <core> [msg_translator.c:1725]: build_req_buf_from_sip_req(): could not
> > create Via header*
> > *Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: ERROR:
> > <core> [forward.c:607]: forward_request(): ERROR: forward_request: building
> > failed*
> > *Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: ERROR: sl
> > [sl_funcs.c:371]: sl_reply_error(): ERROR: sl_reply_error used: I'm
> > terribly sorry, server error occurred (1/SL)*
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [usr_avp.c:644]: destroy_avp_list(): DEBUG:destroy_avp_list:
> > destroying list (nil)
> > Jun 23 18:45:46 /usr/local/ghanti-ko/sbin/kamailio[22879]: last message
> > repeated 5 times
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [xavp.c:447]: xavp_destroy_list(): destroying xavp list (nil)
> > Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
> > <core> [receive.c:293]: receive_msg(): receive_msg: cleaning up
> >
> > Thanks for all the help.
> >
> > --- Jayesh
> >
> >
> > On Sun, Jun 23, 2013 at 8:53 PM, Daniel-Constantin Mierla <
> > miconda@gmail.com> wrote:
> >
> > > Are you sure the error messages are printed for this ACK, because it
> > > has to be sent via UDP, not via WS, thus the messages seem to be unrelated.
> > >
> > > Get the log messages with debug=3 in order to see what is happening.
> > >
> > > Cheers,
> > > Daniel
> > >
> > >
> > > On 6/22/13 9:10 AM, Jayesh Nambiar wrote:
> > >
> > > Hi,
> > > Is it possible that this could be a problem in the script. But when I
> > > call using a normal SIP Client like X-Lite, it works well. This only
> > > happens when the request comes on websocket. Is there something to be
> > > handled specially when handling requests like ACK over websocket?
> > > The reference is more or less taken from
> > > https://gist.github.com/jesusprubio/4066845
> > >
> > > --- Jayesh
> > >
> > >
> > > On Wed, Jun 19, 2013 at 2:14 PM, Jayesh Nambiar <jayesh1017@gmail.com>wrote:
> > >
> > > > Hi Daniel,
> > > > I checked using the kamcmd command and I see the webrtc connection
> > > > active. The ACK comes from the webrtc client but somehow kamailio is unable
> > > > to create a via header and forward the request. The ACK coming from webrtc
> > > > client is as follows:
> > > >
> > > > SEND: ACK sip:1223@126.128.68.8:5065;transport=udp SIP/2.0
> > > > Via: SIP/2.0/WS
> > > > df7jal23ls0d.invalid;branch=z9hG4bKJ0Qsiuh94B2slPLp19qH;rport
> > > > From: "Jayesh"<sip:1000001001@ghanti.com>;tag=vsTKsfB1ZR8EkHTPqzyc
> > > > To: <sip:1223@ghanti.com>;tag=UQ9veX0vUg7QS
> > > > Contact: "Jayesh"
> > > > <sip:1000001001@df7jal23ls0d.invalid;rtcweb-breaker=no;click2call=no;transport=ws>
> > > > ;+g.oma.sip-im;+sip.ice;language="en,fr"
> > > > Call-ID: 2c76d5ee-e9d0-7f22-8be2-76e80b4ab48b
> > > > CSeq: 42684 ACK
> > > > Content-Length: 0
> > > > Route: <sip:126.128.68.9:5060;lr;sipml5-outbound;transport=udp>
> > > > Max-Forwards: 70
> > > > Proxy-Authorization: Digest username="1000001001",realm="ghanti.com
> > > > ",nonce="UcFsQ1HBaxc84k4N1J00fpVDj9G57x5p",uri=
> > > > "sip:1223@126.128.68.8:5065;transport=udp"
> > > > ,response="5b18a2182c335315875224f2244fb48b",algorithm=MD5
> > > > Route:
> > > > <sip:126.128.68.9:8080;transport=ws;r2=on;lr=on;ftag=vsTKsfB1ZR8EkHTPqzyc;nat=yes>
> > > >
> > > > Route: <sip:126.128.68.9;r2=on;lr=on;ftag=vsTKsfB1ZR8EkHTPqzyc;nat=yes>
> > > > User-Agent: IM-client/OMA1.0 sipML5-v1.2013.03.27
> > > > Organization: Doubango Telecom
> > > >
> > > > Where 126.128.68.9:5060 is the Kamailio; 126.128.68.8:5065 is a
> > > > freeswitch playing music and the request is received on
> > > > 126.128.68.9:8080 which is kamailio acting as a websocket server.
> > > > Also the connection between Kamailio and Freeswitch is UDP. I am not
> > > > able to use the websocket module just because of this small problem caused
> > > > in signaling. Any help is really appreciated. Could it be related to the
> > > > nathelper module?
> > > >
> > > > Thanks,
> > > >
> > > > --- Jayesh
> > > >
> > > >
> > > > On Tue, Jun 18, 2013 at 2:17 PM, Daniel-Constantin Mierla <
> > > > miconda@gmail.com> wrote:
> > > >
> > > > > Hello,
> > > > >
> > > > >
> > > > > On 6/14/13 4:52 PM, Jayesh Nambiar wrote:
> > > > >
> > > > > Hello All,
> > > > > I have a setup which is SIPML5 -> Kamailio(Websocket) -> Freeswitch.
> > > > > All I am trying to do is initiate a call from SIPML5 and Play a Music file
> > > > > from freeswitch. This works, but the call hangs up after 30 seconds due to
> > > > > ACK timeout from from the SIPML5.
> > > > >
> > > > > What I can see is the SIPML5 from Chrome does send an ACK on
> > > > > websocket, but I see the following error in kamailio syslog:
> > > > >
> > > > > *via_builder(): TCP/TLS connection (id: 0) for WebSocket could not
> > > > > be found*
> > > > > *ERROR: <core> [msg_translator.c:1725]: build_req_buf_from_sip_req():
> > > > > could not create Via header*
> > > > > *ERROR: <core> [forward.c:607]: forward_request(): ERROR:
> > > > > forward_request: building failed*
> > > > > *ERROR: sl [sl_funcs.c:371]: sl_reply_error(): ERROR: sl_reply_error
> > > > > used: I'm terribly sorry, server error occurred (1/SL)*
> > > > >
> > > > > Can someone help me understand what I am missing here and why
> > > > > kamailio is not able to create a VIA header to forward this request towards
> > > > > freeswitch. I have built a simple config file by following
> > > > > https://gist.github.com/jesusprubio/4066845 as reference.
> > > > >
> > > > > Any help in understanding this is really appreciated.
> > > > >
> > > > > looks like the web rtc connection was down (closed by one side or
> > > > > interrupted by the network). You can check with kamcmd the list of active
> > > > > connections.
> > > > >
> > > > > Cheers,
> > > > > Daniel
> > > > >
> > > > > --
> > > > > Daniel-Constantin Mierla - \
> > > > > http://www.asipto.comhttp://twitter.com/#!/miconda - \
> > > > > http://www.linkedin.com/in/miconda Kamailio Advanced Training, San \
> > > > > Francisco, USA - June 24-27, 2013
> > > > > * http://asipto.com/u/katu *
> > > > >
> > > > >
> > > > > _______________________________________________
> > > > > SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list
> > > > > sr-users@lists.sip-router.org
> > > > > http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
> > > > >
> > > > >
> > > >
> > >
> > > --
> > > Daniel-Constantin Mierla - http://www.asipto.comhttp://twitter.com/#!/miconda - \
> > > http://www.linkedin.com/in/miconda
> > >
> >
> > --
> > Daniel-Constantin Mierla - http://www.asipto.comhttp://twitter.com/#!/miconda - \
> > http://www.linkedin.com/in/miconda
> >
> > _______________________________________________
> > SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list
> > sr-users@lists.sip-router.org
> > http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
> >
> >
>
>
> --
> Tais Plougmann Hansen
>
> OSD Consulting ApS
> osd.dk
> Tel: +45 78101078
> CVR: DK31332737
>
--
Tais Plougmann Hansen
OSD Consulting ApS
osd.dk
Tel: +45 78101078
CVR: DK31332737
[Attachment #5 (text/html)]
<div dir="ltr">I found out that when a subscriber has multiple contacts (ie. by \
stopping and starting the WS client), kamailio either fails matching the connection \
or matches the wrong one. Setting registrar max_contacts to 1 and using \
save("location", "0x04") solved this problem for me.</div>
<div class="gmail_extra"><br><br><div class="gmail_quote">On Wed, Sep 25, 2013 at \
12:01 PM, Tais Plougmann Hansen <span dir="ltr"><<a href="mailto:taisph@osd.dk" \
target="_blank">taisph@osd.dk</a>></span> wrote:<br> <blockquote \
class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc \
solid;padding-left:1ex"> <div dir="ltr">I am getting this error when trying to call \
from an ip phone -> kamailio -> freeswitch -> kamailio -> jssip. It looks \
like it can't match the invited subscriber to a WS connection. Calls from jssip \
to ip phone works (although it hangs up after 3-4 seconds for some reason).</div>
<div class="gmail_extra"><div><div class="h5"><br><br><div class="gmail_quote">On \
Mon, Jun 24, 2013 at 5:11 PM, Daniel-Constantin Mierla <span dir="ltr"><<a \
href="mailto:miconda@gmail.com" target="_blank">miconda@gmail.com</a>></span> \
wrote:<br>
<blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc \
solid;padding-left:1ex">
<div bgcolor="#FFFFFF" text="#000000">
Can you get the ngrep on the server from the initial invite to the
ack. It seems that record route is not properly mirrored, so one
client might mess the route path.<br>
<br>
Cheers,<br>
Daniel<div><br>
<br>
<div>On 6/23/13 8:58 PM, Jayesh Nambiar
wrote:<br>
</div>
</div><blockquote type="cite">
<div dir="ltr"><div>I did do debug=3 and saw the logs but couldn't
figure out much. Here is the log for the appropriate ACK
received on websocket port. I've highlighted a few lines I felt
might be problematic:
<div><br>
</div>
</div><div>
<div>DEBUG: <core> [tcp_read.c:1146]: ws_process_msg():
WebSocket Message:
[[>>>#012<81>þ#003ø #037<8a>õõT Çßo \
<85><84>, ô<84>. <9a><87>- <9a><8e>) \
<8c><8c>* \
<82><83>$þÆ×qùÄÙmþ<89>Ã{ú<94>åVÚ<9b><84>1 \
IãÕ<8c>?Ùýæ0 \
<9a><86>0Ýç<96>{ì<83>Ü~æ<86><85>sù<84>Ò1ãÚÀ~æÝÒ$èÆ×qéÜ<8b>e \
Üñ+èÿ<8e>pÛÓÔjçñ<86>iÛ<8c>äKûöä+ \
ú<8d>múÛÄk<87> ðmåÙ<8c>? þ×fïÇÞ= Çßo \
<85><86>/ <84><86>. \
<84><87>_íÜ×qþÝ<98>|åÙ<88>$þÕÑ" \
ñýVÙÿ÷~áòñ-Ûî<84>UüÄòP<87> âp \
<94><8a>lãÄ<8c>. \
<87><82>_íÜ×qþÝ<98>|åÙ<88>$þÕÑ" \
ö<85>Y <8c><81>T ÿÀzç \åÚÂ~éÀ<8c>? \
þ×fïÇÞ= Çßo <85><86>/ <84><86>. \
<84><87>_à �Ò<81>uëØ<84>,æÇ<86>{ ÝØiëØß{ \
ÆÂ|ýÑÔ2èÆÓ~áÑÄ"äÛ<8d>|æÝÕt ××sæ<89>Øp \
ÀÄ~äÇÆpøÀ<8b>hù<8a><8d>4í<9a>Ùrë<9a>Åvú<99>ßr \
<9f>Åvú<9a>ß|ï<8f>Ú~äÓÃ~íÑ<8b>=ïÚ<9a>yø<96> \
#025ÉÕÚs ýò% <86><87>/ ÕÔ' <99><80>& \
<82><9b>&è×<87>2 <86><8e>z \
Ö<87>'èÐ<8f>{ Ö<85>.é \ÙÑÇ% \
<80><8e>' õõT<87> õpäÀÓqþ<99>úzäÓÂw \
<94><86>#022<80>æÙjþÑ<8c>? Çßo <86><87>) \
<85><84>' <8c><80>1 <8e><83>/ \
<84><8d>sø<8f>ÅvúÙÚ* \
ÛÃkèÛÃqî<8f>ÂmëÚÅoåÆÂ"ÿÐÆ!<87> \
û~ò<99>ðpøÃ×mîÇ<8c>? <84> \
#025ÚÆÙgó<99>÷jþÜÙmãÎ×kãÛØ% ðßxïÇÂ?ÿÇÓmäÕÛz \
<96> <87>/ <84><86>/ <84><86>. \
<98>ÄzëØÛ" ÓÞ~äÀß1éÛÛ= \
ÚÙqéÑ<8b>=ß×Ò[ìØþWÛØúYÿÝþHÇ<84>ØI \
í<86>'þ ÐFÆÓÁV <98>Ãmã<89><94>lãÄ<8c>. \
<87><82>_ <85><80>1 <86><8e>1 \
<82><98>' <81><86>) \
<8f>ÂmëÚÅoåÆÂ"ÿÐÆ= \
ÆÓlúÛØlï<89><94>{é<82><85>~ <83><81>y \
<82><8e>{ <81>×& \
<8d>Ð)ëÕ<87>*ì<80>×z <82><83>= \
ÕÚxåÆßkâÙ<8b>RÎ<81> #025ØÛÃkï<8e><96>#ùÝÆ% \
<85><80>1 <86><8e>1 <82><98>& \
<8c><86>' <8f>ÂmëÚÅoåÆÂ"ýÇ<8d>m \
<89>Ùq ØÄ"åÚ<8d>yþÕÑ" \
ñýVÙÿ÷~áòñ-Ûî<84>UüÄòP Ú×k ÍÓl MåÁÂz \
<94><8a>lãÄ<8c>- <82><98>. <8c \
><98>' <9a><8f>$ø<86><8b>pä<8f>Úm \
ÛØ$ìÀ×x <83>óTÃçý^ëßðX \
åì-ÀÂÆ[Å<8f>Ø~þ<89>Ïzù<8a> #025ßÇÓm \
õÑzäÀ<8c>?Ãù<9b>|æÝÓqþ<9b>ùRË<85><98>/ \
ÇßoÇø<83>2ü<85><98>- <85><85>1 \
<87><98>- PøÓ×qãÎ×kãÛØ% \
ðÙjèÕØxå<94>âzæÑÕpç #022<80><<<]]</div>
<div><div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: websocket
[ws_frame.c:346]: decode_and_validate_ws_frame(): decoding
WebSocket frame</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: websocket
[ws_frame.c:396]: decode_and_validate_ws_frame(): supported
non-control frame: 0x1</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: websocket
[ws_frame.c:500]: decode_and_validate_ws_frame(): Rx
(decoded): ACK <a>sip:1234@126.128.68.8:5065;transport=udp</a>
SIP/2.0#015#012Via: SIP/2.0/WS
df7jal23ls0d.invalid;branch=z9hG4bK8oQgbumE0vQ8RTqBR44N;rport#015#012From:
"Jayesh"<<a href="mailto:sip%3A1000001001@ghanti.com" \
target="_blank">sip:1000001001@ghanti.com</a>>;tag=7EKISKAakFG2QZ2JvpDO#015#012To:
<<a href="mailto:sip%3A1234@ghanti.com" \
target="_blank">sip:1234@ghanti.com</a>>;tag=8B3F887K7Kvem#015#012Contact: \
"Jayesh"<a><sip:1000001001@df7jal23ls0d.invalid;rtcweb-breaker=no;click2c \
all=no;transport=ws></a>;+g.oma.sip-im;+sip.ice;language="en,fr"#015#012Call-ID:
2104ab89-6956-9bc1-528e-b18bd9d4b31c#015#012CSeq: 488
ACK#015#012Content-Length: 0#015#012Route:
<a><sip:126.128.68.9:5060;lr;sipml5-outbound;transport=udp></a>#015#012Max-Forwards:
70#015#012Proxy-Authorization: Digest
username="1000001001",realm="<a href="http://ghanti.com" \
target="_blank">ghanti.com</a>",nonce="UcdDflHHQlLFuiHWM0nV+Y08tTfYLgwI" \
;,uri=<a>"sip:1234@126.128.68.8:5065;transport=udp"</a>,response="dc63a077f468d55a949f6aa15f4ae665",algorithm=MD5#015#012Route:
<a><sip:126.128.68.9:8080;transport=ws;r2=on;lr=on;ftag=7EKISKAakFG2QZ2JvpDO;nat=yes></a>#015#012Route:
<a><sip:126.128.68.9;r2=on;lr=on;ftag=7EKISKAakFG2QZ2JvpDO;nat=yes></a>#015#012User-Agent:
IM-client/OMA1.0 sipML5-v1.2013.03.27#015#012Organization:
Doubango Telecom#015#012#015#012</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: websocket
[ws_frame.c:580]: ws_frame_receive(): Rx SIP <a>message:#012ACK</a>
<a>sip:1234@126.128.68.8:5065;transport=udp</a> SIP/2.0#015#012Via:
SIP/2.0/WS
df7jal23ls0d.invalid;branch=z9hG4bK8oQgbumE0vQ8RTqBR44N;rport#015#012From:
"Jayesh"<<a href="mailto:sip%3A1000001001@ghanti.com" \
target="_blank">sip:1000001001@ghanti.com</a>>;tag=7EKISKAakFG2QZ2JvpDO#015#012To:
<<a href="mailto:sip%3A1234@ghanti.com" \
target="_blank">sip:1234@ghanti.com</a>>;tag=8B3F887K7Kvem#015#012Contact: \
"Jayesh"<a><sip:1000001001@df7jal23ls0d.invalid;rtcweb-breaker=no;click2c \
all=no;transport=ws></a>;+g.oma.sip-im;+sip.ice;language="en,fr"#015#012Call-ID:
2104ab89-6956-9bc1-528e-b18bd9d4b31c#015#012CSeq: 488
ACK#015#012Content-Length: 0#015#012Route:
<a><sip:126.128.68.9≈:5060;lr;sipml5-outbound;transport=udp></a>#015#012Max-Forwards:
70#015#012Proxy-Authorization: Digest
username="1000001001",realm="<a href="http://ghanti.com" \
target="_blank">ghanti.com</a>",nonce="UcdDflHHQlLFuiHWM0nV+Y08tTfYLgwI" \
;,uri=<a>"sip:1234@126.128.68.8:5065;transport=udp"</a>,response="dc63a077f468d55a949f6aa15f4ae665",algorithm=MD5#015#012Route:
<a><sip:126.128.68.9:8080;transport=ws;r2=on;lr=on;ftag=7EKISKAakFG2QZ2JvpDO;nat=yes></a>#015#012Route:
<a><sip:126.128.68.9;r2=on;lr=on;ftag=7EKISKAakFG2QZ2JvpDO;nat=yes></a>#015#012User-Agent:
IM-client/OMA1.0 sipML5-v1.2013.03.27#015#012Organization:
Doubango Telecom#015#012#015#012</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [parser/msg_parser.c:623]: parse_msg(): SIP
Request:</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [parser/msg_parser.c:625]: parse_msg():
method: <ACK></div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [parser/msg_parser.c:627]: parse_msg(): uri:
<a><sip:1234@126.128.68.8:5065;transport=udp></a></div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [parser/msg_parser.c:629]: parse_msg():
version: <SIP/2.0></div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [parser/parse_via.c:1284]: parse_via_param():
Found param type 232, <branch> =
<z9hG4bK8oQgbumE0vQ8RTqBR44N>; state=6</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [parser/parse_via.c:1284]: parse_via_param():
Found param type 235, <rport> = <n/a>; state=17</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [parser/parse_via.c:2672]: parse_via(): end of
header reached, state=5</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [parser/msg_parser.c:513]: parse_headers():
parse_headers: Via found, flags=2</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [parser/msg_parser.c:515]: parse_headers():
parse_headers: this is the first via</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [receive.c:149]: receive_msg(): After
parse_msg...</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [receive.c:190]: receive_msg(): preparing to
run routing scripts...</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: sl
[sl_funcs.c:396]: sl_filter_ACK(): DEBUG : sl_filter_ACK: to
late to be a local ACK!</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [parser/parse_to.c:176]: parse_to_param():
DEBUG: add_param: tag=8B3F887K7Kvem</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [parser/parse_to.c:799]: parse_to(): end of
header reached, state=29</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [parser/msg_parser.c:190]: get_hdr_field():
DEBUG: get_hdr_field: <To> [41]; uri=[<a \
href="mailto:sip%3A1234@ghanti.com" target="_blank">sip:1234@ghanti.com</a>]</div> \
<div>Jun 23 18:45:46 v9 /usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [parser/msg_parser.c:192]: get_hdr_field():
DEBUG: to body [<<a href="mailto:sip%3A1234@ghanti.com" \
target="_blank">sip:1234@ghanti.com</a>>]</div> <div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [parser/msg_parser.c:170]: get_hdr_field():
get_hdr_field: cseq <CSeq>: <488> <ACK></div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [parser/msg_parser.c:204]: get_hdr_field():
DEBUG: get_hdr_body : content_length=0</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: maxfwd
[mf_funcs.c:85]: is_maxfwd_present(): value = 70</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: maxfwd
[maxfwd.c:161]: process_maxfwd_header(): value 70 decreased
to 16</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [parser/msg_parser.c:106]: get_hdr_field():
found end of header</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [parser/parse_to.c:176]: parse_to_param():
DEBUG: add_param: tag=7EKISKAakFG2QZ2JvpDO</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [parser/parse_to.c:799]: parse_to(): end of
header reached, state=29</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: sanity
[mod_sanity.c:255]: w_sanity_check(): sanity checks result:
1</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: INFO:
<script>: Request Method is ACK</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: nathelper
[nathelper.c:888]: add_contact_alias_0_f(): contact uri host
is not an ip address</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: nathelper
[nathelper.c:965]: add_contact_alias_0_f(): adding param
<;alias=203.153.53.166~59841~5></div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: INFO:
<script>: Inside NATDETECT</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: nathelper
[nathelper.c:888]: add_contact_alias_0_f(): contact uri host
is not an ip address</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: nathelper
[nathelper.c:965]: add_contact_alias_0_f(): adding param
<;alias=203.153.53.166~59841~5></div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: siputils
[checks.c:106]: has_totag(): totag found</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: rr
[loose.c:89]: is_preloaded(): is_preloaded: No</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [socket_info.c:589]: grep_sock_info():
grep_sock_info - checking if host==us: 12==12 &&
[126.128.68.8] == [126.128.68.9]</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [socket_info.c:593]: grep_sock_info():
grep_sock_info - checking if port 5060 (advertise 0) matches
port 5065</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [socket_info.c:589]: grep_sock_info():
grep_sock_info - checking if host==us: 12==12 &&
[126.128.68.8] == [126.128.68.9]</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [socket_info.c:593]: grep_sock_info():
grep_sock_info - checking if port 5060 (advertise 0) matches
port 5065</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [socket_info.c:589]: grep_sock_info():
grep_sock_info - checking if host==us: 12==12 &&
[126.128.68.8] == [126.128.68.9]</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [socket_info.c:593]: grep_sock_info():
grep_sock_info - checking if port 8080 (advertise 0) matches
port 5065</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [forward.c:462]: check_self(): check_self: host
!= me</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [socket_info.c:589]: grep_sock_info():
grep_sock_info - checking if host==us: 12==12 &&
[126.128.68.9] == [126.128.68.9]</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [socket_info.c:593]: grep_sock_info():
grep_sock_info - checking if port 5060 (advertise 0) matches
port 5060</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: rr
[loose.c:778]: after_loose(): Topmost route URI:
'<a>sip:126.128.68.9:5060;lr;sipml5-outbound;transport=udp</a>' \
is me</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: rr
[loose.c:862]: after_loose(): URI to be processed:
'<a>sip:126.128.68.9:8080;transport=ws;r2=on;lr=on;ftag=7EKISKAakFG2QZ2JvpDO;nat=yes</a>'</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: rr
[loose.c:871]: after_loose(): Next URI is a loose router</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: siputils
[checks.c:106]: has_totag(): totag found</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: rr
[loose.c:974]: check_route_param(): params are
<;lr;sipml5-outbound;transport=udp></div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: INFO:
<script>: Inside Natmanage ACK</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: siputils
[checks.c:106]: has_totag(): totag found</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: tm
[t_lookup.c:1395]: t_newtran(): DEBUG: t_newtran: msg id=8 ,
global msg id=7 , T on entrance=(nil)</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: tm
[t_lookup.c:534]: t_lookup_request(): t_lookup_request:
start searching: hash=60000, isACK=1</div>
<div>un 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: tm
[t_lookup.c:492]: matching_3261(): <b>DEBUG: RFC3261
transaction matching failed</b></div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: tm
[t_lookup.c:716]: t_lookup_request(): <b>DEBUG:
t_lookup_request: no transaction found</b></div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG: tm
[t_funcs.c:311]: t_relay_to(): SER: forwarding ACK
statelessly</div>
<div><b>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: WARNING:
<core> [msg_translator.c:2499]: via_builder():
TCP/TLS connection (id: 0) for WebSocket could not be
found</b></div>
<div><b>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: ERROR:
<core> [msg_translator.c:1725]:
build_req_buf_from_sip_req(): could not create Via header</b></div>
<div><b>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: ERROR:
<core> [forward.c:607]: forward_request(): ERROR:
forward_request: building failed</b></div>
<div><b>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: ERROR: sl
[sl_funcs.c:371]: sl_reply_error(): ERROR: sl_reply_error
used: I'm terribly sorry, server error occurred (1/SL)</b></div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [usr_avp.c:644]: destroy_avp_list():
DEBUG:destroy_avp_list: destroying list (nil)</div>
<div>Jun 23 18:45:46
/usr/local/ghanti-ko/sbin/kamailio[22879]: last message
repeated 5 times</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [xavp.c:447]: xavp_destroy_list(): destroying
xavp list (nil)</div>
<div>Jun 23 18:45:46 v9
/usr/local/ghanti-ko/sbin/kamailio[22879]: DEBUG:
<core> [receive.c:293]: receive_msg(): receive_msg:
cleaning up</div>
</div></div></div><div><div>
<div><br>
</div>
<div>Thanks for all the help.</div>
<div><br>
</div>
<div>--- Jayesh</div>
</div></div></div><div><div>
<div class="gmail_extra"><br>
<br>
<div class="gmail_quote">On Sun, Jun 23, 2013 at 8:53 PM,
Daniel-Constantin Mierla <span dir="ltr"><<a \
href="mailto:miconda@gmail.com" target="_blank">miconda@gmail.com</a>></span> \
wrote:<br>
<blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px \
#ccc solid;padding-left:1ex"> <div bgcolor="#FFFFFF" text="#000000"> Are you sure \
the error messages are printed for this ACK, because it has to
be sent via UDP, not via WS, thus the messages seem to be
unrelated.<br>
<br>
Get the log messages with debug=3 in order to see what is
happening.<br>
<br>
Cheers,<br>
Daniel
<div>
<div><br>
<br>
<div>On 6/22/13 9:10 AM, Jayesh Nambiar wrote:<br>
</div>
<blockquote type="cite">
<div dir="ltr">Hi,
<div>Is it possible that this could be a problem
in the script. But when I call using a normal
SIP Client like X-Lite, it works well. This only
happens when the request comes on websocket. Is
there something to be handled specially when
handling requests like ACK over websocket?</div>
<div>The reference is more or less taken from <a \
href="https://gist.github.com/jesusprubio/4066845" \
target="_blank">https://gist.github.com/jesusprubio/4066845</a></div> <div><br>
</div>
<div>--- Jayesh</div>
</div>
<div class="gmail_extra"> <br>
<br>
<div class="gmail_quote">On Wed, Jun 19, 2013 at
2:14 PM, Jayesh Nambiar <span dir="ltr"><<a \
href="mailto:jayesh1017@gmail.com" \
target="_blank">jayesh1017@gmail.com</a>></span> wrote:<br>
<blockquote class="gmail_quote" style="margin:0 0 0 \
.8ex;border-left:1px #ccc solid;padding-left:1ex"> <div dir="ltr">Hi Daniel,
<div>I checked using the kamcmd command and
I see the webrtc connection active. The
ACK comes from the webrtc client but
somehow kamailio is unable to create a via
header and forward the request. The ACK
coming from webrtc client is as follows:</div>
<div><br>
</div>
<div>
<div>SEND: ACK \
<a>sip:1223@126.128.68.8:5065;transport=udp</a> SIP/2.0</div>
<div>Via: SIP/2.0/WS
\
df7jal23ls0d.invalid;branch=z9hG4bKJ0Qsiuh94B2slPLp19qH;rport</div> <div>From: \
"Jayesh"<<a href="mailto:sip%3A1000001001@ghanti.com" \
target="_blank">sip:1000001001@ghanti.com</a>>;tag=vsTKsfB1ZR8EkHTPqzyc</div>
<div>To: <<a href="mailto:sip%3A1223@ghanti.com" \
target="_blank">sip:1223@ghanti.com</a>>;tag=UQ9veX0vUg7QS</div> <div>Contact:
\
"Jayesh"<a><sip:1000001001@df7jal23ls0d.invalid;rtcweb-breaker=no;click2c \
all=no;transport=ws></a>;+g.oma.sip-im;+sip.ice;language="en,fr"</div> \
<div>Call-ID: 2c76d5ee-e9d0-7f22-8be2-76e80b4ab48b</div>
<div>CSeq: 42684 ACK</div>
<div>Content-Length: 0</div>
<div>Route: \
<a><sip:126.128.68.9:5060;lr;sipml5-outbound;transport=udp></a></div> \
<div>Max-Forwards: 70</div> <div> Proxy-Authorization: Digest
username="1000001001",realm="<a \
href="http://ghanti.com" \
target="_blank">ghanti.com</a>",nonce="UcFsQ1HBaxc84k4N1J00fpVDj9G57x5p" \
;,uri=<a>"sip:1223@126.128.68.8:5065;transport=udp"</a>,response="5b18a2182c335315875224f2244fb48b",algorithm=MD5</div>
<div>Route:
\
<a><sip:126.128.68.9:8080;transport=ws;r2=on;lr=on;ftag=vsTKsfB1ZR8EkHTPqzyc;nat=yes></a></div>
<div>Route: \
<a><sip:126.128.68.9;r2=on;lr=on;ftag=vsTKsfB1ZR8EkHTPqzyc;nat=yes></a></div> \
<div>User-Agent: IM-client/OMA1.0 sipML5-v1.2013.03.27</div>
<div>Organization: Doubango Telecom</div>
<div><br>
</div>
<div>Where <a href="http://126.128.68.9:5060" \
target="_blank">126.128.68.9:5060</a>
is the Kamailio; <a href="http://126.128.68.8:5065" \
target="_blank">126.128.68.8:5065</a> is a freeswitch playing music and the
request is received on <a \
href="http://126.128.68.9:8080" target="_blank">126.128.68.9:8080</a> which is \
kamailio acting as a websocket server.</div>
<div>Also the connection between Kamailio
and Freeswitch is UDP. I am not able to
use the websocket module just because of
this small problem caused in signaling.
Any help is really appreciated. Could it
be related to the nathelper module?</div>
<div><br>
</div>
<div>Thanks,</div>
<div><br>
</div>
<div>--- Jayesh</div>
</div>
</div>
<div class="gmail_extra"><br>
<br>
<div class="gmail_quote">
<div>
<div>On Tue, Jun 18, 2013 at 2:17 PM,
Daniel-Constantin Mierla <span dir="ltr"><<a \
href="mailto:miconda@gmail.com" target="_blank">miconda@gmail.com</a>></span> \
wrote:<br> </div>
</div>
<blockquote class="gmail_quote" style="margin:0 0 0 \
.8ex;border-left:1px #ccc solid;padding-left:1ex"> <div>
<div>
<div text="#000000" bgcolor="#FFFFFF"> Hello,
<div>
<div><br>
<br>
<div>On 6/14/13 4:52 PM,
Jayesh Nambiar wrote:<br>
</div>
<blockquote type="cite">
<div dir="ltr">
<div>Hello All,</div>
<div>I have a setup which
is SIPML5 ->
Kamailio(Websocket)
-> Freeswitch. All I
am trying to do is
initiate a call from
SIPML5 and Play a Music
file from freeswitch.
This works, but the call
hangs up after 30
seconds due to ACK
timeout from from the
SIPML5.</div>
<div><br>
</div>
<div>What I can see is the
SIPML5 from Chrome does
send an ACK on
websocket, but I see the
following error in
kamailio syslog:</div>
<div><br>
</div>
<div><b>via_builder():
TCP/TLS connection
(id: 0) for WebSocket
could not be found</b></div>
<div><b>ERROR:
<core>
[msg_translator.c:1725]:
build_req_buf_from_sip_req():
could not create Via
header</b></div>
<div><b>ERROR:
<core>
[forward.c:607]:
forward_request():
ERROR:
forward_request:
building failed</b></div>
<div><b>ERROR: sl
[sl_funcs.c:371]:
sl_reply_error():
ERROR: sl_reply_error
used: I'm terribly
sorry, server error
occurred (1/SL)</b></div>
<div><br>
</div>
<div>Can someone help me
understand what I am
missing here and why
kamailio is not able to
create a VIA header to
forward this request
towards freeswitch. I
have built a simple
config file by
following <a \
href="https://gist.github.com/jesusprubio/4066845" \
target="_blank">https://gist.github.com/jesusprubio/4066845</a> as reference.<br>
</div>
<div><br>
</div>
<div>Any help in
understanding this is
really appreciated.</div>
</div>
</blockquote>
</div>
</div>
looks like the web rtc connection
was down (closed by one side or
interrupted by the network). You
can check with kamcmd the list of
active connections.<br>
<br>
Cheers,<br>
Daniel<span><font color="#888888"><br>
<br>
<pre cols="72">--
Daniel-Constantin Mierla - <a href="http://www.asipto.com" \
target="_blank">http://www.asipto.com</a> <a href="http://twitter.com/#%21/miconda" \
target="_blank">http://twitter.com/#!/miconda</a> - <a \
href="http://www.linkedin.com/in/miconda" \
target="_blank">http://www.linkedin.com/in/miconda</a> Kamailio Advanced Training, \
San Francisco, USA - June 24-27, 2013
* <a href="http://asipto.com/u/katu" target="_blank">http://asipto.com/u/katu</a> \
*</pre> </font></span></div>
<br>
</div>
</div>
_______________________________________________<br>
SIP Express Router (SER) and Kamailio
(OpenSER) - sr-users mailing list<br>
<a href="mailto:sr-users@lists.sip-router.org" \
target="_blank">sr-users@lists.sip-router.org</a><br> <a \
href="http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users" \
target="_blank">http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users</a><br> \
<br> </blockquote>
</div>
<br>
</div>
</blockquote>
</div>
<br>
</div>
</blockquote>
<br>
<pre cols="72">--
Daniel-Constantin Mierla - <a href="http://www.asipto.com" \
target="_blank">http://www.asipto.com</a> <a href="http://twitter.com/#%21/miconda" \
target="_blank">http://twitter.com/#!/miconda</a> - <a \
href="http://www.linkedin.com/in/miconda" \
target="_blank">http://www.linkedin.com/in/miconda</a> </pre>
</div>
</div>
</div>
</blockquote>
</div>
<br>
</div>
</div></div></blockquote><div><div>
<br>
<pre cols="72">--
Daniel-Constantin Mierla - <a href="http://www.asipto.com" \
target="_blank">http://www.asipto.com</a> <a href="http://twitter.com/#!/miconda" \
target="_blank">http://twitter.com/#!/miconda</a> - <a \
href="http://www.linkedin.com/in/miconda" \
target="_blank">http://www.linkedin.com/in/miconda</a> </pre>
</div></div></div>
<br>_______________________________________________<br>
SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list<br>
<a href="mailto:sr-users@lists.sip-router.org" \
target="_blank">sr-users@lists.sip-router.org</a><br> <a \
href="http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users" \
target="_blank">http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users</a><br> \
<br></blockquote></div><br><br clear="all"><div><br></div>-- <br></div></div><font \
color="#666666"><font face="arial, helvetica, sans-serif">Tais Plougmann \
Hansen</font><font face="arial, helvetica, sans-serif"><br></font></font><div>
<font face="arial, helvetica, sans-serif" \
color="#666666"><br></font></div><div><table><tbody><tr><td><font face="arial, \
helvetica, sans-serif" color="#666666"><img \
src="http://osd.dk/img/osd-signature.png"></font></td><td>
<font face="arial, helvetica, sans-serif" color="#666666">OSD Consulting ApS<br><a \
href="http://osd.dk/" target="_blank">osd.dk</a><br>Tel: <a \
href="tel:%2B45%2078101078" value="+4578101078" target="_blank">+45 78101078</a><br>
CVR: DK31332737<br></font></td></tr></tbody></table></div>
</div>
</blockquote></div><br><br clear="all"><div><br></div>-- <br><font \
color="#666666"><font face="arial, helvetica, sans-serif">Tais Plougmann \
Hansen</font><font face="arial, helvetica, sans-serif"><br></font></font><div><font \
face="arial, helvetica, sans-serif" color="#666666"><br>
</font></div><div><table><tbody><tr><td><font face="arial, helvetica, sans-serif" \
color="#666666"><img src="http://osd.dk/img/osd-signature.png"></font></td><td><font \
face="arial, helvetica, sans-serif" color="#666666">OSD Consulting ApS<br>
<a href="http://osd.dk/" target="_blank">osd.dk</a><br>Tel: +45 78101078<br>CVR: \
DK31332737<br></font></td></tr></tbody></table></div> </div>
_______________________________________________
SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list
sr-users@lists.sip-router.org
http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
[prev in list] [next in list] [prev in thread] [next in thread]
Configure |
About |
News |
Add a list |
Sponsored by KoreLogic