[sr-dev] [kamailio/kamailio] http_async_client frees pointer twice(Kamailio 5.0.4) (#1340)

arik notifications at github.com
Tue Nov 28 09:54:24 CET 2017


Attached

 

From: Federico Cabiddu <notifications at github.com>
Reply-To: kamailio/kamailio <reply at reply.github.com>
Date: Tuesday, 28 November 2017 at 10:42
To: kamailio/kamailio <kamailio at noreply.github.com>
Cc: arik <arik.halperin at gmail.com>, Author <author at noreply.github.com>
Subject: Re: [kamailio/kamailio] http_async_client frees pointer twice(Kamailio 5.0.4) (#1340)

 

Could please provide more logs (possible at debug level) and a description of when this happens?
Always? upon a failure? In the http reply route?
Also, not related, I see that in $var(re_url) you are missing "http://".

—
You are receiving this because you authored the thread.
Reply to this email directly, view it on GitHub, or mute the thread.


Nov 28 08:46:19 tm-kamailio-ingress kamailio[875]: 26(940) DEBUG: <core> [core/io_wait.h:380]: io_watch_add(): DBG: io_watch_add(0xa4eb40, 46, 4, 0x7fe0ddbbc708), fd_no=15
Nov 28 08:46:19 tm-kamailio-ingress kamailio[875]: 26(940) DEBUG: <core> [core/io_wait.h:380]: io_watch_add(): DBG: io_watch_add(0xa4eb40, 50, 4, 0x7fe0ddbbc794), fd_no=16
Nov 28 08:46:19 tm-kamailio-ingress kamailio[875]: 26(940) DEBUG: <core> [core/io_wait.h:380]: io_watch_add(): DBG: io_watch_add(0xa4eb40, 54, 4, 0x7fe0ddbbc820), fd_no=17
Nov 28 08:46:19 tm-kamailio-ingress kamailio[875]: 26(940) DEBUG: <core> [core/io_wait.h:380]: io_watch_add(): DBG: io_watch_add(0xa4eb40, 58, 4, 0x7fe0ddbbc8ac), fd_no=18
Nov 28 08:46:19 tm-kamailio-ingress kamailio[875]: 26(940) DEBUG: <core> [core/io_wait.h:380]: io_watch_add(): DBG: io_watch_add(0xa4eb40, 62, 4, 0x7fe0ddbbc938), fd_no=19
Nov 28 08:46:19 tm-kamailio-ingress kamailio[875]: 26(940) DEBUG: <core> [core/io_wait.h:380]: io_watch_add(): DBG: io_watch_add(0xa4eb40, 66, 4, 0x7fe0ddbbc9c4), fd_no=20
Nov 28 08:46:19 tm-kamailio-ingress kamailio[875]: 26(940) DEBUG: <core> [core/io_wait.h:380]: io_watch_add(): DBG: io_watch_add(0xa4eb40, 70, 4, 0x7fe0ddbbca50), fd_no=21
Nov 28 08:46:19 tm-kamailio-ingress kamailio[875]: 26(940) DEBUG: <core> [core/io_wait.h:380]: io_watch_add(): DBG: io_watch_add(0xa4eb40, 71, 4, 0x7fe0ddbbcadc), fd_no=22
Nov 28 08:46:19 tm-kamailio-ingress kamailio[875]: 26(940) DEBUG: <core> [core/io_wait.h:380]: io_watch_add(): DBG: io_watch_add(0xa4eb40, 72, 4, 0x7fe0ddbbcb68), fd_no=23
Nov 28 08:46:19 tm-kamailio-ingress kamailio[875]: 26(940) DEBUG: <core> [core/io_wait.h:380]: io_watch_add(): DBG: io_watch_add(0xa4eb40, 73, 4, 0x7fe0ddbbcbf4), fd_no=24
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [core/parser/msg_parser.c:600]: parse_msg(): SIP Request:
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [core/parser/msg_parser.c:602]: parse_msg():  method:  <REGISTER>
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [core/parser/msg_parser.c:604]: parse_msg():  uri:     <sip:138.197.183.92:5099>
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [core/parser/msg_parser.c:606]: parse_msg():  version: <SIP/2.0>
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=6
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPjAwS7kvUGVJxZEzvLNzmwJf4AN43bYSnn>; state=16
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of header reached, state=5
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [core/parser/msg_parser.c:491]: parse_headers(): Via found, flags=2
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [core/parser/msg_parser.c:493]: parse_headers(): this is the first via
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=10
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [core/parser/msg_parser.c:171]: get_hdr_field(): <To> [27]; uri=[sip:1004 at 138.197.183.92]
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [core/parser/msg_parser.c:172]: get_hdr_field(): to body [<sip:1004 at 138.197.183.92>
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]: ]
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [core/parser/msg_parser.c:152]: get_hdr_field(): cseq <CSeq>: <28636> <REGISTER>
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [core/receive.c:186]: receive_msg(): --- received sip message - request - call-id: [Tur2OzFG4u2Gmf.9TTWPx5hjyv6YbDoq] - cseq: [28636 REGISTER]
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [core/receive.c:234]: receive_msg(): preparing to run routing scripts...
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=485 a=5 n=route
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=624 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=619 a=25 n=mf_process_maxfwd_header
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: maxfwd [mf_funcs.c:76]: is_maxfwd_present(): value = 70
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=629 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=624 a=25 n=is_method
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=633 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=629 a=26 n=sanity_check
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [core/parser/msg_parser.c:183]: get_hdr_field(): content_length=0
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [core/parser/msg_parser.c:89]: get_hdr_field(): found end of header
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [core/parser/parse_addr_spec.c:185]: parse_to_param(): add param: tag=G.Lmpz.KMTY-9-Tp7YDRBTxzKBuqxKZZ
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=29
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: sanity [sanity_mod.c:256]: w_sanity_check(): sanity checks result: 1
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=487 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) ALERT: <script>: PSTN Destination is :<null> Walla!!!
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=489 a=63 n=assign
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=492 a=5 n=route
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=815 a=55 n=force_rport
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=827 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=816 a=25 n=nat_uac_test
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [core/msg_translator.c:159]: check_via_address(): (82.80.164.63, 10.0.0.28, 0)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=823 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=817 a=25 n=is_method
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=818 a=24 n=fix_nated_register
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=824 a=39 n=setflag
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=827 a=2 n=return
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=503 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=494 a=25 n=is_present_hf
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=509 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=503 a=25 n=is_method
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=504 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) ERROR: <script>: 1111 Routing to register 1(895) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=505 a=5 n=route
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[REGISTER] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1032 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[REGISTER] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1030 a=25 n=save
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [sruid.c:182]: sruid_next(): new sruid is [uloc-5a1d225b-37f-1] (1 / 19)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: registrar [save.c:410]: pack_ci(): generated ruid is: uloc-5a1d225b-37f-1
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [sruid.c:182]: sruid_next(): new sruid is [uloc-5a1d225b-37f-2] (2 / 19)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: registrar [save.c:410]: pack_ci(): generated ruid is: uloc-5a1d225b-37f-2
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: registrar [reply.c:377]: build_contact(): created Contact HF: Contact: <sip:1004 at 82.80.164.63:44927;ob>;expires=163;received="sip:82.80.164.63:44927", <sip:1004 at 10.0.0.28:44927;ob>;expires=300;received="sip:82.80.164.63:44927"
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: sl [sl.c:282]: send_reply(): reply in stateless mode (sl)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[REGISTER] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1032 a=5 n=route
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1039 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) ERROR: <script>: 1111 PUSHJOIN 1(895) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1040 a=63 n=assign
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1041 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) ERROR: <script>: 1111 locking 1004 1(895) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1042 a=25 n=lock
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: cfgutils [cfgutils.c:661]: cfg_lock_helper(): cfg_lock mode 0 on 535 (1004)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1043 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) ERROR: <script>: 1111 Getting vars 1(895) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1044 a=63 n=assign
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1045 a=63 n=assign
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1046 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) ERROR: <script>: 1111 tU=1004 0 0 1(895) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1047 a=63 n=assign
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: htable [ht_var.c:89]: pv_set_ht_cell(): set value for $sht(vtp=>join::1004)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1048 a=25 n=unlock
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: cfgutils [cfgutils.c:661]: cfg_lock_helper(): cfg_lock mode 1 on 535 (1004)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1056 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1051 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) ERROR: <script>: 1111 ts_append location 1004 1(895) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1054 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1054 a=2 n=return
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) exec: *** cfgtrace:request_route=[REGISTER] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1033 a=2 n=exit
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [core/receive.c:275]: receive_msg(): request-route executed in: 1003 usec
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [core/usr_avp.c:631]: destroy_avp_list(): destroying list 0x7fe0ddbf8330
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [core/usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]: message repeated 4 times: [  1(895) DEBUG: <core> [core/usr_avp.c:631]: destroy_avp_list(): destroying list (nil)]
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [core/xavp.c:446]: xavp_destroy_list(): destroying xavp list (nil)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  1(895) DEBUG: <core> [core/receive.c:364]: receive_msg(): cleaning up
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [core/parser/msg_parser.c:600]: parse_msg(): SIP Request:
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [core/parser/msg_parser.c:602]: parse_msg():  method:  <REGISTER>
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [core/parser/msg_parser.c:604]: parse_msg():  uri:     <sip:138.197.183.92:5099>
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [core/parser/msg_parser.c:606]: parse_msg():  version: <SIP/2.0>
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=6
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPjy.9YUHv9K0zq6Qz8AKdFk-r01iE4pNMC>; state=16
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of header reached, state=5
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [core/parser/msg_parser.c:491]: parse_headers(): Via found, flags=2
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [core/parser/msg_parser.c:493]: parse_headers(): this is the first via
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=10
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [core/parser/msg_parser.c:171]: get_hdr_field(): <To> [27]; uri=[sip:1004 at 138.197.183.92]
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [core/parser/msg_parser.c:172]: get_hdr_field(): to body [<sip:1004 at 138.197.183.92>
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]: ]
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [core/parser/msg_parser.c:152]: get_hdr_field(): cseq <CSeq>: <28637> <REGISTER>
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [core/receive.c:186]: receive_msg(): --- received sip message - request - call-id: [Tur2OzFG4u2Gmf.9TTWPx5hjyv6YbDoq] - cseq: [28637 REGISTER]
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [core/receive.c:234]: receive_msg(): preparing to run routing scripts...
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=485 a=5 n=route
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=624 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=619 a=25 n=mf_process_maxfwd_header
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: maxfwd [mf_funcs.c:76]: is_maxfwd_present(): value = 70
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=629 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=624 a=25 n=is_method
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=633 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=629 a=26 n=sanity_check
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [core/parser/msg_parser.c:183]: get_hdr_field(): content_length=0
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [core/parser/msg_parser.c:89]: get_hdr_field(): found end of header
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [core/parser/parse_addr_spec.c:185]: parse_to_param(): add param: tag=XgTDfqhjtcTotD3jDPFxsO2ppY7S-m8E
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=29
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: sanity [sanity_mod.c:256]: w_sanity_check(): sanity checks result: 1
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=487 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) ALERT: <script>: PSTN Destination is :<null> Walla!!!
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=489 a=63 n=assign
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=492 a=5 n=route
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=815 a=55 n=force_rport
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=827 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=816 a=25 n=nat_uac_test
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [core/msg_translator.c:159]: check_via_address(): (82.80.164.63, 10.0.0.28, 0)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=823 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=817 a=25 n=is_method
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=818 a=24 n=fix_nated_register
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=824 a=39 n=setflag
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=827 a=2 n=return
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=503 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=494 a=25 n=is_present_hf
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=509 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=503 a=25 n=is_method
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=504 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) ERROR: <script>: 1111 Routing to register 2(896) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=505 a=5 n=route
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[REGISTER] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1032 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[REGISTER] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1030 a=25 n=save
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [sruid.c:182]: sruid_next(): new sruid is [uloc-5a1d225b-380-1] (1 / 19)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: registrar [save.c:410]: pack_ci(): generated ruid is: uloc-5a1d225b-380-1
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [sruid.c:182]: sruid_next(): new sruid is [uloc-5a1d225b-380-2] (2 / 19)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: registrar [save.c:410]: pack_ci(): generated ruid is: uloc-5a1d225b-380-2
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [sruid.c:182]: sruid_next(): new sruid is [uloc-5a1d225b-380-3] (3 / 19)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: registrar [save.c:410]: pack_ci(): generated ruid is: uloc-5a1d225b-380-3
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: registrar [reply.c:377]: build_contact(): created Contact HF: Contact: <sip:1004 at 82.80.164.63:44927;ob>;expires=300;received="sip:82.80.164.63:44927"
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: sl [sl.c:282]: send_reply(): reply in stateless mode (sl)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[REGISTER] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1032 a=5 n=route
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1039 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) ERROR: <script>: 1111 PUSHJOIN 2(896) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1040 a=63 n=assign
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1041 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) ERROR: <script>: 1111 locking 1004 2(896) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1042 a=25 n=lock
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: cfgutils [cfgutils.c:661]: cfg_lock_helper(): cfg_lock mode 0 on 535 (1004)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1043 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) ERROR: <script>: 1111 Getting vars 2(896) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1044 a=63 n=assign
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1045 a=63 n=assign
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1046 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) ERROR: <script>: 1111 tU=1004 0 0 2(896) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1047 a=63 n=assign
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: htable [ht_var.c:89]: pv_set_ht_cell(): set value for $sht(vtp=>join::1004)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1048 a=25 n=unlock
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: cfgutils [cfgutils.c:661]: cfg_lock_helper(): cfg_lock mode 1 on 535 (1004)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1056 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1051 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) ERROR: <script>: 1111 ts_append location 1004 2(896) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1054 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1054 a=2 n=return
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) exec: *** cfgtrace:request_route=[REGISTER] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1033 a=2 n=exit
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [core/receive.c:275]: receive_msg(): request-route executed in: 916 usec
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [core/usr_avp.c:631]: destroy_avp_list(): destroying list 0x7fe0ddbf8330
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [core/usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]: message repeated 4 times: [  2(896) DEBUG: <core> [core/usr_avp.c:631]: destroy_avp_list(): destroying list (nil)]
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [core/xavp.c:446]: xavp_destroy_list(): destroying xavp list (nil)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  2(896) DEBUG: <core> [core/receive.c:364]: receive_msg(): cleaning up
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [core/parser/msg_parser.c:600]: parse_msg(): SIP Request:
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [core/parser/msg_parser.c:602]: parse_msg():  method:  <REGISTER>
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [core/parser/msg_parser.c:604]: parse_msg():  uri:     <sip:138.197.183.92:5099>
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [core/parser/msg_parser.c:606]: parse_msg():  version: <SIP/2.0>
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=6
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPjxhu8S1NJyydfxy.gwPrfe.Vr10wihm5q>; state=16
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of header reached, state=5
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [core/parser/msg_parser.c:491]: parse_headers(): Via found, flags=2
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [core/parser/msg_parser.c:493]: parse_headers(): this is the first via
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=10
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [core/parser/msg_parser.c:171]: get_hdr_field(): <To> [27]; uri=[sip:1004 at 138.197.183.92]
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [core/parser/msg_parser.c:172]: get_hdr_field(): to body [<sip:1004 at 138.197.183.92>
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]: ]
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [core/parser/msg_parser.c:152]: get_hdr_field(): cseq <CSeq>: <28638> <REGISTER>
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [core/receive.c:186]: receive_msg(): --- received sip message - request - call-id: [Tur2OzFG4u2Gmf.9TTWPx5hjyv6YbDoq] - cseq: [28638 REGISTER]
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [core/receive.c:234]: receive_msg(): preparing to run routing scripts...
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=485 a=5 n=route
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=624 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=619 a=25 n=mf_process_maxfwd_header
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: maxfwd [mf_funcs.c:76]: is_maxfwd_present(): value = 70
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=629 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=624 a=25 n=is_method
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=633 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=629 a=26 n=sanity_check
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [core/parser/msg_parser.c:183]: get_hdr_field(): content_length=0
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [core/parser/msg_parser.c:89]: get_hdr_field(): found end of header
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [core/parser/parse_addr_spec.c:185]: parse_to_param(): add param: tag=5.O8JiVt-kHYaFKlgIlmNXnLKirX8K1X
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=29
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: sanity [sanity_mod.c:256]: w_sanity_check(): sanity checks result: 1
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=487 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) ALERT: <script>: PSTN Destination is :<null> Walla!!!
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=489 a=63 n=assign
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=492 a=5 n=route
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=815 a=55 n=force_rport
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=827 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=816 a=25 n=nat_uac_test
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [core/msg_translator.c:159]: check_via_address(): (82.80.164.63, 10.0.0.28, 0)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=823 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=817 a=25 n=is_method
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=818 a=24 n=fix_nated_register
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=824 a=39 n=setflag
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=827 a=2 n=return
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=503 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=494 a=25 n=is_present_hf
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=509 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=503 a=25 n=is_method
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=504 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) ERROR: <script>: 1111 Routing to register 4(898) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=505 a=5 n=route
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[REGISTER] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1032 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[REGISTER] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1030 a=25 n=save
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [sruid.c:182]: sruid_next(): new sruid is [uloc-5a1d225b-382-1] (1 / 19)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: registrar [save.c:410]: pack_ci(): generated ruid is: uloc-5a1d225b-382-1
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [sruid.c:182]: sruid_next(): new sruid is [uloc-5a1d225b-382-2] (2 / 19)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: registrar [save.c:410]: pack_ci(): generated ruid is: uloc-5a1d225b-382-2
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: sl [sl.c:282]: send_reply(): reply in stateless mode (sl)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[REGISTER] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1032 a=5 n=route
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1039 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) ERROR: <script>: 1111 PUSHJOIN 4(898) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1040 a=63 n=assign
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1041 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) ERROR: <script>: 1111 locking 1004 4(898) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1042 a=25 n=lock
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: cfgutils [cfgutils.c:661]: cfg_lock_helper(): cfg_lock mode 0 on 535 (1004)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1043 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) ERROR: <script>: 1111 Getting vars 4(898) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1044 a=63 n=assign
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1045 a=63 n=assign
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1046 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) ERROR: <script>: 1111 tU=1004 0 0 4(898) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1047 a=63 n=assign
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: htable [ht_var.c:89]: pv_set_ht_cell(): set value for $sht(vtp=>join::1004)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1048 a=25 n=unlock
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: cfgutils [cfgutils.c:661]: cfg_lock_helper(): cfg_lock mode 1 on 535 (1004)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1056 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1051 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) ERROR: <script>: 1111 ts_append location 1004 4(898) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1054 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1054 a=2 n=return
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) exec: *** cfgtrace:request_route=[REGISTER] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1033 a=2 n=exit
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [core/receive.c:275]: receive_msg(): request-route executed in: 699 usec
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [core/usr_avp.c:631]: destroy_avp_list(): destroying list 0x7fe0ddbf8330
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [core/usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]: message repeated 4 times: [  4(898) DEBUG: <core> [core/usr_avp.c:631]: destroy_avp_list(): destroying list (nil)]
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [core/xavp.c:446]: xavp_destroy_list(): destroying xavp list (nil)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  4(898) DEBUG: <core> [core/receive.c:364]: receive_msg(): cleaning up
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [core/parser/msg_parser.c:600]: parse_msg(): SIP Request:
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [core/parser/msg_parser.c:602]: parse_msg():  method:  <REGISTER>
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [core/parser/msg_parser.c:604]: parse_msg():  uri:     <sip:138.197.183.92:5099>
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [core/parser/msg_parser.c:606]: parse_msg():  version: <SIP/2.0>
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=6
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPjDWS8IcXcvUNOnJUhXXMw-KGgm2hzFpx6>; state=16
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of header reached, state=5
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [core/parser/msg_parser.c:491]: parse_headers(): Via found, flags=2
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [core/parser/msg_parser.c:493]: parse_headers(): this is the first via
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=10
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [core/parser/msg_parser.c:171]: get_hdr_field(): <To> [27]; uri=[sip:1004 at 138.197.183.92]
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [core/parser/msg_parser.c:172]: get_hdr_field(): to body [<sip:1004 at 138.197.183.92>
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]: ]
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [core/parser/msg_parser.c:152]: get_hdr_field(): cseq <CSeq>: <64607> <REGISTER>
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [core/receive.c:186]: receive_msg(): --- received sip message - request - call-id: [Cjbi-NxKv7jmg8-AUJMnectUWIUgz7i4] - cseq: [64607 REGISTER]
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [core/receive.c:234]: receive_msg(): preparing to run routing scripts...
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=485 a=5 n=route
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=624 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=619 a=25 n=mf_process_maxfwd_header
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: maxfwd [mf_funcs.c:76]: is_maxfwd_present(): value = 70
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=629 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=624 a=25 n=is_method
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=633 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=629 a=26 n=sanity_check
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [core/parser/msg_parser.c:183]: get_hdr_field(): content_length=0
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [core/parser/msg_parser.c:89]: get_hdr_field(): found end of header
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [core/parser/parse_addr_spec.c:185]: parse_to_param(): add param: tag=I9AB-K-2W1QbfB9xq1AFnCUo2v0TAuEW
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=29
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: sanity [sanity_mod.c:256]: w_sanity_check(): sanity checks result: 1
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=487 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) ALERT: <script>: PSTN Destination is :<null> Walla!!!
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=489 a=63 n=assign
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=492 a=5 n=route
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=815 a=55 n=force_rport
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=827 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=816 a=25 n=nat_uac_test
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [core/msg_translator.c:159]: check_via_address(): (82.80.164.63, 10.0.0.28, 0)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=823 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=817 a=25 n=is_method
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=818 a=24 n=fix_nated_register
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=824 a=39 n=setflag
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=827 a=2 n=return
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=503 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=494 a=25 n=is_present_hf
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=509 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=503 a=25 n=is_method
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=504 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) ERROR: <script>: 1111 Routing to register 3(897) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=505 a=5 n=route
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[REGISTER] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1032 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[REGISTER] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1030 a=25 n=save
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [sruid.c:182]: sruid_next(): new sruid is [uloc-5a1d225b-381-1] (1 / 19)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: registrar [save.c:410]: pack_ci(): generated ruid is: uloc-5a1d225b-381-1
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [sruid.c:182]: sruid_next(): new sruid is [uloc-5a1d225b-381-2] (2 / 19)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: registrar [save.c:410]: pack_ci(): generated ruid is: uloc-5a1d225b-381-2
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: registrar [reply.c:377]: build_contact(): created Contact HF: Contact: <sip:1004 at 10.0.0.28:44927;ob>;expires=300;received="sip:82.80.164.63:44927"
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: sl [sl.c:282]: send_reply(): reply in stateless mode (sl)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[REGISTER] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1032 a=5 n=route
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1039 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) ERROR: <script>: 1111 PUSHJOIN 3(897) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1040 a=63 n=assign
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1041 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) ERROR: <script>: 1111 locking 1004 3(897) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1042 a=25 n=lock
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: cfgutils [cfgutils.c:661]: cfg_lock_helper(): cfg_lock mode 0 on 535 (1004)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1043 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) ERROR: <script>: 1111 Getting vars 3(897) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1044 a=63 n=assign
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1045 a=63 n=assign
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1046 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) ERROR: <script>: 1111 tU=1004 0 0 3(897) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1047 a=63 n=assign
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: htable [ht_var.c:89]: pv_set_ht_cell(): set value for $sht(vtp=>join::1004)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1048 a=25 n=unlock
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: cfgutils [cfgutils.c:661]: cfg_lock_helper(): cfg_lock mode 1 on 535 (1004)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1056 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1051 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) ERROR: <script>: 1111 ts_append location 1004 3(897) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1054 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1054 a=2 n=return
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) exec: *** cfgtrace:request_route=[REGISTER] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1033 a=2 n=exit
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [core/receive.c:275]: receive_msg(): request-route executed in: 871 usec
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [core/usr_avp.c:631]: destroy_avp_list(): destroying list 0x7fe0ddbf8330
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [core/usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]: message repeated 4 times: [  3(897) DEBUG: <core> [core/usr_avp.c:631]: destroy_avp_list(): destroying list (nil)]
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [core/xavp.c:446]: xavp_destroy_list(): destroying xavp list (nil)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  3(897) DEBUG: <core> [core/receive.c:364]: receive_msg(): cleaning up
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: <core> [core/parser/msg_parser.c:600]: parse_msg(): SIP Request:
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: <core> [core/parser/msg_parser.c:602]: parse_msg():  method:  <REGISTER>
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: <core> [core/parser/msg_parser.c:604]: parse_msg():  uri:     <sip:138.197.183.92:5099>
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: <core> [core/parser/msg_parser.c:606]: parse_msg():  version: <SIP/2.0>
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=6
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPjdYeHjHbPlejp7Tx7ZNXGoyerlhQ3Jmqg>; state=16
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of header reached, state=5
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: <core> [core/parser/msg_parser.c:491]: parse_headers(): Via found, flags=2
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: <core> [core/parser/msg_parser.c:493]: parse_headers(): this is the first via
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=10
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: <core> [core/parser/msg_parser.c:171]: get_hdr_field(): <To> [27]; uri=[sip:1004 at 138.197.183.92]
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: <core> [core/parser/msg_parser.c:172]: get_hdr_field(): to body [<sip:1004 at 138.197.183.92>
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]: ]
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: <core> [core/parser/msg_parser.c:152]: get_hdr_field(): cseq <CSeq>: <64608> <REGISTER>
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: <core> [core/receive.c:186]: receive_msg(): --- received sip message - request - call-id: [Cjbi-NxKv7jmg8-AUJMnectUWIUgz7i4] - cseq: [64608 REGISTER]
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: <core> [core/receive.c:234]: receive_msg(): preparing to run routing scripts...
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=485 a=5 n=route
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=624 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=619 a=25 n=mf_process_maxfwd_header
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: maxfwd [mf_funcs.c:76]: is_maxfwd_present(): value = 70
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=629 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=624 a=25 n=is_method
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=633 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[REQINIT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=629 a=26 n=sanity_check
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: <core> [core/parser/msg_parser.c:183]: get_hdr_field(): content_length=0
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: <core> [core/parser/msg_parser.c:89]: get_hdr_field(): found end of header
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: <core> [core/parser/parse_addr_spec.c:185]: parse_to_param(): add param: tag=Mxea3NowuFKGt5aiXRFWbC-jZgnJcqDR
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=29
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: sanity [sanity_mod.c:256]: w_sanity_check(): sanity checks result: 1
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=487 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) ALERT: <script>: PSTN Destination is :<null> Walla!!!
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=489 a=63 n=assign
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=492 a=5 n=route
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=815 a=55 n=force_rport
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=827 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=816 a=25 n=nat_uac_test
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: <core> [core/msg_translator.c:159]: check_via_address(): (82.80.164.63, 10.0.0.28, 0)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=823 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=817 a=25 n=is_method
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=818 a=24 n=fix_nated_register
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=824 a=39 n=setflag
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[NATDETECT] c=[/usr/local/etc/kamailio/kamailio.cfg] l=827 a=2 n=return
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=503 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=494 a=25 n=is_present_hf
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=509 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=503 a=25 n=is_method
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=504 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) ERROR: <script>: 1111 Routing to register 5(899) exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/etc/kamailio/kamailio.cfg] l=505 a=5 n=route
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[REGISTER] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1032 a=16 n=if
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[REGISTER] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1030 a=25 n=save
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: <core> [sruid.c:182]: sruid_next(): new sruid is [uloc-5a1d225b-383-1] (1 / 19)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: registrar [save.c:410]: pack_ci(): generated ruid is: uloc-5a1d225b-383-1
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: <core> [sruid.c:182]: sruid_next(): new sruid is [uloc-5a1d225b-383-2] (2 / 19)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: registrar [save.c:410]: pack_ci(): generated ruid is: uloc-5a1d225b-383-2
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: <core> [sruid.c:182]: sruid_next(): new sruid is [uloc-5a1d225b-383-3] (3 / 19)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: registrar [save.c:410]: pack_ci(): generated ruid is: uloc-5a1d225b-383-3
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: registrar [reply.c:377]: build_contact(): created Contact HF: Contact: <sip:1004 at 82.80.164.63:44927;ob>;expires=300;received="sip:82.80.164.63:44927"
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: sl [sl.c:282]: send_reply(): reply in stateless mode (sl)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[REGISTER] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1032 a=5 n=route
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1039 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) ERROR: <script>: 1111 PUSHJOIN 5(899) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1040 a=63 n=assign
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1041 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) ERROR: <script>: 1111 locking 1004 5(899) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1042 a=25 n=lock
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) DEBUG: cfgutils [cfgutils.c:661]: cfg_lock_helper(): cfg_lock mode 0 on 535 (1004)
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1043 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) ERROR: <script>: 1111 Getting vars 5(899) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1044 a=63 n=assign
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1045 a=63 n=assign
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) exec: *** cfgtrace:request_route=[PUSHJOIN] c=[/usr/local/etc/kamailio/kamailio.cfg] l=1046 a=26 n=xlog
Nov 28 08:46:43 tm-kamailio-ingress kamailio[875]:  5(899) ERROR: <script>: 1111 tU=1004 0 0 5(899) exec: *** cfgtrace:request_route=[PUSH

-- 
You are receiving this because you are subscribed to this thread.
Reply to this email directly or view it on GitHub:
https://github.com/kamailio/kamailio/issues/1340#issuecomment-347455108
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.kamailio.org/pipermail/sr-dev/attachments/20171128/78563003/attachment-0001.html>


More information about the sr-dev mailing list