[SR-Users] Confused with forwarding REGISTER

fuxfwgc4a2i1gr fuxfwgc4a2i1gr at gmail.com
Mon Apr 6 12:32:46 CEST 2020


Hello. Thanks for your reply .

I understand about nat . Am i right that even without nat traversal 
logic i have to see on proxy itself attempts to connect to private ip 
addresses ?

But i not see them.

Ok i changed "== false", to "!= true". I prefer to use long condition 
forms to have better config file readability.

But i am not sure that even my "==false" which in block 
onreply_route[REPLYROUTE] can influence on something because xlog 
operator stay before condition and i have to see a least message that 
packet reached onreply_route .

To make capture i using "ngrep -d any -qt -W byline port 7060" it listen 
on all interfaces and result exactly same as bug report on github.

I attached debug log from kamailio on system where issue persist. Well i 
replaced some private information inside it to avoid voip frauders  to 
collect information. But privately i can send original ones if needed.

Affected host does not have firewall configured.

It have two ip addresses(two physical interfaces) . One of them assigned 
public address, another private (10.34.79.254/20). REGISTRAR in same LAN 
segment with proxy private ip address.

On 2020-04-05 09:03, Daniel-Constantin Mierla wrote:
> Hello,
>
> if the device is behind nat router, you have to do the nat traversal
> logic, because the Via header will be a private IP address, which cannot
> be used for routing by Kamailio.
>
> To troubleshoot further, set debug=3 in kamailio.cfg and test again.
> Grab all log messages printed by kamailio in syslog (there should be a
> lot with DEBUG:...) and send them here. Also, get the pcap file with sip
> traffic for such case. It helps seeing what addresses are in the SIP
> headers.
>
> Moreover, remove all those " == false ", as I said in the github issue,
> that can be something not giving what you would expect.
>
> Cheers,
> Daniel
>
> On 05.04.20 07:15, fuxfwgc4a2i1gr wrote:
>> Hi, Thanks for your solution.
>>
>> I tried to use it from early beginning and this is was a reason why i
>> created bug report on github.
>>
>> When i start tcpdump on proxy. I see 404 reply from REGISTRAR to
>> Proxy. But not see reply from Proxy to UA.
>>
>> Look like that Kamailio don`t think that 404 reply is a part of
>> transaction.
>>
>>
>> _______________________________________________
>> Kamailio (SER) - Users Mailing List
>> sr-users at lists.kamailio.org
>> https://lists.kamailio.org/cgi-bin/mailman/listinfo/sr-users
-------------- next part --------------
Apr  6 11:54:20 fsinnosbc systemd[1]: /lib/systemd/system/kamailio.service:14: PIDFile= references path below legacy directory /var/run/, updating /var/run/kamailio/kamailio.pid → /run/kamailio/kamailio.pid; please update the unit file accordingly.
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.y:1764]: yyparse(): loading module jsonrpcs.so
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:505]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/jsonrpcs.so>
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/kemi.c:2642]: sr_kemi_modules_add(): adding core module
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/kemi.c:2646]: sr_kemi_modules_add(): adding pv module
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/kemi.c:2650]: sr_kemi_modules_add(): adding hdr module
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/kemi.c:2664]: sr_kemi_modules_add(): adding module: jsonrpcs
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:267]: register_module(): register PV from: jsonrpcs
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.lex:1780]: pp_define(): defining id: MOD_jsonrpcs
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.y:1764]: yyparse(): loading module kex.so
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:505]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/kex.so>
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/kemi.c:2664]: sr_kemi_modules_add(): adding module: kex
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:267]: register_module(): register PV from: kex
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.lex:1780]: pp_define(): defining id: MOD_kex
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.y:1764]: yyparse(): loading module corex.so
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:505]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/corex.so>
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/kemi.c:2664]: sr_kemi_modules_add(): adding module: corex
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:267]: register_module(): register PV from: corex
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.lex:1780]: pp_define(): defining id: MOD_corex
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.y:1764]: yyparse(): loading module tm.so
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:505]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so>
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/kemi.c:2664]: sr_kemi_modules_add(): adding module: tm
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.lex:1780]: pp_define(): defining id: MOD_tm
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.y:1764]: yyparse(): loading module tmx.so
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:505]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/tmx.so>
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/kemi.c:2664]: sr_kemi_modules_add(): adding module: tmx
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:267]: register_module(): register PV from: tmx
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.lex:1780]: pp_define(): defining id: MOD_tmx
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.y:1764]: yyparse(): loading module sl.so
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:505]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/sl.so>
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/kemi.c:2664]: sr_kemi_modules_add(): adding module: sl
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:267]: register_module(): register PV from: sl
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.lex:1780]: pp_define(): defining id: MOD_sl
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.y:1764]: yyparse(): loading module rr.so
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:505]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/rr.so>
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/kemi.c:2664]: sr_kemi_modules_add(): adding module: rr
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:267]: register_module(): register PV from: rr
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.lex:1780]: pp_define(): defining id: MOD_rr
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.y:1764]: yyparse(): loading module pv.so
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:505]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/pv.so>
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/kemi.c:2664]: sr_kemi_modules_add(): adding module: pvx
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:267]: register_module(): register PV from: pv
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.lex:1780]: pp_define(): defining id: MOD_pv
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.y:1764]: yyparse(): loading module maxfwd.so
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:505]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/maxfwd.so>
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/kemi.c:2664]: sr_kemi_modules_add(): adding module: maxfwd
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.lex:1780]: pp_define(): defining id: MOD_maxfwd
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.y:1764]: yyparse(): loading module textops.so
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:505]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/textops.so>
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/kemi.c:2664]: sr_kemi_modules_add(): adding module: textops
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.lex:1780]: pp_define(): defining id: MOD_textops
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.y:1764]: yyparse(): loading module siputils.so
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:505]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/siputils.so>
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/kemi.c:2664]: sr_kemi_modules_add(): adding module: siputils
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:267]: register_module(): register PV from: siputils
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.lex:1780]: pp_define(): defining id: MOD_siputils
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.y:1764]: yyparse(): loading module xlog.so
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:505]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/xlog.so>
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/kemi.c:2664]: sr_kemi_modules_add(): adding module: xlog
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:267]: register_module(): register PV from: xlog
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.lex:1780]: pp_define(): defining id: MOD_xlog
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.y:1764]: yyparse(): loading module sanity.so
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:505]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/sanity.so>
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/kemi.c:2664]: sr_kemi_modules_add(): adding module: sanity
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.lex:1780]: pp_define(): defining id: MOD_sanity
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.y:1764]: yyparse(): loading module ctl.so
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:505]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/ctl.so>
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.lex:1780]: pp_define(): defining id: MOD_ctl
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.y:1764]: yyparse(): loading module cfg_rpc.so
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:505]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/cfg_rpc.so>
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.lex:1780]: pp_define(): defining id: MOD_cfg_rpc
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.y:1764]: yyparse(): loading module acc.so
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:505]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/acc.so>
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/kemi.c:2664]: sr_kemi_modules_add(): adding module: acc
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.lex:1780]: pp_define(): defining id: MOD_acc
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.y:1764]: yyparse(): loading module counters.so
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:505]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/counters.so>
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/kemi.c:2664]: sr_kemi_modules_add(): adding module: counters
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.lex:1780]: pp_define(): defining id: MOD_counters
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.y:1764]: yyparse(): loading module outbound
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:505]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/outbound.so>
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.lex:1780]: pp_define(): defining id: MOD_outbound
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.y:1764]: yyparse(): loading module path
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:505]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/path.so>
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/kemi.c:2664]: sr_kemi_modules_add(): adding module: path
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.lex:1780]: pp_define(): defining id: MOD_path
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/mem/shm.c:100]: shm_core_pools_init(): preparing to initialize shm core pools
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/mem/q_malloc.c:199]: qm_malloc_init(): QM_OPTIMIZE=16384, /ROUNDTO=2048
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/mem/q_malloc.c:201]: qm_malloc_init(): QM_HASH_SIZE=2099, qm_block size=235152
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/mem/q_malloc.c:203]: qm_malloc_init(): qm_malloc_init(0x7fe378c0b000, 67108864), start=0x7fe378c0b000
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/mem/q_malloc.c:212]: qm_malloc_init(): size= 67108864, init_overhead=235256
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:107]: set_mod_param_regex(): 'jsonrpcs' matches module 'jsonrpcs'
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:724]: find_param_export(): found <pretty_format> in module jsonrpcs [/usr/lib/x86_64-linux-gnu/kamailio/modules/jsonrpcs.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:123]: set_mod_param_regex(): found <pretty_format> in module jsonrpcs [/usr/lib/x86_64-linux-gnu/kamailio/modules/jsonrpcs.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:107]: set_mod_param_regex(): 'tm' matches module 'tm'
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:724]: find_param_export(): found <failure_reply_mode> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:123]: set_mod_param_regex(): found <failure_reply_mode> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:107]: set_mod_param_regex(): 'tm' matches module 'tm'
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:724]: find_param_export(): found <fr_timer> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:123]: set_mod_param_regex(): found <fr_timer> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:107]: set_mod_param_regex(): 'tm' matches module 'tm'
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:724]: find_param_export(): found <fr_inv_timer> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:123]: set_mod_param_regex(): found <fr_inv_timer> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:107]: set_mod_param_regex(): 'rr' matches module 'rr'
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:724]: find_param_export(): found <enable_full_lr> in module rr [/usr/lib/x86_64-linux-gnu/kamailio/modules/rr.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:123]: set_mod_param_regex(): found <enable_full_lr> in module rr [/usr/lib/x86_64-linux-gnu/kamailio/modules/rr.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:107]: set_mod_param_regex(): 'rr' matches module 'rr'
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:724]: find_param_export(): found <append_fromtag> in module rr [/usr/lib/x86_64-linux-gnu/kamailio/modules/rr.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:123]: set_mod_param_regex(): found <append_fromtag> in module rr [/usr/lib/x86_64-linux-gnu/kamailio/modules/rr.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:107]: set_mod_param_regex(): 'acc' matches module 'acc'
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:724]: find_param_export(): found <early_media> in module acc [/usr/lib/x86_64-linux-gnu/kamailio/modules/acc.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:123]: set_mod_param_regex(): found <early_media> in module acc [/usr/lib/x86_64-linux-gnu/kamailio/modules/acc.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:107]: set_mod_param_regex(): 'acc' matches module 'acc'
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:724]: find_param_export(): found <report_ack> in module acc [/usr/lib/x86_64-linux-gnu/kamailio/modules/acc.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:123]: set_mod_param_regex(): found <report_ack> in module acc [/usr/lib/x86_64-linux-gnu/kamailio/modules/acc.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:107]: set_mod_param_regex(): 'acc' matches module 'acc'
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:724]: find_param_export(): found <report_cancels> in module acc [/usr/lib/x86_64-linux-gnu/kamailio/modules/acc.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:123]: set_mod_param_regex(): found <report_cancels> in module acc [/usr/lib/x86_64-linux-gnu/kamailio/modules/acc.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:107]: set_mod_param_regex(): 'acc' matches module 'acc'
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:724]: find_param_export(): found <detect_direction> in module acc [/usr/lib/x86_64-linux-gnu/kamailio/modules/acc.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:123]: set_mod_param_regex(): found <detect_direction> in module acc [/usr/lib/x86_64-linux-gnu/kamailio/modules/acc.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.lex:1888]: pp_define_get(): ### returning define ID [FLT_ACC] value [1]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:107]: set_mod_param_regex(): 'acc' matches module 'acc'
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:724]: find_param_export(): found <log_flag> in module acc [/usr/lib/x86_64-linux-gnu/kamailio/modules/acc.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:123]: set_mod_param_regex(): found <log_flag> in module acc [/usr/lib/x86_64-linux-gnu/kamailio/modules/acc.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.lex:1888]: pp_define_get(): ### returning define ID [FLT_ACCMISSED] value [2]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:107]: set_mod_param_regex(): 'acc' matches module 'acc'
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:724]: find_param_export(): found <log_missed_flag> in module acc [/usr/lib/x86_64-linux-gnu/kamailio/modules/acc.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:123]: set_mod_param_regex(): found <log_missed_flag> in module acc [/usr/lib/x86_64-linux-gnu/kamailio/modules/acc.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:107]: set_mod_param_regex(): 'acc' matches module 'acc'
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:724]: find_param_export(): found <log_extra> in module acc [/usr/lib/x86_64-linux-gnu/kamailio/modules/acc.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:123]: set_mod_param_regex(): found <log_extra> in module acc [/usr/lib/x86_64-linux-gnu/kamailio/modules/acc.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.lex:1888]: pp_define_get(): ### returning define ID [FLT_ACCFAILED] value [3]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:107]: set_mod_param_regex(): 'acc' matches module 'acc'
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:724]: find_param_export(): found <failed_transaction_flag> in module acc [/usr/lib/x86_64-linux-gnu/kamailio/modules/acc.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/modparam.c:123]: set_mod_param_regex(): found <failed_transaction_flag> in module acc [/usr/lib/x86_64-linux-gnu/kamailio/modules/acc.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#5 #0/1: 1(1)/ 0x7fe37d7129a8
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#5 #0/1: 1(1)/ 0x7fe37d712be0
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#5 #0/1: 1(1)/ 0x7fe37d712e18
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#5 #0/1: 1(1)/ 0x7fe37d713050
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <xlog> in module xlog [/usr/lib/x86_64-linux-gnu/kamailio/modules/xlog.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/pvapi.c:335]: pv_cache_add(): PV cache not initialized, doing it now
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/pvapi.c:371]: pv_cache_add(): pvar [$du] added in cache
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#63 #0/2: 21(15)/ 0x7fe37d7137f8
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#63 #1/2: 22(16)/ 0x7fe37d713dc0
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#5 #0/1: 1(1)/ 0x7fe37d713b40
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#2 #0/2: 3(3)/ 0x1
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#2 #1/2: 3(3)/ 0x1
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <is_method> in module textops [/usr/lib/x86_64-linux-gnu/kamailio/modules/textops.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <t_check_trans> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#5 #0/1: 1(1)/ 0x7fe37d717a50
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #0/3: 22(16)/ 0x7fe37d717320
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #1/3: 8(8)/ 0x7fe37d717b38
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #2/3: 0(0)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <sl_reply> in module sl [/usr/lib/x86_64-linux-gnu/kamailio/modules/sl.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#2 #0/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#2 #1/2: 3(3)/ 0x9
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #0/3: 22(16)/ 0x7fe37d715b58
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #1/3: 8(8)/ 0x7fe37d717d70
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #2/3: 0(0)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route.c:129]: route_add(): mapping routing block (0x55e848843a80)[CATCH_CANCEL] to 1
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <loose_route> in module rr [/usr/lib/x86_64-linux-gnu/kamailio/modules/rr.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <xlog> in module xlog [/usr/lib/x86_64-linux-gnu/kamailio/modules/xlog.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <append_hf> in module textops [/usr/lib/x86_64-linux-gnu/kamailio/modules/textops.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#5 #0/1: 1(1)/ 0x7fe37d71a748
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <xlog> in module xlog [/usr/lib/x86_64-linux-gnu/kamailio/modules/xlog.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <record_route> in module rr [/usr/lib/x86_64-linux-gnu/kamailio/modules/rr.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #0/3: 22(16)/ 0x7fe37d719860
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #1/3: 8(8)/ 0x7fe37d71a078
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #2/3: 8(8)/ 0x7fe37d71abb0
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route.c:129]: route_add(): mapping routing block (0x55e848843a80)[RR_PARSE] to 2
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <is_method> in module textops [/usr/lib/x86_64-linux-gnu/kamailio/modules/textops.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <add_path_received> in module path [/usr/lib/x86_64-linux-gnu/kamailio/modules/path.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <append_hf> in module textops [/usr/lib/x86_64-linux-gnu/kamailio/modules/textops.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <xlog> in module xlog [/usr/lib/x86_64-linux-gnu/kamailio/modules/xlog.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #0/3: 22(16)/ 0x7fe37d71c7b8
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #1/3: 8(8)/ 0x7fe37d71cfd0
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #2/3: 0(0)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route.c:129]: route_add(): mapping routing block (0x55e848843a80)[REGISTRATION] to 3
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/pvapi.c:371]: pv_cache_add(): pvar [$ua] added in cache
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#2 #0/2: 3(3)/ 0x1
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#2 #1/2: 3(3)/ 0x1
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #0/3: 22(16)/ 0x7fe37d71ee70
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #1/3: 8(8)/ 0x7fe37d71f5a0
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #2/3: 0(0)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <mf_process_maxfwd_header> in module maxfwd [/usr/lib/x86_64-linux-gnu/kamailio/modules/maxfwd.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <sl_send_reply> in module sl [/usr/lib/x86_64-linux-gnu/kamailio/modules/sl.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#2 #0/2: 3(3)/ 0x1
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#2 #1/2: 3(3)/ 0x1
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #0/3: 22(16)/ 0x7fe37d7209c0
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #1/3: 8(8)/ 0x7fe37d7211d8
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #2/3: 0(0)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <is_method> in module textops [/usr/lib/x86_64-linux-gnu/kamailio/modules/textops.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/pvapi.c:371]: pv_cache_add(): pvar [$rU] added in cache
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/pvapi.c:371]: pv_cache_add(): pvar [$null] added in cache
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg.y:2900]: yyparse(): comparison with $null switched to defined operator
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <sl_send_reply> in module sl [/usr/lib/x86_64-linux-gnu/kamailio/modules/sl.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#2 #0/2: 3(3)/ 0x1
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#2 #1/2: 3(3)/ 0x1
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #0/3: 22(16)/ 0x7fe37d723e08
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #1/3: 8(8)/ 0x7fe37d724d50
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #2/3: 0(0)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <sanity_check> in module sanity [/usr/lib/x86_64-linux-gnu/kamailio/modules/sanity.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <xlog> in module xlog [/usr/lib/x86_64-linux-gnu/kamailio/modules/xlog.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#2 #0/2: 3(3)/ 0x1
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#2 #1/2: 3(3)/ 0x1
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #0/3: 22(16)/ 0x7fe37d726da0
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #1/3: 8(8)/ 0x7fe37d7275b8
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #2/3: 0(0)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route.c:129]: route_add(): mapping routing block (0x55e848843a80)[REQINIT] to 4
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <t_on_failure> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <t_on_reply> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <t_relay> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <sl_reply_error> in module sl [/usr/lib/x86_64-linux-gnu/kamailio/modules/sl.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #0/3: 22(16)/ 0x7fe37d729730
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #1/3: 8(8)/ 0x7fe37d729e60
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #2/3: 0(0)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#2 #0/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#2 #1/2: 3(3)/ 0x9
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route.c:129]: route_add(): mapping routing block (0x55e848843a80)[FORWARD] to 5
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <xlog> in module xlog [/usr/lib/x86_64-linux-gnu/kamailio/modules/xlog.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <t_check_trans> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#2 #0/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#2 #1/2: 3(3)/ 0x9
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #0/3: 22(16)/ 0x7fe37d72bd08
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #1/3: 8(8)/ 0x7fe37d72a928
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#16 #2/3: 0(0)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route.c:129]: route_add(): mapping routing block (0x55e848843a00)[REPLYROUTE] to 1
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #0/2: 9(9)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route_struct.c:129]: mk_action(): ACTION_#24 #1/2: 3(3)/ (nil)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <xlog> in module xlog [/usr/lib/x86_64-linux-gnu/kamailio/modules/xlog.so]
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route.c:129]: route_add(): mapping routing block (0x55e848843a40)[FAILROUTE] to 1
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/ppcfg.c:230]: pp_ifdef_level_check(): same number of pairing preprocessor directives #!IF[N]DEF - #!ENDIF
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/route.c:129]: route_add(): mapping routing block (0x55e848843a60)[core:receive-parse-error] to 1
Apr  6 11:54:20 fsinnosbc kamailio: INFO: <core> [core/sctp_core.c:74]: sctp_core_check_support(): SCTP API not enabled - if you want to use it, load sctp module
Apr  6 11:54:20 fsinnosbc kamailio: WARNING: <core> [core/socket_info.c:1394]: fix_hostname(): could not rev. resolve 88.88.88.88
Apr  6 11:54:20 fsinnosbc kamailio: WARNING: <core> [core/socket_info.c:1394]: fix_hostname(): could not rev. resolve 10.34.79.254
Apr  6 11:54:20 fsinnosbc kamailio: WARNING: <core> [core/socket_info.c:1394]: fix_hostname(): could not rev. resolve 88.88.88.88
Apr  6 11:54:20 fsinnosbc kamailio: WARNING: <core> [core/socket_info.c:1394]: fix_hostname(): could not rev. resolve 10.34.79.254
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/mem/pkg.c:108]: pkg_print_manager(): pkg - using memory manager: q_malloc
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/mem/shm.c:300]: shm_print_manager(): shm - using memory manager: q_malloc
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg/cfg.c:173]: cfg_declare(): new config group has been registered: 'core' (num=56, size=224)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/cfg/cfg.c:173]: cfg_declare(): new config group has been registered: 'tcp' (num=27, size=108)
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/timer.c:239]: init_timer(): starting with *ticks=2121041112
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/timer.c:280]: init_timer(): timer_list between 0x7fe378c44af0 and 0x7fe378c88af0
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/pt.c:138]: register_procs(): registering new processes: 0 (old) + 1 (new) = 1 (total)
Apr  6 11:54:20 fsinnosbc kamailio: INFO: <core> [core/tcp_main.c:5042]: init_tcp(): using epoll_lt as the io watch method (auto detected)
Apr  6 11:54:20 fsinnosbc kamailio[1718]: Listening on
Apr  6 11:54:20 fsinnosbc kamailio[1718]:              udp: 88.88.88.88:7060
Apr  6 11:54:20 fsinnosbc kamailio[1718]:              udp: 10.34.79.254:7060
Apr  6 11:54:20 fsinnosbc kamailio[1718]:              tcp: 88.88.88.88:7060
Apr  6 11:54:20 fsinnosbc kamailio[1718]:              tcp: 10.34.79.254:7060
Apr  6 11:54:20 fsinnosbc kamailio[1718]: Aliases:
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/daemonize.c:207]: enable_dumpable(): trying enable core dumping...
Apr  6 11:54:20 fsinnosbc kamailio: DEBUG: <core> [core/daemonize.c:224]: enable_dumpable(): core dumping is enabled now (1)...
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/daemonize.c:583]: set_core_dump(): core dump limits set to 18446744073709551615
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/async_task.c:123]: async_task_init(): start initializing asynk task framework
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:847]: init_mod(): jsonrpcs
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: jsonrpcs [jsonrpcs_mod.c:1127]: mod_init(): preparing to listen on fifo file: kamailio_rpc.fifo
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: jsonrpcs [jsonrpcs_fifo.c:534]: jsonrpc_fifo_mod_init(): fifo path is [/var/run/kamailio/kamailio_rpc.fifo]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: jsonrpcs [jsonrpcs_fifo.c:151]: jsonrpc_init_fifo_file(): testing if fifo file exists ...
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: jsonrpcs [jsonrpcs_fifo.c:72]: jsonrpc_init_fifo_server(): FIFO created @ /var/run/kamailio/kamailio_rpc.fifo
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: jsonrpcs [jsonrpcs_fifo.c:87]: jsonrpc_init_fifo_server(): fifo /var/run/kamailio/kamailio_rpc.fifo opened, mode=660
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/pt.c:138]: register_procs(): registering new processes: 1 (old) + 1 (new) = 2 (total)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: jsonrpcs [jsonrpcs_mod.c:1146]: mod_init(): preparing to listen on datagram socket: kamailio_rpc.sock
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: jsonrpcs [jsonrpcs_sock.c:109]: jsonrpc_dgram_mod_init(): testing socket existence...
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: jsonrpcs [jsonrpcs_sock.c:116]: jsonrpc_dgram_mod_init(): the socket's name/address is kamailio_rpc.sock
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: jsonrpcs [jsonrpcs_sock.c:172]: jsonrpc_dgram_mod_init(): UNIX socket provided
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: jsonrpcs [jsonrpcs_sock.c:191]: jsonrpc_dgram_mod_init(): unix socket path is [/var/run/kamailio/kamailio_rpc.sock]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: jsonrpcs [jsonrpcs_sock.c:338]: jsonrpc_dgram_init_server(): we have a unix socket: /var/run/kamailio/kamailio_rpc.sock
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/pt.c:138]: register_procs(): registering new processes: 2 (old) + 1 (new) = 3 (total)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:847]: init_mod(): kex
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [sruid.c:105]: sruid_init(): root for sruid is [srid-5e8afc4c-6b8-] (0 / 18)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:847]: init_mod(): corex
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:847]: init_mod(): tm
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: tm [tm.c:697]: mod_init(): TM - (sizeof cell=504, sip_msg=1792) initializing...
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: tm [callid.c:105]: init_callid(): Call-ID initialization: '447a2cfa5d837c62'
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: tm [lock.c:66]: lock_initialize(): lock initialization started
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: tm [timer.c:195]: tm_init_timers(): tm init timers - fr=480 fr_inv=1920 wait=80 t1=500 t2=4000 max_inv_lifetime=2880 max_noninv_lifetime=512
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/cfg/cfg.c:173]: cfg_declare(): new config group has been registered: 'tm' (num=36, size=168)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/md5utils.c:67]: MD5StringArray(): MD5 calculated: 11d08ad2e8b5a4df21160ee79420e9c0
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/md5utils.c:67]: MD5StringArray(): MD5 calculated: f83e3ed9fd2e9efce597451a3371e941
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:847]: init_mod(): tmx
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <load_tm> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <t_newtran> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <t_relay_to_tcp> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <t_relay_to_udp> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <t_relay> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <t_forward_nonack> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <t_release> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:847]: init_mod(): sl
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/md5utils.c:67]: MD5StringArray(): MD5 calculated: 10b9a26243baf3ee42ba374ee14b07d3
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <load_tm> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <t_newtran> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <t_relay_to_tcp> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <t_relay_to_udp> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <t_relay> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <t_forward_nonack> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <t_release> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:847]: init_mod(): rr
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <bind_ob> in module outbound [/usr/lib/x86_64-linux-gnu/kamailio/modules/outbound.so]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: rr [rr_mod.c:174]: mod_init(): Bound rr module to outbound module
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:847]: init_mod(): pv
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:847]: init_mod(): maxfwd
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/cfg/cfg.c:173]: cfg_declare(): new config group has been registered: 'maxfwd' (num=1, size=4)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:847]: init_mod(): textops
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:847]: init_mod(): siputils
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <bind_sl> in module sl [/usr/lib/x86_64-linux-gnu/kamailio/modules/sl.so]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/usr_avp.c:887]: parse_avp_ident(): Parsing 's:rpid'
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/cfg/cfg.c:173]: cfg_declare(): new config group has been registered: 'siputils' (num=1, size=4)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:847]: init_mod(): xlog
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/cfg/cfg.c:173]: cfg_declare(): new config group has been registered: 'xlog' (num=1, size=4)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:847]: init_mod(): sanity
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: sanity [sanity_mod.c:103]: mod_init(): sanity initializing
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <bind_sl> in module sl [/usr/lib/x86_64-linux-gnu/kamailio/modules/sl.so]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: sanity [sanity_mod.c:113]: mod_init(): parsing proxy requires string:
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: sanity [sanity.c:178]: parse_str_list(): list is empty
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:847]: init_mod(): ctl
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: ctl [ctl.c:250]: mod_init(): listening on:
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: ctl [ctl.c:260]: mod_init():         [binrpc:unix stream] /var/run/kamailio//kamailio_ctl
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/pt.c:138]: register_procs(): registering new processes: 3 (old) + 1 (new) = 4 (total)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:847]: init_mod(): cfg_rpc
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:847]: init_mod(): acc
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <load_tm> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <t_newtran> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <t_relay_to_tcp> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <t_relay_to_udp> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <t_relay> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <t_forward_nonack> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <t_release> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:847]: init_mod(): outbound
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/cfg/cfg.c:173]: cfg_declare(): new config group has been registered: 'outbound' (num=1, size=4)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:698]: find_module_by_name(): module <stun> not found
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: WARNING: outbound [outbound_mod.c:121]: mod_init(): "stun" module is not loaded. STUN is required to use outbound with UDP.
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:847]: init_mod(): path
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:632]: find_mod_export_record(): found export of <bind_ob> in module outbound [/usr/lib/x86_64-linux-gnu/kamailio/modules/outbound.so]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: path [path_mod.c:149]: mod_init(): Bound path module to outbound module
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/pt.c:99]: init_pt(): registering new processes: 4 (old) + 10 (new) = 14 (total)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: INFO: <core> [main.c:2779]: main(): processes (at least): 14 - shm size: 67108864 - pkg size: 8388608
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing xlog()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2873]: fix_rval(): RV fixing type 2
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2881]: fix_rval(): RV is str: "sip:10.34.64.2:5060"
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2873]: fix_rval(): RV fixing type 4
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing is_method()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: textops [textops.c:3508]: fixup_method(): using id for method [CANCEL/2]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2873]: fix_rval(): RV fixing type 1
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2877]: fix_rval(): RV is int: 1
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:3577]: rve_optimize(): FIXUP RVE (178,27-178,35): changed ==/!= into integer ==/!=
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2873]: fix_rval(): RV fixing type 4
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing t_check_trans()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2873]: fix_rval(): RV fixing type 1
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2877]: fix_rval(): RV is int: 1
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:3577]: rve_optimize(): FIXUP RVE (180,20-180,28): changed ==/!= into integer ==/!=
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing sl_reply()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2873]: fix_rval(): RV fixing type 4
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing loose_route()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2873]: fix_rval(): RV fixing type 1
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2877]: fix_rval(): RV is int: 1
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:3577]: rve_optimize(): FIXUP RVE (191,20-191,28): changed ==/!= into integer ==/!=
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing xlog()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing append_hf()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing xlog()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing record_route()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2873]: fix_rval(): RV fixing type 4
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing is_method()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: textops [textops.c:3508]: fixup_method(): using id for method [REGISTER/32]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2873]: fix_rval(): RV fixing type 1
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2877]: fix_rval(): RV is int: 1
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:3577]: rve_optimize(): FIXUP RVE (217,28-217,36): changed ==/!= into integer ==/!=
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing add_path_received()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing append_hf()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing xlog()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2873]: fix_rval(): RV fixing type 7
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2873]: fix_rval(): RV fixing type 4
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing mf_process_maxfwd_header()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing sl_send_reply()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2873]: fix_rval(): RV fixing type 4
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing is_method()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: textops [textops.c:3508]: fixup_method(): using id for method [OPTIONS/512]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2873]: fix_rval(): RV fixing type 3
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2873]: fix_rval(): RV fixing type 7
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing sl_send_reply()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2873]: fix_rval(): RV fixing type 4
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing sanity_check()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing xlog()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/pvapi.c:497]: pv_spec_lookup(): PV <$si> is not in cache
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/pvapi.c:371]: pv_cache_add(): pvar [$si] added in cache
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/pvapi.c:497]: pv_spec_lookup(): PV <$sp> is not in cache
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/pvapi.c:371]: pv_cache_add(): pvar [$sp] added in cache
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing t_on_failure()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing t_on_reply()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2873]: fix_rval(): RV fixing type 4
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing t_relay()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2873]: fix_rval(): RV fixing type 1
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2877]: fix_rval(): RV is int: 0
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing sl_reply_error()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing xlog()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/pvapi.c:398]: pv_cache_lookup(): pvar [$si] found in cache
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/pvapi.c:398]: pv_cache_lookup(): pvar [$sp] found in cache
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2873]: fix_rval(): RV fixing type 4
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing t_check_trans()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2873]: fix_rval(): RV fixing type 1
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:2877]: fix_rval(): RV is int: 1
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/rvalue.c:3577]: rve_optimize(): FIXUP RVE (269,23-269,31): changed ==/!= into integer ==/!=
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/route.c:885]: fix_actions(): fixing xlog()
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/pvapi.c:398]: pv_cache_lookup(): pvar [$si] found in cache
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/pvapi.c:398]: pv_cache_lookup(): pvar [$sp] found in cache
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: INFO: <core> [core/udp_server.c:154]: probe_max_receive_buffer(): SO_RCVBUF is initially 212992
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: INFO: <core> [core/udp_server.c:206]: probe_max_receive_buffer(): SO_RCVBUF is finally 425984
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: INFO: <core> [core/udp_server.c:154]: probe_max_receive_buffer(): SO_RCVBUF is initially 212992
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: INFO: <core> [core/udp_server.c:206]: probe_max_receive_buffer(): SO_RCVBUF is finally 425984
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/tcp_main.c:3060]: tcp_init(): added 88.88.88.88:7060
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/tcp_main.c:3060]: tcp_init(): added 10.34.79.254:7060
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/daemonize.c:207]: enable_dumpable(): trying enable core dumping...
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/daemonize.c:209]: enable_dumpable(): core dumping is disabled now...
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/daemonize.c:213]: enable_dumpable(): core dumping has just been enabled...
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/daemonize.c:219]: enable_dumpable(): current core file limit: 18446744073709551615 (max: 18446744073709551615)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/pvapi.c:497]: pv_spec_lookup(): PV <$mt> is not in cache
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/pvapi.c:371]: pv_cache_add(): pvar [$mt] added in cache
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/pvapi.c:497]: pv_spec_lookup(): PV <$hdr(CSeq)> is not in cache
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: pv [pv_core.c:3187]: pv_parse_hdr_name(): using hdr type (5) instead of <CSeq>
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/pvapi.c:371]: pv_cache_add(): pvar [$hdr(CSeq)] added in cache
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/pvapi.c:497]: pv_spec_lookup(): PV <$ci> is not in cache
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/pvapi.c:371]: pv_cache_add(): pvar [$ci] added in cache
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:820]: init_child(): initializing PROC_INIT with rank -127
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 0 rank -127: jsonrpcs [main]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 0 rank -127: kex [main]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: kex [kex_mod.c:155]: child_init(): rank is (-127)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [sruid.c:105]: sruid_init(): root for sruid is [srid-5e8afc4c-6b8-] (0 / 18)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 0 rank -127: corex [main]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 0 rank -127: tm [main]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 0 rank -127: tmx [main]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: tmx [tmx_mod.c:262]: child_init(): rank is (-127)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 0 rank -127: sl [main]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 0 rank -127: ctl [main]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 0 rank -127: acc [main]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:820]: init_child(): initializing PROC_MAIN with rank 0
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 0 rank 0: jsonrpcs [main]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1723]: DEBUG: <core> [core/pt.c:311]: fork_process(): test random numbers 1262950142 497801752 2874971674
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/pt.c:311]: fork_process(): test random numbers 991551746 759357063 2841098224
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/sr_module.c:820]: init_child(): initializing PROC_SIPINIT with rank 1
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 1 rank 1: jsonrpcs [udp receiver child=0 sock=88.88.88.88:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 1 rank 1: kex [udp receiver child=0 sock=88.88.88.88:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: kex [kex_mod.c:155]: child_init(): rank is (1)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [sruid.c:105]: sruid_init(): root for sruid is [srid-5e8afc4c-6b9-] (0 / 18)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 1 rank 1: corex [udp receiver child=0 sock=88.88.88.88:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 1 rank 1: tm [udp receiver child=0 sock=88.88.88.88:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '447a2cfa5d837c62-1721 at 88.88.88.88'
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 1 rank 1: tmx [udp receiver child=0 sock=88.88.88.88:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: tmx [tmx_mod.c:262]: child_init(): rank is (1)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 1 rank 1: sl [udp receiver child=0 sock=88.88.88.88:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 0 rank 0: kex [main]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 1 rank 1: ctl [udp receiver child=0 sock=88.88.88.88:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: kex [kex_mod.c:155]: child_init(): rank is (0)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [sruid.c:105]: sruid_init(): root for sruid is [srid-5e8afc4c-6b8-] (0 / 18)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 1 rank 1: acc [udp receiver child=0 sock=88.88.88.88:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/action.c:1681]: run_child_one_init_route(): attempting to run event_route[core:worker-one-init]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 0 rank 0: corex [main]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 0 rank 0: tm [main]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '447a2cfa5d837c62-1720 at 88.88.88.88'
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/route.c:129]: route_add(): mapping routing block (0x55e848843a60)[core:worker-one-init] to 2
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 0 rank 0: tmx [main]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: tmx [tmx_mod.c:262]: child_init(): rank is (0)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 0 rank 0: sl [main]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 0 rank 0: ctl [main]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: ctl [ctl.c:322]: mod_child(): ctl: mod_child(0), ctrl_sock_lst=0x55e84931d0d0
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1723]: DEBUG: <core> [core/sr_module.c:820]: init_child(): initializing CHILD with rank 3
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1723]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 3 rank 3: jsonrpcs [udp receiver child=0 sock=10.34.79.254:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1723]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 3 rank 3: kex [udp receiver child=0 sock=10.34.79.254:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1723]: DEBUG: kex [kex_mod.c:155]: child_init(): rank is (3)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1723]: DEBUG: <core> [sruid.c:105]: sruid_init(): root for sruid is [srid-5e8afc4c-6bb-] (0 / 18)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1723]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 3 rank 3: corex [udp receiver child=0 sock=10.34.79.254:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1723]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 3 rank 3: tm [udp receiver child=0 sock=10.34.79.254:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1723]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '447a2cfa5d837c62-1723 at 88.88.88.88'
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1723]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 3 rank 3: tmx [udp receiver child=0 sock=10.34.79.254:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1723]: DEBUG: tmx [tmx_mod.c:262]: child_init(): rank is (3)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1723]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 3 rank 3: sl [udp receiver child=0 sock=10.34.79.254:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1723]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 3 rank 3: ctl [udp receiver child=0 sock=10.34.79.254:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1723]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 3 rank 3: acc [udp receiver child=0 sock=10.34.79.254:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1724]: DEBUG: <core> [core/pt.c:311]: fork_process(): test random numbers 1464210494 181362152 595469368
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1724]: DEBUG: <core> [core/sr_module.c:820]: init_child(): initializing CHILD with rank 4
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: ctl [ctl.c:330]: mod_child(): ctl: mod_child(0), fork_process=1730, csl=0x55e84931d0d0
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 0 rank 0: acc [main]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1724]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 4 rank 4: jsonrpcs [udp receiver child=1 sock=10.34.79.254:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1724]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 4 rank 4: kex [udp receiver child=1 sock=10.34.79.254:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1724]: DEBUG: kex [kex_mod.c:155]: child_init(): rank is (4)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1724]: DEBUG: <core> [sruid.c:105]: sruid_init(): root for sruid is [srid-5e8afc4c-6bc-] (0 / 18)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1724]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 4 rank 4: corex [udp receiver child=1 sock=10.34.79.254:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1724]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 4 rank 4: tm [udp receiver child=1 sock=10.34.79.254:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1725]: DEBUG: <core> [core/pt.c:311]: fork_process(): test random numbers 1703359415 2063977156 2012041996
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1725]: DEBUG: <core> [core/sr_module.c:820]: init_child(): initializing PROC_TIMER with rank -1
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1725]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 5 rank -1: jsonrpcs [slow timer]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1725]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 5 rank -1: kex [slow timer]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1725]: DEBUG: kex [kex_mod.c:155]: child_init(): rank is (-1)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1725]: DEBUG: <core> [sruid.c:105]: sruid_init(): root for sruid is [srid-5e8afc4c-6bd-] (0 / 18)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1725]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 5 rank -1: corex [slow timer]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1725]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 5 rank -1: tm [slow timer]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1725]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '447a2cfa5d837c62-1725 at 88.88.88.88'
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1724]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '447a2cfa5d837c62-1724 at 88.88.88.88'
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1725]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 5 rank -1: tmx [slow timer]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1724]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 4 rank 4: tmx [udp receiver child=1 sock=10.34.79.254:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1725]: DEBUG: tmx [tmx_mod.c:262]: child_init(): rank is (-1)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1724]: DEBUG: tmx [tmx_mod.c:262]: child_init(): rank is (4)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1725]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 5 rank -1: sl [slow timer]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1724]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 4 rank 4: sl [udp receiver child=1 sock=10.34.79.254:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1724]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 4 rank 4: ctl [udp receiver child=1 sock=10.34.79.254:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1724]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 4 rank 4: acc [udp receiver child=1 sock=10.34.79.254:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1725]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 5 rank -1: ctl [slow timer]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1725]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 5 rank -1: acc [slow timer]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1727]: DEBUG: <core> [core/pt.c:311]: fork_process(): test random numbers 1009812817 1626377195 2163483774
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1727]: DEBUG: <core> [core/sr_module.c:820]: init_child(): initializing PROC_TIMER with rank -1
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1727]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 7 rank -1: jsonrpcs [secondary timer]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1727]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 7 rank -1: kex [secondary timer]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1727]: DEBUG: kex [kex_mod.c:155]: child_init(): rank is (-1)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1727]: DEBUG: <core> [sruid.c:105]: sruid_init(): root for sruid is [srid-5e8afc4c-6bf-] (0 / 18)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1727]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 7 rank -1: corex [secondary timer]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1727]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 7 rank -1: tm [secondary timer]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1727]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '447a2cfa5d837c62-1727 at 88.88.88.88'
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1727]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 7 rank -1: tmx [secondary timer]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1727]: DEBUG: tmx [tmx_mod.c:262]: child_init(): rank is (-1)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1727]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 7 rank -1: sl [secondary timer]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1727]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 7 rank -1: ctl [secondary timer]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1726]: DEBUG: <core> [core/pt.c:311]: fork_process(): test random numbers 895452234 1923156897 2889230523
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1727]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 7 rank -1: acc [secondary timer]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1726]: DEBUG: <core> [core/sr_module.c:820]: init_child(): initializing PROC_TIMER with rank -1
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1726]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 6 rank -1: jsonrpcs [timer]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1729]: DEBUG: <core> [core/pt.c:311]: fork_process(): test random numbers 416297002 760896466 446305047
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1726]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 6 rank -1: kex [timer]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1726]: DEBUG: kex [kex_mod.c:155]: child_init(): rank is (-1)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1729]: DEBUG: <core> [core/sr_module.c:820]: init_child(): initializing PROC_RPC with rank -2
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1726]: DEBUG: <core> [sruid.c:105]: sruid_init(): root for sruid is [srid-5e8afc4c-6be-] (0 / 18)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1729]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 9 rank -2: jsonrpcs [JSONRPCS DATAGRAM]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1729]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 9 rank -2: kex [JSONRPCS DATAGRAM]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1726]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 6 rank -1: corex [timer]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1729]: DEBUG: kex [kex_mod.c:155]: child_init(): rank is (-2)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1729]: DEBUG: <core> [sruid.c:105]: sruid_init(): root for sruid is [srid-5e8afc4c-6c1-] (0 / 18)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1729]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 9 rank -2: corex [JSONRPCS DATAGRAM]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1729]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 9 rank -2: tm [JSONRPCS DATAGRAM]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1729]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '447a2cfa5d837c62-1729 at 88.88.88.88'
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1729]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 9 rank -2: tmx [JSONRPCS DATAGRAM]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1729]: DEBUG: tmx [tmx_mod.c:262]: child_init(): rank is (-2)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1729]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 9 rank -2: sl [JSONRPCS DATAGRAM]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1729]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 9 rank -2: ctl [JSONRPCS DATAGRAM]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1729]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 9 rank -2: acc [JSONRPCS DATAGRAM]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1729]: INFO: jsonrpcs [jsonrpcs_sock.c:443]: jsonrpc_dgram_process(): a new child 0/1729
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1726]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 6 rank -1: tm [timer]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1726]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '447a2cfa5d837c62-1726 at 88.88.88.88'
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1726]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 6 rank -1: tmx [timer]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1726]: DEBUG: tmx [tmx_mod.c:262]: child_init(): rank is (-1)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1726]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 6 rank -1: sl [timer]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1726]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 6 rank -1: ctl [timer]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1726]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 6 rank -1: acc [timer]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1728]: DEBUG: <core> [core/pt.c:311]: fork_process(): test random numbers 1587604212 880659982 2762215351
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1728]: DEBUG: <core> [core/sr_module.c:820]: init_child(): initializing PROC_RPC with rank -2
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1728]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 8 rank -2: jsonrpcs [JSONRPCS FIFO]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1728]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 8 rank -2: kex [JSONRPCS FIFO]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1731]: DEBUG: <core> [core/sr_module.c:820]: init_child(): initializing CHILD with rank 5
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1731]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 11 rank 5: jsonrpcs [tcp receiver (generic) child=0]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1731]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 11 rank 5: kex [tcp receiver (generic) child=0]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1731]: DEBUG: kex [kex_mod.c:155]: child_init(): rank is (5)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1731]: DEBUG: <core> [sruid.c:105]: sruid_init(): root for sruid is [srid-5e8afc4c-6c3-] (0 / 18)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1728]: DEBUG: kex [kex_mod.c:155]: child_init(): rank is (-2)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1731]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 11 rank 5: corex [tcp receiver (generic) child=0]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1731]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 11 rank 5: tm [tcp receiver (generic) child=0]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1728]: DEBUG: <core> [sruid.c:105]: sruid_init(): root for sruid is [srid-5e8afc4c-6c0-] (0 / 18)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1731]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '447a2cfa5d837c62-1731 at 88.88.88.88'
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1728]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 8 rank -2: corex [JSONRPCS FIFO]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1731]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 11 rank 5: tmx [tcp receiver (generic) child=0]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1728]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 8 rank -2: tm [JSONRPCS FIFO]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1731]: DEBUG: tmx [tmx_mod.c:262]: child_init(): rank is (5)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1731]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 11 rank 5: sl [tcp receiver (generic) child=0]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1731]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 11 rank 5: ctl [tcp receiver (generic) child=0]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1731]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 11 rank 5: acc [tcp receiver (generic) child=0]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1728]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '447a2cfa5d837c62-1728 at 88.88.88.88'
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1728]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 8 rank -2: tmx [JSONRPCS FIFO]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1728]: DEBUG: tmx [tmx_mod.c:262]: child_init(): rank is (-2)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1728]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 8 rank -2: sl [JSONRPCS FIFO]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1728]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 8 rank -2: ctl [JSONRPCS FIFO]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/pt.c:311]: fork_process(): test random numbers 1092430453 1174844026 914723612
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/sr_module.c:820]: init_child(): initializing CHILD with rank 2
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 2 rank 2: jsonrpcs [udp receiver child=1 sock=88.88.88.88:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1728]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 8 rank -2: acc [JSONRPCS FIFO]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1728]: DEBUG: jsonrpcs [jsonrpcs_fifo.c:490]: jsonrpc_fifo_process(): new process with pid = 1728 created
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [main.c:1796]: main_loop(): Expect maximum 2123  open fds
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1731]: DEBUG: <core> [core/local_timer.c:60]: init_local_timer(): timer_list between 0x55e8487f44a8 and 0x55e8488384a8
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1731]: DEBUG: <core> [core/io_wait.h:377]: io_watch_add(): DBG: io_watch_add(0x55e8487f42e0, 26, 1, (nil)), fd_no=0
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 2 rank 2: kex [udp receiver child=1 sock=88.88.88.88:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: kex [kex_mod.c:155]: child_init(): rank is (2)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [sruid.c:105]: sruid_init(): root for sruid is [srid-5e8afc4c-6ba-] (0 / 18)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 2 rank 2: corex [udp receiver child=1 sock=88.88.88.88:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 2 rank 2: tm [udp receiver child=1 sock=88.88.88.88:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1732]: DEBUG: <core> [core/sr_module.c:820]: init_child(): initializing CHILD with rank 6
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1732]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 12 rank 6: jsonrpcs [tcp receiver (generic) child=1]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1732]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 12 rank 6: kex [tcp receiver (generic) child=1]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '447a2cfa5d837c62-1722 at 88.88.88.88'
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 2 rank 2: tmx [udp receiver child=1 sock=88.88.88.88:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: tmx [tmx_mod.c:262]: child_init(): rank is (2)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 2 rank 2: sl [udp receiver child=1 sock=88.88.88.88:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 2 rank 2: ctl [udp receiver child=1 sock=88.88.88.88:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1730]: DEBUG: <core> [core/pt.c:311]: fork_process(): test random numbers 766684593 40398124 1703926471
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1730]: DEBUG: <core> [core/sr_module.c:820]: init_child(): initializing PROC_RPC with rank -2
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1730]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 10 rank -2: jsonrpcs [ctl handler]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 2 rank 2: acc [udp receiver child=1 sock=88.88.88.88:7060]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1730]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 10 rank -2: kex [ctl handler]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1730]: DEBUG: kex [kex_mod.c:155]: child_init(): rank is (-2)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1730]: DEBUG: <core> [sruid.c:105]: sruid_init(): root for sruid is [srid-5e8afc4c-6c2-] (0 / 18)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1730]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 10 rank -2: corex [ctl handler]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1730]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 10 rank -2: tm [ctl handler]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1730]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '447a2cfa5d837c62-1730 at 88.88.88.88'
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1730]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 10 rank -2: tmx [ctl handler]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1730]: DEBUG: tmx [tmx_mod.c:262]: child_init(): rank is (-2)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1730]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 10 rank -2: sl [ctl handler]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1730]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 10 rank -2: ctl [ctl handler]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1730]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 10 rank -2: acc [ctl handler]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1730]: DEBUG: ctl [ctl.c:330]: mod_child(): ctl: mod_child(0), fork_process=0, csl=0x55e84931d0d0
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1730]: DEBUG: ctl [ctl.c:337]: mod_child(): ctl: 0 io_listen_loop(1, 0x55e84931d0d0)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1730]: INFO: ctl [io_listener.c:214]: io_listen_loop(): io_listen_loop:  using epoll_lt io watch method (config)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1730]: DEBUG: ctl [io_listener.c:246]: io_listen_loop(): io_listen_loop: adding socket 9, type 2, transport 3 (/var/run/kamailio//kamailio_ctl)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1730]: DEBUG: ctl [../../core/io_wait.h:377]: io_watch_add(): DBG: io_watch_add(0x7fe37d0ad2a0, 9, 2, 0x55e84931d0d0), fd_no=0
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1732]: DEBUG: kex [kex_mod.c:155]: child_init(): rank is (6)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1732]: DEBUG: <core> [sruid.c:105]: sruid_init(): root for sruid is [srid-5e8afc4c-6c4-] (0 / 18)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1732]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 12 rank 6: corex [tcp receiver (generic) child=1]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1732]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 12 rank 6: tm [tcp receiver (generic) child=1]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1732]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '447a2cfa5d837c62-1732 at 88.88.88.88'
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1732]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 12 rank 6: tmx [tcp receiver (generic) child=1]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1732]: DEBUG: tmx [tmx_mod.c:262]: child_init(): rank is (6)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1732]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 12 rank 6: sl [tcp receiver (generic) child=1]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1732]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 12 rank 6: ctl [tcp receiver (generic) child=1]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1732]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 12 rank 6: acc [tcp receiver (generic) child=1]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1732]: DEBUG: <core> [core/local_timer.c:60]: init_local_timer(): timer_list between 0x55e8487f44a8 and 0x55e8488384a8
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1732]: DEBUG: <core> [core/io_wait.h:377]: io_watch_add(): DBG: io_watch_add(0x55e8487f42e0, 28, 1, (nil)), fd_no=0
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/pt.c:311]: fork_process(): test random numbers 891835791 2071308017 2003065895
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/sr_module.c:820]: init_child(): initializing PROC_TCP_MAIN with rank -4
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 13 rank -4: jsonrpcs [tcp main process]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 13 rank -4: kex [tcp main process]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: kex [kex_mod.c:155]: child_init(): rank is (-4)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [sruid.c:105]: sruid_init(): root for sruid is [srid-5e8afc4c-6c5-] (0 / 18)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 13 rank -4: corex [tcp main process]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 13 rank -4: tm [tcp main process]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '447a2cfa5d837c62-1733 at 88.88.88.88'
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 13 rank -4: tmx [tcp main process]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: tmx [tmx_mod.c:262]: child_init(): rank is (-4)
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 13 rank -4: sl [tcp main process]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 13 rank -4: ctl [tcp main process]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/sr_module.c:778]: init_mod_child(): idx 13 rank -4: acc [tcp main process]
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/local_timer.c:60]: init_local_timer(): timer_list between 0x55e8487889e8 and 0x55e8487cc9e8
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/io_wait.h:377]: io_watch_add(): DBG: io_watch_add(0x55e848788820, 13, 1, 0x7fe37d6fca10), fd_no=0
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/io_wait.h:377]: io_watch_add(): DBG: io_watch_add(0x55e848788820, 14, 1, 0x7fe37d6fd010), fd_no=1
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/io_wait.h:377]: io_watch_add(): DBG: io_watch_add(0x55e848788820, 15, 4, 0x7fe378e9fa94), fd_no=2
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/io_wait.h:377]: io_watch_add(): DBG: io_watch_add(0x55e848788820, 16, 4, 0x7fe378e9fb28), fd_no=3
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/io_wait.h:377]: io_watch_add(): DBG: io_watch_add(0x55e848788820, 17, 4, 0x7fe378e9fbbc), fd_no=4
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/io_wait.h:377]: io_watch_add(): DBG: io_watch_add(0x55e848788820, 18, 4, 0x7fe378e9fc50), fd_no=5
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/io_wait.h:377]: io_watch_add(): DBG: io_watch_add(0x55e848788820, 19, 4, 0x7fe378e9fce4), fd_no=6
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/io_wait.h:377]: io_watch_add(): DBG: io_watch_add(0x55e848788820, 20, 4, 0x7fe378e9fd78), fd_no=7
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/io_wait.h:377]: io_watch_add(): DBG: io_watch_add(0x55e848788820, 21, 4, 0x7fe378e9fe0c), fd_no=8
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/io_wait.h:377]: io_watch_add(): DBG: io_watch_add(0x55e848788820, 22, 4, 0x7fe378e9fea0), fd_no=9
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/io_wait.h:377]: io_watch_add(): DBG: io_watch_add(0x55e848788820, 23, 4, 0x7fe378e9ff34), fd_no=10
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/io_wait.h:377]: io_watch_add(): DBG: io_watch_add(0x55e848788820, 7, 4, 0x7fe378e9ffc8), fd_no=11
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/io_wait.h:377]: io_watch_add(): DBG: io_watch_add(0x55e848788820, 9, 4, 0x7fe378ea005c), fd_no=12
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/io_wait.h:377]: io_watch_add(): DBG: io_watch_add(0x55e848788820, 24, 4, 0x7fe378ea00f0), fd_no=13
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/io_wait.h:377]: io_watch_add(): DBG: io_watch_add(0x55e848788820, 25, 3, 0x7fe37d725b10), fd_no=14
Apr  6 11:54:20 fsinnosbc /usr/sbin/kamailio[1733]: DEBUG: <core> [core/io_wait.h:377]: io_watch_add(): DBG: io_watch_add(0x55e848788820, 27, 3, 0x7fe37d725b30), fd_no=15
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/udp_server.c:498]: udp_rcv_loop(): received on udp socket: (106/100/633) [[REGISTER sip:frontend.pb.supertest.com:7060 SIP/2.0 0D  0A Via: SIP/2.0/UDP 10.32.0.9:5060;branch=z9hG4bK2]]
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:610]: parse_msg(): SIP Request:
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:612]: parse_msg():  method:  <REGISTER>
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:614]: parse_msg():  uri:     <sip:frontend.pb.supertest.com:7060>
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:616]: parse_msg():  version: <SIP/2.0>
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK2659639528>; state=6
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=17
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of header reached, state=5
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:498]: parse_headers(): Via found, flags=2
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:500]: parse_headers(): this is the first via
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=10
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:171]: get_hdr_field(): <To> [60]; uri=[sip:999100044 at frontend.pb.supertest.com:7060]
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:174]: get_hdr_field(): to body ["999100044" <sip:999100044 at frontend.pb.supertest.com:7060>#015#012], to tag []
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:152]: get_hdr_field(): cseq <CSeq>: <1> <REGISTER>
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/receive.c:320]: receive_msg(): --- received sip message - request - call-id: [2_2710590263 at 10.32.0.9] - cseq: [1 REGISTER]
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:185]: get_hdr_field(): content_length=0
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:89]: get_hdr_field(): found end of header
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/receive.c:380]: receive_msg(): preparing to run routing scripts...
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} maxfwd [mf_funcs.c:74]: is_maxfwd_present(): value = 70 
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:247]: check_ruri_sip_version(): check_ruri_sip_version entered
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:270]: check_ruri_sip_version(): check_ruri_sip_version passed
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:277]: check_ruri_scheme(): check_ruri_scheme entered
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:297]: check_ruri_scheme(): check_ruri_scheme passed
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:305]: check_required_headers(): check_required_headers entered
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:313]: check_required_headers(): check_required_headers passed
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:479]: check_cseq_method(): check_cseq_method entered
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:512]: check_cseq_method(): check_cseq_method passed
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:521]: check_cseq_value(): check_cseq_value entered
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:549]: check_cseq_value(): check_cseq_value passed
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:558]: check_cl(): check_cl entered
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:583]: check_cl(): check_cl passed
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:595]: check_expires_value(): check_expires_value entered
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:630]: check_expires_value(): check_expires_value passed
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:732]: check_parse_uris(): check_parse_uris entered
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:736]: check_parse_uris(): parsing ruri
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:750]: check_parse_uris(): looking up From header
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:764]: check_parse_uris(): parsing From header
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/parser/parse_addr_spec.c:185]: parse_to_param(): add param: tag=4161628471
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=29
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:790]: check_parse_uris(): parsing From URI
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:808]: check_parse_uris(): looking up To header
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:830]: check_parse_uris(): check_parse_uris(): parsing To URI
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:875]: check_parse_uris(): check_parse_uris passed
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity_mod.c:254]: w_sanity_check(): sanity checks result: 1
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} rr [loose.c:113]: find_first_route(): No Route headers found
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} rr [loose.c:967]: loose_route(): There is no Route HF
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: INFO: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <script>: RR simple
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} outbound [outbound_mod.c:489]: use_outbound(): Analysing REGISTER for outbound markers
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} outbound [outbound_mod.c:331]: use_outbound_register(): outbound not used
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} outbound [outbound_mod.c:489]: use_outbound(): Analysing REGISTER for outbound markers
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} outbound [outbound_mod.c:331]: use_outbound_register(): outbound not used
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: INFO: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <script>: GOT REGISTER
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: INFO: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <script>: Initial relay packet
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_lookup.c:1328]: t_newtran(): msg (0x7fe37d740ce8) id=1/1721 global id=0/0 T start=0xffffffffffffffff
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_lookup.c:497]: t_lookup_request(): start searching: hash=64596, isACK=0
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_lookup.c:455]: matching_3261(): RFC3261 transaction matching failed - via branch [z9hG4bK2659639528]
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_lookup.c:675]: t_lookup_request(): no transaction found
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_hooks.c:336]: run_reqin_callbacks_internal(): trans=0x7fe378ea6480, callback type 1, id 0 entered
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/md5utils.c:67]: MD5StringArray(): MD5 calculated: f9be7646fc0ae1d770642bed1fc41457
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/msg_translator.c:1765]: check_boundaries(): no multi-part body
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_funcs.c:374]: t_relay_to(): new transaction forwarded
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/receive.c:438]: receive_msg(): request-route executed in: 3060 usec
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/xavp.c:529]: xavp_destroy_list(): destroying xavp list (nil)
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/receive.c:529]: receive_msg(): cleaning up
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/udp_server.c:498]: udp_rcv_loop(): received on udp socket: (106/100/633) [[REGISTER sip:frontend.pb.supertest.com:7060 SIP/2.0 0D  0A Via: SIP/2.0/UDP 10.32.0.9:5060;branch=z9hG4bK2]]
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/msg_parser.c:610]: parse_msg(): SIP Request:
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/msg_parser.c:612]: parse_msg():  method:  <REGISTER>
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/msg_parser.c:614]: parse_msg():  uri:     <sip:frontend.pb.supertest.com:7060>
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/msg_parser.c:616]: parse_msg():  version: <SIP/2.0>
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK2659639528>; state=6
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=17
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of header reached, state=5
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/msg_parser.c:498]: parse_headers(): Via found, flags=2
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/msg_parser.c:500]: parse_headers(): this is the first via
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=10
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/msg_parser.c:171]: get_hdr_field(): <To> [60]; uri=[sip:999100044 at frontend.pb.supertest.com:7060]
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/msg_parser.c:174]: get_hdr_field(): to body ["999100044" <sip:999100044 at frontend.pb.supertest.com:7060>#015#012], to tag []
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/msg_parser.c:152]: get_hdr_field(): cseq <CSeq>: <1> <REGISTER>
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/receive.c:320]: receive_msg(): --- received sip message - request - call-id: [2_2710590263 at 10.32.0.9] - cseq: [1 REGISTER]
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/msg_parser.c:185]: get_hdr_field(): content_length=0
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/msg_parser.c:89]: get_hdr_field(): found end of header
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/receive.c:380]: receive_msg(): preparing to run routing scripts...
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} maxfwd [mf_funcs.c:74]: is_maxfwd_present(): value = 70 
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:247]: check_ruri_sip_version(): check_ruri_sip_version entered
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:270]: check_ruri_sip_version(): check_ruri_sip_version passed
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:277]: check_ruri_scheme(): check_ruri_scheme entered
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:297]: check_ruri_scheme(): check_ruri_scheme passed
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:305]: check_required_headers(): check_required_headers entered
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:313]: check_required_headers(): check_required_headers passed
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:479]: check_cseq_method(): check_cseq_method entered
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:512]: check_cseq_method(): check_cseq_method passed
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:521]: check_cseq_value(): check_cseq_value entered
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:549]: check_cseq_value(): check_cseq_value passed
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:558]: check_cl(): check_cl entered
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:583]: check_cl(): check_cl passed
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:595]: check_expires_value(): check_expires_value entered
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:630]: check_expires_value(): check_expires_value passed
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:732]: check_parse_uris(): check_parse_uris entered
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:736]: check_parse_uris(): parsing ruri
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:750]: check_parse_uris(): looking up From header
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:764]: check_parse_uris(): parsing From header
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/parser/parse_addr_spec.c:185]: parse_to_param(): add param: tag=4161628471
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=29
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:790]: check_parse_uris(): parsing From URI
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:808]: check_parse_uris(): looking up To header
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:830]: check_parse_uris(): check_parse_uris(): parsing To URI
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:875]: check_parse_uris(): check_parse_uris passed
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity_mod.c:254]: w_sanity_check(): sanity checks result: 1
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} rr [loose.c:113]: find_first_route(): No Route headers found
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} rr [loose.c:967]: loose_route(): There is no Route HF
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: INFO: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <script>: RR simple
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} outbound [outbound_mod.c:489]: use_outbound(): Analysing REGISTER for outbound markers
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} outbound [outbound_mod.c:331]: use_outbound_register(): outbound not used
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} outbound [outbound_mod.c:489]: use_outbound(): Analysing REGISTER for outbound markers
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} outbound [outbound_mod.c:331]: use_outbound_register(): outbound not used
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: INFO: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <script>: GOT REGISTER
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: INFO: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <script>: Initial relay packet
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_lookup.c:1328]: t_newtran(): msg (0x7fe37d740ce8) id=1/1722 global id=0/0 T start=0xffffffffffffffff
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_lookup.c:497]: t_lookup_request(): start searching: hash=64596, isACK=0
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_lookup.c:439]: matching_3261(): RFC3261 transaction matched, tid=2659639528
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_lookup.c:692]: t_lookup_request(): transaction found (T=0x7fe378ea6480)
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_reply.c:1586]: t_retransmit_reply(): DBG: t_retransmit_reply: nothing to retransmit
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/receive.c:438]: receive_msg(): request-route executed in: 2058 usec
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/xavp.c:529]: xavp_destroy_list(): destroying xavp list (nil)
Apr  6 11:54:58 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/receive.c:529]: receive_msg(): cleaning up
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/udp_server.c:498]: udp_rcv_loop(): received on udp socket: (106/100/633) [[REGISTER sip:frontend.pb.supertest.com:7060 SIP/2.0 0D  0A Via: SIP/2.0/UDP 10.32.0.9:5060;branch=z9hG4bK2]]
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:610]: parse_msg(): SIP Request:
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:612]: parse_msg():  method:  <REGISTER>
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:614]: parse_msg():  uri:     <sip:frontend.pb.supertest.com:7060>
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:616]: parse_msg():  version: <SIP/2.0>
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK2659639528>; state=6
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=17
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of header reached, state=5
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:498]: parse_headers(): Via found, flags=2
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:500]: parse_headers(): this is the first via
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=10
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:171]: get_hdr_field(): <To> [60]; uri=[sip:999100044 at frontend.pb.supertest.com:7060]
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:174]: get_hdr_field(): to body ["999100044" <sip:999100044 at frontend.pb.supertest.com:7060>#015#012], to tag []
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:152]: get_hdr_field(): cseq <CSeq>: <1> <REGISTER>
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/receive.c:320]: receive_msg(): --- received sip message - request - call-id: [2_2710590263 at 10.32.0.9] - cseq: [1 REGISTER]
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:185]: get_hdr_field(): content_length=0
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:89]: get_hdr_field(): found end of header
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/receive.c:380]: receive_msg(): preparing to run routing scripts...
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} maxfwd [mf_funcs.c:74]: is_maxfwd_present(): value = 70 
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:247]: check_ruri_sip_version(): check_ruri_sip_version entered
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:270]: check_ruri_sip_version(): check_ruri_sip_version passed
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:277]: check_ruri_scheme(): check_ruri_scheme entered
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:297]: check_ruri_scheme(): check_ruri_scheme passed
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:305]: check_required_headers(): check_required_headers entered
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:313]: check_required_headers(): check_required_headers passed
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:479]: check_cseq_method(): check_cseq_method entered
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:512]: check_cseq_method(): check_cseq_method passed
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:521]: check_cseq_value(): check_cseq_value entered
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:549]: check_cseq_value(): check_cseq_value passed
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:558]: check_cl(): check_cl entered
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:583]: check_cl(): check_cl passed
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:595]: check_expires_value(): check_expires_value entered
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:630]: check_expires_value(): check_expires_value passed
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:732]: check_parse_uris(): check_parse_uris entered
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:736]: check_parse_uris(): parsing ruri
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:750]: check_parse_uris(): looking up From header
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:764]: check_parse_uris(): parsing From header
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/parser/parse_addr_spec.c:185]: parse_to_param(): add param: tag=4161628471
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=29
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:790]: check_parse_uris(): parsing From URI
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:808]: check_parse_uris(): looking up To header
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:830]: check_parse_uris(): check_parse_uris(): parsing To URI
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:875]: check_parse_uris(): check_parse_uris passed
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity_mod.c:254]: w_sanity_check(): sanity checks result: 1
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} rr [loose.c:113]: find_first_route(): No Route headers found
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} rr [loose.c:967]: loose_route(): There is no Route HF
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: INFO: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <script>: RR simple
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} outbound [outbound_mod.c:489]: use_outbound(): Analysing REGISTER for outbound markers
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} outbound [outbound_mod.c:331]: use_outbound_register(): outbound not used
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} outbound [outbound_mod.c:489]: use_outbound(): Analysing REGISTER for outbound markers
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} outbound [outbound_mod.c:331]: use_outbound_register(): outbound not used
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: INFO: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <script>: GOT REGISTER
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: INFO: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <script>: Initial relay packet
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_lookup.c:1328]: t_newtran(): msg (0x7fe37d740ce8) id=2/1721 global id=1/1721 T start=0xffffffffffffffff
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_lookup.c:497]: t_lookup_request(): start searching: hash=64596, isACK=0
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_lookup.c:439]: matching_3261(): RFC3261 transaction matched, tid=2659639528
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_lookup.c:692]: t_lookup_request(): transaction found (T=0x7fe378ea6480)
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_reply.c:1586]: t_retransmit_reply(): DBG: t_retransmit_reply: nothing to retransmit
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/receive.c:438]: receive_msg(): request-route executed in: 2700 usec
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/xavp.c:529]: xavp_destroy_list(): destroying xavp list (nil)
Apr  6 11:54:59 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/receive.c:529]: receive_msg(): cleaning up
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/udp_server.c:498]: udp_rcv_loop(): received on udp socket: (106/100/633) [[REGISTER sip:frontend.pb.supertest.com:7060 SIP/2.0 0D  0A Via: SIP/2.0/UDP 10.32.0.9:5060;branch=z9hG4bK2]]
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/msg_parser.c:610]: parse_msg(): SIP Request:
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/msg_parser.c:612]: parse_msg():  method:  <REGISTER>
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/msg_parser.c:614]: parse_msg():  uri:     <sip:frontend.pb.supertest.com:7060>
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/msg_parser.c:616]: parse_msg():  version: <SIP/2.0>
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK2659639528>; state=6
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=17
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of header reached, state=5
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/msg_parser.c:498]: parse_headers(): Via found, flags=2
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/msg_parser.c:500]: parse_headers(): this is the first via
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=10
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/msg_parser.c:171]: get_hdr_field(): <To> [60]; uri=[sip:999100044 at frontend.pb.supertest.com:7060]
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/msg_parser.c:174]: get_hdr_field(): to body ["999100044" <sip:999100044 at frontend.pb.supertest.com:7060>#015#012], to tag []
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/msg_parser.c:152]: get_hdr_field(): cseq <CSeq>: <1> <REGISTER>
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/receive.c:320]: receive_msg(): --- received sip message - request - call-id: [2_2710590263 at 10.32.0.9] - cseq: [1 REGISTER]
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/msg_parser.c:185]: get_hdr_field(): content_length=0
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: <core> [core/parser/msg_parser.c:89]: get_hdr_field(): found end of header
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/receive.c:380]: receive_msg(): preparing to run routing scripts...
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} maxfwd [mf_funcs.c:74]: is_maxfwd_present(): value = 70 
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:247]: check_ruri_sip_version(): check_ruri_sip_version entered
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:270]: check_ruri_sip_version(): check_ruri_sip_version passed
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:277]: check_ruri_scheme(): check_ruri_scheme entered
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:297]: check_ruri_scheme(): check_ruri_scheme passed
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:305]: check_required_headers(): check_required_headers entered
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:313]: check_required_headers(): check_required_headers passed
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:479]: check_cseq_method(): check_cseq_method entered
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:512]: check_cseq_method(): check_cseq_method passed
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:521]: check_cseq_value(): check_cseq_value entered
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:549]: check_cseq_value(): check_cseq_value passed
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:558]: check_cl(): check_cl entered
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:583]: check_cl(): check_cl passed
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:595]: check_expires_value(): check_expires_value entered
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:630]: check_expires_value(): check_expires_value passed
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:732]: check_parse_uris(): check_parse_uris entered
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:736]: check_parse_uris(): parsing ruri
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:750]: check_parse_uris(): looking up From header
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:764]: check_parse_uris(): parsing From header
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/parser/parse_addr_spec.c:185]: parse_to_param(): add param: tag=4161628471
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=29
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:790]: check_parse_uris(): parsing From URI
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:808]: check_parse_uris(): looking up To header
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:830]: check_parse_uris(): check_parse_uris(): parsing To URI
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:875]: check_parse_uris(): check_parse_uris passed
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity_mod.c:254]: w_sanity_check(): sanity checks result: 1
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} rr [loose.c:113]: find_first_route(): No Route headers found
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} rr [loose.c:967]: loose_route(): There is no Route HF
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: INFO: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <script>: RR simple
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} outbound [outbound_mod.c:489]: use_outbound(): Analysing REGISTER for outbound markers
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} outbound [outbound_mod.c:331]: use_outbound_register(): outbound not used
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} outbound [outbound_mod.c:489]: use_outbound(): Analysing REGISTER for outbound markers
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} outbound [outbound_mod.c:331]: use_outbound_register(): outbound not used
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: INFO: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <script>: GOT REGISTER
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: INFO: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <script>: Initial relay packet
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_lookup.c:1328]: t_newtran(): msg (0x7fe37d740ce8) id=2/1722 global id=1/1722 T start=0xffffffffffffffff
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_lookup.c:497]: t_lookup_request(): start searching: hash=64596, isACK=0
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_lookup.c:439]: matching_3261(): RFC3261 transaction matched, tid=2659639528
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_lookup.c:692]: t_lookup_request(): transaction found (T=0x7fe378ea6480)
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_reply.c:1586]: t_retransmit_reply(): DBG: t_retransmit_reply: nothing to retransmit
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/receive.c:438]: receive_msg(): request-route executed in: 1583 usec
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/xavp.c:529]: xavp_destroy_list(): destroying xavp list (nil)
Apr  6 11:55:01 fsinnosbc /usr/sbin/kamailio[1722]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/receive.c:529]: receive_msg(): cleaning up
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/udp_server.c:498]: udp_rcv_loop(): received on udp socket: (106/100/633) [[REGISTER sip:frontend.pb.supertest.com:7060 SIP/2.0 0D  0A Via: SIP/2.0/UDP 10.32.0.9:5060;branch=z9hG4bK2]]
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:610]: parse_msg(): SIP Request:
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:612]: parse_msg():  method:  <REGISTER>
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:614]: parse_msg():  uri:     <sip:frontend.pb.supertest.com:7060>
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:616]: parse_msg():  version: <SIP/2.0>
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK2659639528>; state=6
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=17
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of header reached, state=5
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:498]: parse_headers(): Via found, flags=2
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:500]: parse_headers(): this is the first via
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=10
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:171]: get_hdr_field(): <To> [60]; uri=[sip:999100044 at frontend.pb.supertest.com:7060]
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:174]: get_hdr_field(): to body ["999100044" <sip:999100044 at frontend.pb.supertest.com:7060>#015#012], to tag []
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:152]: get_hdr_field(): cseq <CSeq>: <1> <REGISTER>
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/receive.c:320]: receive_msg(): --- received sip message - request - call-id: [2_2710590263 at 10.32.0.9] - cseq: [1 REGISTER]
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:185]: get_hdr_field(): content_length=0
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: <core> [core/parser/msg_parser.c:89]: get_hdr_field(): found end of header
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/receive.c:380]: receive_msg(): preparing to run routing scripts...
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} maxfwd [mf_funcs.c:74]: is_maxfwd_present(): value = 70 
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:247]: check_ruri_sip_version(): check_ruri_sip_version entered
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:270]: check_ruri_sip_version(): check_ruri_sip_version passed
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:277]: check_ruri_scheme(): check_ruri_scheme entered
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:297]: check_ruri_scheme(): check_ruri_scheme passed
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:305]: check_required_headers(): check_required_headers entered
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:313]: check_required_headers(): check_required_headers passed
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:479]: check_cseq_method(): check_cseq_method entered
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:512]: check_cseq_method(): check_cseq_method passed
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:521]: check_cseq_value(): check_cseq_value entered
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:549]: check_cseq_value(): check_cseq_value passed
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:558]: check_cl(): check_cl entered
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:583]: check_cl(): check_cl passed
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:595]: check_expires_value(): check_expires_value entered
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:630]: check_expires_value(): check_expires_value passed
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:732]: check_parse_uris(): check_parse_uris entered
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:736]: check_parse_uris(): parsing ruri
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:750]: check_parse_uris(): looking up From header
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:764]: check_parse_uris(): parsing From header
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/parser/parse_addr_spec.c:185]: parse_to_param(): add param: tag=4161628471
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=29
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:790]: check_parse_uris(): parsing From URI
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:808]: check_parse_uris(): looking up To header
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:830]: check_parse_uris(): check_parse_uris(): parsing To URI
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity.c:875]: check_parse_uris(): check_parse_uris passed
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} sanity [sanity_mod.c:254]: w_sanity_check(): sanity checks result: 1
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} rr [loose.c:113]: find_first_route(): No Route headers found
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} rr [loose.c:967]: loose_route(): There is no Route HF
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: INFO: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <script>: RR simple
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} outbound [outbound_mod.c:489]: use_outbound(): Analysing REGISTER for outbound markers
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} outbound [outbound_mod.c:331]: use_outbound_register(): outbound not used
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} outbound [outbound_mod.c:489]: use_outbound(): Analysing REGISTER for outbound markers
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} outbound [outbound_mod.c:331]: use_outbound_register(): outbound not used
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: INFO: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <script>: GOT REGISTER
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: INFO: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <script>: Initial relay packet
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_lookup.c:1328]: t_newtran(): msg (0x7fe37d740ce8) id=3/1721 global id=2/1721 T start=0xffffffffffffffff
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_lookup.c:497]: t_lookup_request(): start searching: hash=64596, isACK=0
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_lookup.c:439]: matching_3261(): RFC3261 transaction matched, tid=2659639528
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_lookup.c:692]: t_lookup_request(): transaction found (T=0x7fe378ea6480)
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} tm [t_reply.c:1586]: t_retransmit_reply(): DBG: t_retransmit_reply: nothing to retransmit
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/receive.c:438]: receive_msg(): request-route executed in: 4773 usec
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/xavp.c:529]: xavp_destroy_list(): destroying xavp list (nil)
Apr  6 11:55:05 fsinnosbc /usr/sbin/kamailio[1721]: DEBUG: {1 1 REGISTER 2_2710590263 at 10.32.0.9} <core> [core/receive.c:529]: receive_msg(): cleaning up
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [main.c:724]: handle_sigs(): SIGTERM received, program terminates
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1720]: NOTICE: <core> [main.c:725]: handle_sigs(): Thank you for flying kamailio!!!
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1722]: INFO: <core> [main.c:847]: sig_usr(): signal 15 received
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1723]: INFO: <core> [main.c:847]: sig_usr(): signal 15 received
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1724]: INFO: <core> [main.c:847]: sig_usr(): signal 15 received
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1725]: INFO: <core> [main.c:847]: sig_usr(): signal 15 received
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1728]: INFO: <core> [main.c:847]: sig_usr(): signal 15 received
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1726]: INFO: <core> [main.c:847]: sig_usr(): signal 15 received
Apr  6 11:55:09 fsinnosbc systemd[1]: kamailio.service: Succeeded.
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1730]: INFO: <core> [main.c:847]: sig_usr(): signal 15 received
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1727]: INFO: <core> [main.c:847]: sig_usr(): signal 15 received
Apr  6 11:55:09 fsinnosbc systemd[1]: /lib/systemd/system/kamailio.service:14: PIDFile= references path below legacy directory /var/run/, updating /var/run/kamailio/kamailio.pid → /run/kamailio/kamailio.pid; please update the unit file accordingly.
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1729]: INFO: <core> [main.c:847]: sig_usr(): signal 15 received
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1731]: INFO: <core> [main.c:847]: sig_usr(): signal 15 received
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1732]: INFO: <core> [main.c:847]: sig_usr(): signal 15 received
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1733]: INFO: <core> [main.c:847]: sig_usr(): signal 15 received
Apr  6 11:55:09 fsinnosbc systemd[1]: /lib/systemd/system/kamailio.service:14: PIDFile= references path below legacy directory /var/run/, updating /var/run/kamailio/kamailio.pid → /run/kamailio/kamailio.pid; please update the unit file accordingly.
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1721]: INFO: <core> [main.c:847]: sig_usr(): signal 15 received
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1720]: ERROR: ctl [ctl.c:390]: mod_destroy(): ERROR: ctl: could not delete unix socket /var/run/kamailio//kamailio_ctl: Permission denied (13)
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: tm [t_funcs.c:84]: tm_shutdown(): start
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: tm [t_funcs.c:87]: tm_shutdown(): emptying hash table
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: tm [h_table.c:132]: free_cell_helper(): freeing transaction 0x7fe378ea6480 from h_table.c:449
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: tm [t_funcs.c:89]: tm_shutdown(): removing semaphores
Apr  6 11:55:09 fsinnosbc systemd[1]: /lib/systemd/system/kamailio.service:14: PIDFile= references path below legacy directory /var/run/, updating /var/run/kamailio/kamailio.pid → /run/kamailio/kamailio.pid; please update the unit file accordingly.
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: tm [t_funcs.c:91]: tm_shutdown(): destroying tmcb lists
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: tm [t_funcs.c:94]: tm_shutdown(): done
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1720]: ERROR: jsonrpcs [jsonrpcs_fifo.c:599]: jsonrpc_fifo_destroy(): FIFO stat failed: Permission denied
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1720]: ERROR: jsonrpcs [jsonrpcs_sock.c:516]: jsonrpc_dgram_destroy(): socket stat failed: Permission denied
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1720]: INFO: <core> [core/sctp_core.c:53]: sctp_core_destroy(): SCTP API not initialized
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/mem/shm.c:288]: shm_destroy_manager(): destroying memory manager: q_malloc
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/mem/q_malloc.c:1185]: qm_shm_lock_destroy(): destroying the shared memory lock
Apr  6 11:55:09 fsinnosbc /usr/sbin/kamailio[1720]: DEBUG: <core> [core/mem/pkg.c:97]: pkg_destroy_manager(): destroying memory manager: q_malloc


More information about the sr-users mailing list