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: [xavp.c:365]: destroying xavp list (nil) Jun 21 11:51:44 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [receive.c:293]: receive_msg: cleaning up Jun 21 11:51:44 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [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: [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: [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: [tcp_read.c:1286]: extra_data (nil) Jun 21 11:51:50 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: [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: [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: [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: [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: [tcp_main.c:4298]: tcp: DBG: sending to child, events 1 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: [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: [tcp_read.c:1358]: received n=4 con=0xb34f0b90, fd=6 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: [tcp_read.c:1168]: tcp_read_req: content-length= 5 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: [parser/msg_parser.c:624]: SIP Request: Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: [parser/msg_parser.c:626]: method: Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: [parser/msg_parser.c:628]: uri: Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: [parser/msg_parser.c:630]: version: Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: [parser/parse_via.c:1286]: Found param type 235, = ; state=6 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: [parser/parse_via.c:1286]: Found param type 232, = ; state=16 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: [parser/parse_via.c:2561]: end of header reached, state=5 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: [parser/msg_parser.c:511]: parse_headers: Via found, flags=2 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: [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: [receive.c:149]: After parse_msg... Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: [receive.c:190]: preparing to run routing scripts... Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: [parser/parse_to.c:802]: end of header reached, state=10 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: [parser/msg_parser.c:188]: DEBUG: get_hdr_field: [34]; uri=[sip:sard7@43.88.79.137] Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: [parser/msg_parser.c:190]: DEBUG: to body ["sard7" #015#012] Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: [parser/msg_parser.c:168]: get_hdr_field: cseq : <20> 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: [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: [parser/msg_parser.c:104]: found end of header Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: [parser/parse_to.c:178]: DEBUG: add_param: tag=29636 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: [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: [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: [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: [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: [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: [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: [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: [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: [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: [tcp_main.c:1089]: tcpconn_new: on port 5060, type 2 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: [tcp_main.c:1403]: tcpconn_add: hashes: 1600:1269:0, 4 Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: [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: [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: [xavp.c:365]: destroying xavp list (nil) Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: [receive.c:293]: receive_msg: cleaning up Jun 21 11:53:29 ubuntu-desktop /usr/local/sbin/kamailio[11057]: DEBUG: [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: [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: [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: [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: [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: [tcp_main.c:4298]: tcp: DBG: sending to child, events 1 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: [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: [tcp_read.c:1358]: received n=4 con=0xb34f3538, fd=6 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: [tcp_read.c:1168]: tcp_read_req: content-length= 0 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: [parser/msg_parser.c:634]: SIP Reply (status): Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: [parser/msg_parser.c:636]: version: Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: [parser/msg_parser.c:638]: status: <200> Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: [parser/msg_parser.c:640]: reason: Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: [parser/parse_via.c:1286]: Found param type 232, = ; state=6 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: [parser/parse_via.c:1286]: Found param type 236, = <3>; state=16 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: [parser/parse_via.c:2561]: end of header reached, state=5 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: [parser/msg_parser.c:511]: parse_headers: Via found, flags=2 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: [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: [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: [parser/parse_via.c:1286]: Found param type 235, = <64935>; state=6 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: [parser/parse_via.c:1286]: Found param type 232, = ; state=16 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: [parser/parse_via.c:2561]: end of header reached, state=5 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: [parser/msg_parser.c:511]: parse_headers: Via found, flags=22 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: [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: [parser/parse_to.c:178]: DEBUG: add_param: tag=12730 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: [parser/parse_to.c:802]: end of header reached, state=29 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: [parser/msg_parser.c:188]: DEBUG: get_hdr_field: [44]; uri=[sip:sard7@43.88.79.137] Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: [parser/msg_parser.c:190]: DEBUG: to body ["sard7" ] Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: [parser/msg_parser.c:168]: get_hdr_field: cseq : <20> 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: [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: [parser/msg_parser.c:104]: found end of header Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: [msg_translator.c:1933]: old size: 337, new size: 272 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: [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: ;tag=29636#015#012To: "sard7" ;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: [mem/shm_mem.c:111]: WARNING:vqm_resize: resize(0) called Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: [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: [tcp_main.c:2343]: tcp_send, c= 0xb34f0b90, n=8 Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: [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: [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: [tcp_main.c:2552]: tcp_send: sending... Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: [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: [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: ;tag=29636#015#012To: "sard7" ;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: [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: [xavp.c:365]: destroying xavp list (nil) Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: [receive.c:293]: receive_msg: cleaning up Jun 21 11:53:30 ubuntu-desktop /usr/local/sbin/kamailio[11054]: DEBUG: [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: [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: [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: [tcp_read.c:1286]: extra_data (nil) Jun 21 11:53:35 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: [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: [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: [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: [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: [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: [tcp_read.c:1286]: extra_data (nil) Jun 21 11:53:36 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: [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: [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: [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: [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: [tcp_main.c:4298]: tcp: DBG: sending to child, events 1 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: [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: [tcp_read.c:1358]: received n=4 con=0xb34ef8a0, fd=6 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [tcp_read.c:1168]: tcp_read_req: content-length= 5 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/msg_parser.c:624]: SIP Request: Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/msg_parser.c:626]: method: Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/msg_parser.c:628]: uri: Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/msg_parser.c:630]: version: Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/parse_via.c:1286]: Found param type 235, = ; state=6 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/parse_via.c:1286]: Found param type 232, = ; state=16 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/parse_via.c:2561]: end of header reached, state=5 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/msg_parser.c:511]: parse_headers: Via found, flags=2 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [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: [receive.c:149]: After parse_msg... Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [receive.c:190]: preparing to run routing scripts... Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/parse_to.c:802]: end of header reached, state=10 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/msg_parser.c:188]: DEBUG: get_hdr_field: [34]; uri=[sip:sard4@43.88.79.137] Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/msg_parser.c:190]: DEBUG: to body ["sard4" #015#012] Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/msg_parser.c:168]: get_hdr_field: cseq : <20> 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: [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: [parser/msg_parser.c:104]: found end of header Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/parse_to.c:178]: DEBUG: add_param: tag=17990 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [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: [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: [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: [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: [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: [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: [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: [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: [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: [tcp_main.c:1089]: tcpconn_new: on port 5060, type 2 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [tcp_main.c:1403]: tcpconn_add: hashes: 2555:2894:0, 5 Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [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: [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: [xavp.c:365]: destroying xavp list (nil) Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [receive.c:293]: receive_msg: cleaning up Jun 21 11:54:03 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [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: [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: [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: [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: [tcp_read.c:1168]: tcp_read_req: content-length= 5 Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/msg_parser.c:624]: SIP Request: Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/msg_parser.c:626]: method: Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/msg_parser.c:628]: uri: Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/msg_parser.c:630]: version: Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/parse_via.c:1286]: Found param type 235, = ; state=6 Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/parse_via.c:1286]: Found param type 232, = ; state=16 Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/parse_via.c:2561]: end of header reached, state=5 Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/msg_parser.c:511]: parse_headers: Via found, flags=2 Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [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: [receive.c:149]: After parse_msg... Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [receive.c:190]: preparing to run routing scripts... Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/parse_to.c:802]: end of header reached, state=10 Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/msg_parser.c:188]: DEBUG: get_hdr_field: [34]; uri=[sip:sard4@43.88.79.137] Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/msg_parser.c:190]: DEBUG: to body ["sard4" #015#012] Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/msg_parser.c:168]: get_hdr_field: cseq : <20> 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: [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: [parser/msg_parser.c:104]: found end of header Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [parser/parse_to.c:178]: DEBUG: add_param: tag=17990 Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [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: [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: [xavp.c:365]: destroying xavp list (nil) Jun 21 11:54:04 ubuntu-desktop /usr/local/sbin/kamailio[11055]: DEBUG: [receive.c:293]: receive_msg: cleaning up Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: [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: [tcp_main.c:4298]: tcp: DBG: sending to child, events 1 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: [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: [tcp_read.c:1358]: received n=4 con=0xb34f4f58, fd=6 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [tcp_read.c:1168]: tcp_read_req: content-length= 0 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [parser/msg_parser.c:634]: SIP Reply (status): Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [parser/msg_parser.c:636]: version: Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [parser/msg_parser.c:638]: status: <480> Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [parser/msg_parser.c:640]: reason: Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [parser/parse_via.c:1286]: Found param type 232, = ; state=6 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [parser/parse_via.c:1286]: Found param type 236, = <2>; state=16 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [parser/parse_via.c:2561]: end of header reached, state=5 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [parser/msg_parser.c:511]: parse_headers: Via found, flags=2 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [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: [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: [parser/parse_via.c:1286]: Found param type 235, = <60840>; state=6 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [parser/parse_via.c:1286]: Found param type 232, = ; state=16 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [parser/parse_via.c:2561]: end of header reached, state=5 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [parser/msg_parser.c:511]: parse_headers: Via found, flags=22 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [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: [parser/parse_to.c:178]: DEBUG: add_param: tag=278a8a835a2e4f92aca1f8bc3899ef93 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [parser/parse_to.c:802]: end of header reached, state=29 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [parser/msg_parser.c:188]: DEBUG: get_hdr_field: [71]; uri=[sip:sard4@43.88.79.137] Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [parser/msg_parser.c:190]: DEBUG: to body ["sard4" ] Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [parser/msg_parser.c:168]: get_hdr_field: cseq : <20> 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: [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: [parser/msg_parser.c:104]: found end of header Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [msg_translator.c:1933]: old size: 343, new size: 279 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [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: ;tag=17990#015#012To: "sard4" ;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: [mem/shm_mem.c:111]: WARNING:vqm_resize: resize(0) called Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [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: [tcp_main.c:2343]: tcp_send, c= 0xb34ef8a0, n=8 Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: [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: [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: [tcp_main.c:2552]: tcp_send: sending... Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [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: [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: ;tag=17990#015#012To: "sard4" ;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: [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: [xavp.c:365]: destroying xavp list (nil) Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [receive.c:293]: receive_msg: cleaning up Jun 21 11:54:07 ubuntu-desktop /usr/local/sbin/kamailio[11056]: DEBUG: [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: [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: [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: [tcp_read.c:1286]: extra_data (nil) Jun 21 11:54:10 ubuntu-desktop /usr/local/sbin/kamailio[11058]: DEBUG: [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: [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: [tcp_main.c:3511]: handle_tcp_child: CONN_RELEASE 0xb34ef8a0 refcnt= 1