Skip to content

Instantly share code, notes, and snippets.

@johnavp1989
Created July 4, 2016 16:29
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save johnavp1989/6ea392880a6fd9aaa4e4eded57819b6c to your computer and use it in GitHub Desktop.
Save johnavp1989/6ea392880a6fd9aaa4e4eded57819b6c to your computer and use it in GitHub Desktop.
Jul 4 12:22:30 s2 /usr/sbin/kamailio[16490]: DEBUG: <core> [parser/msg_parser.c:190]: get_hdr_field(): DEBUG: get_hdr_field: <To> [24]; uri=[sip:bwp.coredial.com]
Jul 4 12:22:30 s2 /usr/sbin/kamailio[16490]: DEBUG: <core> [parser/msg_parser.c:192]: get_hdr_field(): DEBUG: to body [<sip:bwp.coredial.com>#015#012]
Jul 4 12:22:30 s2 /usr/sbin/kamailio[16490]: DEBUG: <core> [parser/msg_parser.c:170]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <1> <OPTIONS>
Jul 4 12:22:30 s2 /usr/sbin/kamailio[16490]: DEBUG: <core> [parser/msg_parser.c:204]: get_hdr_field(): DEBUG: get_hdr_body : content_length=0
Jul 4 12:22:30 s2 /usr/sbin/kamailio[16490]: DEBUG: <core> [parser/msg_parser.c:106]: get_hdr_field(): found end of header
Jul 4 12:22:30 s2 /usr/sbin/kamailio[16490]: ERROR: *** cfgtrace:request_route=[OPTIONS] c=[/etc/kamailio/kamailio.cfg] l=217 a=2 n=exit
Jul 4 12:22:30 s2 /usr/sbin/kamailio[16490]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil)
Jul 4 12:22:30 s2 /usr/sbin/kamailio[16490]: message repeated 5 times: [ DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil)]
Jul 4 12:22:30 s2 /usr/sbin/kamailio[16490]: DEBUG: <core> [xavp.c:448]: xavp_destroy_list(): destroying xavp list (nil)
Jul 4 12:22:30 s2 /usr/sbin/kamailio[16490]: DEBUG: <core> [receive.c:298]: receive_msg(): receive_msg: cleaning up
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [parser/msg_parser.c:625]: parse_msg(): SIP Request:
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [parser/msg_parser.c:627]: parse_msg(): method: <INVITE>
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [parser/msg_parser.c:629]: parse_msg(): uri: <sip:+14444444444@s.core.com:5060>
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [parser/msg_parser.c:631]: parse_msg(): version: <SIP/2.0>
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK04Bdab71e422e25ac87>; state=16
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of header reached, state=5
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers(): parse_headers: Via found, flags=2
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [parser/msg_parser.c:515]: parse_headers(): parse_headers: this is the first via
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [receive.c:154]: receive_msg(): After parse_msg...
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [receive.c:197]: receive_msg(): preparing to run routing scripts...
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=144 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[BLACKLIST] c=[/etc/kamailio/kamailio.cfg] l=269 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[BLACKLIST] c=[/etc/kamailio/kamailio.cfg] l=264 a=25 n=allow_source_address
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: permissions [address.c:516]: allow_source_address(): looking for <2, 710de743, 5060>
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=146 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[WHITELIST] c=[/etc/kamailio/kamailio.cfg] l=278 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[WHITELIST] c=[/etc/kamailio/kamailio.cfg] l=273 a=25 n=allow_source_address
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: permissions [address.c:516]: allow_source_address(): looking for <1, 710de743, 5060>
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=149 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[OPTIONS] c=[/etc/kamailio/kamailio.cfg] l=219 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[OPTIONS] c=[/etc/kamailio/kamailio.cfg] l=215 a=25 n=is_method
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=152 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=208 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=203 a=25 n=mf_process_maxfwd_header
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [parser/parse_addr_spec.c:898]: parse_addr_spec(): end of header reached, state=10
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [parser/msg_parser.c:190]: get_hdr_field(): DEBUG: get_hdr_field: <To> [42]; uri=[sip:4444444444@s.core.com]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [parser/msg_parser.c:192]: get_hdr_field(): DEBUG: to body [<sip:4444444444@s.core.com>#015#012]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [parser/msg_parser.c:170]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <790554> <INVITE>
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: maxfwd [mf_funcs.c:85]: is_maxfwd_present(): value = 70
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=212 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=208 a=26 n=sanity_check
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [parser/msg_parser.c:204]: get_hdr_field(): DEBUG: get_hdr_body : content_length=282
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [parser/msg_parser.c:106]: get_hdr_field(): found end of header
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [parser/parse_addr_spec.c:176]: parse_to_param(): DEBUG: add_param: tag=gK04215262
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [parser/parse_addr_spec.c:898]: parse_addr_spec(): end of header reached, state=29
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: sanity [mod_sanity.c:255]: w_sanity_check(): sanity checks result: 1
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=157 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DETERMINE_DIRECTION] c=[/etc/kamailio/kamailio.cfg] l=347 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DETERMINE_DIRECTION] c=[/etc/kamailio/kamailio.cfg] l=343 a=24 n=allow_trusted
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DETERMINE_DIRECTION] c=[/etc/kamailio/kamailio.cfg] l=346 a=63 n=assign
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DETERMINE_DIRECTION] c=[/etc/kamailio/kamailio.cfg] l=348 a=26 n=xlog
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: INFO: <script>: KDM: in: 201634603_98039056@22.222.22.222
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=160 a=63 n=assign
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=161 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=987 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=984 a=26 n=xlog
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: pv [pv_core.c:823]: pv_get_useragent(): no User-Agent header
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: INFO: <script>: New Packet -- INVITE R-URI: sip:+14444444444@s.core.com:5060 From: sip:+12222222222@22.222.22.222;isup-oli=62 (22.222.22.222) To: sip:4444444444@s.core.com UA: <null> CID: 201634603_98039056@22.222.22.222
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=988 a=63 n=assign
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=164 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[CANCEL] c=[/etc/kamailio/kamailio.cfg] l=228 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[CANCEL] c=[/etc/kamailio/kamailio.cfg] l=222 a=25 n=is_method
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=167 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=260 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=233 a=24 n=has_totag
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: siputils [checks.c:103]: has_totag(): no totag
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=169 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[HANDLE_RETRANSMITS] c=[/etc/kamailio/kamailio.cfg] l=309 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[HANDLE_RETRANSMITS] c=[/etc/kamailio/kamailio.cfg] l=305 a=24 n=t_precheck_trans
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[HANDLE_RETRANSMITS] c=[/etc/kamailio/kamailio.cfg] l=309 a=24 n=t_check_trans
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg: msg id=8 global id=1 T start=0xffffffffffffffff
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: tm [t_lookup.c:527]: t_lookup_request(): t_lookup_request: start searching: hash=25619, isACK=0
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: tm [t_lookup.c:485]: matching_3261(): DEBUG: RFC3261 transaction matching failed
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: tm [t_lookup.c:709]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: tm [t_lookup.c:1141]: t_check_msg(): DEBUG: t_check_msg: msg id=8 global id=8 T end=(nil)
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=172 a=63 n=assign
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=173 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=987 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=984 a=26 n=xlog
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: pv [pv_core.c:823]: pv_get_useragent(): no User-Agent header
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: INFO: <script>: New Request -- INVITE R-URI: sip:+14444444444@s.core.com:5060 From: sip:+12222222222@22.222.22.222;isup-oli=62 (22.222.22.222) To: sip:4444444444@s.core.com UA: <null> CID: 201634603_98039056@22.222.22.222
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=988 a=63 n=assign
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=176 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[BOUNCE_UNDESIRABLES] c=[/etc/kamailio/kamailio.cfg] l=289 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[BOUNCE_UNDESIRABLES] c=[/etc/kamailio/kamailio.cfg] l=296 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[BOUNCE_UNDESIRABLES] c=[/etc/kamailio/kamailio.cfg] l=289 a=25 n=is_method
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[BOUNCE_UNDESIRABLES] c=[/etc/kamailio/kamailio.cfg] l=302 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[BOUNCE_UNDESIRABLES] c=[/etc/kamailio/kamailio.cfg] l=296 a=25 n=is_method
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=178 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RECORD_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=314 a=25 n=remove_hf
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RECORD_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=319 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RECORD_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=316 a=25 n=is_method
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RECORD_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=317 a=24 n=record_route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=183 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[SET_DESTINATION] c=[/etc/kamailio/kamailio.cfg] l=323 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DETERMINE_PLATFORM] c=[/etc/kamailio/kamailio.cfg] l=353 a=63 n=assign
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [re.c:448]: subst_run(): subst_run: running. r=0
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [re.c:469]: subst_run(): subst_run: matched (0, 12): [+14444444444]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DETERMINE_PLATFORM] c=[/etc/kamailio/kamailio.cfg] l=354 a=27 n=sql_xquery
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:118]: db_new_result(): allocate 56 bytes for result set at 0x7fd715b96f18
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:68]: db_mysql_get_columns(): 1 columns returned from the query
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:156]: db_allocate_columns(): allocate 8 bytes for result names at 0x7fd715b946a0
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:167]: db_allocate_columns(): allocate 4 bytes for result types at 0x7fd715b93a78
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:86]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[0] at 0x7fd715b96e98
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:93]: db_mysql_get_columns(): RES_NAMES(0x7fd715b96e98)[0]=[platform_id]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:101]: db_mysql_get_columns(): use DB1_INT result type
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:186]: db_allocate_rows(): allocate 16 bytes for rows at 0x7fd715b583a0
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_row.c:119]: db_allocate_row(): allocate 32 bytes for row values at 0x7fd715b58410
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_val.c:76]: db_str2val(): converting INT [4]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: sqlops [sql_api.c:525]: sql_exec_xquery(): Adding column: platform_id
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: sqlops [sql_api.c:531]: sql_exec_xquery(): Adding row
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:81]: db_free_columns(): freeing 1 columns
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:85]: db_free_columns(): freeing RES_NAMES[0] at 0x7fd715b96e98
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:94]: db_free_columns(): freeing result names at 0x7fd715b946a0
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:99]: db_free_columns(): freeing result types at 0x7fd715b93a78
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:54]: db_free_rows(): freeing 1 rows
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_row.c:97]: db_free_row(): freeing row values at 0x7fd715b58410
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:62]: db_free_rows(): freeing rows at 0x7fd715b583a0
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:136]: db_free_result(): freeing result set at 0x7fd715b96f18
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DETERMINE_PLATFORM] c=[/etc/kamailio/kamailio.cfg] l=359 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DETERMINE_PLATFORM] c=[/etc/kamailio/kamailio.cfg] l=356 a=26 n=xlog
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: INFO: <script>: KDM: platform_id is 4
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DETERMINE_PLATFORM] c=[/etc/kamailio/kamailio.cfg] l=357 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[MAP_PLATFORM_ID_TO_PLATFORM] c=[/etc/kamailio/kamailio.cfg] l=377 a=20 n=switch
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[MAP_PLATFORM_ID_TO_PLATFORM] c=[/etc/kamailio/kamailio.cfg] l=373 a=63 n=assign
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[MAP_PLATFORM_ID_TO_PLATFORM] c=[/etc/kamailio/kamailio.cfg] l=374 a=2 n=exit
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[SET_DESTINATION] c=[/etc/kamailio/kamailio.cfg] l=325 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DISCARD_UNKNOWN_INBOUND] c=[/etc/kamailio/kamailio.cfg] l=400 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[SET_DESTINATION] c=[/etc/kamailio/kamailio.cfg] l=329 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[GENERAL_CLEANUP] c=[/etc/kamailio/kamailio.cfg] l=404 a=26 n=xlog
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: INFO: <script>: JPD DBG: route[GENERAL_CLEANUP]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[GENERAL_CLEANUP] c=[/etc/kamailio/kamailio.cfg] l=417 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[GENERAL_CLEANUP] c=[/etc/kamailio/kamailio.cfg] l=425 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[GENERAL_CLEANUP] c=[/etc/kamailio/kamailio.cfg] l=425 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[SET_DESTINATION] c=[/etc/kamailio/kamailio.cfg] l=330 a=63 n=assign
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [re.c:448]: subst_run(): subst_run: running. r=0
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [re.c:469]: subst_run(): subst_run: matched (0, 12): [+12222222222]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[SET_DESTINATION] c=[/etc/kamailio/kamailio.cfg] l=331 a=26 n=xlog
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: INFO: <script>: JDP DBG: Source TN: 2222222222
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[SET_DESTINATION] c=[/etc/kamailio/kamailio.cfg] l=334 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[SET_DESTINATION] c=[/etc/kamailio/kamailio.cfg] l=333 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=442 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=430 a=25 n=t_on_branch
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=431 a=25 n=t_on_reply
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=432 a=25 n=t_on_failure
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=433 a=63 n=assign
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=434 a=27 n=sql_xquery
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:118]: db_new_result(): allocate 56 bytes for result set at 0x7fd715b96f18
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:68]: db_mysql_get_columns(): 10 columns returned from the query
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:156]: db_allocate_columns(): allocate 80 bytes for result names at 0x7fd715b58490
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:167]: db_allocate_columns(): allocate 40 bytes for result types at 0x7fd715b58540
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:86]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[0] at 0x7fd715b96e98
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:93]: db_mysql_get_columns(): RES_NAMES(0x7fd715b96e98)[0]=[id]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:101]: db_mysql_get_columns(): use DB1_INT result type
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:86]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[1] at 0x7fd715b58410
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:93]: db_mysql_get_columns(): RES_NAMES(0x7fd715b58410)[1]=[telephoneNumber]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:137]: db_mysql_get_columns(): use DB1_STRING result type
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:86]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[2] at 0x7fd715b585c8
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:93]: db_mysql_get_columns(): RES_NAMES(0x7fd715b585c8)[2]=[carrierRouteId]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:101]: db_mysql_get_columns(): use DB1_INT result type
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:86]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[3] at 0x7fd715b58638
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:93]: db_mysql_get_columns(): RES_NAMES(0x7fd715b58638)[3]=[resellerId]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:101]: db_mysql_get_columns(): use DB1_INT result type
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:86]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[4] at 0x7fd715b586a8
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:93]: db_mysql_get_columns(): RES_NAMES(0x7fd715b586a8)[4]=[branchId]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:101]: db_mysql_get_columns(): use DB1_INT result type
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:86]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[5] at 0x7fd715b577c0
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:93]: db_mysql_get_columns(): RES_NAMES(0x7fd715b577c0)[5]=[cnamDipAuthorized]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:101]: db_mysql_get_columns(): use DB1_INT result type
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:86]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[6] at 0x7fd715b57830
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:93]: db_mysql_get_columns(): RES_NAMES(0x7fd715b57830)[6]=[inboundHost]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:137]: db_mysql_get_columns(): use DB1_STRING result type
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:86]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[7] at 0x7fd715b578a0
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:93]: db_mysql_get_columns(): RES_NAMES(0x7fd715b578a0)[7]=[inboundPort]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:101]: db_mysql_get_columns(): use DB1_INT result type
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:86]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[8] at 0x7fd715b57910
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:93]: db_mysql_get_columns(): RES_NAMES(0x7fd715b57910)[8]=[routeMapDomestic]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:137]: db_mysql_get_columns(): use DB1_STRING result type
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:86]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[9] at 0x7fd715b57980
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:93]: db_mysql_get_columns(): RES_NAMES(0x7fd715b57980)[9]=[routeMapInternational]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: db_mysql [km_res.c:137]: db_mysql_get_columns(): use DB1_STRING result type
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:186]: db_allocate_rows(): allocate 16 bytes for rows at 0x7fd715b579f0
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_row.c:119]: db_allocate_row(): allocate 320 bytes for row values at 0x7fd715b57a60
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_val.c:76]: db_str2val(): converting INT [282700]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_val.c:120]: db_str2val(): converting STRING [4444444444]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_val.c:76]: db_str2val(): converting INT [30]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_val.c:76]: db_str2val(): converting INT [1]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: message repeated 2 times: [ DEBUG: <core> [db_val.c:76]: db_str2val(): converting INT [1]]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_val.c:57]: db_str2val(): converting NULL value
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: message repeated 3 times: [ DEBUG: <core> [db_val.c:57]: db_str2val(): converting NULL value]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: sqlops [sql_api.c:525]: sql_exec_xquery(): Adding column: routeMapInternational
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: sqlops [sql_api.c:525]: sql_exec_xquery(): Adding column: routeMapDomestic
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: sqlops [sql_api.c:525]: sql_exec_xquery(): Adding column: inboundPort
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: sqlops [sql_api.c:525]: sql_exec_xquery(): Adding column: inboundHost
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: sqlops [sql_api.c:525]: sql_exec_xquery(): Adding column: cnamDipAuthorized
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: sqlops [sql_api.c:525]: sql_exec_xquery(): Adding column: branchId
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: sqlops [sql_api.c:525]: sql_exec_xquery(): Adding column: resellerId
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: sqlops [sql_api.c:525]: sql_exec_xquery(): Adding column: carrierRouteId
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: sqlops [sql_api.c:525]: sql_exec_xquery(): Adding column: telephoneNumber
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: sqlops [sql_api.c:525]: sql_exec_xquery(): Adding column: id
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: sqlops [sql_api.c:531]: sql_exec_xquery(): Adding row
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:81]: db_free_columns(): freeing 10 columns
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:85]: db_free_columns(): freeing RES_NAMES[0] at 0x7fd715b96e98
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:85]: db_free_columns(): freeing RES_NAMES[1] at 0x7fd715b58410
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:85]: db_free_columns(): freeing RES_NAMES[2] at 0x7fd715b585c8
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:85]: db_free_columns(): freeing RES_NAMES[3] at 0x7fd715b58638
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:85]: db_free_columns(): freeing RES_NAMES[4] at 0x7fd715b586a8
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:85]: db_free_columns(): freeing RES_NAMES[5] at 0x7fd715b577c0
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:85]: db_free_columns(): freeing RES_NAMES[6] at 0x7fd715b57830
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:85]: db_free_columns(): freeing RES_NAMES[7] at 0x7fd715b578a0
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:85]: db_free_columns(): freeing RES_NAMES[8] at 0x7fd715b57910
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:85]: db_free_columns(): freeing RES_NAMES[9] at 0x7fd715b57980
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:94]: db_free_columns(): freeing result names at 0x7fd715b58490
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:99]: db_free_columns(): freeing result types at 0x7fd715b58540
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:54]: db_free_rows(): freeing 1 rows
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_row.c:97]: db_free_row(): freeing row values at 0x7fd715b57a60
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:62]: db_free_rows(): freeing rows at 0x7fd715b579f0
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [db_res.c:136]: db_free_result(): freeing result set at 0x7fd715b96f18
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=435 a=63 n=assign
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=436 a=26 n=append_branch
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=437 a=24 n=t_load_contacts
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: tm [t_serial.c:188]: t_load_contacts(): nr_branches is 1
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=438 a=24 n=t_next_contacts
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [xavp.c:448]: xavp_destroy_list(): destroying xavp list 0x7fd70c9c5538
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=439 a=24 n=t_relay
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: tm [t_lookup.c:1373]: t_newtran(): DEBUG: t_newtran: msg id=8 , global msg id=8 , T on entrance=(nil)
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: tm [t_lookup.c:527]: t_lookup_request(): t_lookup_request: start searching: hash=25619, isACK=0
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: tm [t_lookup.c:485]: matching_3261(): DEBUG: RFC3261 transaction matching failed
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: tm [t_lookup.c:709]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: tm [t_hooks.c:380]: run_reqin_callbacks_internal(): DBG: trans=0x7fd70c9cc6c0, callback type 1, id 0 entered
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [md5utils.c:67]: MD5StringArray(): DEBUG: MD5 calculated: e2f2772bed9e8a03a36bf76e27ccdf96
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: tm [t_funcs.c:348]: t_relay_to(): SER: new INVITE
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [msg_translator.c:206]: check_via_address(): check_via_address(22.222.22.222, 22.222.22.222, 0)
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [mem/shm_mem.c:111]: _shm_resize(): WARNING:vqm_resize: resize(0) called
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: tm [t_reply.c:728]: _reply_light(): DEBUG: reply sent out. buf=0x7fd715b57ce0: SIP/2.0 100 trying -..., shmem=0x7fd70c9cf378: SIP/2.0 100 trying -
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: tm [t_reply.c:738]: _reply_light(): DEBUG: _reply_light: finished
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:branch_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=445 a=63 n=assign
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:branch_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=446 a=25 n=uac_replace_from
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: uac [uac.c:454]: w_replace_from(): dsp=(nil) (len=0) , uri=0x7ffdb0092930 (len=29)
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: uac [replace.c:361]: replace_uri(): uri to replace [sip:+12222222222@22.222.22.222;isup-oli=62]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: uac [replace.c:362]: replace_uri(): replacement uri is [sip:+12222222222@sip.core.com]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: uac [replace.c:473]: replace_uri(): encode is=<AAAAAAAAAAAAAAAAAAAAAABFXl4cUF5cVB1NXlwzO2lzdXAtb2xpPTYy> len=56
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [forward.c:211]: get_out_socket(): DEBUG: get_out_socket: socket determined: 0x7fd715b974e8
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [msg_translator.c:206]: check_via_address(): check_via_address(22.222.22.222, 22.222.22.222, 0)
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: tm [t_funcs.c:395]: t_relay_to(): SER: new transaction fwd'ed
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=440 a=2 n=exit
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[SET_DESTINATION] c=[/etc/kamailio/kamailio.cfg] l=339 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[PREPARE_FOR_LAUNCH] c=[/etc/kamailio/kamailio.cfg] l=482 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[PREPARE_FOR_LAUNCH] c=[/etc/kamailio/kamailio.cfg] l=482 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[PREPARE_FOR_LAUNCH] c=[/etc/kamailio/kamailio.cfg] l=474 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[PREPARE_FOR_BWP] c=[/etc/kamailio/kamailio.cfg] l=743 a=63 n=assign
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[] c=[] l=0 a=7 n=sethost
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[PREPARE_FOR_BWP] c=[/etc/kamailio/kamailio.cfg] l=745 a=63 n=assign
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[] c=[] l=0 a=11 n=setport
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[PREPARE_FOR_LAUNCH] c=[/etc/kamailio/kamailio.cfg] l=483 a=63 n=assign
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[PREPARE_FOR_LAUNCH] c=[/etc/kamailio/kamailio.cfg] l=484 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=987 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=984 a=26 n=xlog
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: pv [pv_core.c:823]: pv_get_useragent(): no User-Agent header
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: INFO: <script>: (route[PREPARE_FOR_LAUNCH]) -- INVITE R-URI: sip:8888888888@ns.cored.com;trans-type=5 From: sip:+12222222222@22.222.22.222;isup-oli=62 (22.222.22.222) To: sip:4444444444@s.core.com UA: <null> CID: 201634603_98039056@22.222.22.222
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=988 a=63 n=assign
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=186 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=880 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=876 a=25 n=is_method
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=878 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=877 a=25 n=t_is_set
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=877 a=25 n=t_on_branch
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=883 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=880 a=25 n=is_method
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=886 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=883 a=25 n=is_method
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=885 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=884 a=25 n=t_is_set
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=893 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=886 a=25 n=is_method
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=890 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg: msg id=8 global id=8 T start=0x7fd70c9cc6c0
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: tm [t_lookup.c:1144]: t_check_msg(): DEBUG: t_check_msg: T already found!
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: tmx [t_var.c:522]: pv_get_tm_reply_code(): reply code is <100>
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=888 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=788 a=26 n=xlog
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: INFO: <script>: KDM: managing sdp: 201634603_98039056@22.222.22.222
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=795 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=790 a=25 n=is_method
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=798 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=795 a=24 n=sdp_content
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [parser/sdp/sdp_helpr_funcs.c:504]: extract_mediaip(): located IP address [22.222.22.222] in `o=' field
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [parser/sdp/sdp_helpr_funcs.c:504]: extract_mediaip(): located IP address [67.231.13.80] in `c=' field
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=798 a=63 n=assign
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=799 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=987 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=984 a=26 n=xlog
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: pv [pv_core.c:823]: pv_get_useragent(): no User-Agent header
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: INFO: <script>: Has SDP content -- INVITE R-URI: sip:8888888888@ns.cored.com;trans-type=5 From: sip:+12222222222@22.222.22.222;isup-oli=62 (22.222.22.222) To: sip:4444444444@s.core.com UA: <null> CID: 201634603_98039056@22.222.22.222
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=988 a=63 n=assign
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=801 a=26 n=xlog
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: INFO: <script>: KDM: direction in and skip_sdp 0: 201634603_98039056@22.222.22.222
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=808 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=844 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=809 a=26 n=xlog
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: INFO: <script>: KDM: inbound: 201634603_98039056@22.222.22.222
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=828 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=813 a=26 n=sdp_get_line_startswith
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [pvapi.c:321]: pv_cache_lookup(): pvar [$avp(cline)] found in cache
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=813 a=26 n=sdp_get_line_startswith
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [usr_avp.c:894]: parse_avp_ident(): Parsing 'mline'
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [pvapi.c:293]: pv_cache_add(): pvar [$avp(mline)] added in cache
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=814 a=63 n=assign
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [re.c:448]: subst_run(): subst_run: running. r=0
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [re.c:469]: subst_run(): subst_run: matched (0, 21): [c=IN IP4 67.231.13.80]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=815 a=63 n=assign
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [re.c:448]: subst_run(): subst_run: running. r=0
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [re.c:469]: subst_run(): subst_run: matched (0, 29): [m=audio 2188 RTP/AVP 0 18 101]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=817 a=26 n=xlog
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: INFO: <script>: KDM: connect host: 67.231.13.80 and port 2188: 201634603_98039056@22.222.22.222
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=819 a=25 n=append_hf
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=820 a=25 n=append_hf
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=823 a=25 n=subst_body
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [re.c:448]: subst_run(): subst_run: running. r=0
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [re.c:469]: subst_run(): subst_run: matched (140, 21): [a=rtpmap:0 PCMU/8000#015]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: textops [textops.c:844]: subst_body_f(): textops replacing at offset 819 [a=rtpmap:0 PCMU/8000#015] with [a=pfc:67.231.13.80#015#012a=pfm:2188#015#012a=rtpmap:0 PCMU/8000#015]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: textops [textops.c:861]: subst_body_f(): lst was 0x7fd715b57318
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=825 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RTPENGINE_MANAGE] c=[/etc/kamailio/kamailio.cfg] l=778 a=26 n=sdp_get_line_startswith
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [pvapi.c:321]: pv_cache_lookup(): pvar [$avp(cline)] found in cache
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RTPENGINE_MANAGE] c=[/etc/kamailio/kamailio.cfg] l=779 a=26 n=sdp_get_line_startswith
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [pvapi.c:321]: pv_cache_lookup(): pvar [$avp(mline)] found in cache
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RTPENGINE_MANAGE] c=[/etc/kamailio/kamailio.cfg] l=780 a=63 n=assign
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [re.c:448]: subst_run(): subst_run: running. r=0
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [re.c:469]: subst_run(): subst_run: matched (0, 21): [c=IN IP4 67.231.13.80]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RTPENGINE_MANAGE] c=[/etc/kamailio/kamailio.cfg] l=781 a=63 n=assign
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [re.c:448]: subst_run(): subst_run: running. r=0
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [re.c:469]: subst_run(): subst_run: matched (0, 29): [m=audio 2188 RTP/AVP 0 18 101]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RTPENGINE_MANAGE] c=[/etc/kamailio/kamailio.cfg] l=783 a=26 n=xlog
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: INFO: <script>: KDM: SENDING RTPMANAGE WITH host: 67.231.13.80 port: 2188: 22.222.22.222 201634603_98039056@22.222.22.222
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RTPENGINE_MANAGE] c=[/etc/kamailio/kamailio.cfg] l=784 a=25 n=rtpengine_manage
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: rtpengine [rtpengine_funcs.c:148]: check_content_type(): type <application/sdp> found valid
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: rtpengine [rtpengine.c:1457]: rtpp_function_call(): proxy reply: d3:sdp296:v=0#015#012o=Sonus_UAC 154781 110448 IN IP4 22.222.22.222#015#012s=SIP Media Capabilities#015#012c=IN IP4 888.88.88.8#015#012t=0 0#015#012m=audio 25954 RTP/AVP 0 18 101#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:18 G729/8000#015#012a=fmtp:18 annexb=no#015#012a=rtpmap:101 telephone-event/8000#015#012a=fmtp:101 0-15#015#012a=ptime:20#015#012a=sendrecv#015#012a=rtcp:25955#015#0126:result2:oke
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=891 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=890 a=25 n=t_is_set
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=893 a=63 n=assign
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=894 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=987 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=984 a=26 n=xlog
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: pv [pv_core.c:823]: pv_get_useragent(): no User-Agent header
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: INFO: <script>: Relaying -- INVITE R-URI: sip:8888888888@ns.cored.com;trans-type=5 From: sip:+12222222222@22.222.22.222;isup-oli=62 (22.222.22.222) To: sip:4444444444@s.core.com UA: <null> CID: 201634603_98039056@22.222.22.222
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=988 a=63 n=assign
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=903 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=896 a=24 n=t_relay
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: tm [t_lookup.c:1373]: t_newtran(): DEBUG: t_newtran: msg id=8 , global msg id=8 , T on entrance=0x7fd70c9cc6c0
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: tm [t_lookup.c:1378]: t_newtran(): DEBUG: t_newtran: transaction already in process 0x7fd70c9cc6c0
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:branch_route=[MANAGE_BRANCH] c=[/etc/kamailio/kamailio.cfg] l=908 a=63 n=assign
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:branch_route=[MANAGE_BRANCH] c=[/etc/kamailio/kamailio.cfg] l=909 a=5 n=route
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:branch_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=987 a=16 n=if
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:branch_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=984 a=26 n=xlog
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: pv [pv_core.c:823]: pv_get_useragent(): no User-Agent header
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: INFO: <script>: Manage branch -- INVITE R-URI: sip:8888888888@ns.cored.com;trans-type=5 From: sip:+12222222222@22.222.22.222;isup-oli=62 (22.222.22.222) To: sip:4444444444@s.core.com UA: <null> CID: 201634603_98039056@22.222.22.222
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:branch_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=988 a=63 n=assign
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [dns_cache.c:566]: _dns_hash_find(): dns_hash_find(_sip._udp.ns.cored.com(29), 33), h=0
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [dns_cache.c:566]: _dns_hash_find(): dns_hash_find(ns2-8-1.bwp.coredial.com(24), 1), h=522
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [forward.c:211]: get_out_socket(): DEBUG: get_out_socket: socket determined: 0x7fd715b976c0
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [msg_translator.c:470]: clen_builder(): clen_builder: content-length: 349 (349)
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [msg_translator.c:206]: check_via_address(): check_via_address(22.222.22.222, 22.222.22.222, 0)
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: tm [t_funcs.c:395]: t_relay_to(): SER: new transaction fwd'ed
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=903 a=2 n=exit
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil)
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: message repeated 5 times: [ DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil)]
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [xavp.c:448]: xavp_destroy_list(): destroying xavp list (nil)
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [receive.c:298]: receive_msg(): receive_msg: cleaning up
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [parser/sdp/sdp.c:793]: free_sdp(): _sdp = 0x7fd715ba5d70
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [parser/sdp/sdp.c:795]: free_sdp(): sdp = 0x7fd715b466c8
Jul 4 12:22:34 s2 /usr/sbin/kamailio[16491]: DEBUG: <core> [parser/sdp/sdp.c:797]: free_sdp(): session = 0x7fd715b57c00
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: <core> [parser/msg_parser.c:635]: parse_msg(): SIP Reply (status):
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: <core> [parser/msg_parser.c:637]: parse_msg(): version: <SIP/2.0>
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: <core> [parser/msg_parser.c:639]: parse_msg(): status: <404>
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: <core> [parser/msg_parser.c:641]: parse_msg(): reason: <Not found>
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK3146.e2f2772bed9e8a03a36bf76e27ccdf96.1>; state=9
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: <core> [parser/parse_via.c:2715]: parse_via(): parse_via: next_via
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK04Bdab71e422e25ac87>; state=16
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of header reached, state=5
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers(): parse_headers: Via found, flags=2
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: <core> [parser/msg_parser.c:515]: parse_headers(): parse_headers: this is the first via
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: <core> [receive.c:154]: receive_msg(): After parse_msg...
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg: msg id=1 global id=0 T start=0xffffffffffffffff
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: <core> [parser/parse_addr_spec.c:176]: parse_to_param(): DEBUG: add_param: tag=1615124083-1467649355005
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: <core> [parser/parse_addr_spec.c:898]: parse_addr_spec(): end of header reached, state=29
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: <core> [parser/msg_parser.c:190]: get_hdr_field(): DEBUG: get_hdr_field: <To> [71]; uri=[sip:4444444444@s.core.com]
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: <core> [parser/msg_parser.c:192]: get_hdr_field(): DEBUG: to body [<sip:4444444444@s.core.com>]
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: <core> [parser/msg_parser.c:170]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <790554> <INVITE>
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: tm [t_lookup.c:949]: t_reply_matching(): DEBUG: t_reply_matching: hash 25619 label 0 branch 1
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: tm [t_lookup.c:1004]: t_reply_matching(): DEBUG: t_reply_matching: reply matched (T=0x7fd70c9cc6c0)!
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: tm [t_hooks.c:288]: run_trans_callbacks_internal(): DBG: trans=0x7fd70c9cc6c0, callback type 2, id 0 entered
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: <core> [parser/parse_addr_spec.c:176]: parse_to_param(): DEBUG: add_param: tag=gK04215262
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: <core> [parser/parse_addr_spec.c:898]: parse_addr_spec(): end of header reached, state=29
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: uac [replace.c:719]: restore_uri_reply(): removing <"John Doe"<sip:+12222222222@22.222.22.222;isup-oli=62>>
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: uac [replace.c:728]: restore_uri_reply(): inserting <"John Doe" <sip:+12222222222@22.222.22.222;isup-oli=62>>
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: tm [t_lookup.c:1141]: t_check_msg(): DEBUG: t_check_msg: msg id=1 global id=1 T end=0x7fd70c9cc6c0
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: tm [t_reply.c:2220]: reply_received(): DEBUG: reply_received: org. status uas=100, uac[1]=0 local=0 is_invite=1)
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: ERROR: *** cfgtrace:onreply_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=455 a=16 n=if
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: ERROR: *** cfgtrace:onreply_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=450 a=25 n=t_check_status
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg: msg id=1 global id=1 T start=0x7fd70c9cc6c0
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: tm [t_lookup.c:1144]: t_check_msg(): DEBUG: t_check_msg: T already found!
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: tm [tm.c:1037]: t_check_status(): DEBUG:t_check_status: checked status is <404>
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: ERROR: *** cfgtrace:onreply_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=454 a=26 n=xlog
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: ERROR: <script>: INFO: Received bad reply from TNSi (on_reply_route[CNAM_DIPS])
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: ERROR: *** cfgtrace:onreply_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=456 a=2 n=drop
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: tm [t_reply.c:1313]: t_should_relay_response(): ->>>>>>>>> T_code=100, new_code=404
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: tm [t_reply.c:1831]: relay_reply(): DEBUG: relay_reply: branch=1, save=1, relay=-1 icode=0
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil)
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: message repeated 5 times: [ DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil)]
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: <core> [xavp.c:448]: xavp_destroy_list(): destroying xavp list (nil)
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16545]: DEBUG: <core> [receive.c:298]: receive_msg(): receive_msg: cleaning up
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [parser/msg_parser.c:635]: parse_msg(): SIP Reply (status):
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [parser/msg_parser.c:637]: parse_msg(): version: <SIP/2.0>
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [parser/msg_parser.c:639]: parse_msg(): status: <380>
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [parser/msg_parser.c:641]: parse_msg(): reason: <cnam lookup>
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK3146.e2f2772bed9e8a03a36bf76e27ccdf96.0>; state=16
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of header reached, state=5
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers(): parse_headers: Via found, flags=2
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [parser/msg_parser.c:515]: parse_headers(): parse_headers: this is the first via
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [receive.c:154]: receive_msg(): After parse_msg...
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg: msg id=8 global id=1 T start=0xffffffffffffffff
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK04Bdab71e422e25ac87>; state=16
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of header reached, state=5
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers(): parse_headers: Via found, flags=62
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [parser/msg_parser.c:526]: parse_headers(): parse_headers: this is the second via
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [parser/parse_addr_spec.c:176]: parse_to_param(): DEBUG: add_param: tag=CNAM-2557-1467650355943
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [parser/parse_addr_spec.c:898]: parse_addr_spec(): end of header reached, state=29
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [parser/msg_parser.c:190]: get_hdr_field(): DEBUG: get_hdr_field: <To> [70]; uri=[sip:4444444444@s.core.com]
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [parser/msg_parser.c:192]: get_hdr_field(): DEBUG: to body [<sip:4444444444@s.core.com>]
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [parser/msg_parser.c:170]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <790554> <INVITE>
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: tm [t_lookup.c:949]: t_reply_matching(): DEBUG: t_reply_matching: hash 25619 label 0 branch 0
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: tm [t_lookup.c:1004]: t_reply_matching(): DEBUG: t_reply_matching: reply matched (T=0x7fd70c9cc6c0)!
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: tm [t_hooks.c:288]: run_trans_callbacks_internal(): DBG: trans=0x7fd70c9cc6c0, callback type 2, id 0 entered
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [parser/parse_addr_spec.c:176]: parse_to_param(): DEBUG: add_param: tag=gK04215262
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [parser/parse_addr_spec.c:898]: parse_addr_spec(): end of header reached, state=29
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: uac [replace.c:719]: restore_uri_reply(): removing <"John Doe" <sip:+12222222222@sip.core.com>>
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: uac [replace.c:728]: restore_uri_reply(): inserting <"John Doe" <sip:+12222222222@22.222.22.222;isup-oli=62>>
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: tm [t_lookup.c:1141]: t_check_msg(): DEBUG: t_check_msg: msg id=8 global id=8 T end=0x7fd70c9cc6c0
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: tm [t_reply.c:2220]: reply_received(): DEBUG: reply_received: org. status uas=100, uac[0]=0 local=0 is_invite=1)
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: ERROR: *** cfgtrace:onreply_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=455 a=16 n=if
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: ERROR: *** cfgtrace:onreply_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=450 a=25 n=t_check_status
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg: msg id=8 global id=8 T start=0x7fd70c9cc6c0
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: tm [t_lookup.c:1144]: t_check_msg(): DEBUG: t_check_msg: T already found!
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: tm [tm.c:1037]: t_check_status(): DEBUG:t_check_status: checked status is <380>
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: ERROR: *** cfgtrace:onreply_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=451 a=26 n=xlog
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: INFO: <script>: INFO: Received valid reply from TNSi (on_reply_route[CNAM_DIPS])
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: ERROR: *** cfgtrace:onreply_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=452 a=63 n=assign
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [parser/msg_parser.c:204]: get_hdr_field(): DEBUG: get_hdr_body : content_length=0
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [parser/msg_parser.c:106]: get_hdr_field(): found end of header
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: ERROR: *** cfgtrace:onreply_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=456 a=2 n=drop
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: tm [t_reply.c:1313]: t_should_relay_response(): ->>>>>>>>> T_code=100, new_code=380
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: ERROR: *** cfgtrace:failure_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=466 a=16 n=if
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: ERROR: *** cfgtrace:failure_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=460 a=24 n=t_next_contacts
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [xavp.c:448]: xavp_destroy_list(): destroying xavp list 0x7fd70c9cc4d8
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: ERROR: *** cfgtrace:failure_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=464 a=24 n=t_next_contacts
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: tm [t_serial.c:433]: t_next_contacts(): no contacts in contacts_avp - we are done!
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: ERROR: *** cfgtrace:failure_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=465 a=24 n=t_relay
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [dns_cache.c:566]: _dns_hash_find(): dns_hash_find(s.core.com(23), 1), h=790
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: ERROR: <core> [resolve.c:1726]: sip_hostport2su(): could not resolve hostname: "s.core.com"
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: ERROR: tm [ut.h:337]: uri2dst2(): failed to resolve "s.core.com"
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: ERROR: tm [t_fwd.c:1779]: t_forward_nonack(): ERROR: t_forward_nonack: failure to add branches
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: ERROR: tm [tm.c:1507]: _w_t_relay_to(): ERROR: w_t_relay_to: t_relay_to failed
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: ERROR: tm [t_reply.c:1071]: run_failure_handlers(): ERROR: run_failure_handlers: Error in run_top_route
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: tm [t_reply.c:1831]: relay_reply(): DEBUG: relay_reply: branch=0, save=0, relay=0 icode=0
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [msg_translator.c:2278]: generate_res_buf_from_sip_res(): old size: 557, new size: 486
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [msg_translator.c:2296]: generate_res_buf_from_sip_res(): copied size: orig:235, new: 164, rest: 322 msg=#012SIP/2.0 380 cnam lookup#015#012Via: SIP/2.0/UDP 22.222.22.222:5060;branch=z9hG4bK04Bdab71e422e25ac87#015#012From: "John Doe" <sip:+12222222222@22.222.22.222;isup-oli=62>;tag=gK04215262#015#012To: <sip:4444444444@s.core.com>;tag=CNAM-2557-1467650355943#015#012Call-ID: 201634603_98039056@22.222.22.222#015#012CSeq: 790554 INVITE#015#012Contact: "CNAM" <sip:cnam_gw@10.212.16.31>; transport=udp#015#012Max-Forwards: 10#015#012P-Asserted-Identity: "Unavailable" <sip:+12222222222@sip.core.com>#015#012Content-Length: 0#015#012#015#012
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: tm [t_reply.c:1672]: cleanup_uac_timers(): DEBUG: cleanup_uac_timers: RETR/FR timers reset
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil)
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: message repeated 5 times: [ DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil)]
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [xavp.c:448]: xavp_destroy_list(): destroying xavp list (nil)
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16492]: DEBUG: <core> [receive.c:298]: receive_msg(): receive_msg: cleaning up
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: <core> [parser/msg_parser.c:625]: parse_msg(): SIP Request:
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: <core> [parser/msg_parser.c:627]: parse_msg(): method: <ACK>
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: <core> [parser/msg_parser.c:629]: parse_msg(): uri: <sip:+14444444444@s.core.com:5060>
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: <core> [parser/msg_parser.c:631]: parse_msg(): version: <SIP/2.0>
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK04Bdab71e422e25ac87>; state=16
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of header reached, state=5
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers(): parse_headers: Via found, flags=2
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: <core> [parser/msg_parser.c:515]: parse_headers(): parse_headers: this is the first via
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: <core> [receive.c:154]: receive_msg(): After parse_msg...
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: <core> [receive.c:197]: receive_msg(): preparing to run routing scripts...
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: sl [sl_funcs.c:412]: sl_filter_ACK(): DEBUG : sl_filter_ACK: to late to be a local ACK!
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=144 a=5 n=route
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[BLACKLIST] c=[/etc/kamailio/kamailio.cfg] l=269 a=16 n=if
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[BLACKLIST] c=[/etc/kamailio/kamailio.cfg] l=264 a=25 n=allow_source_address
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: permissions [address.c:516]: allow_source_address(): looking for <2, 710de743, 5060>
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=146 a=5 n=route
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[WHITELIST] c=[/etc/kamailio/kamailio.cfg] l=278 a=16 n=if
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[WHITELIST] c=[/etc/kamailio/kamailio.cfg] l=273 a=25 n=allow_source_address
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: permissions [address.c:516]: allow_source_address(): looking for <1, 710de743, 5060>
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=149 a=5 n=route
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[OPTIONS] c=[/etc/kamailio/kamailio.cfg] l=219 a=16 n=if
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[OPTIONS] c=[/etc/kamailio/kamailio.cfg] l=215 a=25 n=is_method
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=152 a=5 n=route
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=208 a=16 n=if
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=203 a=25 n=mf_process_maxfwd_header
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: <core> [parser/parse_addr_spec.c:176]: parse_to_param(): DEBUG: add_param: tag=CNAM-2557-1467650355943
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: <core> [parser/parse_addr_spec.c:898]: parse_addr_spec(): end of header reached, state=29
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: <core> [parser/msg_parser.c:190]: get_hdr_field(): DEBUG: get_hdr_field: <To> [70]; uri=[sip:4444444444@s.core.com]
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: <core> [parser/msg_parser.c:192]: get_hdr_field(): DEBUG: to body [<sip:4444444444@s.core.com>]
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: <core> [parser/msg_parser.c:170]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <790554> <ACK>
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: maxfwd [mf_funcs.c:85]: is_maxfwd_present(): value = 70
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=212 a=16 n=if
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=208 a=26 n=sanity_check
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: <core> [parser/msg_parser.c:204]: get_hdr_field(): DEBUG: get_hdr_body : content_length=0
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: <core> [parser/msg_parser.c:106]: get_hdr_field(): found end of header
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: <core> [parser/parse_addr_spec.c:176]: parse_to_param(): DEBUG: add_param: tag=gK04215262
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: <core> [parser/parse_addr_spec.c:898]: parse_addr_spec(): end of header reached, state=29
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: sanity [mod_sanity.c:255]: w_sanity_check(): sanity checks result: 1
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=157 a=5 n=route
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[DETERMINE_DIRECTION] c=[/etc/kamailio/kamailio.cfg] l=347 a=16 n=if
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[DETERMINE_DIRECTION] c=[/etc/kamailio/kamailio.cfg] l=343 a=24 n=allow_trusted
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[DETERMINE_DIRECTION] c=[/etc/kamailio/kamailio.cfg] l=346 a=63 n=assign
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[DETERMINE_DIRECTION] c=[/etc/kamailio/kamailio.cfg] l=348 a=26 n=xlog
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: INFO: <script>: KDM: in: 201634603_98039056@22.222.22.222
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=160 a=63 n=assign
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=161 a=5 n=route
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=987 a=16 n=if
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=984 a=26 n=xlog
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: pv [pv_core.c:823]: pv_get_useragent(): no User-Agent header
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: INFO: <script>: New Packet -- ACK R-URI: sip:+14444444444@s.core.com:5060 From: sip:+12222222222@22.222.22.222;isup-oli=62 (22.222.22.222) To: sip:4444444444@s.core.com UA: <null> CID: 201634603_98039056@22.222.22.222
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=988 a=63 n=assign
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=164 a=5 n=route
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[CANCEL] c=[/etc/kamailio/kamailio.cfg] l=228 a=16 n=if
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[CANCEL] c=[/etc/kamailio/kamailio.cfg] l=222 a=25 n=is_method
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=167 a=5 n=route
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=260 a=16 n=if
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=233 a=24 n=has_totag
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: siputils [checks.c:106]: has_totag(): totag found
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=255 a=16 n=if
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=235 a=24 n=loose_route
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: rr [loose.c:113]: find_first_route(): No Route headers found
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: rr [loose.c:931]: loose_route(): There is no Route HF
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=254 a=16 n=if
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=242 a=25 n=is_method
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=252 a=16 n=if
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=243 a=24 n=t_check_trans
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg: msg id=8 global id=1 T start=0xffffffffffffffff
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: tm [t_lookup.c:527]: t_lookup_request(): t_lookup_request: start searching: hash=25619, isACK=1
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: tm [t_lookup.c:470]: matching_3261(): DEBUG: RFC3261 transaction matched, tid=04Bdab71e422e25ac87
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: tm [t_lookup.c:726]: t_lookup_request(): DEBUG: t_lookup_request: transaction found (T=0x7fd70c9cc6c0)
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: tm [t_lookup.c:1141]: t_check_msg(): DEBUG: t_check_msg: msg id=8 global id=8 T end=0x7fd70c9cc6c0
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: tm [t_reply.c:1672]: cleanup_uac_timers(): DEBUG: cleanup_uac_timers: RETR/FR timers reset
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: <core> [timer.c:589]: timer_add_safe(): timer_add called on an active timer 0x7fd70c9cc740 (0x7fd70c761348, 0x7fd70c761348), flags 201
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: tm [t_funcs.c:181]: put_on_wait(): tm: put_on_wait: transaction 0x7fd70c9cc6c0 already on wait
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list 0x7fd70c9c5058
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil)
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: message repeated 4 times: [ DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil)]
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: <core> [xavp.c:448]: xavp_destroy_list(): destroying xavp list (nil)
Jul 4 12:22:35 s2 /usr/sbin/kamailio[16493]: DEBUG: <core> [receive.c:298]: receive_msg(): receive_msg: cleaning up
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [parser/msg_parser.c:625]: parse_msg(): SIP Request:
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [parser/msg_parser.c:627]: parse_msg(): method: <INVITE>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [parser/msg_parser.c:629]: parse_msg(): uri: <sip:+14444444444@s.core.com:5060>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [parser/msg_parser.c:631]: parse_msg(): version: <SIP/2.0>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK08Bcb20235d128e4898>; state=16
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of header reached, state=5
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers(): parse_headers: Via found, flags=2
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [parser/msg_parser.c:515]: parse_headers(): parse_headers: this is the first via
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [receive.c:154]: receive_msg(): After parse_msg...
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [receive.c:197]: receive_msg(): preparing to run routing scripts...
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=144 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[BLACKLIST] c=[/etc/kamailio/kamailio.cfg] l=269 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[BLACKLIST] c=[/etc/kamailio/kamailio.cfg] l=264 a=25 n=allow_source_address
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: permissions [address.c:516]: allow_source_address(): looking for <2, 7009e743, 5060>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=146 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[WHITELIST] c=[/etc/kamailio/kamailio.cfg] l=278 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[WHITELIST] c=[/etc/kamailio/kamailio.cfg] l=273 a=25 n=allow_source_address
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: permissions [address.c:516]: allow_source_address(): looking for <1, 7009e743, 5060>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=149 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[OPTIONS] c=[/etc/kamailio/kamailio.cfg] l=219 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[OPTIONS] c=[/etc/kamailio/kamailio.cfg] l=215 a=25 n=is_method
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=152 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=208 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=203 a=25 n=mf_process_maxfwd_header
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [parser/parse_addr_spec.c:898]: parse_addr_spec(): end of header reached, state=10
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [parser/msg_parser.c:190]: get_hdr_field(): DEBUG: get_hdr_field: <To> [42]; uri=[sip:4444444444@s.core.com]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [parser/msg_parser.c:192]: get_hdr_field(): DEBUG: to body [<sip:4444444444@s.core.com>#015#012]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [parser/msg_parser.c:170]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <307492> <INVITE>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: maxfwd [mf_funcs.c:85]: is_maxfwd_present(): value = 70
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=212 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=208 a=26 n=sanity_check
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [parser/msg_parser.c:204]: get_hdr_field(): DEBUG: get_hdr_body : content_length=281
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [parser/msg_parser.c:106]: get_hdr_field(): found end of header
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [parser/parse_addr_spec.c:176]: parse_to_param(): DEBUG: add_param: tag=gK0832d1cc
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [parser/parse_addr_spec.c:898]: parse_addr_spec(): end of header reached, state=29
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: sanity [mod_sanity.c:255]: w_sanity_check(): sanity checks result: 1
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=157 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DETERMINE_DIRECTION] c=[/etc/kamailio/kamailio.cfg] l=347 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DETERMINE_DIRECTION] c=[/etc/kamailio/kamailio.cfg] l=343 a=24 n=allow_trusted
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DETERMINE_DIRECTION] c=[/etc/kamailio/kamailio.cfg] l=346 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DETERMINE_DIRECTION] c=[/etc/kamailio/kamailio.cfg] l=348 a=26 n=xlog
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: INFO: <script>: KDM: in: 1697153532_90171947@67.231.9.112
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=160 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=161 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=987 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=984 a=26 n=xlog
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: pv [pv_core.c:823]: pv_get_useragent(): no User-Agent header
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: INFO: <script>: New Packet -- INVITE R-URI: sip:+14444444444@s.core.com:5060 From: sip:+12222222222@67.231.9.112;isup-oli=62 (67.231.9.112) To: sip:4444444444@s.core.com UA: <null> CID: 1697153532_90171947@67.231.9.112
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=988 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=164 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[CANCEL] c=[/etc/kamailio/kamailio.cfg] l=228 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[CANCEL] c=[/etc/kamailio/kamailio.cfg] l=222 a=25 n=is_method
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=167 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=260 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=233 a=24 n=has_totag
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: siputils [checks.c:103]: has_totag(): no totag
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=169 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[HANDLE_RETRANSMITS] c=[/etc/kamailio/kamailio.cfg] l=309 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[HANDLE_RETRANSMITS] c=[/etc/kamailio/kamailio.cfg] l=305 a=24 n=t_precheck_trans
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[HANDLE_RETRANSMITS] c=[/etc/kamailio/kamailio.cfg] l=309 a=24 n=t_check_trans
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg: msg id=8 global id=1 T start=0xffffffffffffffff
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: tm [t_lookup.c:527]: t_lookup_request(): t_lookup_request: start searching: hash=45642, isACK=0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: tm [t_lookup.c:485]: matching_3261(): DEBUG: RFC3261 transaction matching failed
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: tm [t_lookup.c:709]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: tm [t_lookup.c:1141]: t_check_msg(): DEBUG: t_check_msg: msg id=8 global id=8 T end=(nil)
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=172 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=173 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=987 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=984 a=26 n=xlog
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: pv [pv_core.c:823]: pv_get_useragent(): no User-Agent header
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: INFO: <script>: New Request -- INVITE R-URI: sip:+14444444444@s.core.com:5060 From: sip:+12222222222@67.231.9.112;isup-oli=62 (67.231.9.112) To: sip:4444444444@s.core.com UA: <null> CID: 1697153532_90171947@67.231.9.112
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=988 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=176 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[BOUNCE_UNDESIRABLES] c=[/etc/kamailio/kamailio.cfg] l=289 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[BOUNCE_UNDESIRABLES] c=[/etc/kamailio/kamailio.cfg] l=296 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[BOUNCE_UNDESIRABLES] c=[/etc/kamailio/kamailio.cfg] l=289 a=25 n=is_method
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[BOUNCE_UNDESIRABLES] c=[/etc/kamailio/kamailio.cfg] l=302 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[BOUNCE_UNDESIRABLES] c=[/etc/kamailio/kamailio.cfg] l=296 a=25 n=is_method
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=178 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RECORD_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=314 a=25 n=remove_hf
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RECORD_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=319 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RECORD_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=316 a=25 n=is_method
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RECORD_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=317 a=24 n=record_route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=183 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[SET_DESTINATION] c=[/etc/kamailio/kamailio.cfg] l=323 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DETERMINE_PLATFORM] c=[/etc/kamailio/kamailio.cfg] l=353 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [re.c:448]: subst_run(): subst_run: running. r=0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [re.c:469]: subst_run(): subst_run: matched (0, 12): [+14444444444]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DETERMINE_PLATFORM] c=[/etc/kamailio/kamailio.cfg] l=354 a=27 n=sql_xquery
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:118]: db_new_result(): allocate 56 bytes for result set at 0x7fd715b96f18
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:68]: db_mysql_get_columns(): 1 columns returned from the query
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:156]: db_allocate_columns(): allocate 8 bytes for result names at 0x7fd715b946a0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:167]: db_allocate_columns(): allocate 4 bytes for result types at 0x7fd715b93a78
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:86]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[0] at 0x7fd715b96e98
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:93]: db_mysql_get_columns(): RES_NAMES(0x7fd715b96e98)[0]=[platform_id]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:101]: db_mysql_get_columns(): use DB1_INT result type
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:186]: db_allocate_rows(): allocate 16 bytes for rows at 0x7fd715b583a0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_row.c:119]: db_allocate_row(): allocate 32 bytes for row values at 0x7fd715b58410
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_val.c:76]: db_str2val(): converting INT [4]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: sqlops [sql_api.c:525]: sql_exec_xquery(): Adding column: platform_id
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: sqlops [sql_api.c:531]: sql_exec_xquery(): Adding row
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:81]: db_free_columns(): freeing 1 columns
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:85]: db_free_columns(): freeing RES_NAMES[0] at 0x7fd715b96e98
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:94]: db_free_columns(): freeing result names at 0x7fd715b946a0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:99]: db_free_columns(): freeing result types at 0x7fd715b93a78
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:54]: db_free_rows(): freeing 1 rows
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_row.c:97]: db_free_row(): freeing row values at 0x7fd715b58410
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:62]: db_free_rows(): freeing rows at 0x7fd715b583a0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:136]: db_free_result(): freeing result set at 0x7fd715b96f18
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DETERMINE_PLATFORM] c=[/etc/kamailio/kamailio.cfg] l=359 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DETERMINE_PLATFORM] c=[/etc/kamailio/kamailio.cfg] l=356 a=26 n=xlog
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: INFO: <script>: KDM: platform_id is 4
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DETERMINE_PLATFORM] c=[/etc/kamailio/kamailio.cfg] l=357 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[MAP_PLATFORM_ID_TO_PLATFORM] c=[/etc/kamailio/kamailio.cfg] l=377 a=20 n=switch
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[MAP_PLATFORM_ID_TO_PLATFORM] c=[/etc/kamailio/kamailio.cfg] l=373 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[MAP_PLATFORM_ID_TO_PLATFORM] c=[/etc/kamailio/kamailio.cfg] l=374 a=2 n=exit
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[SET_DESTINATION] c=[/etc/kamailio/kamailio.cfg] l=325 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DISCARD_UNKNOWN_INBOUND] c=[/etc/kamailio/kamailio.cfg] l=400 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[SET_DESTINATION] c=[/etc/kamailio/kamailio.cfg] l=329 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[GENERAL_CLEANUP] c=[/etc/kamailio/kamailio.cfg] l=404 a=26 n=xlog
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: INFO: <script>: JPD DBG: route[GENERAL_CLEANUP]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[GENERAL_CLEANUP] c=[/etc/kamailio/kamailio.cfg] l=417 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[GENERAL_CLEANUP] c=[/etc/kamailio/kamailio.cfg] l=425 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[GENERAL_CLEANUP] c=[/etc/kamailio/kamailio.cfg] l=425 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[SET_DESTINATION] c=[/etc/kamailio/kamailio.cfg] l=330 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [re.c:448]: subst_run(): subst_run: running. r=0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [re.c:469]: subst_run(): subst_run: matched (0, 12): [+12222222222]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[SET_DESTINATION] c=[/etc/kamailio/kamailio.cfg] l=331 a=26 n=xlog
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: INFO: <script>: JDP DBG: Source TN: 2222222222
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[SET_DESTINATION] c=[/etc/kamailio/kamailio.cfg] l=334 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[SET_DESTINATION] c=[/etc/kamailio/kamailio.cfg] l=333 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=442 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=430 a=25 n=t_on_branch
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=431 a=25 n=t_on_reply
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=432 a=25 n=t_on_failure
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=433 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=434 a=27 n=sql_xquery
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:118]: db_new_result(): allocate 56 bytes for result set at 0x7fd715b96f18
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:68]: db_mysql_get_columns(): 10 columns returned from the query
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:156]: db_allocate_columns(): allocate 80 bytes for result names at 0x7fd715b58490
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:167]: db_allocate_columns(): allocate 40 bytes for result types at 0x7fd715b58540
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:86]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[0] at 0x7fd715b96e98
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:93]: db_mysql_get_columns(): RES_NAMES(0x7fd715b96e98)[0]=[id]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:101]: db_mysql_get_columns(): use DB1_INT result type
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:86]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[1] at 0x7fd715b58410
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:93]: db_mysql_get_columns(): RES_NAMES(0x7fd715b58410)[1]=[telephoneNumber]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:137]: db_mysql_get_columns(): use DB1_STRING result type
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:86]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[2] at 0x7fd715b585c8
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:93]: db_mysql_get_columns(): RES_NAMES(0x7fd715b585c8)[2]=[carrierRouteId]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:101]: db_mysql_get_columns(): use DB1_INT result type
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:86]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[3] at 0x7fd715b58638
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:93]: db_mysql_get_columns(): RES_NAMES(0x7fd715b58638)[3]=[resellerId]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:101]: db_mysql_get_columns(): use DB1_INT result type
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:86]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[4] at 0x7fd715b586a8
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:93]: db_mysql_get_columns(): RES_NAMES(0x7fd715b586a8)[4]=[branchId]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:101]: db_mysql_get_columns(): use DB1_INT result type
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:86]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[5] at 0x7fd715b577c0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:93]: db_mysql_get_columns(): RES_NAMES(0x7fd715b577c0)[5]=[cnamDipAuthorized]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:101]: db_mysql_get_columns(): use DB1_INT result type
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:86]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[6] at 0x7fd715b57830
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:93]: db_mysql_get_columns(): RES_NAMES(0x7fd715b57830)[6]=[inboundHost]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:137]: db_mysql_get_columns(): use DB1_STRING result type
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:86]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[7] at 0x7fd715b578a0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:93]: db_mysql_get_columns(): RES_NAMES(0x7fd715b578a0)[7]=[inboundPort]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:101]: db_mysql_get_columns(): use DB1_INT result type
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:86]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[8] at 0x7fd715b57910
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:93]: db_mysql_get_columns(): RES_NAMES(0x7fd715b57910)[8]=[routeMapDomestic]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:137]: db_mysql_get_columns(): use DB1_STRING result type
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:86]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[9] at 0x7fd715b57980
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:93]: db_mysql_get_columns(): RES_NAMES(0x7fd715b57980)[9]=[routeMapInternational]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: db_mysql [km_res.c:137]: db_mysql_get_columns(): use DB1_STRING result type
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:186]: db_allocate_rows(): allocate 16 bytes for rows at 0x7fd715b579f0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_row.c:119]: db_allocate_row(): allocate 320 bytes for row values at 0x7fd715b57a60
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_val.c:76]: db_str2val(): converting INT [282700]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_val.c:120]: db_str2val(): converting STRING [4444444444]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_val.c:76]: db_str2val(): converting INT [30]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_val.c:76]: db_str2val(): converting INT [1]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: message repeated 2 times: [ DEBUG: <core> [db_val.c:76]: db_str2val(): converting INT [1]]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_val.c:57]: db_str2val(): converting NULL value
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: message repeated 3 times: [ DEBUG: <core> [db_val.c:57]: db_str2val(): converting NULL value]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: sqlops [sql_api.c:525]: sql_exec_xquery(): Adding column: routeMapInternational
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: sqlops [sql_api.c:525]: sql_exec_xquery(): Adding column: routeMapDomestic
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: sqlops [sql_api.c:525]: sql_exec_xquery(): Adding column: inboundPort
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: sqlops [sql_api.c:525]: sql_exec_xquery(): Adding column: inboundHost
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: sqlops [sql_api.c:525]: sql_exec_xquery(): Adding column: cnamDipAuthorized
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: sqlops [sql_api.c:525]: sql_exec_xquery(): Adding column: branchId
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: sqlops [sql_api.c:525]: sql_exec_xquery(): Adding column: resellerId
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: sqlops [sql_api.c:525]: sql_exec_xquery(): Adding column: carrierRouteId
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: sqlops [sql_api.c:525]: sql_exec_xquery(): Adding column: telephoneNumber
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: sqlops [sql_api.c:525]: sql_exec_xquery(): Adding column: id
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: sqlops [sql_api.c:531]: sql_exec_xquery(): Adding row
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:81]: db_free_columns(): freeing 10 columns
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:85]: db_free_columns(): freeing RES_NAMES[0] at 0x7fd715b96e98
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:85]: db_free_columns(): freeing RES_NAMES[1] at 0x7fd715b58410
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:85]: db_free_columns(): freeing RES_NAMES[2] at 0x7fd715b585c8
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:85]: db_free_columns(): freeing RES_NAMES[3] at 0x7fd715b58638
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:85]: db_free_columns(): freeing RES_NAMES[4] at 0x7fd715b586a8
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:85]: db_free_columns(): freeing RES_NAMES[5] at 0x7fd715b577c0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:85]: db_free_columns(): freeing RES_NAMES[6] at 0x7fd715b57830
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:85]: db_free_columns(): freeing RES_NAMES[7] at 0x7fd715b578a0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:85]: db_free_columns(): freeing RES_NAMES[8] at 0x7fd715b57910
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:85]: db_free_columns(): freeing RES_NAMES[9] at 0x7fd715b57980
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:94]: db_free_columns(): freeing result names at 0x7fd715b58490
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:99]: db_free_columns(): freeing result types at 0x7fd715b58540
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:54]: db_free_rows(): freeing 1 rows
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_row.c:97]: db_free_row(): freeing row values at 0x7fd715b57a60
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:62]: db_free_rows(): freeing rows at 0x7fd715b579f0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [db_res.c:136]: db_free_result(): freeing result set at 0x7fd715b96f18
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=435 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=436 a=26 n=append_branch
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=437 a=24 n=t_load_contacts
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: tm [t_serial.c:188]: t_load_contacts(): nr_branches is 1
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=438 a=24 n=t_next_contacts
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [xavp.c:448]: xavp_destroy_list(): destroying xavp list 0x7fd70c9cc578
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=439 a=24 n=t_relay
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: tm [t_lookup.c:1373]: t_newtran(): DEBUG: t_newtran: msg id=8 , global msg id=8 , T on entrance=(nil)
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: tm [t_lookup.c:527]: t_lookup_request(): t_lookup_request: start searching: hash=45642, isACK=0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: tm [t_lookup.c:485]: matching_3261(): DEBUG: RFC3261 transaction matching failed
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: tm [t_lookup.c:709]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: tm [t_hooks.c:380]: run_reqin_callbacks_internal(): DBG: trans=0x7fd70c9c6348, callback type 1, id 0 entered
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [md5utils.c:67]: MD5StringArray(): DEBUG: MD5 calculated: 40ff4e894a42b3d80b3f0a7ec59a8d84
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: tm [t_funcs.c:348]: t_relay_to(): SER: new INVITE
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [msg_translator.c:206]: check_via_address(): check_via_address(67.231.9.112, 67.231.9.112, 0)
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [mem/shm_mem.c:111]: _shm_resize(): WARNING:vqm_resize: resize(0) called
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: tm [t_reply.c:728]: _reply_light(): DEBUG: reply sent out. buf=0x7fd715b57ce0: SIP/2.0 100 trying -..., shmem=0x7fd70c9d0498: SIP/2.0 100 trying -
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: tm [t_reply.c:738]: _reply_light(): DEBUG: _reply_light: finished
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:branch_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=445 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:branch_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=446 a=25 n=uac_replace_from
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: uac [uac.c:454]: w_replace_from(): dsp=(nil) (len=0) , uri=0x7ffdb0092930 (len=29)
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: uac [replace.c:361]: replace_uri(): uri to replace [sip:+12222222222@67.231.9.112;isup-oli=62]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: uac [replace.c:362]: replace_uri(): replacement uri is [sip:+12222222222@sip.core.com]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: uac [replace.c:473]: replace_uri(): encode is=<AAAAAAAAAAAAAAAAAAAAAABFXl4cUF5cXABSXl87aXN1cC1vbGk9NjI-> len=56
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [forward.c:211]: get_out_socket(): DEBUG: get_out_socket: socket determined: 0x7fd715b974e8
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [msg_translator.c:206]: check_via_address(): check_via_address(67.231.9.112, 67.231.9.112, 0)
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: tm [t_funcs.c:395]: t_relay_to(): SER: new transaction fwd'ed
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=440 a=2 n=exit
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[SET_DESTINATION] c=[/etc/kamailio/kamailio.cfg] l=339 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[PREPARE_FOR_LAUNCH] c=[/etc/kamailio/kamailio.cfg] l=482 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[PREPARE_FOR_LAUNCH] c=[/etc/kamailio/kamailio.cfg] l=482 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[PREPARE_FOR_LAUNCH] c=[/etc/kamailio/kamailio.cfg] l=474 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[PREPARE_FOR_BWP] c=[/etc/kamailio/kamailio.cfg] l=743 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[] c=[] l=0 a=7 n=sethost
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[PREPARE_FOR_BWP] c=[/etc/kamailio/kamailio.cfg] l=745 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[] c=[] l=0 a=11 n=setport
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[PREPARE_FOR_LAUNCH] c=[/etc/kamailio/kamailio.cfg] l=483 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[PREPARE_FOR_LAUNCH] c=[/etc/kamailio/kamailio.cfg] l=484 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=987 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=984 a=26 n=xlog
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: pv [pv_core.c:823]: pv_get_useragent(): no User-Agent header
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: INFO: <script>: (route[PREPARE_FOR_LAUNCH]) -- INVITE R-URI: sip:8888888888@ns.cored.com;trans-type=5 From: sip:+12222222222@67.231.9.112;isup-oli=62 (67.231.9.112) To: sip:4444444444@s.core.com UA: <null> CID: 1697153532_90171947@67.231.9.112
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=988 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=186 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=880 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=876 a=25 n=is_method
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=878 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=877 a=25 n=t_is_set
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=877 a=25 n=t_on_branch
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=883 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=880 a=25 n=is_method
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=886 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=883 a=25 n=is_method
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=885 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=884 a=25 n=t_is_set
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=893 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=886 a=25 n=is_method
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=890 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg: msg id=8 global id=8 T start=0x7fd70c9c6348
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: tm [t_lookup.c:1144]: t_check_msg(): DEBUG: t_check_msg: T already found!
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: tmx [t_var.c:522]: pv_get_tm_reply_code(): reply code is <100>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=888 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=788 a=26 n=xlog
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: INFO: <script>: KDM: managing sdp: 1697153532_90171947@67.231.9.112
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=795 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=790 a=25 n=is_method
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=798 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=795 a=24 n=sdp_content
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [parser/sdp/sdp_helpr_funcs.c:504]: extract_mediaip(): located IP address [67.231.9.112] in `o=' field
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [parser/sdp/sdp_helpr_funcs.c:504]: extract_mediaip(): located IP address [67.231.9.79] in `c=' field
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=798 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=799 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=987 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=984 a=26 n=xlog
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: pv [pv_core.c:823]: pv_get_useragent(): no User-Agent header
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: INFO: <script>: Has SDP content -- INVITE R-URI: sip:8888888888@ns.cored.com;trans-type=5 From: sip:+12222222222@67.231.9.112;isup-oli=62 (67.231.9.112) To: sip:4444444444@s.core.com UA: <null> CID: 1697153532_90171947@67.231.9.112
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=988 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=801 a=26 n=xlog
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: INFO: <script>: KDM: direction in and skip_sdp 0: 1697153532_90171947@67.231.9.112
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=808 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=844 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=809 a=26 n=xlog
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: INFO: <script>: KDM: inbound: 1697153532_90171947@67.231.9.112
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=828 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=813 a=26 n=sdp_get_line_startswith
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [pvapi.c:321]: pv_cache_lookup(): pvar [$avp(cline)] found in cache
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=813 a=26 n=sdp_get_line_startswith
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [usr_avp.c:894]: parse_avp_ident(): Parsing 'mline'
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [pvapi.c:293]: pv_cache_add(): pvar [$avp(mline)] added in cache
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=814 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [re.c:448]: subst_run(): subst_run: running. r=0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [re.c:469]: subst_run(): subst_run: matched (0, 20): [c=IN IP4 67.231.9.79]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=815 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [re.c:448]: subst_run(): subst_run: running. r=0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [re.c:469]: subst_run(): subst_run: matched (0, 30): [m=audio 41134 RTP/AVP 0 18 101]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=817 a=26 n=xlog
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: INFO: <script>: KDM: connect host: 67.231.9.79 and port 41134: 1697153532_90171947@67.231.9.112
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=819 a=25 n=append_hf
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=820 a=25 n=append_hf
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=823 a=25 n=subst_body
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [re.c:448]: subst_run(): subst_run: running. r=0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [re.c:469]: subst_run(): subst_run: matched (139, 21): [a=rtpmap:0 PCMU/8000#015]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: textops [textops.c:844]: subst_body_f(): textops replacing at offset 814 [a=rtpmap:0 PCMU/8000#015] with [a=pfc:67.231.9.79#015#012a=pfm:41134#015#012a=rtpmap:0 PCMU/8000#015]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: textops [textops.c:861]: subst_body_f(): lst was 0x7fd715b57318
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[MANAGE_SDP] c=[/etc/kamailio/kamailio.cfg] l=825 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RTPENGINE_MANAGE] c=[/etc/kamailio/kamailio.cfg] l=778 a=26 n=sdp_get_line_startswith
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [pvapi.c:321]: pv_cache_lookup(): pvar [$avp(cline)] found in cache
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RTPENGINE_MANAGE] c=[/etc/kamailio/kamailio.cfg] l=779 a=26 n=sdp_get_line_startswith
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [pvapi.c:321]: pv_cache_lookup(): pvar [$avp(mline)] found in cache
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RTPENGINE_MANAGE] c=[/etc/kamailio/kamailio.cfg] l=780 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [re.c:448]: subst_run(): subst_run: running. r=0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [re.c:469]: subst_run(): subst_run: matched (0, 20): [c=IN IP4 67.231.9.79]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RTPENGINE_MANAGE] c=[/etc/kamailio/kamailio.cfg] l=781 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [re.c:448]: subst_run(): subst_run: running. r=0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [re.c:469]: subst_run(): subst_run: matched (0, 30): [m=audio 41134 RTP/AVP 0 18 101]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RTPENGINE_MANAGE] c=[/etc/kamailio/kamailio.cfg] l=783 a=26 n=xlog
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: INFO: <script>: KDM: SENDING RTPMANAGE WITH host: 67.231.9.79 port: 41134: 67.231.9.112 1697153532_90171947@67.231.9.112
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RTPENGINE_MANAGE] c=[/etc/kamailio/kamailio.cfg] l=784 a=25 n=rtpengine_manage
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: rtpengine [rtpengine_funcs.c:148]: check_content_type(): type <application/sdp> found valid
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: rtpengine [rtpengine.c:1457]: rtpp_function_call(): proxy reply: d3:sdp295:v=0#015#012o=Sonus_UAC 462007 154137 IN IP4 67.231.9.112#015#012s=SIP Media Capabilities#015#012c=IN IP4 198.58.45.8#015#012t=0 0#015#012m=audio 26020 RTP/AVP 0 18 101#015#012a=rtpmap:0 PCMU/8000#015#012a=rtpmap:18 G729/8000#015#012a=fmtp:18 annexb=no#015#012a=rtpmap:101 telephone-event/8000#015#012a=fmtp:101 0-15#015#012a=ptime:20#015#012a=sendrecv#015#012a=rtcp:26021#015#0126:result2:oke
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=891 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=890 a=25 n=t_is_set
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=893 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=894 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=987 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=984 a=26 n=xlog
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: pv [pv_core.c:823]: pv_get_useragent(): no User-Agent header
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: INFO: <script>: Relaying -- INVITE R-URI: sip:8888888888@ns.cored.com;trans-type=5 From: sip:+12222222222@67.231.9.112;isup-oli=62 (67.231.9.112) To: sip:4444444444@s.core.com UA: <null> CID: 1697153532_90171947@67.231.9.112
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=988 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=903 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=896 a=24 n=t_relay
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: tm [t_lookup.c:1373]: t_newtran(): DEBUG: t_newtran: msg id=8 , global msg id=8 , T on entrance=0x7fd70c9c6348
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: tm [t_lookup.c:1378]: t_newtran(): DEBUG: t_newtran: transaction already in process 0x7fd70c9c6348
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:branch_route=[MANAGE_BRANCH] c=[/etc/kamailio/kamailio.cfg] l=908 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:branch_route=[MANAGE_BRANCH] c=[/etc/kamailio/kamailio.cfg] l=909 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:branch_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=987 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:branch_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=984 a=26 n=xlog
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: pv [pv_core.c:823]: pv_get_useragent(): no User-Agent header
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: INFO: <script>: Manage branch -- INVITE R-URI: sip:8888888888@ns.cored.com;trans-type=5 From: sip:+12222222222@67.231.9.112;isup-oli=62 (67.231.9.112) To: sip:4444444444@s.core.com UA: <null> CID: 1697153532_90171947@67.231.9.112
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:branch_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=988 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [dns_cache.c:566]: _dns_hash_find(): dns_hash_find(_sip._udp.ns.cored.com(29), 33), h=0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [dns_cache.c:566]: _dns_hash_find(): dns_hash_find(ns2-8-1.bwp.coredial.com(24), 1), h=522
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [forward.c:211]: get_out_socket(): DEBUG: get_out_socket: socket determined: 0x7fd715b976c0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [msg_translator.c:470]: clen_builder(): clen_builder: content-length: 348 (348)
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [msg_translator.c:206]: check_via_address(): check_via_address(67.231.9.112, 67.231.9.112, 0)
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: tm [t_funcs.c:395]: t_relay_to(): SER: new transaction fwd'ed
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=903 a=2 n=exit
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil)
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: message repeated 5 times: [ DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil)]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [xavp.c:448]: xavp_destroy_list(): destroying xavp list (nil)
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [receive.c:298]: receive_msg(): receive_msg: cleaning up
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [parser/sdp/sdp.c:793]: free_sdp(): _sdp = 0x7fd715ba5d70
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [parser/sdp/sdp.c:795]: free_sdp(): sdp = 0x7fd715b466c8
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16522]: DEBUG: <core> [parser/sdp/sdp.c:797]: free_sdp(): session = 0x7fd715b57c00
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: <core> [parser/msg_parser.c:635]: parse_msg(): SIP Reply (status):
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: <core> [parser/msg_parser.c:637]: parse_msg(): version: <SIP/2.0>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: <core> [parser/msg_parser.c:639]: parse_msg(): status: <404>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: <core> [parser/msg_parser.c:641]: parse_msg(): reason: <Not found>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKa42b.40ff4e894a42b3d80b3f0a7ec59a8d84.1>; state=9
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: <core> [parser/parse_via.c:2715]: parse_via(): parse_via: next_via
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK08Bcb20235d128e4898>; state=16
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of header reached, state=5
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers(): parse_headers: Via found, flags=2
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: <core> [parser/msg_parser.c:515]: parse_headers(): parse_headers: this is the first via
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: <core> [receive.c:154]: receive_msg(): After parse_msg...
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg: msg id=1 global id=0 T start=0xffffffffffffffff
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: <core> [parser/parse_addr_spec.c:176]: parse_to_param(): DEBUG: add_param: tag=940410080-1467649358752
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: <core> [parser/parse_addr_spec.c:898]: parse_addr_spec(): end of header reached, state=29
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: <core> [parser/msg_parser.c:190]: get_hdr_field(): DEBUG: get_hdr_field: <To> [70]; uri=[sip:4444444444@s.core.com]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: <core> [parser/msg_parser.c:192]: get_hdr_field(): DEBUG: to body [<sip:4444444444@s.core.com>]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: <core> [parser/msg_parser.c:170]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <307492> <INVITE>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: tm [t_lookup.c:949]: t_reply_matching(): DEBUG: t_reply_matching: hash 45642 label 0 branch 1
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: tm [t_lookup.c:1004]: t_reply_matching(): DEBUG: t_reply_matching: reply matched (T=0x7fd70c9c6348)!
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: tm [t_hooks.c:288]: run_trans_callbacks_internal(): DBG: trans=0x7fd70c9c6348, callback type 2, id 0 entered
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: <core> [parser/parse_addr_spec.c:176]: parse_to_param(): DEBUG: add_param: tag=gK0832d1cc
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: <core> [parser/parse_addr_spec.c:898]: parse_addr_spec(): end of header reached, state=29
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: uac [replace.c:719]: restore_uri_reply(): removing <"John Doe"<sip:+12222222222@67.231.9.112;isup-oli=62>>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: uac [replace.c:728]: restore_uri_reply(): inserting <"John Doe" <sip:+12222222222@67.231.9.112;isup-oli=62>>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: tm [t_lookup.c:1141]: t_check_msg(): DEBUG: t_check_msg: msg id=1 global id=1 T end=0x7fd70c9c6348
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: tm [t_reply.c:2220]: reply_received(): DEBUG: reply_received: org. status uas=100, uac[1]=0 local=0 is_invite=1)
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: ERROR: *** cfgtrace:onreply_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=455 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: ERROR: *** cfgtrace:onreply_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=450 a=25 n=t_check_status
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg: msg id=1 global id=1 T start=0x7fd70c9c6348
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: tm [t_lookup.c:1144]: t_check_msg(): DEBUG: t_check_msg: T already found!
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: tm [tm.c:1037]: t_check_status(): DEBUG:t_check_status: checked status is <404>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: ERROR: *** cfgtrace:onreply_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=454 a=26 n=xlog
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: ERROR: <script>: INFO: Received bad reply from TNSi (on_reply_route[CNAM_DIPS])
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: ERROR: *** cfgtrace:onreply_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=456 a=2 n=drop
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: tm [t_reply.c:1313]: t_should_relay_response(): ->>>>>>>>> T_code=100, new_code=404
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: tm [t_reply.c:1831]: relay_reply(): DEBUG: relay_reply: branch=1, save=1, relay=-1 icode=0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil)
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: message repeated 5 times: [ DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil)]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: <core> [xavp.c:448]: xavp_destroy_list(): destroying xavp list (nil)
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16552]: DEBUG: <core> [receive.c:298]: receive_msg(): receive_msg: cleaning up
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [parser/msg_parser.c:635]: parse_msg(): SIP Reply (status):
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [parser/msg_parser.c:637]: parse_msg(): version: <SIP/2.0>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [parser/msg_parser.c:639]: parse_msg(): status: <380>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [parser/msg_parser.c:641]: parse_msg(): reason: <cnam lookup>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKa42b.40ff4e894a42b3d80b3f0a7ec59a8d84.0>; state=16
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of header reached, state=5
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers(): parse_headers: Via found, flags=2
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [parser/msg_parser.c:515]: parse_headers(): parse_headers: this is the first via
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [receive.c:154]: receive_msg(): After parse_msg...
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg: msg id=8 global id=1 T start=0xffffffffffffffff
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK08Bcb20235d128e4898>; state=16
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of header reached, state=5
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers(): parse_headers: Via found, flags=62
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [parser/msg_parser.c:526]: parse_headers(): parse_headers: this is the second via
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [parser/parse_addr_spec.c:176]: parse_to_param(): DEBUG: add_param: tag=CNAM-18686-1467650105732
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [parser/parse_addr_spec.c:898]: parse_addr_spec(): end of header reached, state=29
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [parser/msg_parser.c:190]: get_hdr_field(): DEBUG: get_hdr_field: <To> [71]; uri=[sip:4444444444@s.core.com]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [parser/msg_parser.c:192]: get_hdr_field(): DEBUG: to body [<sip:4444444444@s.core.com>]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [parser/msg_parser.c:170]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <307492> <INVITE>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: tm [t_lookup.c:949]: t_reply_matching(): DEBUG: t_reply_matching: hash 45642 label 0 branch 0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: tm [t_lookup.c:1004]: t_reply_matching(): DEBUG: t_reply_matching: reply matched (T=0x7fd70c9c6348)!
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: tm [t_hooks.c:288]: run_trans_callbacks_internal(): DBG: trans=0x7fd70c9c6348, callback type 2, id 0 entered
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [parser/parse_addr_spec.c:176]: parse_to_param(): DEBUG: add_param: tag=gK0832d1cc
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [parser/parse_addr_spec.c:898]: parse_addr_spec(): end of header reached, state=29
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: uac [replace.c:719]: restore_uri_reply(): removing <"John Doe" <sip:+12222222222@sip.core.com>>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: uac [replace.c:728]: restore_uri_reply(): inserting <"John Doe" <sip:+12222222222@67.231.9.112;isup-oli=62>>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: tm [t_lookup.c:1141]: t_check_msg(): DEBUG: t_check_msg: msg id=8 global id=8 T end=0x7fd70c9c6348
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: tm [t_reply.c:2220]: reply_received(): DEBUG: reply_received: org. status uas=100, uac[0]=0 local=0 is_invite=1)
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: ERROR: *** cfgtrace:onreply_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=455 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: ERROR: *** cfgtrace:onreply_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=450 a=25 n=t_check_status
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg: msg id=8 global id=8 T start=0x7fd70c9c6348
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: tm [t_lookup.c:1144]: t_check_msg(): DEBUG: t_check_msg: T already found!
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: tm [tm.c:1037]: t_check_status(): DEBUG:t_check_status: checked status is <380>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: ERROR: *** cfgtrace:onreply_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=451 a=26 n=xlog
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: INFO: <script>: INFO: Received valid reply from TNSi (on_reply_route[CNAM_DIPS])
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: ERROR: *** cfgtrace:onreply_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=452 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [parser/msg_parser.c:204]: get_hdr_field(): DEBUG: get_hdr_body : content_length=0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [parser/msg_parser.c:106]: get_hdr_field(): found end of header
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: ERROR: *** cfgtrace:onreply_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=456 a=2 n=drop
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: tm [t_reply.c:1313]: t_should_relay_response(): ->>>>>>>>> T_code=100, new_code=380
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: ERROR: *** cfgtrace:failure_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=466 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: ERROR: *** cfgtrace:failure_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=460 a=24 n=t_next_contacts
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [xavp.c:448]: xavp_destroy_list(): destroying xavp list 0x7fd70c9cc220
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: ERROR: *** cfgtrace:failure_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=464 a=24 n=t_next_contacts
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: tm [t_serial.c:433]: t_next_contacts(): no contacts in contacts_avp - we are done!
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: ERROR: *** cfgtrace:failure_route=[CNAM_DIPS] c=[/etc/kamailio/kamailio.cfg] l=465 a=24 n=t_relay
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [dns_cache.c:566]: _dns_hash_find(): dns_hash_find(s.core.com(23), 1), h=790
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: ERROR: <core> [resolve.c:1726]: sip_hostport2su(): could not resolve hostname: "s.core.com"
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: ERROR: tm [ut.h:337]: uri2dst2(): failed to resolve "s.core.com"
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: ERROR: tm [t_fwd.c:1779]: t_forward_nonack(): ERROR: t_forward_nonack: failure to add branches
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: ERROR: tm [tm.c:1507]: _w_t_relay_to(): ERROR: w_t_relay_to: t_relay_to failed
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: ERROR: tm [t_reply.c:1071]: run_failure_handlers(): ERROR: run_failure_handlers: Error in run_top_route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: tm [t_reply.c:1831]: relay_reply(): DEBUG: relay_reply: branch=0, save=0, relay=0 icode=0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [msg_translator.c:2278]: generate_res_buf_from_sip_res(): old size: 557, new size: 485
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [msg_translator.c:2296]: generate_res_buf_from_sip_res(): copied size: orig:234, new: 162, rest: 323 msg=#012SIP/2.0 380 cnam lookup#015#012Via: SIP/2.0/UDP 67.231.9.112:5060;branch=z9hG4bK08Bcb20235d128e4898#015#012From: "John Doe" <sip:+12222222222@67.231.9.112;isup-oli=62>;tag=gK0832d1cc#015#012To: <sip:4444444444@s.core.com>;tag=CNAM-18686-1467650105732#015#012Call-ID: 1697153532_90171947@67.231.9.112#015#012CSeq: 307492 INVITE#015#012Contact: "CNAM" <sip:cnam_gw@10.212.16.30>; transport=udp#015#012Max-Forwards: 10#015#012P-Asserted-Identity: "Unavailable" <sip:+12222222222@sip.core.com>#015#012Content-Length: 0#015#012#015#012
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: tm [t_reply.c:1672]: cleanup_uac_timers(): DEBUG: cleanup_uac_timers: RETR/FR timers reset
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil)
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: message repeated 5 times: [ DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil)]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [xavp.c:448]: xavp_destroy_list(): destroying xavp list (nil)
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16523]: DEBUG: <core> [receive.c:298]: receive_msg(): receive_msg: cleaning up
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: <core> [parser/msg_parser.c:625]: parse_msg(): SIP Request:
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: <core> [parser/msg_parser.c:627]: parse_msg(): method: <ACK>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: <core> [parser/msg_parser.c:629]: parse_msg(): uri: <sip:+14444444444@s.core.com:5060>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: <core> [parser/msg_parser.c:631]: parse_msg(): version: <SIP/2.0>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK08Bcb20235d128e4898>; state=16
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of header reached, state=5
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers(): parse_headers: Via found, flags=2
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: <core> [parser/msg_parser.c:515]: parse_headers(): parse_headers: this is the first via
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: <core> [receive.c:154]: receive_msg(): After parse_msg...
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: <core> [receive.c:197]: receive_msg(): preparing to run routing scripts...
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: sl [sl_funcs.c:412]: sl_filter_ACK(): DEBUG : sl_filter_ACK: to late to be a local ACK!
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=144 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[BLACKLIST] c=[/etc/kamailio/kamailio.cfg] l=269 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[BLACKLIST] c=[/etc/kamailio/kamailio.cfg] l=264 a=25 n=allow_source_address
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: permissions [address.c:516]: allow_source_address(): looking for <2, 7009e743, 5060>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=146 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[WHITELIST] c=[/etc/kamailio/kamailio.cfg] l=278 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[WHITELIST] c=[/etc/kamailio/kamailio.cfg] l=273 a=25 n=allow_source_address
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: permissions [address.c:516]: allow_source_address(): looking for <1, 7009e743, 5060>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=149 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[OPTIONS] c=[/etc/kamailio/kamailio.cfg] l=219 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[OPTIONS] c=[/etc/kamailio/kamailio.cfg] l=215 a=25 n=is_method
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=152 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=208 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=203 a=25 n=mf_process_maxfwd_header
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: <core> [parser/parse_addr_spec.c:176]: parse_to_param(): DEBUG: add_param: tag=CNAM-18686-1467650105732
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: <core> [parser/parse_addr_spec.c:898]: parse_addr_spec(): end of header reached, state=29
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: <core> [parser/msg_parser.c:190]: get_hdr_field(): DEBUG: get_hdr_field: <To> [71]; uri=[sip:4444444444@s.core.com]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: <core> [parser/msg_parser.c:192]: get_hdr_field(): DEBUG: to body [<sip:4444444444@s.core.com>]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: <core> [parser/msg_parser.c:170]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <307492> <ACK>
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: maxfwd [mf_funcs.c:85]: is_maxfwd_present(): value = 70
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=212 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=208 a=26 n=sanity_check
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: <core> [parser/msg_parser.c:204]: get_hdr_field(): DEBUG: get_hdr_body : content_length=0
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: <core> [parser/msg_parser.c:106]: get_hdr_field(): found end of header
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: <core> [parser/parse_addr_spec.c:176]: parse_to_param(): DEBUG: add_param: tag=gK0832d1cc
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: <core> [parser/parse_addr_spec.c:898]: parse_addr_spec(): end of header reached, state=29
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: sanity [mod_sanity.c:255]: w_sanity_check(): sanity checks result: 1
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=157 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[DETERMINE_DIRECTION] c=[/etc/kamailio/kamailio.cfg] l=347 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[DETERMINE_DIRECTION] c=[/etc/kamailio/kamailio.cfg] l=343 a=24 n=allow_trusted
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[DETERMINE_DIRECTION] c=[/etc/kamailio/kamailio.cfg] l=346 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[DETERMINE_DIRECTION] c=[/etc/kamailio/kamailio.cfg] l=348 a=26 n=xlog
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: INFO: <script>: KDM: in: 1697153532_90171947@67.231.9.112
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=160 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=161 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=987 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=984 a=26 n=xlog
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: pv [pv_core.c:823]: pv_get_useragent(): no User-Agent header
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: INFO: <script>: New Packet -- ACK R-URI: sip:+14444444444@s.core.com:5060 From: sip:+12222222222@67.231.9.112;isup-oli=62 (67.231.9.112) To: sip:4444444444@s.core.com UA: <null> CID: 1697153532_90171947@67.231.9.112
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[LOG] c=[/etc/kamailio/kamailio.cfg] l=988 a=63 n=assign
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=164 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[CANCEL] c=[/etc/kamailio/kamailio.cfg] l=228 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[CANCEL] c=[/etc/kamailio/kamailio.cfg] l=222 a=25 n=is_method
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=167 a=5 n=route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=260 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=233 a=24 n=has_totag
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: siputils [checks.c:106]: has_totag(): totag found
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=255 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=235 a=24 n=loose_route
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: rr [loose.c:113]: find_first_route(): No Route headers found
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: rr [loose.c:931]: loose_route(): There is no Route HF
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=254 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=242 a=25 n=is_method
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=252 a=16 n=if
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=243 a=24 n=t_check_trans
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg: msg id=8 global id=0 T start=0xffffffffffffffff
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: tm [t_lookup.c:527]: t_lookup_request(): t_lookup_request: start searching: hash=45642, isACK=1
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: tm [t_lookup.c:470]: matching_3261(): DEBUG: RFC3261 transaction matched, tid=08Bcb20235d128e4898
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: tm [t_lookup.c:726]: t_lookup_request(): DEBUG: t_lookup_request: transaction found (T=0x7fd70c9c6348)
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: tm [t_lookup.c:1141]: t_check_msg(): DEBUG: t_check_msg: msg id=8 global id=8 T end=0x7fd70c9c6348
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: tm [t_reply.c:1672]: cleanup_uac_timers(): DEBUG: cleanup_uac_timers: RETR/FR timers reset
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: <core> [timer.c:589]: timer_add_safe(): timer_add called on an active timer 0x7fd70c9c63c8 (0x7fd70c761718, 0x7fd70c761718), flags 201
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: tm [t_funcs.c:181]: put_on_wait(): tm: put_on_wait: transaction 0x7fd70c9c6348 already on wait
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list 0x7fd70c9c6160
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil)
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: message repeated 4 times: [ DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil)]
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: <core> [xavp.c:448]: xavp_destroy_list(): destroying xavp list (nil)
Jul 4 12:22:38 s2 /usr/sbin/kamailio[16524]: DEBUG: <core> [receive.c:298]: receive_msg(): receive_msg: cleaning up
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment