Description

Kamailio fails with core on reading Custom Global Parameters in python script.
I have defined parameter like server.ip = "192.168.33.1" in kamailio.cfg
A I trying to access it from python script like this.
server_ip = KSR.pv.get("$sel(cfg_get.server.ip)")
And kamailio crushes with core dump.

Reproduction

root@kamailio:/home/sa# more /etc/kamailio/kamailio.cfg

#!KAMAILIO
debug=4
#log_stderror=yes

memdbg=5
memlog=5

log_facility=LOG_LOCAL0
log_prefix="{$mt $hdr(CSeq) $ci} "

/* number of SIP routing processes */
children=8

/* uncomment the next line to disable TCP (default on) */
disable_tcp=yes

/* uncomment the next line to disable the auto discovery of local aliases
 * based on reverse DNS on IPs (default on) */
auto_aliases=no

/* uncomment and configure the following line if you want Kamailio to
 * bind on a specific interface/port/proto (default bind on all available) */
listen=udp:192.168.56.10:5060

port=5060

# Server configuration
server.ip = "192.168.33.1" 

####### Modules Section ########

/* set paths to location of modules */
# mpath="/usr/lib/x86_64-linux-gnu/kamailio/modules/"

loadmodule "ctl.so"
loadmodule "tm.so"
loadmodule "corex.so"
loadmodule "sl.so"
loadmodule "pv.so"
loadmodule "maxfwd.so"
loadmodule "siputils.so"
loadmodule "xlog.so"
loadmodule "sanity.so"
loadmodule "auth.so"
loadmodule "app_python.so"
loadmodule "htable.so"
loadmodule "rr.so"
loadmodule "dialog.so"

# ----------------- setting module-specific parameters ---------------

# auto-discard branches from previous serial forking leg
modparam("tm", "failure_reply_mode", 3)
# default retransmission timeout: 30sec
modparam("tm", "fr_timer", 3000)
# default invite retransmission timeout after 1xx: 120sec
modparam("tm", "fr_inv_timer", 120000)
modparam("tm", "contacts_avp", "tm_contacts")
modparam("tm", "contact_flows_avp", "tm_contact_flows")

modparam("htable", "htable", "a=>size=12;autoexpire=3600;")

modparam("dialog", "dlg_flag", 5)

#
####### Routing Logic ########

modparam("app_python", "script_name", "/opt/myfiles/kam-router.py")
 
cfgengine "python"

root@kamailio:/home/sa# more /opt/myfiles/kam-router.py

import sys
import KSR as KSR
import os


def mod_init():
    KSR.info("===== from Python mod init\n")
    return kamailio()

class kamailio:
    def __init__(self):
        KSR.info('===== kamailio.__init__(), PID: %d\n' % (os.getpid()))

    def child_init(self, rank):
        KSR.info('===== kamailio.child_init(%d), PID: %d\n' % (rank, os.getpid()))

        # TODO: It does not work for some reason. Check it again
        server_ip = KSR.pv.get("$sel(cfg_get.server.ip)")
        
        KSR.info("Server configuration. IP: %s" % server_ip)

        return 0

    def ksr_onsend_route(self, msg):
        return 1

    def ksr_request_route(self, msg):
        return 1

    def ksr_reply_route(self, msg):
        return 1

    def ksr_failure_route_one(self, msg):
        return 1

Debugging Data

root@kamailio:/home/sa# gdb /usr/sbin/kamailio /core

