sr-users June 2013

sr-users@lists.kamailio.org

94 participants
171 discussions

Kamailio Crashing with excessive Via headers
by Krishna Kurapati 25 Jun '13

25 Jun '13

In 4.x, Following message is crashing the Kamailio. MESSAGE sip:50.62.12.174:15060;transport=udp SIP/2.0..Via: SIP/2.0/UDP 50.62.72.174:15060;branch=z9hG4bK3333.defaafa4.0..Via: SIP/2.0/UDP 50.62.72.174:15060;branch=z9hG4bK3333.cefaafa4.0.. Via: SIP/2.0/UDP 50.62.12.174:15060;branch=z9hG4bK3333.befaafa4.0.. Via: SIP/2.0/UDP 50.62.12.174:15060;branch=z9hG4bK3333.aefaafa4.0.. Via: SIP/2.0/UDP 50.62.12.174:15060;branch=z9hG4bK33339efaafa4.0.. Via: SIP/2.0/UDP 50.62.12.174:15060;branch=z9hG4bK3333.8efaafa4.0.. Via: SIP/2.0/UDP 50.62.12.174:15060;branch=z9hG4bK3333.7efaafa4.0.. Via: SIP/2.0/UDP 50.62.12.174;branch=z9hk4bK3333.4b488206.0.. Via: SIP/2.0/UDP 50.62.12.174;rport=5060;branch=z9hG4bK3333.3b488206.0.. To: sip:578626051@50.62.12.174.. From: sip:notifier@abc.com;tag=5571efee096a394dda7d0dffc5bb 32a5-c771..CSeq: 10 MESSAGE..Call-ID: presence-T[578626051]-R[578626051]..Max-Forwards: 9..Co ntent-Length: 110..User-Agent: kamailio (4.0.1 (x86_64/linux))..Content-Type: text/html; chars et=utf-8. stack trace: #0 qm_detach_free (qm=0x2ac39d748010, size=64) at mem/q_malloc.c:269 #1 qm_malloc (qm=0x2ac39d748010, size=64) at mem/q_malloc.c:386 #2 0x0000000000560fa1 in parse_via ( buffer=0x8c6a3b "SIP/2.0/UDP 50.62.72.174:15060;branch=z9hG4bK3333.defaafa4.0\r\nVia: SIP/2.0/UDP 50.62.72.174:15060;branch=z9hG4bK3333.cefaafa4.0\r\nVia: SIP/2.0/UDP 50.62.72.174:15060;branch=z9hG4bK3333.befaafa4.0\r\nVia:"..., end=0x8c6e31 "", vbody=0x2ac39d769e90) at parser/parse_via.c:2540 #3 0x0000000000538e68 in get_hdr_field (buf=<value optimized out>, end=0x8c6e31 "", hdr=0x2ac39d7999c0) at parser/msg_parser.c:140 #4 0x0000000000539ac9 in parse_headers (msg=0x2ac39d78a100, flags=2, next=<value optimized out>) at parser/msg_parser.c:351 #5 0x000000000053af8d in parse_msg (buf=<value optimized out>, len=<value optimized out>, msg=0x2ac39d78a100) at parser/msg_parser.c:650 #6 0x000000000049a2ef in receive_msg ( buf=0x8c6a00 "MESSAGE sip:50.62.72.174:15060;transport=udp SIP/2.0\r\nVia: SIP/2.0/UDP 50.62.72.174:15060;branch=z9hG4bK3333.defaafa4.0\r\nVia: SIP/2.0/UDP 50.62.72.174:15060;branch=z9hG4bK3333.cefaafa4.0\r\nVia: SIP/2.0"..., len=1073, rcv_info=0x7fffb40ab770) at receive.c:144 #7 0x0000000000528666 in udp_rcv_loop () at udp_server.c:557 #8 0x0000000000464daa in main_loop () at main.c:1638 #9 0x0000000000467adc in main (argc=<value optimized out>, argv=<value optimized out>)

2 1

Issue with Location table
by Ali Jawad 25 Jun '13

25 Jun '13

Dear All I had an issue with my kamailio that non-registered users were able to send calls "I.e. similar to Asterisk Peer mode" . So I did add the following statement if(!reg_fetch_contacts("location", "$fu", "caller")) { sl_send_reply("403", "Please register first"); exit; } That did fix the the problem with my registration issues, however as a a side effect the location table is not updated anymore and this broke a few scripts I use to maintain a few aspects of my system. kamctl ul --show does display all users correctly. However the database table only contains a few entries. My location settings are : # ----- usrloc params ----- /* enable DB persistency for location entries */ #!ifdef WITH_USRLOCDB modparam("usrloc", "timer_interval", 1) modparam("usrloc", "db_url", DBURL) modparam("usrloc", "db_mode", 2) modparam("usrloc", "use_domain", MULTIDOMAIN) #!endif Please advice * *

3 4

Kamailio+Asterisk Integrated server: 481 dialog/transaction does not exists error
by Ravindra Gowda 25 Jun '13

25 Jun '13

Dear All, I have integrated Kamailio (Version 4.0.1) with Asterisk (Version 11.4.0 rc1) server. I should have get VoIP features(call, SMS) with this integrated server. But when i tried to call other end SIP client through this integrated server, I'm getting this '*481 dialog/transaction does not exists*' error (please find the attachment 'call.pcap' below). SMS is through with the kamailio server without any problem (Find the attachment 'SMS.pcap' below). But when it comes to Calling feature, something is wrong and i am unable to find it. So please help me in resolving this issue. My system configuration is as follows: Host Architecture: i686 OS : Ubuntu 12.04 LTS Clients: Wi-Fi enabled VoIP phones. Also find the attachments below for the kamailio configuration file and Asterisk's sip.conf and extension.conf files. And tcpdump based trace files for Calling and SMSing process, to give a more complete picture. Any help will greatly appreciate. *Thank you and Best regards,* *R Ravindra **Gowda*

2 1

MSILOModule - Offline Message delivery
by Raj Roy Ghandhi 25 Jun '13

25 Jun '13

Hi, Anybody added MSILO module to store offline message delivery. I tried to implement with the guide at http://kamailio.org/docs/modules/stable/modules/msilo.html but it kamiailio does not start and saying the config errors. Please let me know the config file route scripts for this. Thanks, Roy.

2 1

Regarding Instant messaging using TCP on Kamailio 3.3
by Sunil Chandrasekharan 24 Jun '13

24 Jun '13

