[SR-Users] TOPOS module errors

Aleksandar Sosic alex.sosic at evosip.cloud
Wed Jun 6 08:56:20 CEST 2018


Ok Daniel,

thank you very much!
--
Aleksandar Sosic
linkedin.com/in/alexsosic/
mail: alex.sosic at evosip.cloud

On Wed, Jun 6, 2018 at 8:23 AM Daniel-Constantin Mierla
<miconda at 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 at 172.22.5.101:5060]
> > 13(591) DEBUG: <core> [core/parser/msg_parser.c:172]: get_hdr_field():
> > to body [<sip:notification_peer at 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 at 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 at evosip.cloud
> > On Tue, Jun 5, 2018 at 3:24 PM Daniel-Constantin Mierla
> > <miconda at 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 at evosip.cloud
> >>> On Wed, May 30, 2018 at 6:10 PM Daniel-Constantin Mierla
> >>> <miconda at 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.bandiera at 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 at 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 at 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 at 127.0.0.1:5060]
> >>>>>  0(111) DEBUG: <core> [core/parser/msg_parser.c:172]: get_hdr_field(): to body [<sip:notification_peer at 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 <miconda at 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 <miconda at 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 at proxy-bbd996f48-mjzr4:/# kamcmd ps
> >>>>>>> 116 main process - attendant
> >>>>>>>
> >>>>>>> Thanks,
> >>>>>>> Enrico.
> >>>>>>>
> >>>>>>>
> >>>>>>> 2018-05-03 11:48 GMT+02:00 Daniel-Constantin Mierla <miconda at 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 at 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 at 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
>



More information about the sr-users mailing list