GNU gdb (Debian 7.12-6) 7.12.0.20161007-git
Copyright (C) 2016 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law.  Type "show copying"
and "show warranty" for details.
This GDB was configured as "x86_64-linux-gnu".
Type "show configuration" for configuration details.
For bug reporting instructions, please see:
<http://www.gnu.org/software/gdb/bugs/>.
Find the GDB manual and other documentation resources online at:
<http://www.gnu.org/software/gdb/documentation/>.
For help, type "help".
Type "apropos word" to search for commands related to "word"...
Reading symbols from /usr/sbin/kamailio...(no debugging symbols found)...done.
[New LWP 15782]
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
Core was generated by `kamailio'.
Program terminated with signal SIGSEGV, Segmentation fault.
#0  0x000055ea6d92219f in select_cfg_var ()
(gdb) bt
#0  0x000055ea6d92219f in select_cfg_var ()
#1  0x000055ea6d792db2 in run_select ()
#2  0x00007f49b7873af2 in pv_get_select () from /usr/lib/x86_64-linux-gnu/kamailio/modules/pv.so
#3  0x000055ea6d7bff69 in pv_get_spec_value ()
#4  0x00007f49b63cec07 in ?? () from /usr/lib/x86_64-linux-gnu/kamailio/modules/app_python.so
#5  0x00007f49b63cefb9 in ?? () from /usr/lib/x86_64-linux-gnu/kamailio/modules/app_python.so
#6  0x00007f49b5e9a091 in PyEval_EvalFrameEx () from /usr/lib/x86_64-linux-gnu/libpython2.7.so.1.0
#7  0x00007f49b600129c in PyEval_EvalCodeEx () from /usr/lib/x86_64-linux-gnu/libpython2.7.so.1.0
#8  0x00007f49b5f55670 in ?? () from /usr/lib/x86_64-linux-gnu/libpython2.7.so.1.0
#9  0x00007f49b5eed5c3 in PyObject_Call () from /usr/lib/x86_64-linux-gnu/libpython2.7.so.1.0
#10 0x00007f49b5faadfc in ?? () from /usr/lib/x86_64-linux-gnu/libpython2.7.so.1.0
#11 0x00007f49b5eed5c3 in PyObject_Call () from /usr/lib/x86_64-linux-gnu/libpython2.7.so.1.0
#12 0x00007f49b60006c7 in PyEval_CallObjectWithKeywords () from /usr/lib/x86_64-linux-gnu/libpython2.7.so.1.0
#13 0x00007f49b63e0438 in apy_init_script () from /usr/lib/x86_64-linux-gnu/kamailio/modules/app_python.so
#14 0x00007f49b63df2f8 in ?? () from /usr/lib/x86_64-linux-gnu/kamailio/modules/app_python.so
#15 0x000055ea6d74149a in ?? ()
#16 0x000055ea6d741121 in ?? ()
#17 0x000055ea6d741121 in ?? ()
#18 0x000055ea6d741121 in ?? ()
#19 0x000055ea6d74186a in init_child ()
#20 0x000055ea6d6b5f58 in fork_process ()
#21 0x00007f49b824d3c9 in ?? () from /usr/lib/x86_64-linux-gnu/kamailio/modules/ctl.so
#22 0x000055ea6d74149a in ?? ()
#23 0x000055ea6d741121 in ?? ()
#24 0x000055ea6d741121 in ?? ()
#25 0x000055ea6d741121 in ?? ()
#26 0x000055ea6d741121 in ?? ()
#27 0x000055ea6d741121 in ?? ()
#28 0x000055ea6d741121 in ?? ()
#29 0x000055ea6d741121 in ?? ()
#30 0x000055ea6d741121 in ?? ()
#31 0x000055ea6d741121 in ?? ()
#32 0x000055ea6d741121 in ?? ()
#33 0x000055ea6d741121 in ?? ()
#34 0x000055ea6d741121 in ?? ()
#35 0x000055ea6d741121 in ?? ()
#36 0x000055ea6d74186a in init_child ()
#37 0x000055ea6d6079e4 in main_loop ()
#38 0x000055ea6d60ec8a in main ()
(gdb) 

Log Messages

Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg/cfg_script.c:41]: new_cfg_script_var(): declaring server.ip
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.y:1659]: yyparse(): loading module ctl.so
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:575]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/ctl.so>
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.lex:1737]: pp_define(): defining id: MOD_ctl
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.y:1659]: yyparse(): loading module tm.so
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:575]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so>
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/kemi.c:1277]: sr_kemi_modules_add(): adding core module
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/kemi.c:1281]: sr_kemi_modules_add(): adding hdr module
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/kemi.c:1295]: sr_kemi_modules_add(): adding module: tm
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.lex:1737]: pp_define(): defining id: MOD_tm
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.y:1659]: yyparse(): loading module corex.so
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:575]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/corex.so>
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/kemi.c:1295]: sr_kemi_modules_add(): adding module: corex
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:345]: register_module(): register PV from: corex
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.lex:1737]: pp_define(): defining id: MOD_corex
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.y:1659]: yyparse(): loading module sl.so
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:575]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/sl.so>
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/kemi.c:1295]: sr_kemi_modules_add(): adding module: sl
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.lex:1737]: pp_define(): defining id: MOD_sl
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.y:1659]: yyparse(): loading module pv.so
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:575]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/pv.so>
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/kemi.c:1295]: sr_kemi_modules_add(): adding module: pvx
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:345]: register_module(): register PV from: pv
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.lex:1737]: pp_define(): defining id: MOD_pv
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.y:1659]: yyparse(): loading module maxfwd.so
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:575]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/maxfwd.so>
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/kemi.c:1295]: sr_kemi_modules_add(): adding module: maxfwd
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.lex:1737]: pp_define(): defining id: MOD_maxfwd
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.y:1659]: yyparse(): loading module siputils.so
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:575]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/siputils.so>
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/kemi.c:1295]: sr_kemi_modules_add(): adding module: siputils
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:345]: register_module(): register PV from: siputils
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.lex:1737]: pp_define(): defining id: MOD_siputils
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.y:1659]: yyparse(): loading module xlog.so
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:575]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/xlog.so>
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/kemi.c:1295]: sr_kemi_modules_add(): adding module: xlog
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:345]: register_module(): register PV from: xlog
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.lex:1737]: pp_define(): defining id: MOD_xlog
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.y:1659]: yyparse(): loading module sanity.so
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:575]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/sanity.so>
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/kemi.c:1295]: sr_kemi_modules_add(): adding module: sanity
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.lex:1737]: pp_define(): defining id: MOD_sanity
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.y:1659]: yyparse(): loading module auth.so
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:575]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/auth.so>
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/kemi.c:1295]: sr_kemi_modules_add(): adding module: auth
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.lex:1737]: pp_define(): defining id: MOD_auth
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.y:1659]: yyparse(): loading module app_python.so
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:575]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/app_python.so>
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/kemi.c:1390]: sr_kemi_eng_register(): registered config routing enginge [python]
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/kemi.c:1295]: sr_kemi_modules_add(): adding module: app_python
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:652]: load_module(): /usr/lib/x86_64-linux-gnu/kamailio/modules/app_python.so: exports dlflags interface is deprecated and it will not be supported in newer versions; consider using mod_register() instead
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/kemi.c:1292]: sr_kemi_modules_add(): updating module: app_python
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.lex:1737]: pp_define(): defining id: MOD_app_python
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.y:1659]: yyparse(): loading module htable.so
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:575]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/htable.so>
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/kemi.c:1295]: sr_kemi_modules_add(): adding module: htable
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:345]: register_module(): register PV from: htable
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.lex:1737]: pp_define(): defining id: MOD_htable
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.y:1659]: yyparse(): loading module rr.so
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:575]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/rr.so>
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/kemi.c:1295]: sr_kemi_modules_add(): adding module: rr
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:345]: register_module(): register PV from: rr
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.lex:1737]: pp_define(): defining id: MOD_rr
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.y:1659]: yyparse(): loading module dialog.so
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:575]: load_module(): trying to load </usr/lib/x86_64-linux-gnu/kamailio/modules/dialog.so>
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/kemi.c:1295]: sr_kemi_modules_add(): adding module: dialog
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:345]: register_module(): register PV from: dialog
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg.lex:1737]: pp_define(): defining id: MOD_dialog
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/mem/shm.c:94]: shm_core_pools_init(): preparing to initialize shm core pools
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/mem/q_malloc.c:192]: qm_malloc_init(): QM_OPTIMIZE=16384, /ROUNDTO=2048
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/mem/q_malloc.c:194]: qm_malloc_init(): QM_HASH_SIZE=2099, qm_block size=235152
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/mem/q_malloc.c:196]: qm_malloc_init(): qm_malloc_init(0x7f49b10a4000, 67108864), start=0x7f49b10a4000
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/mem/q_malloc.c:205]: qm_malloc_init(): size= 67108864, init_overhead=235256
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/modparam.c:83]: set_mod_param_regex(): 'tm' matches module 'tm'
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:810]: find_param_export(): found <failure_reply_mode> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/modparam.c:99]: set_mod_param_regex(): found <failure_reply_mode> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/modparam.c:83]: set_mod_param_regex(): 'tm' matches module 'tm'
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:810]: find_param_export(): found <fr_timer> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/modparam.c:99]: set_mod_param_regex(): found <fr_timer> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/modparam.c:83]: set_mod_param_regex(): 'tm' matches module 'tm'
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:810]: find_param_export(): found <fr_inv_timer> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/modparam.c:99]: set_mod_param_regex(): found <fr_inv_timer> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/modparam.c:83]: set_mod_param_regex(): 'tm' matches module 'tm'
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:810]: find_param_export(): found <contacts_avp> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/modparam.c:99]: set_mod_param_regex(): found <contacts_avp> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/modparam.c:83]: set_mod_param_regex(): 'tm' matches module 'tm'
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:810]: find_param_export(): found <contact_flows_avp> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/modparam.c:99]: set_mod_param_regex(): found <contact_flows_avp> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/modparam.c:83]: set_mod_param_regex(): 'htable' matches module 'htable'
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:810]: find_param_export(): found <htable> in module htable [/usr/lib/x86_64-linux-gnu/kamailio/modules/htable.so]
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/modparam.c:99]: set_mod_param_regex(): found <htable> in module htable [/usr/lib/x86_64-linux-gnu/kamailio/modules/htable.so]
Aug 10 11:43:04 kamailio kamailio: DEBUG: htable [ht_api.c:903]: ht_table_spec(): htable [a] - expire [3600]
Aug 10 11:43:04 kamailio kamailio: DEBUG: htable [ht_api.c:908]: ht_table_spec(): htable [a] - size [12]
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/modparam.c:83]: set_mod_param_regex(): 'dialog' matches module 'dialog'
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:810]: find_param_export(): found <dlg_flag> in module dialog [/usr/lib/x86_64-linux-gnu/kamailio/modules/dialog.so]
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/modparam.c:99]: set_mod_param_regex(): found <dlg_flag> in module dialog [/usr/lib/x86_64-linux-gnu/kamailio/modules/dialog.so]
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/modparam.c:83]: set_mod_param_regex(): 'app_python' matches module 'app_python'
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/sr_module.c:810]: find_param_export(): found <script_name> in module app_python [/usr/lib/x86_64-linux-gnu/kamailio/modules/app_python.so]
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/modparam.c:99]: set_mod_param_regex(): found <script_name> in module app_python [/usr/lib/x86_64-linux-gnu/kamailio/modules/app_python.so]
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/ppcfg.c:223]: pp_ifdef_level_check(): same number of pairing preprocessor directives #!IF[N]DEF - #!ENDIF
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/route.c:129]: route_add(): mapping routing block (0x55ea6dd09ca0)[core:receive-parse-error] to 1
Aug 10 11:43:04 kamailio 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
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/mem/pkg.c:101]: pkg_print_manager(): pkg - using memory manager: q_malloc
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/mem/shm.c:272]: shm_print_manager(): shm - using memory manager: q_malloc
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg/cfg.c:173]: cfg_declare(): new config group has been registered: 'core' (num=54, size=216)
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/cfg/cfg.c:173]: cfg_declare(): new config group has been registered: 'tcp' (num=27, size=108)
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/timer.c:256]: init_timer(): starting with *ticks=780718939
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/timer.c:297]: init_timer(): timer_list between 0x7f49b10e6dd8 and 0x7f49b112add8
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/pt.c:144]: register_procs(): registering new processes: 0 (old) + 1 (new) = 1 (total)
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/daemonize.c:207]: enable_dumpable(): trying enable core dumping...
Aug 10 11:43:04 kamailio kamailio: DEBUG: <core> [core/daemonize.c:224]: enable_dumpable(): core dumping is enabled now (1)...
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/daemonize.c:583]: set_core_dump(): core dump limits set to 18446744073709551615
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/async_task.c:108]: async_task_init(): start initializing asynk task framework
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:988]: init_mod(): ctl
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: ctl [ctl.c:249]: mod_init(): listening on:
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: ctl [ctl.c:259]: mod_init():         [binrpc:unix stream] /var/run/kamailio//kamailio_ctl
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/pt.c:144]: register_procs(): registering new processes: 1 (old) + 1 (new) = 2 (total)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:988]: init_mod(): tm
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: tm [tm.c:709]: mod_init(): TM - (sizeof cell=488, sip_msg=1776) initializing...
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: tm [callid.c:105]: init_callid(): Call-ID initialization: '7c66da7c444e830e'
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: tm [lock.c:72]: lock_initialize(): lock initialization started
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: tm [timer.c:206]: tm_init_timers(): tm init timers - fr=48 fr_inv=1920 wait=80 delete=4 t1=500 t2=4000 max_inv_lifetime=2880 max_noninv_lifetime=512
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/cfg/cfg.c:173]: cfg_declare(): new config group has been registered: 'tm' (num=36, size=168)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/md5utils.c:67]: MD5StringArray(): MD5 calculated: 9273c7f4a88e26e051364440de015839
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/md5utils.c:67]: MD5StringArray(): MD5 calculated: 1c7e135ecaaa58c12938ec85669cfa78
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:988]: init_mod(): corex
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:988]: init_mod(): sl
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/md5utils.c:67]: MD5StringArray(): MD5 calculated: de9231bbc4c5db04517bd4cc72f7eb6e
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:711]: find_mod_export_record(): found export of <load_tm> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:711]: find_mod_export_record(): found export of <t_newtran> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:711]: find_mod_export_record(): found export of <t_relay_to_tcp> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:711]: find_mod_export_record(): found export of <t_relay_to_udp> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:711]: find_mod_export_record(): found export of <t_relay> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:711]: find_mod_export_record(): found export of <t_forward_nonack> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:711]: find_mod_export_record(): found export of <t_release> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:988]: init_mod(): pv
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:988]: init_mod(): maxfwd
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/cfg/cfg.c:173]: cfg_declare(): new config group has been registered: 'maxfwd' (num=1, size=4)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:988]: init_mod(): siputils
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:711]: find_mod_export_record(): found export of <bind_sl> in module sl [/usr/lib/x86_64-linux-gnu/kamailio/modules/sl.so]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/usr_avp.c:887]: parse_avp_ident(): Parsing 's:rpid'
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/cfg/cfg.c:173]: cfg_declare(): new config group has been registered: 'siputils' (num=1, size=4)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:988]: init_mod(): xlog
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/cfg/cfg.c:173]: cfg_declare(): new config group has been registered: 'xlog' (num=1, size=4)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:988]: init_mod(): sanity
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: sanity [sanity_mod.c:97]: mod_init(): sanity initializing
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:711]: find_mod_export_record(): found export of <bind_sl> in module sl [/usr/lib/x86_64-linux-gnu/kamailio/modules/sl.so]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: sanity [sanity_mod.c:105]: mod_init(): parsing proxy requires string:
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:988]: init_mod(): auth
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: auth [auth_mod.c:275]: mod_init(): auth module - initializing
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:711]: find_mod_export_record(): found export of <bind_sl> in module sl [/usr/lib/x86_64-linux-gnu/kamailio/modules/sl.so]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/usr_avp.c:887]: parse_avp_ident(): Parsing 'digest_challenge'
Aug 10 11:43:04 kamailio kamailio[15769]: INFO: auth [auth_mod.c:346]: mod_init(): qop set, but nonce-count (nc_enabled) support disabled
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:988]: init_mod(): app_python
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/parser/msg_parser.c:604]: parse_msg(): SIP Request:
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/parser/msg_parser.c:606]: parse_msg():  method:  <OPTIONS>
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/parser/msg_parser.c:608]: parse_msg():  uri:     <sip:you@kamailio.org>
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/parser/msg_parser.c:610]: parse_msg():  version: <SIP/2.0>
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of header reached, state=2
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/parser/msg_parser.c:492]: parse_headers(): Via found, flags=2
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/parser/msg_parser.c:494]: parse_headers(): this is the first via
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.dbg(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.err(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.info(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.warn(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.notice(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.crit(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.log(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.drop(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.is_myself(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.setflag(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.resetflag(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.isflagset(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.setbflag(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.resetbflag(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.isbflagset(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.setbiflag(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.resetbiflag(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.isbiflagset(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.setsflag(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.resetsflag(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.issflagset(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.seturi(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.setuser(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.sethost(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.setdsturi(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.resetdsturi(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.isdsturiset(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.force_rport(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.is_method(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.forward(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.forward_uri(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.set_forward_close(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.set_forward_no_connect(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.set_reply_close(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1085]: sr_apy_init_ksr(): exporting KSR.set_reply_no_connect(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.hdr.append(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.hdr.append_after(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.hdr.insert(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.hdr.insert_before(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.hdr.remove(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.hdr.is_present(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.hdr.append_to_reply(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1144]: sr_apy_init_ksr(): initializing kemi sub-module: KSR.hdr (hdr)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_relay(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_on_branch(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_on_failure(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_on_branch_failure(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_on_reply(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_reply(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_check_trans(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_is_canceled(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_newtran(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_release(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_replicate(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_is_set(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_lookup_request(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_lookup_cancel(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_lookup_cancel_flags(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_retransmit_reply(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_set_fr_inv(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_set_fr(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_reset_fr(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_set_max_lifetime(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_reset_max_lifetime(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_set_retr(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_reset_retr(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_uac_send(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_load_contacts(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_next_contacts(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_next_contact_flow(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_drop_replies_all(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_drop_replies(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_use_uac_headers(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_save_lumps(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_is_expired(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_check_status(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_grep_status(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_is_retr_async_reply(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_any_replied(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_any_timeout(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_branch_replied(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_branch_timeout(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_set_auto_inv_100(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_set_disable_6xx(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_set_disable_failover(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_set_no_e2e_cancel_reason(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.tm.t_set_disable_internal_reply(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1144]: sr_apy_init_ksr(): initializing kemi sub-module: KSR.tm (tm)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.corex.append_branch(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.corex.append_branch_uri(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.corex.append_branch_uri_q(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1144]: sr_apy_init_ksr(): initializing kemi sub-module: KSR.corex (corex)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.sl.sl_send_reply(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.sl.send_reply(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.sl.sl_reply_error(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.sl.sl_forward_reply(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1144]: sr_apy_init_ksr(): initializing kemi sub-module: KSR.sl (sl)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.pvx.sbranch_set_ruri(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.pvx.sbranch_append(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.pvx.sbranch_reset(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.pvx.pv_var_to_xavp(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.pvx.pv_xavp_to_var(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.pvx.pv_xavp_print(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.pvx.xavp_params_explode(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.pvx.evalx(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1144]: sr_apy_init_ksr(): initializing kemi sub-module: KSR.pvx (pvx)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.maxfwd.process_maxfwd(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1144]: sr_apy_init_ksr(): initializing kemi sub-module: KSR.maxfwd (maxfwd)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.siputils.has_totag(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.siputils.is_request(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.siputils.is_reply(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.siputils.is_first_hop(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1144]: sr_apy_init_ksr(): initializing kemi sub-module: KSR.siputils (siputils)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.xlog.xdbg(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.xlog.xinfo(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.xlog.xnotice(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.xlog.xwarn(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.xlog.xerr(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.xlog.xalert(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.xlog.xcrit(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.xlog.xlog(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1144]: sr_apy_init_ksr(): initializing kemi sub-module: KSR.xlog (xlog)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.sanity.sanity_check(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.sanity.sanity_check_defaults(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1144]: sr_apy_init_ksr(): initializing kemi sub-module: KSR.sanity (sanity)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.auth.consume_credentials(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.auth.auth_challenge(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.auth.pv_auth_check(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.auth.has_credentials(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1144]: sr_apy_init_ksr(): initializing kemi sub-module: KSR.auth (auth)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.app_python.exec(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.app_python.exec_p1(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1144]: sr_apy_init_ksr(): initializing kemi sub-module: KSR.app_python (app_python)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.htable.sht_lock(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.htable.sht_unlock(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.htable.sht_reset(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.htable.sht_iterator_start(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.htable.sht_iterator_next(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.htable.sht_iterator_end(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1144]: sr_apy_init_ksr(): initializing kemi sub-module: KSR.htable (htable)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.rr.record_route(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.rr.record_route_params(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.rr.loose_route(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.rr.remove_record_route(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.rr.add_rr_param(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.rr.check_route_param(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1144]: sr_apy_init_ksr(): initializing kemi sub-module: KSR.rr (rr)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.dialog.dlg_manage(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.dialog.dlg_bye(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.dialog.is_known_dlg(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.dialog.dlg_set_timeout(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.dialog.dlg_set_timeout_id(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.dialog.dlg_set_property(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.dialog.dlg_get(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.dialog.set_dlg_profile_static(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.dialog.set_dlg_profile(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.dialog.unset_dlg_profile_static(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.dialog.unset_dlg_profile(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.dialog.is_in_profile_static(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.dialog.is_in_profile(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.dialog.get_profile_size_static(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.dialog.get_profile_size(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.dialog.dlg_setflag(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.dialog.dlg_resetflag(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1129]: sr_apy_init_ksr(): exporting KSR.dialog.dlg_isflagset(...)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1144]: sr_apy_init_ksr(): initializing kemi sub-module: KSR.dialog (dialog)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:1153]: sr_apy_init_ksr(): module 'KSR' has been initialized
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:213]: sr_apy_kemi_exec_func(): execution of method: .info
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:240]: sr_apy_kemi_exec_func(): param[1] for: info is str: ===== from Python mod init
Aug 10 11:43:04 kamailio kamailio[15769]: INFO: <core> [core/kemi.c:91]: sr_kemi_core_info(): ===== from Python mod init
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:213]: sr_apy_kemi_exec_func(): execution of method: .info
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:240]: sr_apy_kemi_exec_func(): param[1] for: info is str: ===== kamailio.__init__(), PID: 15769
Aug 10 11:43:04 kamailio kamailio[15769]: INFO: <core> [core/kemi.c:91]: sr_kemi_core_info(): ===== kamailio.__init__(), PID: 15769
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:988]: init_mod(): htable
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: htable [ht_api.c:361]: ht_init_tables(): initializing htable [a] with nr. of slots: 4096
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: htable [ht_api.c:376]: ht_init_tables(): event route for expired items in [a] does not exist
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: htable [htable.c:200]: mod_init(): starting auto-expire timer
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:988]: init_mod(): rr
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:718]: find_mod_export_record(): export of <bind_ob> not found (flags 0)
Aug 10 11:43:04 kamailio kamailio[15769]: INFO: rr [../outbound/api.h:52]: ob_load_api(): unable to import bind_ob - maybe module is not loaded
Aug 10 11:43:04 kamailio kamailio[15769]: INFO: rr [rr_mod.c:175]: mod_init(): outbound module not available
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:988]: init_mod(): dialog
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/pvapi.c:494]: pv_spec_lookup(): PV <$ru> is not in cache
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/pvapi.c:333]: pv_cache_add(): PV cache not initialized, doing it now
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/pvapi.c:368]: pv_cache_add(): pvar [$ru] added in cache
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:711]: find_mod_export_record(): found export of <load_tm> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:711]: find_mod_export_record(): found export of <t_newtran> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:711]: find_mod_export_record(): found export of <t_relay_to_tcp> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:711]: find_mod_export_record(): found export of <t_relay_to_udp> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:711]: find_mod_export_record(): found export of <t_relay> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:711]: find_mod_export_record(): found export of <t_forward_nonack> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:711]: find_mod_export_record(): found export of <t_release> in module tm [/usr/lib/x86_64-linux-gnu/kamailio/modules/tm.so]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:711]: find_mod_export_record(): found export of <load_rr> in module rr [/usr/lib/x86_64-linux-gnu/kamailio/modules/rr.so]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/pt.c:144]: register_procs(): registering new processes: 2 (old) + 1 (new) = 3 (total)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/pt.c:101]: init_pt(): registering new processes: 3 (old) + 11 (new) = 14 (total)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [main.c:2618]: main(): Expect (at least) 14 kamailio processes in your process list
Aug 10 11:43:04 kamailio kamailio[15769]: INFO: <core> [core/udp_server.c:153]: probe_max_receive_buffer(): SO_RCVBUF is initially 212992
Aug 10 11:43:04 kamailio kamailio[15769]: INFO: <core> [core/udp_server.c:205]: probe_max_receive_buffer(): SO_RCVBUF is finally 425984
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/daemonize.c:207]: enable_dumpable(): trying enable core dumping...
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/daemonize.c:224]: enable_dumpable(): core dumping is enabled now (1)...
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/pvapi.c:494]: pv_spec_lookup(): PV <$mt> is not in cache
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/pvapi.c:368]: pv_cache_add(): pvar [$mt] added in cache
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/pvapi.c:494]: pv_spec_lookup(): PV <$hdr(CSeq)> is not in cache
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: pv [pv_core.c:3071]: pv_parse_hdr_name(): using hdr type (5) instead of <CSeq>
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/pvapi.c:368]: pv_cache_add(): pvar [$hdr(CSeq)] added in cache
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/pvapi.c:494]: pv_spec_lookup(): PV <$ci> is not in cache
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/pvapi.c:368]: pv_cache_add(): pvar [$ci] added in cache
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 0 rank -127: ctl [main]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 0 rank -127: tm [main]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 0 rank -127: corex [main]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 0 rank -127: sl [main]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 0 rank -127: app_python [main]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:213]: sr_apy_kemi_exec_func(): execution of method: .info
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:240]: sr_apy_kemi_exec_func(): param[1] for: info is str: ===== kamailio.child_init(-127), PID: 15769
Aug 10 11:43:04 kamailio kamailio[15769]: INFO: <core> [core/kemi.c:91]: sr_kemi_core_info(): ===== kamailio.child_init(-127), PID: 15769
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:742]: sr_apy_kemi_f_pv_get_mode(): pv get: $sel(cfg_get.server.ip)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/select.c:111]: w_parse_select(): part 0: cfg_get
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/select.c:111]: w_parse_select(): part 1: server
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/select.c:111]: w_parse_select(): part 2: ip
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/select.c:158]: w_parse_select(): end, total elements: 3, calling resolve_select
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/select.c:263]: resolve_select(): 'cfg_get'
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/select.c:263]: resolve_select(): 'ip'
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/pvapi.c:368]: pv_cache_add(): pvar [$sel(cfg_get.server.ip)] added in cache
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/select.c:412]: run_select(): Calling SELECT 0x7f49b84e3c18
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:213]: sr_apy_kemi_exec_func(): execution of method: .info
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:240]: sr_apy_kemi_exec_func(): param[1] for: info is str: Server configuration. IP: 192.168.33.1
Aug 10 11:43:04 kamailio kamailio[15769]: INFO: <core> [core/kemi.c:91]: sr_kemi_core_info(): Server configuration. IP: 192.168.33.1
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 0 rank -127: htable [main]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: htable [htable.c:236]: child_init(): rank is (-127)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 0 rank -127: dialog [main]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 0 rank 0: ctl [main]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: ctl [ctl.c:321]: mod_child(): ctl: mod_child(0), ctrl_sock_lst=0x55ea6f4b3040
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: ctl [ctl.c:329]: mod_child(): ctl: mod_child(0), fork_process=15782, csl=0x55ea6f4b3040
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 0 rank 0: tm [main]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '7c66da7c444e830e-15769@192.168.56.10'
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 0 rank 0: corex [main]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 0 rank 0: sl [main]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 0 rank 0: app_python [main]
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:213]: sr_apy_kemi_exec_func(): execution of method: .info
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:240]: sr_apy_kemi_exec_func(): param[1] for: info is str: ===== kamailio.child_init(0), PID: 15769
Aug 10 11:43:04 kamailio kamailio[15769]: INFO: <core> [core/kemi.c:91]: sr_kemi_core_info(): ===== kamailio.child_init(0), PID: 15769
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: app_python [apy_kemi.c:742]: sr_apy_kemi_f_pv_get_mode(): pv get: $sel(cfg_get.server.ip)
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/pvapi.c:395]: pv_cache_lookup(): pvar [$sel(cfg_get.server.ip)] found in cache
Aug 10 11:43:04 kamailio kamailio[15769]: DEBUG: <core> [core/select.c:412]: run_select(): Calling SELECT 0x7f49b84e3c18
Aug 10 11:43:04 kamailio kamailio[15775]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 5 rank 5: ctl [udp receiver child=4 sock=192.168.56.10:5060]
Aug 10 11:43:04 kamailio kamailio[15775]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 5 rank 5: tm [udp receiver child=4 sock=192.168.56.10:5060]
Aug 10 11:43:04 kamailio kamailio[15775]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '7c66da7c444e830e-15775@192.168.56.10'
Aug 10 11:43:04 kamailio kamailio[15775]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 5 rank 5: corex [udp receiver child=4 sock=192.168.56.10:5060]
Aug 10 11:43:04 kamailio kamailio[15775]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 5 rank 5: sl [udp receiver child=4 sock=192.168.56.10:5060]
Aug 10 11:43:04 kamailio kamailio[15775]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 5 rank 5: app_python [udp receiver child=4 sock=192.168.56.10:5060]
Aug 10 11:43:04 kamailio kamailio[15775]: DEBUG: app_python [apy_kemi.c:213]: sr_apy_kemi_exec_func(): execution of method: .info
Aug 10 11:43:04 kamailio kamailio[15775]: DEBUG: app_python [apy_kemi.c:240]: sr_apy_kemi_exec_func(): param[1] for: info is str: ===== kamailio.child_init(5), PID: 15775
Aug 10 11:43:04 kamailio kamailio[15775]: INFO: <core> [core/kemi.c:91]: sr_kemi_core_info(): ===== kamailio.child_init(5), PID: 15775
Aug 10 11:43:04 kamailio kamailio[15775]: DEBUG: app_python [apy_kemi.c:742]: sr_apy_kemi_f_pv_get_mode(): pv get: $sel(cfg_get.server.ip)
Aug 10 11:43:04 kamailio kamailio[15775]: DEBUG: <core> [core/pvapi.c:395]: pv_cache_lookup(): pvar [$sel(cfg_get.server.ip)] found in cache
Aug 10 11:43:04 kamailio kamailio[15775]: DEBUG: <core> [core/select.c:412]: run_select(): Calling SELECT 0x7f49b84e3c18
Aug 10 11:43:05 kamailio kamailio[15776]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 6 rank 6: ctl [udp receiver child=5 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15776]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 6 rank 6: tm [udp receiver child=5 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15776]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '7c66da7c444e830e-15776@192.168.56.10'
Aug 10 11:43:05 kamailio kamailio[15776]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 6 rank 6: corex [udp receiver child=5 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15776]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 6 rank 6: sl [udp receiver child=5 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15776]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 6 rank 6: app_python [udp receiver child=5 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15776]: DEBUG: app_python [apy_kemi.c:213]: sr_apy_kemi_exec_func(): execution of method: .info
Aug 10 11:43:05 kamailio kamailio[15776]: DEBUG: app_python [apy_kemi.c:240]: sr_apy_kemi_exec_func(): param[1] for: info is str: ===== kamailio.child_init(6), PID: 15776
Aug 10 11:43:05 kamailio kamailio[15776]: INFO: <core> [core/kemi.c:91]: sr_kemi_core_info(): ===== kamailio.child_init(6), PID: 15776
Aug 10 11:43:05 kamailio kamailio[15776]: DEBUG: app_python [apy_kemi.c:742]: sr_apy_kemi_f_pv_get_mode(): pv get: $sel(cfg_get.server.ip)
Aug 10 11:43:05 kamailio kamailio[15776]: DEBUG: <core> [core/pvapi.c:395]: pv_cache_lookup(): pvar [$sel(cfg_get.server.ip)] found in cache
Aug 10 11:43:05 kamailio kamailio[15776]: DEBUG: <core> [core/select.c:412]: run_select(): Calling SELECT 0x7f49b84e3c18
Aug 10 11:43:05 kamailio kamailio[15774]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 4 rank 4: ctl [udp receiver child=3 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15774]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 4 rank 4: tm [udp receiver child=3 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15774]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '7c66da7c444e830e-15774@192.168.56.10'
Aug 10 11:43:05 kamailio kamailio[15774]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 4 rank 4: corex [udp receiver child=3 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15774]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 4 rank 4: sl [udp receiver child=3 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15774]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 4 rank 4: app_python [udp receiver child=3 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15774]: DEBUG: app_python [apy_kemi.c:213]: sr_apy_kemi_exec_func(): execution of method: .info
Aug 10 11:43:05 kamailio kamailio[15774]: DEBUG: app_python [apy_kemi.c:240]: sr_apy_kemi_exec_func(): param[1] for: info is str: ===== kamailio.child_init(4), PID: 15774
Aug 10 11:43:05 kamailio kamailio[15774]: INFO: <core> [core/kemi.c:91]: sr_kemi_core_info(): ===== kamailio.child_init(4), PID: 15774
Aug 10 11:43:05 kamailio kamailio[15774]: DEBUG: app_python [apy_kemi.c:742]: sr_apy_kemi_f_pv_get_mode(): pv get: $sel(cfg_get.server.ip)
Aug 10 11:43:05 kamailio kamailio[15774]: DEBUG: <core> [core/pvapi.c:395]: pv_cache_lookup(): pvar [$sel(cfg_get.server.ip)] found in cache
Aug 10 11:43:05 kamailio kamailio[15774]: DEBUG: <core> [core/select.c:412]: run_select(): Calling SELECT 0x7f49b84e3c18
Aug 10 11:43:05 kamailio kamailio[15773]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 3 rank 3: ctl [udp receiver child=2 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15773]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 3 rank 3: tm [udp receiver child=2 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15773]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '7c66da7c444e830e-15773@192.168.56.10'
Aug 10 11:43:05 kamailio kamailio[15773]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 3 rank 3: corex [udp receiver child=2 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15773]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 3 rank 3: sl [udp receiver child=2 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15773]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 3 rank 3: app_python [udp receiver child=2 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15773]: DEBUG: app_python [apy_kemi.c:213]: sr_apy_kemi_exec_func(): execution of method: .info
Aug 10 11:43:05 kamailio kamailio[15773]: DEBUG: app_python [apy_kemi.c:240]: sr_apy_kemi_exec_func(): param[1] for: info is str: ===== kamailio.child_init(3), PID: 15773
Aug 10 11:43:05 kamailio kamailio[15773]: INFO: <core> [core/kemi.c:91]: sr_kemi_core_info(): ===== kamailio.child_init(3), PID: 15773
Aug 10 11:43:05 kamailio kamailio[15773]: DEBUG: app_python [apy_kemi.c:742]: sr_apy_kemi_f_pv_get_mode(): pv get: $sel(cfg_get.server.ip)
Aug 10 11:43:05 kamailio kamailio[15773]: DEBUG: <core> [core/pvapi.c:395]: pv_cache_lookup(): pvar [$sel(cfg_get.server.ip)] found in cache
Aug 10 11:43:05 kamailio kamailio[15773]: DEBUG: <core> [core/select.c:412]: run_select(): Calling SELECT 0x7f49b84e3c18
Aug 10 11:43:05 kamailio kamailio[15777]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 7 rank 7: ctl [udp receiver child=6 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15777]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 7 rank 7: tm [udp receiver child=6 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15777]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '7c66da7c444e830e-15777@192.168.56.10'
Aug 10 11:43:05 kamailio kamailio[15777]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 7 rank 7: corex [udp receiver child=6 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15777]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 7 rank 7: sl [udp receiver child=6 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15777]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 7 rank 7: app_python [udp receiver child=6 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15777]: DEBUG: app_python [apy_kemi.c:213]: sr_apy_kemi_exec_func(): execution of method: .info
Aug 10 11:43:05 kamailio kamailio[15777]: DEBUG: app_python [apy_kemi.c:240]: sr_apy_kemi_exec_func(): param[1] for: info is str: ===== kamailio.child_init(7), PID: 15777
Aug 10 11:43:05 kamailio kamailio[15777]: INFO: <core> [core/kemi.c:91]: sr_kemi_core_info(): ===== kamailio.child_init(7), PID: 15777
Aug 10 11:43:05 kamailio kamailio[15777]: DEBUG: app_python [apy_kemi.c:742]: sr_apy_kemi_f_pv_get_mode(): pv get: $sel(cfg_get.server.ip)
Aug 10 11:43:05 kamailio kamailio[15777]: DEBUG: <core> [core/pvapi.c:395]: pv_cache_lookup(): pvar [$sel(cfg_get.server.ip)] found in cache
Aug 10 11:43:05 kamailio kamailio[15777]: DEBUG: <core> [core/select.c:412]: run_select(): Calling SELECT 0x7f49b84e3c18
Aug 10 11:43:05 kamailio kamailio[15772]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 2 rank 2: ctl [udp receiver child=1 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15772]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 2 rank 2: tm [udp receiver child=1 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15772]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '7c66da7c444e830e-15772@192.168.56.10'
Aug 10 11:43:05 kamailio kamailio[15772]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 2 rank 2: corex [udp receiver child=1 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15772]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 2 rank 2: sl [udp receiver child=1 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15772]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 2 rank 2: app_python [udp receiver child=1 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15772]: DEBUG: app_python [apy_kemi.c:213]: sr_apy_kemi_exec_func(): execution of method: .info
Aug 10 11:43:05 kamailio kamailio[15772]: DEBUG: app_python [apy_kemi.c:240]: sr_apy_kemi_exec_func(): param[1] for: info is str: ===== kamailio.child_init(2), PID: 15772
Aug 10 11:43:05 kamailio kamailio[15772]: INFO: <core> [core/kemi.c:91]: sr_kemi_core_info(): ===== kamailio.child_init(2), PID: 15772
Aug 10 11:43:05 kamailio kamailio[15772]: DEBUG: app_python [apy_kemi.c:742]: sr_apy_kemi_f_pv_get_mode(): pv get: $sel(cfg_get.server.ip)
Aug 10 11:43:05 kamailio kamailio[15772]: DEBUG: <core> [core/pvapi.c:395]: pv_cache_lookup(): pvar [$sel(cfg_get.server.ip)] found in cache
Aug 10 11:43:05 kamailio kamailio[15772]: DEBUG: <core> [core/select.c:412]: run_select(): Calling SELECT 0x7f49b84e3c18
Aug 10 11:43:05 kamailio kamailio[15778]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 8 rank 8: ctl [udp receiver child=7 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15778]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 8 rank 8: tm [udp receiver child=7 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15778]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '7c66da7c444e830e-15778@192.168.56.10'
Aug 10 11:43:05 kamailio kamailio[15778]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 8 rank 8: corex [udp receiver child=7 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15778]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 8 rank 8: sl [udp receiver child=7 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15778]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 8 rank 8: app_python [udp receiver child=7 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15778]: DEBUG: app_python [apy_kemi.c:213]: sr_apy_kemi_exec_func(): execution of method: .info
Aug 10 11:43:05 kamailio kamailio[15778]: DEBUG: app_python [apy_kemi.c:240]: sr_apy_kemi_exec_func(): param[1] for: info is str: ===== kamailio.child_init(8), PID: 15778
Aug 10 11:43:05 kamailio kamailio[15778]: INFO: <core> [core/kemi.c:91]: sr_kemi_core_info(): ===== kamailio.child_init(8), PID: 15778
Aug 10 11:43:05 kamailio kamailio[15778]: DEBUG: app_python [apy_kemi.c:742]: sr_apy_kemi_f_pv_get_mode(): pv get: $sel(cfg_get.server.ip)
Aug 10 11:43:05 kamailio kamailio[15778]: DEBUG: <core> [core/pvapi.c:395]: pv_cache_lookup(): pvar [$sel(cfg_get.server.ip)] found in cache
Aug 10 11:43:05 kamailio kamailio[15778]: DEBUG: <core> [core/select.c:412]: run_select(): Calling SELECT 0x7f49b84e3c18
Aug 10 11:43:05 kamailio kamailio[15779]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 9 rank -1: ctl [slow timer]
Aug 10 11:43:05 kamailio kamailio[15779]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 9 rank -1: tm [slow timer]
Aug 10 11:43:05 kamailio kamailio[15779]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '7c66da7c444e830e-15779@192.168.56.10'
Aug 10 11:43:05 kamailio kamailio[15779]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 9 rank -1: corex [slow timer]
Aug 10 11:43:05 kamailio kamailio[15779]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 9 rank -1: sl [slow timer]
Aug 10 11:43:05 kamailio kamailio[15779]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 9 rank -1: app_python [slow timer]
Aug 10 11:43:05 kamailio kamailio[15779]: DEBUG: app_python [apy_kemi.c:213]: sr_apy_kemi_exec_func(): execution of method: .info
Aug 10 11:43:05 kamailio kamailio[15779]: DEBUG: app_python [apy_kemi.c:240]: sr_apy_kemi_exec_func(): param[1] for: info is str: ===== kamailio.child_init(-1), PID: 15779
Aug 10 11:43:05 kamailio kamailio[15779]: INFO: <core> [core/kemi.c:91]: sr_kemi_core_info(): ===== kamailio.child_init(-1), PID: 15779
Aug 10 11:43:05 kamailio kamailio[15779]: DEBUG: app_python [apy_kemi.c:742]: sr_apy_kemi_f_pv_get_mode(): pv get: $sel(cfg_get.server.ip)
Aug 10 11:43:05 kamailio kamailio[15779]: DEBUG: <core> [core/pvapi.c:395]: pv_cache_lookup(): pvar [$sel(cfg_get.server.ip)] found in cache
Aug 10 11:43:05 kamailio kamailio[15779]: DEBUG: <core> [core/select.c:412]: run_select(): Calling SELECT 0x7f49b84e3c18
Aug 10 11:43:05 kamailio kamailio[15771]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 1 rank 1: ctl [udp receiver child=0 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15771]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 1 rank 1: tm [udp receiver child=0 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15771]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '7c66da7c444e830e-15771@192.168.56.10'
Aug 10 11:43:05 kamailio kamailio[15771]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 1 rank 1: corex [udp receiver child=0 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15771]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 1 rank 1: sl [udp receiver child=0 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15771]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 1 rank 1: app_python [udp receiver child=0 sock=192.168.56.10:5060]
Aug 10 11:43:05 kamailio kamailio[15771]: DEBUG: app_python [apy_kemi.c:213]: sr_apy_kemi_exec_func(): execution of method: .info
Aug 10 11:43:05 kamailio kamailio[15771]: DEBUG: app_python [apy_kemi.c:240]: sr_apy_kemi_exec_func(): param[1] for: info is str: ===== kamailio.child_init(1), PID: 15771
Aug 10 11:43:05 kamailio kamailio[15771]: INFO: <core> [core/kemi.c:91]: sr_kemi_core_info(): ===== kamailio.child_init(1), PID: 15771
Aug 10 11:43:05 kamailio kamailio[15771]: DEBUG: app_python [apy_kemi.c:742]: sr_apy_kemi_f_pv_get_mode(): pv get: $sel(cfg_get.server.ip)
Aug 10 11:43:05 kamailio kamailio[15771]: DEBUG: <core> [core/pvapi.c:395]: pv_cache_lookup(): pvar [$sel(cfg_get.server.ip)] found in cache
Aug 10 11:43:05 kamailio kamailio[15771]: DEBUG: <core> [core/select.c:412]: run_select(): Calling SELECT 0x7f49b84e3c18
Aug 10 11:43:05 kamailio kamailio[15780]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 10 rank -1: ctl [timer]
Aug 10 11:43:05 kamailio kamailio[15780]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 10 rank -1: tm [timer]
Aug 10 11:43:05 kamailio kamailio[15780]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '7c66da7c444e830e-15780@192.168.56.10'
Aug 10 11:43:05 kamailio kamailio[15780]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 10 rank -1: corex [timer]
Aug 10 11:43:05 kamailio kamailio[15780]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 10 rank -1: sl [timer]
Aug 10 11:43:05 kamailio kamailio[15780]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 10 rank -1: app_python [timer]
Aug 10 11:43:05 kamailio kamailio[15780]: DEBUG: app_python [apy_kemi.c:213]: sr_apy_kemi_exec_func(): execution of method: .info
Aug 10 11:43:05 kamailio kamailio[15780]: DEBUG: app_python [apy_kemi.c:240]: sr_apy_kemi_exec_func(): param[1] for: info is str: ===== kamailio.child_init(-1), PID: 15780
Aug 10 11:43:05 kamailio kamailio[15780]: INFO: <core> [core/kemi.c:91]: sr_kemi_core_info(): ===== kamailio.child_init(-1), PID: 15780
Aug 10 11:43:05 kamailio kamailio[15780]: DEBUG: app_python [apy_kemi.c:742]: sr_apy_kemi_f_pv_get_mode(): pv get: $sel(cfg_get.server.ip)
Aug 10 11:43:05 kamailio kamailio[15780]: DEBUG: <core> [core/pvapi.c:395]: pv_cache_lookup(): pvar [$sel(cfg_get.server.ip)] found in cache
Aug 10 11:43:05 kamailio kamailio[15780]: DEBUG: <core> [core/select.c:412]: run_select(): Calling SELECT 0x7f49b84e3c18
Aug 10 11:43:05 kamailio kamailio[15781]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 11 rank -1: ctl [secondary timer]
Aug 10 11:43:05 kamailio kamailio[15781]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 11 rank -1: tm [secondary timer]
Aug 10 11:43:05 kamailio kamailio[15781]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '7c66da7c444e830e-15781@192.168.56.10'
Aug 10 11:43:05 kamailio kamailio[15781]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 11 rank -1: corex [secondary timer]
Aug 10 11:43:05 kamailio kamailio[15781]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 11 rank -1: sl [secondary timer]
Aug 10 11:43:05 kamailio kamailio[15781]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 11 rank -1: app_python [secondary timer]
Aug 10 11:43:05 kamailio kamailio[15781]: DEBUG: app_python [apy_kemi.c:213]: sr_apy_kemi_exec_func(): execution of method: .info
Aug 10 11:43:05 kamailio kamailio[15781]: DEBUG: app_python [apy_kemi.c:240]: sr_apy_kemi_exec_func(): param[1] for: info is str: ===== kamailio.child_init(-1), PID: 15781
Aug 10 11:43:05 kamailio kamailio[15781]: INFO: <core> [core/kemi.c:91]: sr_kemi_core_info(): ===== kamailio.child_init(-1), PID: 15781
Aug 10 11:43:05 kamailio kamailio[15781]: DEBUG: app_python [apy_kemi.c:742]: sr_apy_kemi_f_pv_get_mode(): pv get: $sel(cfg_get.server.ip)
Aug 10 11:43:05 kamailio kamailio[15781]: DEBUG: <core> [core/pvapi.c:395]: pv_cache_lookup(): pvar [$sel(cfg_get.server.ip)] found in cache
Aug 10 11:43:05 kamailio kamailio[15781]: DEBUG: <core> [core/select.c:412]: run_select(): Calling SELECT 0x7f49b84e3c18
Aug 10 11:43:05 kamailio kamailio: ERROR: <core> [core/daemonize.c:303]: daemonize(): Main process exited before writing to pipe
Aug 10 11:43:05 kamailio kamailio[15782]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 12 rank -2: ctl [ctl handler]
Aug 10 11:43:05 kamailio kamailio[15782]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 12 rank -2: tm [ctl handler]
Aug 10 11:43:05 kamailio kamailio[15782]: DEBUG: tm [callid.c:136]: child_init_callid(): callid: '7c66da7c444e830e-15782@192.168.56.10'
Aug 10 11:43:05 kamailio kamailio[15782]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 12 rank -2: corex [ctl handler]
Aug 10 11:43:05 kamailio kamailio[15782]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 12 rank -2: sl [ctl handler]
Aug 10 11:43:05 kamailio kamailio[15782]: DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 12 rank -2: app_python [ctl handler]
Aug 10 11:43:05 kamailio kamailio[15782]: DEBUG: app_python [apy_kemi.c:213]: sr_apy_kemi_exec_func(): execution of method: .info
Aug 10 11:43:05 kamailio kamailio[15782]: DEBUG: app_python [apy_kemi.c:240]: sr_apy_kemi_exec_func(): param[1] for: info is str: ===== kamailio.child_init(-2), PID: 15782
Aug 10 11:43:05 kamailio kamailio[15782]: INFO: <core> [core/kemi.c:91]: sr_kemi_core_info(): ===== kamailio.child_init(-2), PID: 15782
Aug 10 11:43:05 kamailio kamailio[15782]: DEBUG: app_python [apy_kemi.c:742]: sr_apy_kemi_f_pv_get_mode(): pv get: $sel(cfg_get.server.ip)
Aug 10 11:43:05 kamailio kamailio[15782]: DEBUG: <core> [core/pvapi.c:395]: pv_cache_lookup(): pvar [$sel(cfg_get.server.ip)] found in cache
Aug 10 11:43:05 kamailio kamailio[15782]: DEBUG: <core> [core/select.c:412]: run_select(): Calling SELECT 0x7f49b84e3c18

Additional Information

version: kamailio 5.1.4 (x86_64/linux) 
flags: STATS: Off, USE_TCP, USE_TLS, USE_SCTP, TLS_HOOKS, DISABLE_NAGLE, USE_MCAST, DNS_IP_HACK, SHM_MEM, SHM_MMAP, PKG_MALLOC, Q_MALLOC, F_MALLOC, TLSF_MALLOC, DBG_SR_MEMORY, USE_FUTEX, FAST_LOCK-ADAPTIVE_WAIT, USE_DNS_CACHE, USE_DNS_FAILOVER, USE_NAPTR, USE_DST_BLACKLIST, HAVE_RESOLV_RES
ADAPTIVE_WAIT_LOOPS=1024, MAX_RECV_BUFFER_SIZE 262144, MAX_LISTEN 16, MAX_URI_SIZE 1024, BUF_SIZE 65535, DEFAULT PKG_SIZE 8MB
poll method support: poll, epoll_lt, epoll_et, sigio_rt, select.
id: unknown 
compiled with gcc 6.3.0
Linux kamailio 4.9.0-6-amd64 #1 SMP Debian 4.9.88-1+deb9u1 (2018-05-07) x86_64 GNU/Linux


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