Hi All, As said i tested with debug=3 and got two set of logs.. 1 - User A succesfully send IM to User B ( with tcp) 2 - User B try to send IM to User B ( with tcp ) = FAIL Kindly help me understand what is happening .. 1. I could see that there i 2 via headers added by Kamailio server. 2. I tested with sudo kamcmd core.tcp_list I get 2 connection ( with 2 users registred with TCP) But when i try to send message from User 2 to User 1, i see that 1 more connection is added. But here the port is confusing. becuase the other 2 tcp connection shows the rport of the users. But with the 3rd connection the port is shown as 5060.. I am attaching the log below. Also i am attaching the log file your reference , ubuntu@ubuntu-desktop:/var/log$ tail -f kamailio.log Jun 21 11:51:44 ubuntu-desktop /usr/local/sbin/kamailio[11056]: last message repeated 5 times Jun 21 11:51:44 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [xavp.c:365]: destroying xavp list (nil) Jun 21 11:51:44 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [receive.c:293]: receive_msg: cleaning up Jun 21 11:51:44 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [io_wait.h:390]: DBG: io_watch_add(0x827f2a0, 6, 2, 0xb34f0b90), fd_no=1 Jun 21 11:51:50 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [io_wait.h:617]: DBG: io_watch_del (0x827f2a0, 6, -1, 0x10) fd_no=2 called Jun 21 11:51:50 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [tcp_read.c:1285]: releasing con 0xb34f0b90, state 1, fd=6, id=3 Jun 21 11:51:50 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [tcp_read.c:1286]: extra_data (nil) Jun 21 11:51:50 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [tcp_main.c:3381]: handle_tcp_child: reader response= b34f0b90, 1 from 2 Jun 21 11:51:50 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [io_wait.h:390]: DBG: io_watch_add(0x825d060, 33, 2, 0xb34f0b90), fd_no=23 Jun 21 11:51:50 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [tcp_main.c:3511]: handle_tcp_child: CONN_RELEASE 0xb34f0b90 refcnt= 1 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [io_wait.h:617]: DBG: io_watch_del (0x825d060, 33, -1, 0x0) fd_no=24 called Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [tcp_main.c:4298]: tcp: DBG: sending to child, events 1 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [tcp_main.c:3969]: selected tcp worker 3 16(11057) for activity on [tcp:44.80.100.130:5060], 0xb34f0b90 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [tcp_read.c:1358]: received n=4 con=0xb34f0b90, fd=6 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [tcp_read.c:1168]: tcp_read_req: content-length= 5 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [parser/msg_parser.c:624]: SIP Request: Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [parser/msg_parser.c:626]: method: <MESSAGE> Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [parser/msg_parser.c:628]: uri: <sip:sad7@44.80.100.130> Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [parser/msg_parser.c:630]: version: <SIP/2.0> Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [parser/parse_via.c:1286]: Found param type 235, <rport> = <n/a>; state=6 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [parser/parse_via.c:1286]: Found param type 232, <branch> = <z9hG4bK11639>; state=16 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [parser/parse_via.c:2561]: end of header reached, state=5 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [parser/msg_parser.c:511]: parse_headers: Via found, flags=2 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers: this is the first via Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [receive.c:149]: After parse_msg... Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [receive.c:190]: preparing to run routing scripts... Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [parser/parse_to.c:802]: end of header reached, state=10 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [parser/msg_parser.c:188]: DEBUG: get_hdr_field: <To> [34]; uri=[ sip:sad7@44.80.100.130] Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [parser/msg_parser.c:190]: DEBUG: to body ["sad7" < sip:sad7@44.80.100.130>#015#012] Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [parser/msg_parser.c:168]: get_hdr_field: cseq <CSeq>: <20> <MESSAGE> Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: maxfwd [mf_funcs.c:85]: value = 70 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [parser/msg_parser.c:202]: DEBUG: get_hdr_body : content_length=5 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [parser/msg_parser.c:104]: found end of header Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [parser/parse_to.c:178]: DEBUG: add_param: tag=29636 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [parser/parse_to.c:802]: end of header reached, state=29 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: sanity [mod_sanity.c:255]: sanity checks result: 1 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: siputils [checks.c:103]: no totag Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: tm [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=1 global id=0 T start=0xffffffff Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: tm [t_lookup.c:527]: t_lookup_request: start searching: hash=38277, isACK=0 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: tm [t_lookup.c:485]: DEBUG: RFC3261 transaction matching failed Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: tm [t_lookup.c:709]: DEBUG: t_lookup_request: no transaction found Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: tm [t_lookup.c:1148]: DEBUG: t_check_msg: msg id=1 global id=1 T end=(nil) Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [socket_info.c:583]: grep_sock_info - checking if host==us: 12==9 && [44.80.100.130] == [127.0.0.1] Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [socket_info.c:587]: grep_sock_info - checking if port 5060 (advertise 0) matches port 5060 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [socket_info.c:583]: grep_sock_info - checking if host==us: 12==12 && [44.80.100.130] == [44.80.100.130] Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [socket_info.c:587]: grep_sock_info - checking if port 5060 (advertise 0) matches port 5060 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: registrar [lookup.c:181]: contact for [sad7] found by address Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: tm [t_lookup.c:1379]: DEBUG: t_newtran: msg id=1 , global msg id=1 , T on entrance=(nil) Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: tm [t_lookup.c:527]: t_lookup_request: start searching: hash=38277, isACK=0 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: tm [t_lookup.c:485]: DEBUG: RFC3261 transaction matching failed Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: tm [t_lookup.c:709]: DEBUG: t_lookup_request: no transaction found Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: tm [t_hooks.c:374]: DBG: trans=0xb34f1de8, callback type 1, id 0 entered Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [msg_translator.c:2496]: create_via_hf: id added: <;i=3>, rcv proto=2 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [msg_translator.c:206]: check_via_address(44.80.100.115, 44.80.100.115, 0) Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [tcp_main.c:1843]: tcp_send: no open tcp connection found, opening new one Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [ip_addr.c:247]: tcpconn_new: new tcp connection: 44.80.100.114 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [tcp_main.c:1089]: tcpconn_new: on port 5060, type 2 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [tcp_main.c:1403]: tcpconn_add: hashes: 1600:1269:0, 4 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [tcp_main.c:2733]: pending write on new connection 0xb34f3538 (-1/439 bytes written) Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: tm [t_funcs.c:388]: SER: new transaction fwd'ed Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil) Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: last message repeated 5 times Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [xavp.c:365]: destroying xavp list (nil) Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [receive.c:293]: receive_msg: cleaning up Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [io_wait.h:390]: DBG: io_watch_add(0x827f2a0, 6, 2, 0xb34f0b90), fd_no=1 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [tcp_main.c:3620]: handle_ser_child: read response= b34f3538, 5, fd 34 from 16 (11057) Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [io_wait.h:390]: DBG: io_watch_add(0x825d060, 34, 2, 0xb34f3538), fd_no=23 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [io_wait.h:796]: DBG: io_watch_chg (0x825d060, 34, 0x1, 0xffffffff) fd_no=24 called Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [io_wait.h:617]: DBG: io_watch_del (0x825d060, 34, -1, 0x0) fd_no=24 called Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [tcp_main.c:4298]: tcp: DBG: sending to child, events 1 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [tcp_main.c:3969]: selected tcp worker 0 13(11054) for activity on [tcp:44.80.100.130:5060], 0xb34f3538 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [tcp_read.c:1358]: received n=4 con=0xb34f3538, fd=6 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [tcp_read.c:1168]: tcp_read_req: content-length= 0 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [parser/msg_parser.c:634]: SIP Reply (status): Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [parser/msg_parser.c:636]: version: <SIP/2.0> Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [parser/msg_parser.c:638]: status: <200> Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [parser/msg_parser.c:640]: reason: <OK> Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [parser/parse_via.c:1286]: Found param type 232, <branch> = <z9hG4bK5859.a75f15f4.0>; state=6 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [parser/parse_via.c:1286]: Found param type 236, <i> = <3>; state=16 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [parser/parse_via.c:2561]: end of header reached, state=5 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [parser/msg_parser.c:511]: parse_headers: Via found, flags=2 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers: this is the first via Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [receive.c:149]: After parse_msg... Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: tm [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=2 global id=1 T start=(nil) Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [parser/parse_via.c:1286]: Found param type 235, <rport> = <64935>; state=6 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [parser/parse_via.c:1286]: Found param type 232, <branch> = <z9hG4bK11639>; state=16 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [parser/parse_via.c:2561]: end of header reached, state=5 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [parser/msg_parser.c:511]: parse_headers: Via found, flags=22 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [parser/msg_parser.c:524]: parse_headers: this is the second via Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [parser/parse_to.c:178]: DEBUG: add_param: tag=12730 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [parser/parse_to.c:802]: end of header reached, state=29 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [parser/msg_parser.c:188]: DEBUG: get_hdr_field: <To> [44]; uri=[ sip:sad7@44.80.100.130] Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [parser/msg_parser.c:190]: DEBUG: to body ["sad7" < sip:sad7@44.80.100.130>] Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [parser/msg_parser.c:168]: get_hdr_field: cseq <CSeq>: <20> <MESSAGE> Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: tm [t_lookup.c:965]: DEBUG: t_reply_matching: hash 38277 label 1330771322 branch 0 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: tm [t_lookup.c:1016]: DEBUG: t_reply_matching: reply matched (T=0xb34f1de8)! Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: tm [t_lookup.c:1148]: DEBUG: t_check_msg: msg id=2 global id=2 T end=0xb34f1de8 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: tm [t_reply.c:2081]: DEBUG: reply_received: org. status uas=0, uac[0]=0 local=0 is_invite=0) Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: tm [t_reply.c:1204]: ->>>>>>>>> T_code=0, new_code=200 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: tm [t_reply.c:1702]: DEBUG: relay_reply: branch=0, save=0, relay=0 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [parser/msg_parser.c:202]: DEBUG: get_hdr_body : content_length=0 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [parser/msg_parser.c:104]: found end of header Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [msg_translator.c:1933]: old size: 337, new size: 272 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [msg_translator.c:1951]: build_res_from_sip_res: copied size: orig:81, new: 16, rest: 256 msg=#012SIP/2.0 200 OK#015#012Via: SIP/2.0/TCP 44.80.100.115:5060;rport=64935;branch=z9hG4bK11639#015#012From: < sip:sad4@44.80.100.130>;tag=29636#015#012To: "sad7" <sip:sad7@44.80.100.130>;tag=12730#015#012Call-ID: 4226#015#012CSeq: 20 MESSAGE#015#012User-Agent: Linphone/3.5.2 (eXosip2/3.6.0)#015#012Content-Length: 0#015#012#015#012 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [mem/shm_mem.c:111]: WARNING:vqm_resize: resize(0) called Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [tcp_main.c:2332]: tcp_send: tcp connection found (0xb34f0b90), acquiring fd Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [tcp_main.c:2343]: tcp_send, c= 0xb34f0b90, n=8 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [tcp_main.c:3620]: handle_ser_child: read response= b34f0b90, 2, fd -1 from 13 (11054) Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [tcp_main.c:2373]: tcp_send: after receive_fd: c= 0xb34f0b90 n=4 fd=10 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [tcp_main.c:2552]: tcp_send: sending... Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [tcp_main.c:2586]: tcp_send: after real write: c= 0xb34f0b90 n=272 fd=10 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [tcp_main.c:2587]: tcp_send: buf=#012SIP/2.0 200 OK#015#012Via: SIP/2.0/TCP 44.80.100.115:5060;rport=64935;branch=z9hG4bK11639#015#012From: <sip:sad4@44.80.100.130>;tag=29636#015#012To: "sad7" <sip:sad7@44.80.100.130>;tag=12730#015#012Call-ID: 4226#015#012CSeq: 20 MESSAGE#015#012User-Agent: Linphone/3.5.2 (eXosip2/3.6.0)#015#012Content-Length: 0#015#012#015#012 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: tm [t_reply.c:1543]: DEBUG: cleanup_uac_timers: RETR/FR timers reset Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil) Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: last message repeated 5 times Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [xavp.c:365]: destroying xavp list (nil) Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [receive.c:293]: receive_msg: cleaning up Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [io_wait.h:390]: DBG: io_watch_add(0x827f2a0, 6, 2, 0xb34f3538), fd_no=1 Jun 21 11:53:35 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [io_wait.h:617]: DBG: io_watch_del (0x827f2a0, 6, -1, 0x10) fd_no=2 called Jun 21 11:53:35 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [tcp_read.c:1285]: releasing con 0xb34f0b90, state 1, fd=6, id=3 Jun 21 11:53:35 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: <core> [tcp_read.c:1286]: extra_data (nil) Jun 21 11:53:35 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [tcp_main.c:3381]: handle_tcp_child: reader response= b34f0b90, 1 from 3 Jun 21 11:53:35 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [io_wait.h:390]: DBG: io_watch_add(0x825d060, 33, 2, 0xb34f0b90), fd_no=23 Jun 21 11:53:35 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [tcp_main.c:3511]: handle_tcp_child: CONN_RELEASE 0xb34f0b90 refcnt= 1 Jun 21 11:53:36 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [io_wait.h:617]: DBG: io_watch_del (0x827f2a0, 6, -1, 0x10) fd_no=2 called Jun 21 11:53:36 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [tcp_read.c:1285]: releasing con 0xb34f3538, state 1, fd=6, id=4 Jun 21 11:53:36 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: <core> [tcp_read.c:1286]: extra_data (nil) Jun 21 11:53:36 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [tcp_main.c:3381]: handle_tcp_child: reader response= b34f3538, 1 from 0 Jun 21 11:53:36 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [io_wait.h:390]: DBG: io_watch_add(0x825d060, 34, 2, 0xb34f3538), fd_no=24 Jun 21 11:53:36 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [tcp_main.c:3511]: handle_tcp_child: CONN_RELEASE 0xb34f3538 refcnt= 1 ================================================== Secnario when IM- Fail======================= Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [io_wait.h:617]: DBG: io_watch_del (0x825d060, 31, -1, 0x0) fd_no=25 called Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [tcp_main.c:4298]: tcp: DBG: sending to child, events 1 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [tcp_main.c:3969]: selected tcp worker 1 14(11055) for activity on [tcp:44.80.100.130:5060], 0xb34ef8a0 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [tcp_read.c:1358]: received n=4 con=0xb34ef8a0, fd=6 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [tcp_read.c:1168]: tcp_read_req: content-length= 5 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/msg_parser.c:624]: SIP Request: Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/msg_parser.c:626]: method: <MESSAGE> Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/msg_parser.c:628]: uri: <sip:sad4@44.80.100.130> Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/msg_parser.c:630]: version: <SIP/2.0> Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/parse_via.c:1286]: Found param type 235, <rport> = <n/a>; state=6 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/parse_via.c:1286]: Found param type 232, <branch> = <z9hG4bK29470>; state=16 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/parse_via.c:2561]: end of header reached, state=5 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/msg_parser.c:511]: parse_headers: Via found, flags=2 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers: this is the first via Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [receive.c:149]: After parse_msg... Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [receive.c:190]: preparing to run routing scripts... Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/parse_to.c:802]: end of header reached, state=10 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/msg_parser.c:188]: DEBUG: get_hdr_field: <To> [34]; uri=[ sip:sad4@44.80.100.130] Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/msg_parser.c:190]: DEBUG: to body ["sad4" < sip:sad4@44.80.100.130>#015#012] Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/msg_parser.c:168]: get_hdr_field: cseq <CSeq>: <20> <MESSAGE> Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: maxfwd [mf_funcs.c:85]: value = 70 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/msg_parser.c:202]: DEBUG: get_hdr_body : content_length=5 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/msg_parser.c:104]: found end of header Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/parse_to.c:178]: DEBUG: add_param: tag=17990 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/parse_to.c:802]: end of header reached, state=29 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: sanity [mod_sanity.c:255]: sanity checks result: 1 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: siputils [checks.c:103]: no totag Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=2 global id=1 T start=(nil) Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm [t_lookup.c:527]: t_lookup_request: start searching: hash=1628, isACK=0 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm [t_lookup.c:485]: DEBUG: RFC3261 transaction matching failed Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm [t_lookup.c:709]: DEBUG: t_lookup_request: no transaction found Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm [t_lookup.c:1148]: DEBUG: t_check_msg: msg id=2 global id=2 T end=(nil) Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [socket_info.c:583]: grep_sock_info - checking if host==us: 12==9 && [44.80.100.130] == [127.0.0.1] Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [socket_info.c:587]: grep_sock_info - checking if port 5060 (advertise 0) matches port 5060 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [socket_info.c:583]: grep_sock_info - checking if host==us: 12==12 && [44.80.100.130] == [44.80.100.130] Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [socket_info.c:587]: grep_sock_info - checking if port 5060 (advertise 0) matches port 5060 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: registrar [lookup.c:181]: contact for [sad4] found by address Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm [t_lookup.c:1379]: DEBUG: t_newtran: msg id=2 , global msg id=2 , T on entrance=(nil) Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm [t_lookup.c:527]: t_lookup_request: start searching: hash=1628, isACK=0 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm [t_lookup.c:485]: DEBUG: RFC3261 transaction matching failed Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm [t_lookup.c:709]: DEBUG: t_lookup_request: no transaction found Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm [t_hooks.c:374]: DBG: trans=0xb34f1de8, callback type 1, id 0 entered Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [msg_translator.c:2496]: create_via_hf: id added: <;i=2>, rcv proto=2 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [msg_translator.c:206]: check_via_address(44.80.100.114, 44.80.100.114, 0) Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [tcp_main.c:1843]: tcp_send: no open tcp connection found, opening new one Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [ip_addr.c:247]: tcpconn_new: new tcp connection: 44.80.100.115 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [tcp_main.c:1089]: tcpconn_new: on port 5060, type 2 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [tcp_main.c:1403]: tcpconn_add: hashes: 2555:2894:0, 5 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [tcp_main.c:2733]: pending write on new connection 0xb34f4f58 (-1/439 bytes written) Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm [t_funcs.c:388]: SER: new transaction fwd'ed Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil) Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: last message repeated 5 times Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [xavp.c:365]: destroying xavp list (nil) Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [receive.c:293]: receive_msg: cleaning up Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [io_wait.h:390]: DBG: io_watch_add(0x827f2a0, 6, 2, 0xb34ef8a0), fd_no=1 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [tcp_main.c:3620]: handle_ser_child: read response= b34f4f58, 5, fd 35 from 14 (11055) Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [io_wait.h:390]: DBG: io_watch_add(0x825d060, 35, 2, 0xb34f4f58), fd_no=24 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [io_wait.h:796]: DBG: io_watch_chg (0x825d060, 35, 0x1, 0xffffffff) fd_no=25 called Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [tcp_read.c:1168]: tcp_read_req: content-length= 5 Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/msg_parser.c:624]: SIP Request: Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/msg_parser.c:626]: method: <MESSAGE> Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/msg_parser.c:628]: uri: <sip:sad4@44.80.100.130> Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/msg_parser.c:630]: version: <SIP/2.0> Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/parse_via.c:1286]: Found param type 235, <rport> = <n/a>; state=6 Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/parse_via.c:1286]: Found param type 232, <branch> = <z9hG4bK29470>; state=16 Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/parse_via.c:2561]: end of header reached, state=5 Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/msg_parser.c:511]: parse_headers: Via found, flags=2 Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers: this is the first via Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [receive.c:149]: After parse_msg... Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [receive.c:190]: preparing to run routing scripts... Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/parse_to.c:802]: end of header reached, state=10 Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/msg_parser.c:188]: DEBUG: get_hdr_field: <To> [34]; uri=[ sip:sad4@44.80.100.130] Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/msg_parser.c:190]: DEBUG: to body ["sad4" < sip:sad4@44.80.100.130>#015#012] Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/msg_parser.c:168]: get_hdr_field: cseq <CSeq>: <20> <MESSAGE> Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: maxfwd [mf_funcs.c:85]: value = 70 Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/msg_parser.c:202]: DEBUG: get_hdr_body : content_length=5 Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/msg_parser.c:104]: found end of header Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/parse_to.c:178]: DEBUG: add_param: tag=17990 Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [parser/parse_to.c:802]: end of header reached, state=29 Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: sanity [mod_sanity.c:255]: sanity checks result: 1 Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: siputils [checks.c:103]: no totag Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=3 global id=2 T start=0xffffffff Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm [t_lookup.c:527]: t_lookup_request: start searching: hash=1628, isACK=0 Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm [t_lookup.c:470]: DEBUG: RFC3261 transaction matched, tid=29470 Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm [t_lookup.c:726]: DEBUG: t_lookup_request: transaction found (T=0xb34f1de8) Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm [t_lookup.c:1148]: DEBUG: t_check_msg: msg id=3 global id=3 T end=0xb34f1de8 Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm [t_reply.c:1483]: DBG: t_retransmit_reply: nothing to retransmit Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil) Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: last message repeated 5 times Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [xavp.c:365]: destroying xavp list (nil) Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [receive.c:293]: receive_msg: cleaning up Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [io_wait.h:617]: DBG: io_watch_del (0x825d060, 35, -1, 0x0) fd_no=25 called Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [tcp_main.c:4298]: tcp: DBG: sending to child, events 1 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [tcp_main.c:3969]: selected tcp worker 2 15(11056) for activity on [tcp:44.80.100.130:5060], 0xb34f4f58 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [tcp_read.c:1358]: received n=4 con=0xb34f4f58, fd=6 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [tcp_read.c:1168]: tcp_read_req: content-length= 0 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [parser/msg_parser.c:634]: SIP Reply (status): Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [parser/msg_parser.c:636]: version: <SIP/2.0> Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [parser/msg_parser.c:638]: status: <480> Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [parser/msg_parser.c:640]: reason: <Temporarily Unavailable> Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [parser/parse_via.c:1286]: Found param type 232, <branch> = <z9hG4bKc56.5c477096.0>; state=6 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [parser/parse_via.c:1286]: Found param type 236, <i> = <2>; state=16 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [parser/parse_via.c:2561]: end of header reached, state=5 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [parser/msg_parser.c:511]: parse_headers: Via found, flags=2 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers: this is the first via Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [receive.c:149]: After parse_msg... Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: tm [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=2 global id=1 T start=(nil) Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [parser/parse_via.c:1286]: Found param type 235, <rport> = <60840>; state=6 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [parser/parse_via.c:1286]: Found param type 232, <branch> = <z9hG4bK29470>; state=16 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [parser/parse_via.c:2561]: end of header reached, state=5 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [parser/msg_parser.c:511]: parse_headers: Via found, flags=22 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [parser/msg_parser.c:524]: parse_headers: this is the second via Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [parser/parse_to.c:178]: DEBUG: add_param: tag=278a8a835a2e4f92aca1f8bc3899ef93 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [parser/parse_to.c:802]: end of header reached, state=29 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [parser/msg_parser.c:188]: DEBUG: get_hdr_field: <To> [71]; uri=[ sip:sad4@44.80.100.130] Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [parser/msg_parser.c:190]: DEBUG: to body ["sad4" < sip:sad4@44.80.100.130>] Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [parser/msg_parser.c:168]: get_hdr_field: cseq <CSeq>: <20> <MESSAGE> Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: tm [t_lookup.c:965]: DEBUG: t_reply_matching: hash 1628 label 1762096325 branch 0 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: tm [t_lookup.c:1016]: DEBUG: t_reply_matching: reply matched (T=0xb34f1de8)! Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: tm [t_lookup.c:1148]: DEBUG: t_check_msg: msg id=2 global id=2 T end=0xb34f1de8 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: tm [t_reply.c:2081]: DEBUG: reply_received: org. status uas=0, uac[0]=0 local=0 is_invite=0) Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: tm [t_reply.c:1204]: ->>>>>>>>> T_code=0, new_code=480 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: tm [t_reply.c:1702]: DEBUG: relay_reply: branch=0, save=0, relay=0 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [parser/msg_parser.c:202]: DEBUG: get_hdr_body : content_length=0 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [parser/msg_parser.c:104]: found end of header Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [msg_translator.c:1933]: old size: 343, new size: 279 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [msg_translator.c:1951]: build_res_from_sip_res: copied size: orig:101, new: 37, rest: 242 msg=#012SIP/2.0 480 Temporarily Unavailable#015#012Via: SIP/2.0/TCP 44.80.100.114:5060;rport=60840;branch=z9hG4bK29470#015#012From: <sip:sad7@44.80.100.130>;tag=17990#015#012To: "sad4" < sip:sad4@44.80.100.130>;tag=278a8a835a2e4f92aca1f8bc3899ef93#015#012Call-ID: 25806#015#012CSeq: 20 MESSAGE#015#012Content-Length: 0#015#012#015#012 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [mem/shm_mem.c:111]: WARNING:vqm_resize: resize(0) called Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [tcp_main.c:2332]: tcp_send: tcp connection found (0xb34ef8a0), acquiring fd Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [tcp_main.c:2343]: tcp_send, c= 0xb34ef8a0, n=8 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [tcp_main.c:3620]: handle_ser_child: read response= b34ef8a0, 2, fd -1 from 15 (11056) Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [tcp_main.c:2373]: tcp_send: after receive_fd: c= 0xb34ef8a0 n=4 fd=10 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [tcp_main.c:2552]: tcp_send: sending... Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [tcp_main.c:2586]: tcp_send: after real write: c= 0xb34ef8a0 n=279 fd=10 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [tcp_main.c:2587]: tcp_send: buf=#012SIP/2.0 480 Temporarily Unavailable#015#012Via: SIP/2.0/TCP 44.80.100.114:5060;rport=60840;branch=z9hG4bK29470#015#012From: <sip:sad7@44.80.100.130>;tag=17990#015#012To: "sad4" < sip:sad4@44.80.100.130>;tag=278a8a835a2e4f92aca1f8bc3899ef93#015#012Call-ID: 25806#015#012CSeq: 20 MESSAGE#015#012Content-Length: 0#015#012#015#012 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: tm [t_reply.c:1543]: DEBUG: cleanup_uac_timers: RETR/FR timers reset Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil) Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: last message repeated 5 times Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [xavp.c:365]: destroying xavp list (nil) Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [receive.c:293]: receive_msg: cleaning up Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: <core> [io_wait.h:390]: DBG: io_watch_add(0x827f2a0, 6, 2, 0xb34f4f58), fd_no=1 Jun 21 11:54:10 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [io_wait.h:617]: DBG: io_watch_del (0x827f2a0, 6, -1, 0x10) fd_no=2 called Jun 21 11:54:10 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [tcp_read.c:1285]: releasing con 0xb34ef8a0, state 1, fd=6, id=2 Jun 21 11:54:10 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: <core> [tcp_read.c:1286]: extra_data (nil) Jun 21 11:54:10 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [tcp_main.c:3381]: handle_tcp_child: reader response= b34ef8a0, 1 from 1 Jun 21 11:54:10 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [io_wait.h:390]: DBG: io_watch_add(0x825d060, 31, 2, 0xb34ef8a0), fd_no=24 Jun 21 11:54:10 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: <core> [tcp_main.c:3511]: handle_tcp_child: CONN_RELEASE 0xb34ef8a0 refcnt= 1 Regards Sunil C On Mon, Jun 24, 2013 at 11:23 AM, Sunil Chandrasekharan < sunil.kainat(a)gmail.com> wrote: > Hi All, > > As said i tested with debug=3 and got two set of logs.. > > 1 - User A succesfully send IM to User B ( with tcp) > 2 - User B try to send IM to User B ( with tcp ) = FAIL > > Kindly help me understand what is happening .. > > 1. I could see that there i 2 via headers added by Kamailio server. > 2. I tested with > > sudo kamcmd core.tcp_list > > I get 2 connection ( with 2 users registred with TCP) > > But when i try to send message from User 2 to User 1, i see that 1 more > connection is added. > > But here the port is confusing. becuase the other 2 tcp connection shows > the rport of the users. But with the 3rd connection the port is shown as > 5060.. > > I am attaching the log below. Also i am attaching the log file your > reference , > > > ubuntu@ubuntu-desktop:/var/log$ tail -f kamailio.log > > Jun 21 11:51:44 ubuntu-desktop /usr/local/sbin/kamailio[11056]: last > message repeated 5 times > Jun 21 11:51:44 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [xavp.c:365]: destroying xavp list (nil) > Jun 21 11:51:44 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [receive.c:293]: receive_msg: cleaning up > Jun 21 11:51:44 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [io_wait.h:390]: DBG: io_watch_add(0x827f2a0, 6, 2, 0xb34f0b90), > fd_no=1 > Jun 21 11:51:50 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [io_wait.h:617]: DBG: io_watch_del (0x827f2a0, 6, -1, 0x10) fd_no=2 > called > Jun 21 11:51:50 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [tcp_read.c:1285]: releasing con 0xb34f0b90, state 1, fd=6, id=3 > Jun 21 11:51:50 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [tcp_read.c:1286]: extra_data (nil) > Jun 21 11:51:50 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [tcp_main.c:3381]: handle_tcp_child: reader response= b34f0b90, 1 > from 2 > Jun 21 11:51:50 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [io_wait.h:390]: DBG: io_watch_add(0x825d060, 33, 2, 0xb34f0b90), > fd_no=23 > Jun 21 11:51:50 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [tcp_main.c:3511]: handle_tcp_child: CONN_RELEASE 0xb34f0b90 > refcnt= 1 > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [io_wait.h:617]: DBG: io_watch_del (0x825d060, 33, -1, 0x0) fd_no=24 > called > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [tcp_main.c:4298]: tcp: DBG: sending to child, events 1 > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [tcp_main.c:3969]: selected tcp worker 3 16(11057) for activity on > [tcp:43.88.79.137:5060], 0xb34f0b90 > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [tcp_read.c:1358]: received n=4 con=0xb34f0b90, fd=6 > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [tcp_read.c:1168]: tcp_read_req: content-length= 5 > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [parser/msg_parser.c:624]: SIP Request: > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [parser/msg_parser.c:626]: method: <MESSAGE> > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [parser/msg_parser.c:628]: uri: <sip:sard7@43.88.79.137> > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [parser/msg_parser.c:630]: version: <SIP/2.0> > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [parser/parse_via.c:1286]: Found param type 235, <rport> = <n/a>; > state=6 > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [parser/parse_via.c:1286]: Found param type 232, <branch> = > <z9hG4bK11639>; state=16 > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [parser/parse_via.c:2561]: end of header reached, state=5 > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [parser/msg_parser.c:511]: parse_headers: Via found, flags=2 > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [parser/msg_parser.c:513]: parse_headers: this is the first via > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [receive.c:149]: After parse_msg... > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [receive.c:190]: preparing to run routing scripts... > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [parser/parse_to.c:802]: end of header reached, state=10 > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [parser/msg_parser.c:188]: DEBUG: get_hdr_field: <To> [34]; uri=[ > sip:sard7@43.88.79.137] > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [parser/msg_parser.c:190]: DEBUG: to body ["sard7" < > sip:sard7@43.88.79.137>#015#012] > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [parser/msg_parser.c:168]: get_hdr_field: cseq <CSeq>: <20> <MESSAGE> > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > maxfwd [mf_funcs.c:85]: value = 70 > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [parser/msg_parser.c:202]: DEBUG: get_hdr_body : content_length=5 > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [parser/msg_parser.c:104]: found end of header > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [parser/parse_to.c:178]: DEBUG: add_param: tag=29636 > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [parser/parse_to.c:802]: end of header reached, state=29 > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > sanity [mod_sanity.c:255]: sanity checks result: 1 > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > siputils [checks.c:103]: no totag > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: tm > [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=1 global id=0 T > start=0xffffffff > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: tm > [t_lookup.c:527]: t_lookup_request: start searching: hash=38277, isACK=0 > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: tm > [t_lookup.c:485]: DEBUG: RFC3261 transaction matching failed > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: tm > [t_lookup.c:709]: DEBUG: t_lookup_request: no transaction found > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: tm > [t_lookup.c:1148]: DEBUG: t_check_msg: msg id=1 global id=1 T end=(nil) > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [socket_info.c:583]: grep_sock_info - checking if host==us: 12==9 && > [43.88.79.137] == [127.0.0.1] > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [socket_info.c:587]: grep_sock_info - checking if port 5060 > (advertise 0) matches port 5060 > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [socket_info.c:583]: grep_sock_info - checking if host==us: 12==12 > && [43.88.79.137] == [43.88.79.137] > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [socket_info.c:587]: grep_sock_info - checking if port 5060 > (advertise 0) matches port 5060 > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > registrar [lookup.c:181]: contact for [sard7] found by address > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: tm > [t_lookup.c:1379]: DEBUG: t_newtran: msg id=1 , global msg id=1 , T on > entrance=(nil) > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: tm > [t_lookup.c:527]: t_lookup_request: start searching: hash=38277, isACK=0 > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: tm > [t_lookup.c:485]: DEBUG: RFC3261 transaction matching failed > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: tm > [t_lookup.c:709]: DEBUG: t_lookup_request: no transaction found > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: tm > [t_hooks.c:374]: DBG: trans=0xb34f1de8, callback type 1, id 0 entered > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [msg_translator.c:2496]: create_via_hf: id added: <;i=3>, rcv proto=2 > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [msg_translator.c:206]: check_via_address(43.88.108.53, > 43.88.108.53, 0) > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [tcp_main.c:1843]: tcp_send: no open tcp connection found, opening > new one > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [ip_addr.c:247]: tcpconn_new: new tcp connection: 43.88.109.14 > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [tcp_main.c:1089]: tcpconn_new: on port 5060, type 2 > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [tcp_main.c:1403]: tcpconn_add: hashes: 1600:1269:0, 4 > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [tcp_main.c:2733]: pending write on new connection 0xb34f3538 > (-1/439 bytes written) > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: tm > [t_funcs.c:388]: SER: new transaction fwd'ed > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil) > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: last > message repeated 5 times > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [xavp.c:365]: destroying xavp list (nil) > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [receive.c:293]: receive_msg: cleaning up > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [io_wait.h:390]: DBG: io_watch_add(0x827f2a0, 6, 2, 0xb34f0b90), > fd_no=1 > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [tcp_main.c:3620]: handle_ser_child: read response= b34f3538, 5, fd > 34 from 16 (11057) > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [io_wait.h:390]: DBG: io_watch_add(0x825d060, 34, 2, 0xb34f3538), > fd_no=23 > Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [io_wait.h:796]: DBG: io_watch_chg (0x825d060, 34, 0x1, 0xffffffff) > fd_no=24 called > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [io_wait.h:617]: DBG: io_watch_del (0x825d060, 34, -1, 0x0) fd_no=24 > called > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [tcp_main.c:4298]: tcp: DBG: sending to child, events 1 > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [tcp_main.c:3969]: selected tcp worker 0 13(11054) for activity on > [tcp:43.88.79.137:5060], 0xb34f3538 > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [tcp_read.c:1358]: received n=4 con=0xb34f3538, fd=6 > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [tcp_read.c:1168]: tcp_read_req: content-length= 0 > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [parser/msg_parser.c:634]: SIP Reply (status): > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [parser/msg_parser.c:636]: version: <SIP/2.0> > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [parser/msg_parser.c:638]: status: <200> > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [parser/msg_parser.c:640]: reason: <OK> > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [parser/parse_via.c:1286]: Found param type 232, <branch> = > <z9hG4bK5859.a75f15f4.0>; state=6 > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [parser/parse_via.c:1286]: Found param type 236, <i> = <3>; state=16 > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [parser/parse_via.c:2561]: end of header reached, state=5 > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [parser/msg_parser.c:511]: parse_headers: Via found, flags=2 > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [parser/msg_parser.c:513]: parse_headers: this is the first via > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [receive.c:149]: After parse_msg... > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: tm > [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=2 global id=1 T start=(nil) > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [parser/parse_via.c:1286]: Found param type 235, <rport> = <64935>; > state=6 > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [parser/parse_via.c:1286]: Found param type 232, <branch> = > <z9hG4bK11639>; state=16 > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [parser/parse_via.c:2561]: end of header reached, state=5 > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [parser/msg_parser.c:511]: parse_headers: Via found, flags=22 > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [parser/msg_parser.c:524]: parse_headers: this is the second via > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [parser/parse_to.c:178]: DEBUG: add_param: tag=12730 > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [parser/parse_to.c:802]: end of header reached, state=29 > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [parser/msg_parser.c:188]: DEBUG: get_hdr_field: <To> [44]; uri=[ > sip:sard7@43.88.79.137] > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [parser/msg_parser.c:190]: DEBUG: to body ["sard7" < > sip:sard7@43.88.79.137>] > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [parser/msg_parser.c:168]: get_hdr_field: cseq <CSeq>: <20> <MESSAGE> > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: tm > [t_lookup.c:965]: DEBUG: t_reply_matching: hash 38277 label 1330771322 > branch 0 > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: tm > [t_lookup.c:1016]: DEBUG: t_reply_matching: reply matched (T=0xb34f1de8)! > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: tm > [t_lookup.c:1148]: DEBUG: t_check_msg: msg id=2 global id=2 T end=0xb34f1de8 > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: tm > [t_reply.c:2081]: DEBUG: reply_received: org. status uas=0, uac[0]=0 > local=0 is_invite=0) > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: tm > [t_reply.c:1204]: ->>>>>>>>> T_code=0, new_code=200 > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: tm > [t_reply.c:1702]: DEBUG: relay_reply: branch=0, save=0, relay=0 > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [parser/msg_parser.c:202]: DEBUG: get_hdr_body : content_length=0 > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [parser/msg_parser.c:104]: found end of header > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [msg_translator.c:1933]: old size: 337, new size: 272 > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [msg_translator.c:1951]: build_res_from_sip_res: copied size: > orig:81, new: 16, rest: 256 msg=#012SIP/2.0 200 OK#015#012Via: SIP/2.0/TCP > 43.88.108.53:5060;rport=64935;branch=z9hG4bK11639#015#012From: < > sip:sard4@43.88.79.137>;tag=29636#015#012To: "sard7" < > sip:sard7@43.88.79.137>;tag=12730#015#012Call-ID: 4226#015#012CSeq: 20 > MESSAGE#015#012User-Agent: Linphone/3.5.2 > (eXosip2/3.6.0)#015#012Content-Length: 0#015#012#015#012 > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [mem/shm_mem.c:111]: WARNING:vqm_resize: resize(0) called > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [tcp_main.c:2332]: tcp_send: tcp connection found (0xb34f0b90), > acquiring fd > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [tcp_main.c:2343]: tcp_send, c= 0xb34f0b90, n=8 > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [tcp_main.c:3620]: handle_ser_child: read response= b34f0b90, 2, fd > -1 from 13 (11054) > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [tcp_main.c:2373]: tcp_send: after receive_fd: c= 0xb34f0b90 n=4 > fd=10 > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [tcp_main.c:2552]: tcp_send: sending... > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [tcp_main.c:2586]: tcp_send: after real write: c= 0xb34f0b90 n=272 > fd=10 > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [tcp_main.c:2587]: tcp_send: buf=#012SIP/2.0 200 OK#015#012Via: > SIP/2.0/TCP 43.88.108.53:5060;rport=64935;branch=z9hG4bK11639#015#012From: > <sip:sard4@43.88.79.137>;tag=29636#015#012To: "sard7" < > sip:sard7@43.88.79.137>;tag=12730#015#012Call-ID: 4226#015#012CSeq: 20 > MESSAGE#015#012User-Agent: Linphone/3.5.2 > (eXosip2/3.6.0)#015#012Content-Length: 0#015#012#015#012 > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: tm > [t_reply.c:1543]: DEBUG: cleanup_uac_timers: RETR/FR timers reset > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil) > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: last > message repeated 5 times > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [xavp.c:365]: destroying xavp list (nil) > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [receive.c:293]: receive_msg: cleaning up > Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [io_wait.h:390]: DBG: io_watch_add(0x827f2a0, 6, 2, 0xb34f3538), > fd_no=1 > Jun 21 11:53:35 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [io_wait.h:617]: DBG: io_watch_del (0x827f2a0, 6, -1, 0x10) fd_no=2 > called > Jun 21 11:53:35 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [tcp_read.c:1285]: releasing con 0xb34f0b90, state 1, fd=6, id=3 > Jun 21 11:53:35 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: > <core> [tcp_read.c:1286]: extra_data (nil) > Jun 21 11:53:35 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [tcp_main.c:3381]: handle_tcp_child: reader response= b34f0b90, 1 > from 3 > Jun 21 11:53:35 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [io_wait.h:390]: DBG: io_watch_add(0x825d060, 33, 2, 0xb34f0b90), > fd_no=23 > Jun 21 11:53:35 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [tcp_main.c:3511]: handle_tcp_child: CONN_RELEASE 0xb34f0b90 > refcnt= 1 > Jun 21 11:53:36 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [io_wait.h:617]: DBG: io_watch_del (0x827f2a0, 6, -1, 0x10) fd_no=2 > called > Jun 21 11:53:36 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [tcp_read.c:1285]: releasing con 0xb34f3538, state 1, fd=6, id=4 > Jun 21 11:53:36 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: > <core> [tcp_read.c:1286]: extra_data (nil) > Jun 21 11:53:36 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [tcp_main.c:3381]: handle_tcp_child: reader response= b34f3538, 1 > from 0 > Jun 21 11:53:36 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [io_wait.h:390]: DBG: io_watch_add(0x825d060, 34, 2, 0xb34f3538), > fd_no=24 > Jun 21 11:53:36 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [tcp_main.c:3511]: handle_tcp_child: CONN_RELEASE 0xb34f3538 > refcnt= 1 > > ================================================== Secnario when IM- > Fail======================= > > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [io_wait.h:617]: DBG: io_watch_del (0x825d060, 31, -1, 0x0) fd_no=25 > called > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [tcp_main.c:4298]: tcp: DBG: sending to child, events 1 > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [tcp_main.c:3969]: selected tcp worker 1 14(11055) for activity on > [tcp:43.88.79.137:5060], 0xb34ef8a0 > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [tcp_read.c:1358]: received n=4 con=0xb34ef8a0, fd=6 > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [tcp_read.c:1168]: tcp_read_req: content-length= 5 > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/msg_parser.c:624]: SIP Request: > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/msg_parser.c:626]: method: <MESSAGE> > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/msg_parser.c:628]: uri: <sip:sard4@43.88.79.137> > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/msg_parser.c:630]: version: <SIP/2.0> > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/parse_via.c:1286]: Found param type 235, <rport> = <n/a>; > state=6 > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/parse_via.c:1286]: Found param type 232, <branch> = > <z9hG4bK29470>; state=16 > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/parse_via.c:2561]: end of header reached, state=5 > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/msg_parser.c:511]: parse_headers: Via found, flags=2 > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/msg_parser.c:513]: parse_headers: this is the first via > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [receive.c:149]: After parse_msg... > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [receive.c:190]: preparing to run routing scripts... > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/parse_to.c:802]: end of header reached, state=10 > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/msg_parser.c:188]: DEBUG: get_hdr_field: <To> [34]; uri=[ > sip:sard4@43.88.79.137] > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/msg_parser.c:190]: DEBUG: to body ["sard4" < > sip:sard4@43.88.79.137>#015#012] > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/msg_parser.c:168]: get_hdr_field: cseq <CSeq>: <20> <MESSAGE> > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > maxfwd [mf_funcs.c:85]: value = 70 > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/msg_parser.c:202]: DEBUG: get_hdr_body : content_length=5 > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/msg_parser.c:104]: found end of header > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/parse_to.c:178]: DEBUG: add_param: tag=17990 > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/parse_to.c:802]: end of header reached, state=29 > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > sanity [mod_sanity.c:255]: sanity checks result: 1 > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > siputils [checks.c:103]: no totag > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm > [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=2 global id=1 T start=(nil) > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm > [t_lookup.c:527]: t_lookup_request: start searching: hash=1628, isACK=0 > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm > [t_lookup.c:485]: DEBUG: RFC3261 transaction matching failed > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm > [t_lookup.c:709]: DEBUG: t_lookup_request: no transaction found > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm > [t_lookup.c:1148]: DEBUG: t_check_msg: msg id=2 global id=2 T end=(nil) > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [socket_info.c:583]: grep_sock_info - checking if host==us: 12==9 && > [43.88.79.137] == [127.0.0.1] > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [socket_info.c:587]: grep_sock_info - checking if port 5060 > (advertise 0) matches port 5060 > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [socket_info.c:583]: grep_sock_info - checking if host==us: 12==12 > && [43.88.79.137] == [43.88.79.137] > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [socket_info.c:587]: grep_sock_info - checking if port 5060 > (advertise 0) matches port 5060 > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > registrar [lookup.c:181]: contact for [sard4] found by address > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm > [t_lookup.c:1379]: DEBUG: t_newtran: msg id=2 , global msg id=2 , T on > entrance=(nil) > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm > [t_lookup.c:527]: t_lookup_request: start searching: hash=1628, isACK=0 > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm > [t_lookup.c:485]: DEBUG: RFC3261 transaction matching failed > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm > [t_lookup.c:709]: DEBUG: t_lookup_request: no transaction found > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm > [t_hooks.c:374]: DBG: trans=0xb34f1de8, callback type 1, id 0 entered > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [msg_translator.c:2496]: create_via_hf: id added: <;i=2>, rcv proto=2 > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [msg_translator.c:206]: check_via_address(43.88.109.14, > 43.88.109.14, 0) > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [tcp_main.c:1843]: tcp_send: no open tcp connection found, opening > new one > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [ip_addr.c:247]: tcpconn_new: new tcp connection: 43.88.108.53 > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [tcp_main.c:1089]: tcpconn_new: on port 5060, type 2 > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [tcp_main.c:1403]: tcpconn_add: hashes: 2555:2894:0, 5 > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [tcp_main.c:2733]: pending write on new connection 0xb34f4f58 > (-1/439 bytes written) > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm > [t_funcs.c:388]: SER: new transaction fwd'ed > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil) > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: last > message repeated 5 times > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [xavp.c:365]: destroying xavp list (nil) > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [receive.c:293]: receive_msg: cleaning up > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [io_wait.h:390]: DBG: io_watch_add(0x827f2a0, 6, 2, 0xb34ef8a0), > fd_no=1 > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [tcp_main.c:3620]: handle_ser_child: read response= b34f4f58, 5, fd > 35 from 14 (11055) > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [io_wait.h:390]: DBG: io_watch_add(0x825d060, 35, 2, 0xb34f4f58), > fd_no=24 > Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [io_wait.h:796]: DBG: io_watch_chg (0x825d060, 35, 0x1, 0xffffffff) > fd_no=25 called > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [tcp_read.c:1168]: tcp_read_req: content-length= 5 > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/msg_parser.c:624]: SIP Request: > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/msg_parser.c:626]: method: <MESSAGE> > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/msg_parser.c:628]: uri: <sip:sard4@43.88.79.137> > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/msg_parser.c:630]: version: <SIP/2.0> > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/parse_via.c:1286]: Found param type 235, <rport> = <n/a>; > state=6 > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/parse_via.c:1286]: Found param type 232, <branch> = > <z9hG4bK29470>; state=16 > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/parse_via.c:2561]: end of header reached, state=5 > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/msg_parser.c:511]: parse_headers: Via found, flags=2 > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/msg_parser.c:513]: parse_headers: this is the first via > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [receive.c:149]: After parse_msg... > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [receive.c:190]: preparing to run routing scripts... > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/parse_to.c:802]: end of header reached, state=10 > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/msg_parser.c:188]: DEBUG: get_hdr_field: <To> [34]; uri=[ > sip:sard4@43.88.79.137] > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/msg_parser.c:190]: DEBUG: to body ["sard4" < > sip:sard4@43.88.79.137>#015#012] > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/msg_parser.c:168]: get_hdr_field: cseq <CSeq>: <20> <MESSAGE> > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > maxfwd [mf_funcs.c:85]: value = 70 > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/msg_parser.c:202]: DEBUG: get_hdr_body : content_length=5 > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/msg_parser.c:104]: found end of header > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/parse_to.c:178]: DEBUG: add_param: tag=17990 > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [parser/parse_to.c:802]: end of header reached, state=29 > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > sanity [mod_sanity.c:255]: sanity checks result: 1 > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > siputils [checks.c:103]: no totag > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm > [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=3 global id=2 T > start=0xffffffff > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm > [t_lookup.c:527]: t_lookup_request: start searching: hash=1628, isACK=0 > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm > [t_lookup.c:470]: DEBUG: RFC3261 transaction matched, tid=29470 > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm > [t_lookup.c:726]: DEBUG: t_lookup_request: transaction found (T=0xb34f1de8) > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm > [t_lookup.c:1148]: DEBUG: t_check_msg: msg id=3 global id=3 T end=0xb34f1de8 > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: tm > [t_reply.c:1483]: DBG: t_retransmit_reply: nothing to retransmit > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil) > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: last > message repeated 5 times > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [xavp.c:365]: destroying xavp list (nil) > Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [receive.c:293]: receive_msg: cleaning up > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [io_wait.h:617]: DBG: io_watch_del (0x825d060, 35, -1, 0x0) fd_no=25 > called > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [tcp_main.c:4298]: tcp: DBG: sending to child, events 1 > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [tcp_main.c:3969]: selected tcp worker 2 15(11056) for activity on > [tcp:43.88.79.137:5060], 0xb34f4f58 > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [tcp_read.c:1358]: received n=4 con=0xb34f4f58, fd=6 > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [tcp_read.c:1168]: tcp_read_req: content-length= 0 > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [parser/msg_parser.c:634]: SIP Reply (status): > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [parser/msg_parser.c:636]: version: <SIP/2.0> > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [parser/msg_parser.c:638]: status: <480> > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [parser/msg_parser.c:640]: reason: <Temporarily Unavailable> > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [parser/parse_via.c:1286]: Found param type 232, <branch> = > <z9hG4bKc56.5c477096.0>; state=6 > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [parser/parse_via.c:1286]: Found param type 236, <i> = <2>; state=16 > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [parser/parse_via.c:2561]: end of header reached, state=5 > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [parser/msg_parser.c:511]: parse_headers: Via found, flags=2 > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [parser/msg_parser.c:513]: parse_headers: this is the first via > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [receive.c:149]: After parse_msg... > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: tm > [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=2 global id=1 T start=(nil) > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [parser/parse_via.c:1286]: Found param type 235, <rport> = <60840>; > state=6 > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [parser/parse_via.c:1286]: Found param type 232, <branch> = > <z9hG4bK29470>; state=16 > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [parser/parse_via.c:2561]: end of header reached, state=5 > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [parser/msg_parser.c:511]: parse_headers: Via found, flags=22 > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [parser/msg_parser.c:524]: parse_headers: this is the second via > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [parser/parse_to.c:178]: DEBUG: add_param: > tag=278a8a835a2e4f92aca1f8bc3899ef93 > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [parser/parse_to.c:802]: end of header reached, state=29 > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [parser/msg_parser.c:188]: DEBUG: get_hdr_field: <To> [71]; uri=[ > sip:sard4@43.88.79.137] > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [parser/msg_parser.c:190]: DEBUG: to body ["sard4" < > sip:sard4@43.88.79.137>] > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [parser/msg_parser.c:168]: get_hdr_field: cseq <CSeq>: <20> <MESSAGE> > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: tm > [t_lookup.c:965]: DEBUG: t_reply_matching: hash 1628 label 1762096325 > branch 0 > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: tm > [t_lookup.c:1016]: DEBUG: t_reply_matching: reply matched (T=0xb34f1de8)! > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: tm > [t_lookup.c:1148]: DEBUG: t_check_msg: msg id=2 global id=2 T end=0xb34f1de8 > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: tm > [t_reply.c:2081]: DEBUG: reply_received: org. status uas=0, uac[0]=0 > local=0 is_invite=0) > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: tm > [t_reply.c:1204]: ->>>>>>>>> T_code=0, new_code=480 > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: tm > [t_reply.c:1702]: DEBUG: relay_reply: branch=0, save=0, relay=0 > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [parser/msg_parser.c:202]: DEBUG: get_hdr_body : content_length=0 > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [parser/msg_parser.c:104]: found end of header > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [msg_translator.c:1933]: old size: 343, new size: 279 > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [msg_translator.c:1951]: build_res_from_sip_res: copied size: > orig:101, new: 37, rest: 242 msg=#012SIP/2.0 480 Temporarily > Unavailable#015#012Via: SIP/2.0/TCP 43.88.109.14:5060;rport=60840;branch=z9hG4bK29470#015#012From: > <sip:sard7@43.88.79.137>;tag=17990#015#012To: "sard4" < > sip:sard4@43.88.79.137>;tag=278a8a835a2e4f92aca1f8bc3899ef93#015#012Call-ID: > 25806#015#012CSeq: 20 MESSAGE#015#012Content-Length: 0#015#012#015#012 > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [mem/shm_mem.c:111]: WARNING:vqm_resize: resize(0) called > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [tcp_main.c:2332]: tcp_send: tcp connection found (0xb34ef8a0), > acquiring fd > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [tcp_main.c:2343]: tcp_send, c= 0xb34ef8a0, n=8 > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [tcp_main.c:3620]: handle_ser_child: read response= b34ef8a0, 2, fd > -1 from 15 (11056) > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [tcp_main.c:2373]: tcp_send: after receive_fd: c= 0xb34ef8a0 n=4 > fd=10 > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [tcp_main.c:2552]: tcp_send: sending... > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [tcp_main.c:2586]: tcp_send: after real write: c= 0xb34ef8a0 n=279 > fd=10 > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [tcp_main.c:2587]: tcp_send: buf=#012SIP/2.0 480 Temporarily > Unavailable#015#012Via: SIP/2.0/TCP 43.88.109.14:5060;rport=60840;branch=z9hG4bK29470#015#012From: > <sip:sard7@43.88.79.137>;tag=17990#015#012To: "sard4" < > sip:sard4@43.88.79.137>;tag=278a8a835a2e4f92aca1f8bc3899ef93#015#012Call-ID: > 25806#015#012CSeq: 20 MESSAGE#015#012Content-Length: 0#015#012#015#012 > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: tm > [t_reply.c:1543]: DEBUG: cleanup_uac_timers: RETR/FR timers reset > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil) > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: last > message repeated 5 times > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [xavp.c:365]: destroying xavp list (nil) > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [receive.c:293]: receive_msg: cleaning up > Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: > <core> [io_wait.h:390]: DBG: io_watch_add(0x827f2a0, 6, 2, 0xb34f4f58), > fd_no=1 > Jun 21 11:54:10 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [io_wait.h:617]: DBG: io_watch_del (0x827f2a0, 6, -1, 0x10) fd_no=2 > called > Jun 21 11:54:10 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [tcp_read.c:1285]: releasing con 0xb34ef8a0, state 1, fd=6, id=2 > Jun 21 11:54:10 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: > <core> [tcp_read.c:1286]: extra_data (nil) > Jun 21 11:54:10 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [tcp_main.c:3381]: handle_tcp_child: reader response= b34ef8a0, 1 > from 1 > Jun 21 11:54:10 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [io_wait.h:390]: DBG: io_watch_add(0x825d060, 31, 2, 0xb34ef8a0), > fd_no=24 > Jun 21 11:54:10 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: > <core> [tcp_main.c:3511]: handle_tcp_child: CONN_RELEASE 0xb34ef8a0 > refcnt= 1 > > > Regards > Sunil C > > > On Sun, Jun 23, 2013 at 8:55 PM, Daniel-Constantin Mierla < > miconda(a)gmail.com> wrote: > >> Hello, >> >> run with debug=3 and see the log messages. I guess there is a mismatch on >> local socket and remote socket conditions that result in creating a new >> connection. >> >> Cheers, >> Daniel >> >> >> On 6/21/13 1:47 PM, Sunil Chandrasekharan wrote: >> >> Hi All >> >> Today i could find some information from the logs. >> When i tested the command : >> >> sudo kamcmd core.tcp_list >> >> I get 2 connection ( with 2 users regitred with TCP) >> >> But when i try to send message from User 2 to User 1, i see that 1 more >> connection is added. >> But here the port is confusing. becuase the other 2 tcp connection >> shows the rport of the users. But with the 3rd connection the port is shown >> as 5060.. >> >> I feel Kamailio is adding a new TCP connection instead of using the >> existing connection between the client and Kamailio with the rport number. >> >> I read that we can use (force_rport()) , but i could not understand how >> to use it . Alo when i gave >> >> force_rport=yes inside the global parameter of Kamaili.cfg file, i >> still face the same issue. >> >> This issue exists even when User 2 try to call/IM to User 1. >> >> my laptop is User 1. But i can send IM/Call User 2 succeessfully. I >> dont understand how my machine can send IM/call successfully, and why no >> other user can do the same? >> >> Kindly support me >> >> On Thu, Jun 20, 2013 at 5:27 PM, Sunil Chandrasekharan < >> sunil.kainat(a)gmail.com> wrote: >> >>> Hi All, >>> >>> I tested again today by disabling the presence module. >>> >>> Still i could not make TCP based IM working with Kamailio. >>> >>> I checked the tcp-connection-lifetime =3605. >>> Still i get 480 Temperory un available. >>> >>> Step 1 : login/register on two lin phones ( on differnt PC) >>> Step 2: from PC 1 (user A) send message to user B >>> Step 3: user B receive the mesage. >>> Step 4. Send message from User B to User A >>> >>> Result : 480 Temperory unavailable. >>> >>> 1. I feel user A connection is getting closed . Hence not able to >>> reach user A. >>> >>> 2. I also see User A and User B message contruct has 2 Via headers. >>> >>> There is no change or anything abnormal happening. >>> >>> Kindly help me forward to get tcp based IM working between two clients. >>> >>> >>> >>> On Tue, Jun 18, 2013 at 2:27 PM, Sunil Chandrasekharan < >>> sunil.kainat(a)gmail.com> wrote: >>> >>>> Hi , >>>> >>>> I used open internet, i really doubt if there is any NAT issue here. >>>> >>>> But my config file(kamailio.cfg) shows : tcp-connection-lifetime=3605 >>>> But i dont know what is the registration expire time . How can i see >>>> the registration expire time? >>>> also my lin phone sends keep alive right? >>>> >>>> can you please help me how can i see connection close parameter during >>>> forward/reply? i dont know where to set them? >>>> >>>> Please suggest me the correct link to find tcp paremeter and cook book. >>>> >>>> >>>> On Tue, Jun 18, 2013 at 2:06 PM, Daniel-Constantin Mierla < >>>> miconda(a)gmail.com> wrote: >>>> >>>>> Hello, >>>>> >>>>> >>>>> On 6/17/13 7:09 AM, Sunil Chandrasekharan wrote: >>>>> >>>>>> >>>>>> Hi All, >>>>>> >>>>>> I have set up Kamailio 3.3 on Ubuntu machine.I created two user test >>>>>> 1 and test 2. >>>>>> I could use Presence and also i was able to register to Kamailio >>>>>> server and exchange presence status with each other. >>>>>> >>>>>> Details- I used TCP protocol . >>>>>> >>>>>> testing methods - Linphone, a sample application. >>>>>> >>>>>> I am able to register succesfully with (TCP) on to kamailio server >>>>>> using Lin phone and sample application. >>>>>> I am able to update presence status of the users. >>>>>> >>>>>> Issue : >>>>>> >>>>>> When i try to send messages between two users ( using TCP ) >>>>>> >>>>>> 1. from Sample application, when i try to send message, i get 420 >>>>>> temporarily Unavailable error from server. >>>>>> 2. from Lin phone 3.5.2, i was able to send messages ( sue TCP) but >>>>>> when the other user try to reply back , i get same error >>>>>> >>>>>> 480 Temporarily Unavailable. error from server. >>>>>> >>>>>> I want a support to understand why i get error while sending messages >>>>>> with TCP via Kamailio server. >>>>>> >>>>>> I am able to succeesfully send and receive messages when i use UDP >>>>>> from my sample application and Lin phone. >>>>>> >>>>> if the phones are behind nat, be sure the tcp connection lifetime is >>>>> higher than the registration expire and that you don't set connection close >>>>> after forward/reply. Look at core cookbook for the appropriate tcp >>>>> parameter and config functions. >>>>> >>>>> Cheers, >>>>> Daniel >>>>> >>>>> -- >>>>> Daniel-Constantin Mierla - http://www.asipto.com >>>>> http://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(a)lists.sip-router.org >>>>> http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users >>>>> >>>> >>>> >>> >> >> >> _______________________________________________ >> SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing listsr-users@lists.sip-router.orghttp://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 >> >> >> _______________________________________________ >> SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list >> sr-users(a)lists.sip-router.org >> http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users >> >> >

1 0

Kamailio+Asterisk integration :'481 dialog/transaction does not exists' error.
by Ravindra Gowda 24 Jun '13

24 Jun '13

Dear All, I have integrated Kamailio (Version 4.0.1) with Asterisk (Version 11.4.0 rc1) server. I should have get VoIP features(call, SMS) with this integrated server. But when i tried to call other end SIP client through this integrated server, I'm getting this '*481 dialog/transaction does not exists*' error (please find the attachment 'call.pcap' below). SMS is through with the kamailio server without any problem (Find the attachment 'SMS.pcap' below). But when it comes to Calling feature, something is wrong and i am unable to find it. So please help me in resolving this issue. My system configuration is as follows: Host Architecture: i686 OS : Ubuntu 12.04 LTS Clients: Wi-Fi enabled VoIP phones. Also find the attachments below for the kamailio configuration file and tcpdump based trace files for Calling and SMSing process, to give a more complete picture. Any help will greatly appreciate. *Thank you and Best regards,* *R Ravindra **Gowda***

1 0

Regarding Instant messaging using TCP on Kamailio 3.3
by Sunil Chandrasekharan 24 Jun '13

24 Jun '13

1 0

enable only TLS transport on kamailio 4
by johnc 23 Jun '13

23 Jun '13

-----BEGIN PGP SIGNED MESSAGE----- Hash: SHA1 Hi, I wish to enable only TLS transport listening on port 5061 for domain xyz.com (say) What combination of the following do I need? alias= listen= port= Everything I've attempted so far has resulted in a segfault or kamailio failing to start. My existing configuration works fine for TLS if I don't try and disable any other transport. I am currently enforcing TLS via iptables as a crude hack. Any help would be greatly appreciated. Many thanks. Regards, John -----BEGIN PGP SIGNATURE----- Version: GnuPG v1.4.12 (GNU/Linux) Comment: Using GnuPG with Mozilla - http://enigmail.mozdev.org/ iQIcBAEBAgAGBQJRxXnIAAoJELy1jPQ1KER7HJ4QAIHGcZ/SEUCtsSQ21rZMYDaf m84i7MksR5TmEjLmRkMImGDOCp/C/dM/x7LZrE+JvaOkKTpx5AKDWgxYGOa7EBxi CsBqTlM0BhBv11+AEJGIVfyKBFBypTRnabzxg6yTkr514HD+Rebg4pVWJbVWqnky ZxUvy0j3lR8wpocGuP9PSlVZq0KMNU3NU1Y9IjRNx2vsk7LrPN5x0L4Xq2XFLI77 dKf75Mlv5/cVETtRq774CFyFi/ra9MBNK1SgiEG4x9IFFVsjZexAd8EHxSQzL1RX JequFcQ1H7XUVC91bXtM/ra4+1NJpMDUlOrxtcznGtKsRnZIoCfY0u8641RQWu/l muiabS4auvDy+oQXkpXXUzEXyKpZzUiPdacdJ/ETq2HlcvXKIwZXvIpHdfYQAKqG LcFP0PQ0hkS7dlE5zcIhih4PRcz/JE2txkONLc9T7aqPfBmQYN/Z0PS3ozN9bGZr NMFWLQ47PF02Ak+Mw6LfFccIQ1lvS83zcGOsuHbK9DoRlqoz9Ax14Pcg4fP1og0m LX66O4WvMCNJV0NiAW6UvZxnOodWe721IsLdD7bKPSgBKjfr+Mx2KLt5S1yUCNJY SpxkmgWEiwAIKVBWFrjefuRYeqs9T+GjvEFta/a7/qCToxggt596vwhAvbwwcUYt CMzFfHeMaqWk7uyBRC6D =Mfpm -----END PGP SIGNATURE-----

2 4

migrate 3.3.x to 4.0
by Daniel W. Graham 23 Jun '13

23 Jun '13

I would like to upgrade kamailio from 3.3.x to 4.0, I see this document about database and config file changes http://www.kamailio.org/wiki/install/upgrade/3.3.x-to-4.0.0 I currently have 3.3.x installed from GIT, is there an easy way to remove or will I have to delete files manually and then install 4.0? [cid:image001.gif@01CE6DBF.061CB990]

2 1

Regarding Instant messaging using TCP on Kamailio 3.3
by Sunil Chandrasekharan 23 Jun '13

23 Jun '13

Hi All Today i could find some information from the logs. When i tested the command : sudo kamcmd core.tcp_list I get 2 connection ( with 2 users regitred with TCP) But when i try to send message from User 2 to User 1, i see that 1 more connection is added. But here the port is confusing. becuase the other 2 tcp connection shows the rport of the users. But with the 3rd connection the port is shown as 5060.. I feel Kamailio is adding a new TCP connection instead of using the existing connection between the client and Kamailio with the rport number. I read that we can use (force_rport()) , but i could not understand how to use it . Alo when i gave force_rport=yes inside the global parameter of Kamaili.cfg file, i still face the same issue. This issue exists even when User 2 try to call/IM to User 1. my laptop is User 1. But i can send IM/Call User 2 succeessfully. I dont understand how my machine can send IM/call successfully, and why no other user can do the same? Kindly support me On Thu, Jun 20, 2013 at 5:27 PM, Sunil Chandrasekharan < sunil.kainat(a)gmail.com> wrote: > Hi All, > > I tested again today by disabling the presence module. > > Still i could not make TCP based IM working with Kamailio. > > I checked the tcp-connection-lifetime =3605. > Still i get 480 Temperory un available. > > Step 1 : login/register on two lin phones ( on differnt PC) > Step 2: from PC 1 (user A) send message to user B > Step 3: user B receive the mesage. > Step 4. Send message from User B to User A > > Result : 480 Temperory unavailable. > > 1. I feel user A connection is getting closed . Hence not able to reach > user A. > > 2. I also see User A and User B message contruct has 2 Via headers. > > There is no change or anything abnormal happening. > > Kindly help me forward to get tcp based IM working between two clients. > > > > On Tue, Jun 18, 2013 at 2:27 PM, Sunil Chandrasekharan < > sunil.kainat(a)gmail.com> wrote: > >> Hi , >> >> I used open internet, i really doubt if there is any NAT issue here. >> >> But my config file(kamailio.cfg) shows : tcp-connection-lifetime=3605 >> But i dont know what is the registration expire time . How can i see the >> registration expire time? >> also my lin phone sends keep alive right? >> >> can you please help me how can i see connection close parameter during >> forward/reply? i dont know where to set them? >> >> Please suggest me the correct link to find tcp paremeter and cook book. >> >> >> On Tue, Jun 18, 2013 at 2:06 PM, Daniel-Constantin Mierla < >> miconda(a)gmail.com> wrote: >> >>> Hello, >>> >>> >>> On 6/17/13 7:09 AM, Sunil Chandrasekharan wrote: >>> >>>> >>>> Hi All, >>>> >>>> I have set up Kamailio 3.3 on Ubuntu machine.I created two user test 1 >>>> and test 2. >>>> I could use Presence and also i was able to register to Kamailio server >>>> and exchange presence status with each other. >>>> >>>> Details- I used TCP protocol . >>>> >>>> testing methods - Linphone, a sample application. >>>> >>>> I am able to register succesfully with (TCP) on to kamailio server >>>> using Lin phone and sample application. >>>> I am able to update presence status of the users. >>>> >>>> Issue : >>>> >>>> When i try to send messages between two users ( using TCP ) >>>> >>>> 1. from Sample application, when i try to send message, i get 420 >>>> temporarily Unavailable error from server. >>>> 2. from Lin phone 3.5.2, i was able to send messages ( sue TCP) but >>>> when the other user try to reply back , i get same error >>>> >>>> 480 Temporarily Unavailable. error from server. >>>> >>>> I want a support to understand why i get error while sending messages >>>> with TCP via Kamailio server. >>>> >>>> I am able to succeesfully send and receive messages when i use UDP from >>>> my sample application and Lin phone. >>>> >>> if the phones are behind nat, be sure the tcp connection lifetime is >>> higher than the registration expire and that you don't set connection close >>> after forward/reply. Look at core cookbook for the appropriate tcp >>> parameter and config functions. >>> >>> Cheers, >>> Daniel >>> >>> -- >>> Daniel-Constantin Mierla - http://www.asipto.com >>> http://twitter.com/#!/miconda - http://www.linkedin.com/in/**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(a)lists.sip-router.org >>> http://lists.sip-router.org/**cgi-bin/mailman/listinfo/sr-**users<http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users> >>> >> >> >

2 1

← Newer
1
...
4
5
6
7
8
9
10
...
18
Older →

Jump to page:

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 June 2013