Ok Daniel, thank you very much! -- Aleksandar Sosic linkedin.com/in/alexsosic/ mail: alex.sosic@evosip.cloud
On Wed, Jun 6, 2018 at 8:23 AM Daniel-Constantin Mierla <mico...@gmail.com> wrote: > > Hello, > > it was a mistake in matching KDMQ, I just pushed a fix for it in master > branch. > > Cheers, > Daniel > > > On 05.06.18 19:29, Aleksandar Sosic wrote: > > Hi Daniel, > > > > here you go: > > > > 0(578) DEBUG: <core> [core/parser/msg_parser.c:152]: get_hdr_field(): > > cseq <CSeq>: <10> <KDMQ> > > 0(578) DEBUG: <core> [core/parser/msg_parser.c:183]: get_hdr_field(): > > content_length=73 > > 22(600) DEBUG: db_mysql [km_my_con.c:136]: db_mysql_new_connection(): > > connection type is router-msgdb-service via TCP/IP > > 22(600) DEBUG: db_mysql [km_my_con.c:137]: db_mysql_new_connection(): > > protocol version is 10 > > 22(600) DEBUG: db_mysql [km_my_con.c:138]: db_mysql_new_connection(): > > server version is 5.7.18 > > 0(578) DEBUG: <core> [core/parser/msg_parser.c:89]: get_hdr_field(): > > found end of header > > 24(602) DEBUG: <core> [db_res.c:119]: db_new_result(): allocate 56 > > bytes for result set at 0x7f02cf32a830 > > 24(602) DEBUG: db_mysql [km_res.c:66]: db_mysql_get_columns(): 1 > > columns returned from the query > > 24(602) DEBUG: <core> [db_res.c:156]: db_allocate_columns(): allocate > > 8 bytes for result names at 0x7f02cf32a948 > > 24(602) DEBUG: <core> [db_res.c:167]: db_allocate_columns(): allocate > > 4 bytes for result types at 0x7f02cf32a9b8 > > 24(602) DEBUG: db_mysql [km_res.c:83]: db_mysql_get_columns(): > > allocate 16 bytes for RES_NAMES[0] at 0x7f02cf32aa28 > > 24(602) DEBUG: db_mysql [km_res.c:90]: db_mysql_get_columns(): > > RES_NAMES(0x7f02cf32aa28)[0]=[table_version] > > 24(602) DEBUG: db_mysql [km_res.c:99]: db_mysql_get_columns(): use > > DB1_INT result type > > 24(602) DEBUG: <core> [db_res.c:188]: db_allocate_rows(): allocate 16 > > bytes for rows at 0x7f02cf341cf0 > > 24(602) DEBUG: <core> [db_row.c:117]: db_allocate_row(): allocate 32 > > bytes for row values at 0x7f02cf341d68 > > 24(602) DEBUG: <core> [db_val.c:74]: db_str2val(): converting INT [6] > > 24(602) DEBUG: <core> [db_res.c:79]: db_free_columns(): freeing 1 columns > > 24(602) DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing > > RES_NAMES[0] at 0x7f02cf32aa28 > > 24(602) DEBUG: <core> [db_res.c:96]: db_free_columns(): freeing result > > names at 0x7f02cf32a948 > > 24(602) DEBUG: <core> [db_res.c:101]: db_free_columns(): freeing > > result types at 0x7f02cf32a9b8 > > 24(602) DEBUG: <core> [db_res.c:52]: db_free_rows(): freeing 1 rows > > 24(602) DEBUG: <core> [db_row.c:95]: db_free_row(): freeing row values > > at 0x7f02cf341d68 > > 24(602) DEBUG: <core> [db_res.c:60]: db_free_rows(): freeing rows at > > 0x7f02cf341cf0 > > 24(602) DEBUG: <core> [db_res.c:138]: db_free_result(): freeing result > > set at 0x7f02cf32a830 > > 24(602) DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 24 > > rank 24: app_python [udp receiver child=7 sock=127.0.0.1:5060] > > 0(578) DEBUG: <core> [core/parser/parse_addr_spec.c:185]: > > parse_to_param(): add param: tag=cc74da418311da4b8fe0787ffe42ae95-7b67 > > 0(578) DEBUG: <core> [core/parser/parse_addr_spec.c:864]: > > parse_addr_spec(): end of header reached, state=29 > > 0(578) DEBUG: topos [tps_msg.c:934]: tps_request_sent(): handling > > outgoing request (0, 1) > > 0(578) DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted > > headers - x_via1: [SIP/2.0/UDP > > 172.22.5.98;branch=z9hG4bKb5bc.cc5f1947000000000000000000000000.0](77) > > - x_via2: [](0) - x_vbranch1: > > [z9hG4bKb5bc.cc5f1947000000000000000000000000.0](46) > > 0(578) DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted > > headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) > > 0(578) DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted > > headers - as_contact: [](0) - bs_contact: [](0) > > 0(578) DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps > > lock get: 61 > > 0(578) DEBUG: <core> [sruid.c:182]: sruid_next(): new sruid is > > [tpsh-5b16c7df-242-1] (1 / 19) > > 0(578) WARNING: topos [tps_storage.c:400]: tps_storage_record(): no > > local address - do record routing for all initial requests BUSDELCUL > > 0(578) ERROR: topos [tps_storage.c:480]: tps_db_insert_dialog(): No > > database handle - misconfiguration? > > 24(602) DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 24 > > rank 24: topos [udp receiver child=7 sock=127.0.0.1:5060] > > 0(578) ERROR: topos [tps_storage.c:412]: tps_storage_record(): failed to > > store > > 0(578) DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): > > tps lock release: 61 > > 24(602) DEBUG: <core> [sruid.c:105]: sruid_init(): root for sruid is > > [tpsh-5b16c7df-25a-] (0 / 18) > > 24(602) DEBUG: <core> [db.c:314]: db_do_init2(): connection > > 0x7f02cf341df0 not found in pool > > 24(602) DEBUG: db_mysql [km_my_con.c:97]: db_mysql_new_connection(): > > opening connection: mysql://xxxx:xxxx@router-msgdb-service/kamailio > > 0(578) DEBUG: tm [uac.c:645]: send_prepared_request_impl(): uac: > > 0x7f02a99815a8 branch: 0 to 172.22.5.101:5060 > > 0(578) DEBUG: tm [../../core/onsend.h:69]: run_onsend(): required > > parameters are not available - ignoring > > 27(605) DEBUG: db_mysql [km_my_con.c:136]: db_mysql_new_connection(): > > connection type is router-msgdb-service via TCP/IP > > 0(578) DEBUG: dmq [dmq_funcs.c:165]: bcast_dmq_message(): skipping > > node sip:172.22.5.98:5060 > > 0(578) DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 0 > > rank 0: htable [main] > > 27(605) DEBUG: db_mysql [km_my_con.c:137]: db_mysql_new_connection(): > > protocol version is 10 > > 27(605) DEBUG: db_mysql [km_my_con.c:138]: db_mysql_new_connection(): > > server version is 5.7.18 > > 13(591) DEBUG: <core> [core/udp_server.c:491]: udp_rcv_loop(): > > received on udp socket: (112/100/539) [[SIP/2.0 200 OK 0D 0A Via: > > SIP/2.0/UDP > > 172.22.5.98;branch=z9hG4bKb5bc.cc5f1947000000000000000000000000.0 > > 0D 0A ]] > > 13(591) DEBUG: <core> [core/parser/msg_parser.c:614]: parse_msg(): SIP > > Reply (status): > > 13(591) DEBUG: <core> [core/parser/msg_parser.c:616]: parse_msg(): > > version: <SIP/2.0> > > 13(591) DEBUG: <core> [core/parser/msg_parser.c:618]: parse_msg(): > > status: <200> > > 13(591) DEBUG: <core> [core/parser/msg_parser.c:620]: parse_msg(): > > reason: <OK> > > 13(591) DEBUG: <core> [core/parser/parse_via.c:1303]: > > parse_via_param(): Found param type 232, <branch> = > > <z9hG4bKb5bc.cc5f1947000000000000000000000000.0>; state=16 > > 13(591) DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end > > of header reached, state=5 > > 13(591) DEBUG: <core> [core/parser/msg_parser.c:492]: parse_headers(): > > Via found, flags=2 > > 13(591) DEBUG: <core> [core/parser/msg_parser.c:494]: parse_headers(): > > this is the first via > > 13(591) DEBUG: <core> [core/parser/parse_addr_spec.c:185]: > > parse_to_param(): add param: tag=bd99401293f1d6eb474c42c4e35ace99.888f > > 13(591) DEBUG: <core> [core/parser/parse_addr_spec.c:864]: > > parse_addr_spec(): end of header reached, state=29 > > 13(591) DEBUG: <core> [core/parser/msg_parser.c:171]: get_hdr_field(): > > <To> [85]; uri=[sip:notification_peer@172.22.5.101:5060] > > 13(591) DEBUG: <core> [core/parser/msg_parser.c:172]: get_hdr_field(): > > to body [<sip:notification_peer@172.22.5.101:5060>], to tag > > [bd99401293f1d6eb474c42c4e35ace99.888f] > > 13(591) DEBUG: <core> [core/parser/msg_parser.c:152]: get_hdr_field(): > > cseq <CSeq>: <10> <KDMQ> > > 13(591) DEBUG: <core> [core/parser/msg_parser.c:183]: get_hdr_field(): > > content_length=107 > > 13(591) DEBUG: <core> [core/parser/msg_parser.c:89]: get_hdr_field(): > > found end of header > > 13(591) DEBUG: <core> [core/parser/parse_addr_spec.c:185]: > > parse_to_param(): add param: tag=cc74da418311da4b8fe0787ffe42ae95-7b67 > > 13(591) DEBUG: <core> [core/parser/parse_addr_spec.c:864]: > > parse_addr_spec(): end of header reached, state=29 > > 13(591) DEBUG: topos [tps_msg.c:868]: tps_response_received(): > > handling incoming response > > 13(591) DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted > > headers - x_via1: [SIP/2.0/UDP > > 172.22.5.98;branch=z9hG4bKb5bc.cc5f1947000000000000000000000000.0](77) > > - x_via2: [](0) - x_vbranch1: > > [z9hG4bKb5bc.cc5f1947000000000000000000000000.0](46) > > 13(591) DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted > > headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) > > 13(591) DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted > > headers - as_contact: [](0) - bs_contact: [](0) > > 13(591) DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps > > lock get: 61 > > 0(578) DEBUG: htable [htable.c:236]: child_init(): rank is (0) > > 0(578) DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 0 > > rank 0: permissions [main] > > 0(578) DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 0 > > rank 0: app_python [main] > > 24(602) DEBUG: db_mysql [km_my_con.c:136]: db_mysql_new_connection(): > > connection type is router-msgdb-service via TCP/IP > > 24(602) DEBUG: db_mysql [km_my_con.c:137]: db_mysql_new_connection(): > > protocol version is 10 > > 24(602) DEBUG: db_mysql [km_my_con.c:138]: db_mysql_new_connection(): > > server version is 5.7.18 > > 0(578) DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 0 > > rank 0: topos [main] > > 0(578) DEBUG: <core> [sruid.c:105]: sruid_init(): root for sruid is > > [tpsh-5b16c7df-242-] (0 / 18) > > 33(611) DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 33 > > rank 25: tm [tcp receiver (generic) child=0] > > 33(611) DEBUG: tm [callid.c:136]: child_init_callid(): callid: > > '374eb255510cbc96-611@31.193.99.6' > > 33(611) DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 33 > > rank 25: tmx [tcp receiver (generic) child=0] > > 33(611) DEBUG: tmx [tmx_mod.c:263]: child_init(): rank is (25) > > 33(611) DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 33 > > rank 25: sl [tcp receiver (generic) child=0] > > 33(611) DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 33 > > rank 25: dispatcher [tcp receiver (generic) child=0] > > 33(611) DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 33 > > rank 25: ctl [tcp receiver (generic) child=0] > > 33(611) DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 33 > > rank 25: jsonrpcs [tcp receiver (generic) child=0] > > 33(611) DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 33 > > rank 25: dmq [tcp receiver (generic) child=0] > > 33(611) DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 33 > > rank 25: htable [tcp receiver (generic) child=0] > > 33(611) DEBUG: htable [htable.c:236]: child_init(): rank is (25) > > 33(611) DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 33 > > rank 25: permissions [tcp receiver (generic) child=0] > > 33(611) DEBUG: <core> [db.c:314]: db_do_init2(): connection > > 0x7f02cf341a00 not found in pool > > 33(611) DEBUG: db_mysql [km_my_con.c:97]: db_mysql_new_connection(): > > opening connection: mysql://xxxx:xxxx@api-db-service/evox_crm > > 13(591) DEBUG: <core> [db_res.c:119]: db_new_result(): allocate 56 > > bytes for result set at 0x7f02cf343318 > > 13(591) DEBUG: db_mysql [km_res.c:66]: db_mysql_get_columns(): 20 > > columns returned from the query > > 13(591) DEBUG: <core> [db_res.c:156]: db_allocate_columns(): allocate > > 160 bytes for result names at 0x7f02cf343430 > > 13(591) DEBUG: <core> [db_res.c:167]: db_allocate_columns(): allocate > > 80 bytes for result types at 0x7f02cf343538 > > 13(591) DEBUG: db_mysql [km_res.c:83]: db_mysql_get_columns(): > > allocate 16 bytes for RES_NAMES[0] at 0x7f02cf3435f0 > > 13(591) DEBUG: db_mysql [km_res.c:90]: db_mysql_get_columns(): > > RES_NAMES(0x7f02cf3435f0)[0]=[rectime] > > 13(591) DEBUG: db_mysql [km_res.c:115]: db_mysql_get_columns(): use > > DB1_DATETIME result type > > 13(591) DEBUG: db_mysql [km_res.c:83]: db_mysql_get_columns(): > > allocate 16 bytes for RES_NAMES[1] at 0x7f02cf343668 > > 13(591) DEBUG: db_mysql [km_res.c:90]: db_mysql_get_columns(): > > RES_NAMES(0x7f02cf343668)[1]=[a_callid] > > 13(591) DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use > > DB1_STRING result type > > 13(591) DEBUG: db_mysql [km_res.c:83]: db_mysql_get_columns(): > > allocate 16 bytes for RES_NAMES[2] at 0x7f02cf3436e0 > > 13(591) DEBUG: db_mysql [km_res.c:90]: db_mysql_get_columns(): > > RES_NAMES(0x7f02cf3436e0)[2]=[a_uuid] > > 13(591) DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use > > DB1_STRING result type > > 13(591) DEBUG: db_mysql [km_res.c:83]: db_mysql_get_columns(): > > allocate 16 bytes for RES_NAMES[3] at 0x7f02cf343758 > > 13(591) DEBUG: db_mysql [km_res.c:90]: db_mysql_get_columns(): > > RES_NAMES(0x7f02cf343758)[3]=[b_uuid] > > 13(591) DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use > > DB1_STRING result type > > 13(591) DEBUG: db_mysql [km_res.c:83]: db_mysql_get_columns(): > > allocate 16 bytes for RES_NAMES[4] at 0x7f02cf3437d0 > > 13(591) DEBUG: db_mysql [km_res.c:90]: db_mysql_get_columns(): > > RES_NAMES(0x7f02cf3437d0)[4]=[direction] > > 13(591) DEBUG: db_mysql [km_res.c:99]: db_mysql_get_columns(): use > > DB1_INT result type > > 13(591) DEBUG: db_mysql [km_res.c:83]: db_mysql_get_columns(): > > allocate 16 bytes for RES_NAMES[5] at 0x7f02cf343848 > > 13(591) DEBUG: db_mysql [km_res.c:90]: db_mysql_get_columns(): > > RES_NAMES(0x7f02cf343848)[5]=[x_via] > > 13(591) DEBUG: db_mysql [km_res.c:120]: db_mysql_get_columns(): use > > DB1_BLOB result type > > 13(591) DEBUG: db_mysql [km_res.c:83]: db_mysql_get_columns(): > > allocate 16 bytes for RES_NAMES[6] at 0x7f02cf3438c0 > > 13(591) DEBUG: db_mysql [km_res.c:90]: db_mysql_get_columns(): > > RES_NAMES(0x7f02cf3438c0)[6]=[x_vbranch] > > 13(591) DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use > > DB1_STRING result type > > 13(591) DEBUG: db_mysql [km_res.c:83]: db_mysql_get_columns(): > > allocate 16 bytes for RES_NAMES[7] at 0x7f02cf343938 > > 13(591) DEBUG: db_mysql [km_res.c:90]: db_mysql_get_columns(): > > RES_NAMES(0x7f02cf343938)[7]=[x_rr] > > 13(591) DEBUG: db_mysql [km_res.c:120]: db_mysql_get_columns(): use > > DB1_BLOB result type > > 13(591) DEBUG: db_mysql [km_res.c:83]: db_mysql_get_columns(): > > allocate 16 bytes for RES_NAMES[8] at 0x7f02cf3439b0 > > 13(591) DEBUG: db_mysql [km_res.c:90]: db_mysql_get_columns(): > > RES_NAMES(0x7f02cf3439b0)[8]=[y_rr] > > 13(591) DEBUG: db_mysql [km_res.c:120]: db_mysql_get_columns(): use > > DB1_BLOB result type > > 13(591) DEBUG: db_mysql [km_res.c:83]: db_mysql_get_columns(): > > allocate 16 bytes for RES_NAMES[9] at 0x7f02cf343a28 > > 13(591) DEBUG: db_mysql [km_res.c:90]: db_mysql_get_columns(): > > RES_NAMES(0x7f02cf343a28)[9]=[s_rr] > > 13(591) DEBUG: db_mysql [km_res.c:120]: db_mysql_get_columns(): use > > DB1_BLOB result type > > 13(591) DEBUG: db_mysql [km_res.c:83]: db_mysql_get_columns(): > > allocate 16 bytes for RES_NAMES[10] at 0x7f02cf343aa0 > > 13(591) DEBUG: db_mysql [km_res.c:90]: db_mysql_get_columns(): > > RES_NAMES(0x7f02cf343aa0)[10]=[x_uri] > > 13(591) DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use > > DB1_STRING result type > > 13(591) DEBUG: db_mysql [km_res.c:83]: db_mysql_get_columns(): > > allocate 16 bytes for RES_NAMES[11] at 0x7f02cf343b18 > > 13(591) DEBUG: db_mysql [km_res.c:90]: db_mysql_get_columns(): > > RES_NAMES(0x7f02cf343b18)[11]=[x_tag] > > 13(591) DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use > > DB1_STRING result type > > 13(591) DEBUG: db_mysql [km_res.c:83]: db_mysql_get_columns(): > > allocate 16 bytes for RES_NAMES[12] at 0x7f02cf343b90 > > 13(591) DEBUG: db_mysql [km_res.c:90]: db_mysql_get_columns(): > > RES_NAMES(0x7f02cf343b90)[12]=[s_method] > > 13(591) DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use > > DB1_STRING result type > > 13(591) DEBUG: db_mysql [km_res.c:83]: db_mysql_get_columns(): > > allocate 16 bytes for RES_NAMES[13] at 0x7f02cf343c08 > > 13(591) DEBUG: db_mysql [km_res.c:90]: db_mysql_get_columns(): > > RES_NAMES(0x7f02cf343c08)[13]=[s_cseq] > > 13(591) DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use > > DB1_STRING result type > > 13(591) DEBUG: db_mysql [km_res.c:83]: db_mysql_get_columns(): > > allocate 16 bytes for RES_NAMES[14] at 0x7f02cf343c80 > > 13(591) DEBUG: db_mysql [km_res.c:90]: db_mysql_get_columns(): > > RES_NAMES(0x7f02cf343c80)[14]=[a_contact] > > 13(591) DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use > > DB1_STRING result type > > 13(591) DEBUG: db_mysql [km_res.c:83]: db_mysql_get_columns(): > > allocate 16 bytes for RES_NAMES[15] at 0x7f02cf343cf8 > > 13(591) DEBUG: db_mysql [km_res.c:90]: db_mysql_get_columns(): > > RES_NAMES(0x7f02cf343cf8)[15]=[b_contact] > > 13(591) DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use > > DB1_STRING result type > > 13(591) DEBUG: db_mysql [km_res.c:83]: db_mysql_get_columns(): > > allocate 16 bytes for RES_NAMES[16] at 0x7f02cf343d70 > > 13(591) DEBUG: db_mysql [km_res.c:90]: db_mysql_get_columns(): > > RES_NAMES(0x7f02cf343d70)[16]=[as_contact] > > 13(591) DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use > > DB1_STRING result type > > 13(591) DEBUG: db_mysql [km_res.c:83]: db_mysql_get_columns(): > > allocate 16 bytes for RES_NAMES[17] at 0x7f02cf343de8 > > 13(591) DEBUG: db_mysql [km_res.c:90]: db_mysql_get_columns(): > > RES_NAMES(0x7f02cf343de8)[17]=[bs_contact] > > 13(591) DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use > > DB1_STRING result type > > 13(591) DEBUG: db_mysql [km_res.c:83]: db_mysql_get_columns(): > > allocate 16 bytes for RES_NAMES[18] at 0x7f02cf343e60 > > 13(591) DEBUG: db_mysql [km_res.c:90]: db_mysql_get_columns(): > > RES_NAMES(0x7f02cf343e60)[18]=[a_tag] > > 13(591) DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use > > DB1_STRING result type > > 13(591) DEBUG: db_mysql [km_res.c:83]: db_mysql_get_columns(): > > allocate 16 bytes for RES_NAMES[19] at 0x7f02cf343ed8 > > 13(591) DEBUG: db_mysql [km_res.c:90]: db_mysql_get_columns(): > > RES_NAMES(0x7f02cf343ed8)[19]=[b_tag] > > 13(591) DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use > > DB1_STRING result type > > 13(591) DEBUG: db_mysql [km_res.c:168]: db_mysql_convert_rows(): no > > rows returned from the query > > 13(591) DEBUG: topos [tps_storage.c:967]: tps_db_load_branch(): no > > stored record for <z9hG4bKb5bc.cc5f1947000000000000000000000000.0> > > 13(591) DEBUG: <core> [db_res.c:79]: db_free_columns(): freeing 20 columns > > 13(591) DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing > > RES_NAMES[0] at 0x7f02cf3435f0 > > 13(591) DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing > > RES_NAMES[1] at 0x7f02cf343668 > > 13(591) DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing > > RES_NAMES[2] at 0x7f02cf3436e0 > > 13(591) DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing > > RES_NAMES[3] at 0x7f02cf343758 > > 13(591) DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing > > RES_NAMES[4] at 0x7f02cf3437d0 > > 13(591) DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing > > RES_NAMES[5] at 0x7f02cf343848 > > 13(591) DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing > > RES_NAMES[6] at 0x7f02cf3438c0 > > 13(591) DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing > > RES_NAMES[7] at 0x7f02cf343938 > > 13(591) DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing > > RES_NAMES[8] at 0x7f02cf3439b0 > > 13(591) DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing > > RES_NAMES[9] at 0x7f02cf343a28 > > 13(591) DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing > > RES_NAMES[10] at 0x7f02cf343aa0 > > 13(591) DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing > > RES_NAMES[11] at 0x7f02cf343b18 > > 13(591) DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing > > RES_NAMES[12] at 0x7f02cf343b90 > > 13(591) DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing > > RES_NAMES[13] at 0x7f02cf343c08 > > 13(591) DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing > > RES_NAMES[14] at 0x7f02cf343c80 > > 13(591) DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing > > RES_NAMES[15] at 0x7f02cf343cf8 > > 13(591) DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing > > RES_NAMES[16] at 0x7f02cf343d70 > > 13(591) DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing > > RES_NAMES[17] at 0x7f02cf343de8 > > 13(591) DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing > > RES_NAMES[18] at 0x7f02cf343e60 > > 13(591) DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing > > RES_NAMES[19] at 0x7f02cf343ed8 > > 13(591) DEBUG: <core> [db_res.c:96]: db_free_columns(): freeing result > > names at 0x7f02cf343430 > > 13(591) DEBUG: <core> [db_res.c:101]: db_free_columns(): freeing > > result types at 0x7f02cf343538 > > 13(591) DEBUG: <core> [db_res.c:138]: db_free_result(): freeing result > > set at 0x7f02cf343318 > > 13(591) DEBUG: topos [tps_msg.c:889]: tps_response_received(): loaded > > dialog a_uuid [] > > 13(591) DEBUG: topos [tps_storage.c:1043]: tps_db_load_dialog(): no > > dlg uuid provided > > 13(591) DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): > > tps lock release: 61 > > > > Let me know if you need a wider log range. > > > > Thanks, > > -- > > Aleksandar Sosic > > linkedin.com/in/alexsosic/ > > mail: alex.sosic@evosip.cloud > > On Tue, Jun 5, 2018 at 3:24 PM Daniel-Constantin Mierla > > <mico...@gmail.com> wrote: > >> Hello, > >> > >> can you give all the log messages with debug=3 in kamailio.cfg? > >> > >> Cheers, > >> Daniel > >> > >> > >> On 01.06.18 20:44, Aleksandar Sosic wrote: > >>> Hi Daniel, > >>> > >>> We've tried today to build from sources and test the patch you've > >>> linked but unfortunately the errors > >>> ``` > >>> 0(94) ERROR: topos [tps_storage.c:480]: tps_db_insert_dialog(): No > >>> database handle - misconfiguration? > >>> 0(94) ERROR: topos [tps_storage.c:412]: tps_storage_record(): failed to > >>> store > >>> ``` > >>> > >>> are still present in the logs. > >>> > >>> Kind regards, > >>> -- > >>> Aleksandar Sosic > >>> linkedin.com/in/alexsosic/ > >>> mail: alex.sosic@evosip.cloud > >>> On Wed, May 30, 2018 at 6:10 PM Daniel-Constantin Mierla > >>> <mico...@gmail.com> wrote: > >>>> I just pushed a patch to skip handling dmq requests, as done for local > >>>> options (keepalive) and notify -- KDMQ is something internal to kamailio > >>>> and was not considered when filtering out. > >>>> > >>>> - > >>>> https://github.com/kamailio/kamailio/commit/7ff8d4284f20763e8e47f9b24e4604867a242e4a > >>>> > >>>> Maybe you can give it a test just to be safe. I will backport it. > >>>> > >>>> Cheers, > >>>> Daniel > >>>> > >>>> > >>>> On 30.05.18 11:39, Enrico Bandiera wrote: > >>>> > >>>> Hi Daniel, since it was just before the KWC I waited some time before > >>>> pinging you :) > >>>> Any news on this issue? > >>>> > >>>> Thanks, > >>>> Enrico. > >>>> > >>>> 2018-05-03 15:42 GMT+02:00 Enrico Bandiera > >>>> <enrico.bandi...@cloud.timenet.it>: > >>>>> Hi Daniel, tell me if you need more portions of the log: > >>>>> > >>>>> 0(111) DEBUG: <core> [core/socket_info.c:559]: grep_sock_info(): > >>>>> checking if host==us: 10==11 && [172.22.3.7] == [31.193.99.4] > >>>>> 0(111) DEBUG: <core> [core/socket_info.c:566]: grep_sock_info(): > >>>>> checking if port 5060 (advertise 0) matches port 5060 > >>>>> 0(111) DEBUG: <core> [core/socket_info.c:559]: grep_sock_info(): > >>>>> checking if host==us: 10==10 && [172.22.3.7] == [172.22.3.7] > >>>>> 0(111) DEBUG: <core> [core/socket_info.c:566]: grep_sock_info(): > >>>>> checking if port 5060 (advertise 0) matches port 5060 > >>>>> 0(111) DEBUG: tm [uac.c:426]: t_uac_prepare(): > >>>>> next_hop=<sip:notification_peer@127.0.0.1:5060> > >>>>> 0(111) DEBUG: tm [uac.c:152]: dlg2hash(): hashid 25495 > >>>>> 0(111) DEBUG: topos [topos_mod.c:468]: tps_execute_event_route(): > >>>>> executing event_route[topos:...] (3) > >>>>> 0(111) ERROR: <script>: HIDING TOPOLOGY: 1:5060:127.0.0.1 > >>>>> 0(111) DEBUG: <core> [core/parser/msg_parser.c:604]: parse_msg(): SIP > >>>>> Request: > >>>>> 0(111) DEBUG: <core> [core/parser/msg_parser.c:606]: parse_msg(): > >>>>> method: <KDMQ> > >>>>> 0(111) DEBUG: <core> [core/parser/msg_parser.c:608]: parse_msg(): > >>>>> uri: <sip:notification_peer@127.0.0.1:5060> > >>>>> 0(111) DEBUG: <core> [core/parser/msg_parser.c:610]: parse_msg(): > >>>>> version: <SIP/2.0> > >>>>> 0(111) DEBUG: <core> [core/parser/parse_via.c:1303]: > >>>>> parse_via_param(): Found param type 232, <branch> = > >>>>> <z9hG4bK7936.bcc62347000000000000000000000000.0>; state=16 > >>>>> 0(111) DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end > >>>>> of header reached, state=5 > >>>>> 0(111) DEBUG: <core> [core/parser/msg_parser.c:492]: parse_headers(): > >>>>> Via found, flags=2 > >>>>> 0(111) DEBUG: <core> [core/parser/msg_parser.c:494]: parse_headers(): > >>>>> this is the first via > >>>>> 0(111) DEBUG: <core> [core/parser/parse_addr_spec.c:864]: > >>>>> parse_addr_spec(): end of header reached, state=10 > >>>>> 0(111) DEBUG: <core> [core/parser/msg_parser.c:171]: get_hdr_field(): > >>>>> <To> [40]; uri=[sip:notification_peer@127.0.0.1:5060] > >>>>> 0(111) DEBUG: <core> [core/parser/msg_parser.c:172]: get_hdr_field(): > >>>>> to body [<sip:notification_peer@127.0.0.1:5060> > >>>>> 0(111) DEBUG: <core> [core/parser/msg_parser.c:152]: get_hdr_field(): > >>>>> cseq <CSeq>: <10> <KDMQ> > >>>>> 0(111) DEBUG: <core> [core/parser/msg_parser.c:183]: get_hdr_field(): > >>>>> content_length=69 > >>>>> 0(111) DEBUG: <core> [core/parser/msg_parser.c:89]: get_hdr_field(): > >>>>> found end of header > >>>>> 0(111) DEBUG: <core> [core/parser/parse_addr_spec.c:185]: > >>>>> parse_to_param(): add param: tag=2a154ea4a528648fbfaaac82505be461-4e03 > >>>>> 0(111) DEBUG: <core> [core/parser/parse_addr_spec.c:864]: > >>>>> parse_addr_spec(): end of header reached, state=29 > >>>>> 0(111) DEBUG: topos [tps_msg.c:934]: tps_request_sent(): handling > >>>>> outgoing request (0, 1) > >>>>> 0(111) DEBUG: topos [tps_msg.c:376]: tps_pack_message(): compacted > >>>>> headers - x_via1: [SIP/2.0/UDP > >>>>> 172.22.3.7;branch=z9hG4bK7936.bcc62347000000000000000000000000.0](76) - > >>>>> x_via2: [](0) - x_vbranch1: > >>>>> [z9hG4bK7936.bcc62347000000000000000000000000.0](46) > >>>>> 0(111) DEBUG: topos [tps_msg.c:485]: tps_pack_message(): compacted > >>>>> headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) > >>>>> 0(111) DEBUG: topos [tps_msg.c:490]: tps_pack_message(): compacted > >>>>> headers - as_contact: [](0) - bs_contact: [](0) > >>>>> 0(111) DEBUG: topos [tps_storage.c:124]: tps_storage_lock_get(): tps > >>>>> lock get: 120 > >>>>> 0(111) DEBUG: <core> [sruid.c:182]: sruid_next(): new sruid is > >>>>> [tpsh-5aeb10fb-6f-1] (1 / 18) > >>>>> 0(111) WARNING: topos [tps_storage.c:400]: tps_storage_record(): no > >>>>> local address - do record routing for all initial requests > >>>>> 0(111) ERROR: topos [tps_storage.c:480]: tps_db_insert_dialog(): No > >>>>> database handle - misconfiguration? > >>>>> 0(111) ERROR: topos [tps_storage.c:412]: tps_storage_record(): failed > >>>>> to store > >>>>> 0(111) DEBUG: topos [tps_storage.c:136]: tps_storage_lock_release(): > >>>>> tps lock release: 120 > >>>>> 0(111) DEBUG: tm [uac.c:645]: send_prepared_request_impl(): uac: > >>>>> 0x7f88fdc0b468 branch: 0 to 127.0.0.1:5060 > >>>>> 0(111) DEBUG: tm [../../core/onsend.h:69]: run_onsend(): required > >>>>> parameters are not available - ignoring > >>>>> 0(111) DEBUG: dmq [dmq_funcs.c:165]: bcast_dmq_message(): skipping > >>>>> node sip:172.22.3.7:5060 > >>>>> 0(111) DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 0 > >>>>> rank 0: htable [main] > >>>>> 0(111) DEBUG: htable [htable.c:232]: child_init(): rank is (0) > >>>>> 0(111) DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 0 > >>>>> rank 0: app_python [main] > >>>>> 0(111) DEBUG: <core> [core/sr_module.c:941]: init_mod_child(): idx 0 > >>>>> rank 0: topos [main] > >>>>> 0(111) DEBUG: <core> [sruid.c:105]: sruid_init(): root for sruid is > >>>>> [tpsh-5aeb10fb-6f-] (0 / 17) > >>>>> 0(111) DEBUG: <core> [main.c:1751]: main_loop(): Expect maximum 2266 > >>>>> open fds > >>>>> > >>>>> > >>>>> Thanks, > >>>>> Enrico. > >>>>> > >>>>> > >>>>> 2018-05-03 15:33 GMT+02:00 Daniel-Constantin Mierla <mico...@gmail.com>: > >>>>>> Can you run with higher debug level (e.g., add -ddd), then reproduce > >>>>>> and send here all DEBUG and the rest of log messages printed by the > >>>>>> same PID showing this error? > >>>>>> > >>>>>> The main attendant doesn't handle sip traffic in fork=yes, but -DD is > >>>>>> telling not to daemonize the main attendant, so I need to see what > >>>>>> that process does before throwing the error messages. > >>>>>> > >>>>>> Cheers, > >>>>>> Daniel > >>>>>> > >>>>>> > >>>>>> On 03.05.18 13:45, Enrico Bandiera wrote: > >>>>>> > >>>>>> kamailio -f $PATH_KAMAILIO_CFG -DD -E -e > >>>>>> > >>>>>> Thanks, > >>>>>> Enrico. > >>>>>> > >>>>>> 2018-05-03 12:52 GMT+02:00 Daniel-Constantin Mierla > >>>>>> <mico...@gmail.com>: > >>>>>>> Hello, > >>>>>>> > >>>>>>> how do you start kamailio, or better, said what are the command line > >>>>>>> parameters? > >>>>>>> > >>>>>>> Cheers, > >>>>>>> Daniel > >>>>>>> > >>>>>>> > >>>>>>> On 03.05.18 12:26, Enrico Bandiera wrote: > >>>>>>> > >>>>>>> Hi Daniel, is kamcmd ps ok for this? > >>>>>>> > >>>>>>> 0(116) ERROR: topos [tps_storage.c:480]: tps_db_insert_dialog(): No > >>>>>>> database handle - misconfiguration? > >>>>>>> 0(116) ERROR: topos [tps_storage.c:412]: tps_storage_record(): > >>>>>>> failed to store > >>>>>>> > >>>>>>> root@proxy-bbd996f48-mjzr4:/# kamcmd ps > >>>>>>> 116 main process - attendant > >>>>>>> > >>>>>>> Thanks, > >>>>>>> Enrico. > >>>>>>> > >>>>>>> > >>>>>>> 2018-05-03 11:48 GMT+02:00 Daniel-Constantin Mierla > >>>>>>> <mico...@gmail.com>: > >>>>>>>> Hello, > >>>>>>>> > >>>>>>>> can you get the output for > >>>>>>>> > >>>>>>>> kamctl ps > >>>>>>>> > >>>>>>>> and see the description for process with pid 94? > >>>>>>>> > >>>>>>>> I assume you run it in docker, given low pid value shown in the log > >>>>>>>> message... > >>>>>>>> > >>>>>>>> Cheers, > >>>>>>>> Daniel > >>>>>>>> > >>>>>>>> > >>>>>>>> On 03.05.18 10:42, Enrico Bandiera wrote: > >>>>>>>> > >>>>>>>> Hi, I'm trying to use the TOPOS module to solve some MTU issues we > >>>>>>>> have (we have multiple kamailio servers in our architecture and > >>>>>>>> route/via headers are becoming a problem) > >>>>>>>> > >>>>>>>> The module seems to work but I'm getting these errors on the log: > >>>>>>>> > >>>>>>>> 0(94) ERROR: topos [tps_storage.c:480]: tps_db_insert_dialog(): No > >>>>>>>> database handle - misconfiguration? > >>>>>>>> 0(94) ERROR: topos [tps_storage.c:412]: tps_storage_record(): > >>>>>>>> failed to store > >>>>>>>> > >>>>>>>> I get these errors for some time after running kamailio and then > >>>>>>>> they stop appearing. > >>>>>>>> > >>>>>>>> Data is inserted on topos_d and topos_t on the db, so I'm not sure > >>>>>>>> what the error is referring to. > >>>>>>>> > >>>>>>>> Any idea? > >>>>>>>> > >>>>>>>> Thanks, > >>>>>>>> Enrico. > >>>>>>>> > >>>>>>>> > >>>>>>>> _______________________________________________ > >>>>>>>> Kamailio (SER) - Users Mailing List > >>>>>>>> sr-users@lists.kamailio.org > >>>>>>>> https://lists.kamailio.org/cgi-bin/mailman/listinfo/sr-users > >>>>>>>> > >>>>>>>> > >>>>>>>> -- > >>>>>>>> Daniel-Constantin Mierla > >>>>>>>> www.twitter.com/miconda -- www.linkedin.com/in/miconda > >>>>>>>> Kamailio World Conference - May 14-16, 2018 - www.kamailioworld.com > >>>>>>> > >>>>>>> -- > >>>>>>> Daniel-Constantin Mierla > >>>>>>> www.twitter.com/miconda -- www.linkedin.com/in/miconda > >>>>>>> Kamailio World Conference - May 14-16, 2018 - www.kamailioworld.com > >>>>>> > >>>>>> -- > >>>>>> Daniel-Constantin Mierla > >>>>>> www.twitter.com/miconda -- www.linkedin.com/in/miconda > >>>>>> Kamailio World Conference - May 14-16, 2018 - www.kamailioworld.com > >>>> -- > >>>> Daniel-Constantin Mierla -- www.asipto.com > >>>> www.twitter.com/miconda -- www.linkedin.com/in/miconda > >>>> Kamailio World Conference -- www.kamailioworld.com > >>>> > >>>> _______________________________________________ > >>>> Kamailio (SER) - Users Mailing List > >>>> sr-users@lists.kamailio.org > >>>> https://lists.kamailio.org/cgi-bin/mailman/listinfo/sr-users > >> -- > >> Daniel-Constantin Mierla -- www.asipto.com > >> www.twitter.com/miconda -- www.linkedin.com/in/miconda > >> Kamailio World Conference -- www.kamailioworld.com > >> > > -- > Daniel-Constantin Mierla -- www.asipto.com > www.twitter.com/miconda -- www.linkedin.com/in/miconda > Kamailio World Conference -- www.kamailioworld.com > _______________________________________________ Kamailio (SER) - Users Mailing List sr-users@lists.kamailio.org https://lists.kamailio.org/cgi-bin/mailman/listinfo/sr-users