On 22/02/2017 14:35, hsdsdssdfsdf dsasd wrote:
I implemented call forwarding according to https://www.kamailio.org/wiki/tutorials/mini-howto-admin/call_forwarding, which is working fine. When I replace db_mysql with db_mongodb however, I receive an error on "if (avp_db_load("$ruri/username", "$avp(s:fwd_blind)")) {":
ERROR: db_mongodb [mongodb_dbase.c:381]: db_mongodb_get_columns(): field [attribute] not found in result iterator ERROR: db_mongodb [mongodb_dbase.c:739]: db_mongodb_store_result(): failed to set the columns ERROR: db_mongodb [mongodb_dbase.c:918]: db_mongodb_query(): failed to store result ERROR: db_mongodb [mongodb_dbase.c:927]: db_mongodb_query(): failed to do the query ERROR: avpops [avpops_impl.c:381]: ops_dbload_avps(): db_load failed
can you set debug=3 in kamailio.cfg, restart kamailio and test again? Then grab the log messages from syslog and send them here. It should provide more debug information.
Is there a record for this query? Or should be an empty response (no record returned)?
Cheers, Daniel
I used the following to store a forward: avp_db_store("$from/username","$avp(s:fwd_blind)");
Which in this case resulted in (after replacing the true forward info): > db.usr_preferences.find() { "_id" : ObjectId("58ac40f7e498420e0703a2e1"), "uuid" : "", "attribute" : "fwd_blind", "value" : "sip:0003@x.x.x;user=phone", "type" : 0, "username" : "0002", "domain" : null }
After setting: debug=3
... xlog("bla00"); if (avp_db_load("$ruri/username", "$avp(s:fwd_blind)")) { xlog("bla01" ... } xlog("bla02"); ...
The syslog shows (after replacing the true username): Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: <script>: bla00 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:851]: db_mongodb_query(): query to collection [usr_preferences] Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:885]: db_mongodb_query(): query filter: { "username" : "0002", "attribute" : "fwd_blind" } Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:904]: db_mongodb_query(): columns filter: { "value" : 1, "attribute" : 1, "type" : 1 } Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:116]: db_new_result(): allocate 56 bytes for result set at 0x7fa03e54a6a0 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:349]: db_mongodb_get_columns(): 3 columns returned from the query Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:154]: db_allocate_columns(): allocate 24 bytes for result names at 0x7fa03e54a798 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:165]: db_allocate_columns(): allocate 12 bytes for result types at 0x7fa03e549848 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:377]: db_mongodb_get_columns(): Found a field[0] named: value Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:396]: db_mongodb_get_columns(): allocate 16 bytes for RES_NAMES[0] at 0x7fa03e549798 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:431]: db_mongodb_get_columns(): use DB1_STRING result type Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:460]: db_mongodb_get_columns(): RES_NAMES(0x7fa03e549798)[0]=[value] (2) Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:377]: db_mongodb_get_columns(): Found a field[1] named: attribute Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: db_mongodb [mongodb_dbase.c:381]: db_mongodb_get_columns(): field [attribute] not found in result iterator Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: db_mongodb [mongodb_dbase.c:739]: db_mongodb_store_result(): failed to set the columns Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: db_mongodb [mongodb_dbase.c:918]: db_mongodb_query(): failed to store result Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: db_mongodb [mongodb_dbase.c:927]: db_mongodb_query(): failed to do the query Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:79]: db_free_columns(): freeing 3 columns Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[0] at 0x7fa03e549798 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:92]: db_free_columns(): freeing result names at 0x7fa03e54a798 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:97]: db_free_columns(): freeing result types at 0x7fa03e549848 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:134]: db_free_result(): freeing result set at 0x7fa03e54a6a0 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: avpops [avpops_impl.c:381]: ops_dbload_avps(): db_load failed Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: <script>: bla02
When changing to db_mysql the error does not occur. I got the following record there: MariaDB [kamailio]> select * from usr_preferences; +----+------+-------------+--------+-----------+------+-------------------------------------------+---------------------+ | id | uuid | username | domain | attribute | type | value | last_modified | +----+------+-------------+--------+-----------+------+-------------------------------------------+---------------------+ | 26 | | 0002 | | fwd_blind | 0 | sip:0003@x.x.x;user=phone | 1900-01-01 00:00:01 | +----+------+-------------+--------+-----------+------+-------------------------------------------+---------------------+
With the same kamailio.cfg (except for replacing mongodb with mysql) resulting in:
Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: ERROR: <script>: bla00 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:116]: db_new_result(): allocate 56 bytes for result set at 0x7fd17c349800 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:66]: db_mysql_get_columns(): 3 columns returned from the query Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:154]: db_allocate_columns(): allocate 24 bytes for result names at 0x7fd17c32f400 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:165]: db_allocate_columns(): allocate 12 bytes for result types at 0x7fd17c33fae8 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[0] at 0x7fd17c349350 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7fd17c349350)[0]=[value] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[1] at 0x7fd17c349458 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7fd17c349458)[1]=[attribute] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[2] at 0x7fd17c3493a8 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7fd17c3493a8)[2]=[type] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:99]: db_mysql_get_columns(): use DB1_INT result type Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:184]: db_allocate_rows(): allocate 16 bytes for rows at 0x7fd17c33fb98 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_row.c:117]: db_allocate_row(): allocate 96 bytes for row values at 0x7fd17c33f778 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [sip:0003@x.x.x;user=phone] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [fwd_blind] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_val.c:74]: db_str2val(): converting INT [0] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: avpops [avpops_impl.c:132]: dbrow2avp(): db_flags=3, flags=12 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: avpops [avpops_db.c:265]: db_close_query(): close avp query Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:79]: db_free_columns(): freeing 3 columns Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[0] at 0x7fd17c349350 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[1] at 0x7fd17c349458 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[2] at 0x7fd17c3493a8 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:92]: db_free_columns(): freeing result names at 0x7fd17c32f400 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:97]: db_free_columns(): freeing result types at 0x7fd17c33fae8 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:52]: db_free_rows(): freeing 1 rows Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_row.c:95]: db_free_row(): freeing row values at 0x7fd17c33f778 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:60]: db_free_rows(): freeing rows at 0x7fd17c33fb98 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:134]: db_free_result(): freeing result set at 0x7fd17c349800 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: avpops [avpops_impl.c:415]: ops_dbload_avps(): loaded avps = 1 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: ERROR: <script>: bla01
Hello,
can you try with current master branch or using the patch from next commit in your version?
- https://github.com/kamailio/kamailio/commit/501c41dd35fb9f15fdf96f4f37788603...
I am not able to test these days, but if you report it is working fine, then I can backport to stable branches.
Cheers, Daniel
On 06/03/2017 09:48, hdssdsdsdsfsdf hdssdsdsdsfsdf wrote:
On 22/02/2017 14:35, hsdsdssdfsdf dsasd wrote:
I implemented call forwarding according to https://www.kamailio.org/wiki/tutorials/mini-howto-admin/call_forwarding, which is working fine. When I replace db_mysql with db_mongodb however, I receive an error on "if (avp_db_load("$ruri/username", "$avp(s:fwd_blind)")) {":
ERROR: db_mongodb [mongodb_dbase.c:381]: db_mongodb_get_columns(): field [attribute] not found in result iterator ERROR: db_mongodb [mongodb_dbase.c:739]: db_mongodb_store_result(): failed to set the columns ERROR: db_mongodb [mongodb_dbase.c:918]: db_mongodb_query(): failed to store result ERROR: db_mongodb [mongodb_dbase.c:927]: db_mongodb_query(): failed to do the query ERROR: avpops [avpops_impl.c:381]: ops_dbload_avps(): db_load failed
can you set debug=3 in kamailio.cfg, restart kamailio and test again? Then grab the log messages from syslog and send them here. It should provide more debug information.
Is there a record for this query? Or should be an empty response (no record returned)?
Cheers, Daniel
I used the following to store a forward: avp_db_store("$from/username","$avp(s:fwd_blind)");
Which in this case resulted in (after replacing the true forward info): > db.usr_preferences.find() { "_id" : ObjectId("58ac40f7e498420e0703a2e1"), "uuid" : "", "attribute" : "fwd_blind", "value" : "sip:0003@x.x.x;user=phone", "type" : 0, "username" : "0002", "domain" : null }
After setting: debug=3
... xlog("bla00"); if (avp_db_load("$ruri/username", "$avp(s:fwd_blind)")) { xlog("bla01" ... } xlog("bla02"); ...
The syslog shows (after replacing the true username): Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: <script>: bla00 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:851]: db_mongodb_query(): query to collection [usr_preferences] Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:885]: db_mongodb_query(): query filter: { "username" : "0002", "attribute" : "fwd_blind" } Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:904]: db_mongodb_query(): columns filter: { "value" : 1, "attribute" : 1, "type" : 1 } Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:116]: db_new_result(): allocate 56 bytes for result set at 0x7fa03e54a6a0 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:349]: db_mongodb_get_columns(): 3 columns returned from the query Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:154]: db_allocate_columns(): allocate 24 bytes for result names at 0x7fa03e54a798 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:165]: db_allocate_columns(): allocate 12 bytes for result types at 0x7fa03e549848 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:377]: db_mongodb_get_columns(): Found a field[0] named: value Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:396]: db_mongodb_get_columns(): allocate 16 bytes for RES_NAMES[0] at 0x7fa03e549798 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:431]: db_mongodb_get_columns(): use DB1_STRING result type Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:460]: db_mongodb_get_columns(): RES_NAMES(0x7fa03e549798)[0]=[value] (2) Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:377]: db_mongodb_get_columns(): Found a field[1] named: attribute Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: db_mongodb [mongodb_dbase.c:381]: db_mongodb_get_columns(): field [attribute] not found in result iterator Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: db_mongodb [mongodb_dbase.c:739]: db_mongodb_store_result(): failed to set the columns Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: db_mongodb [mongodb_dbase.c:918]: db_mongodb_query(): failed to store result Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: db_mongodb [mongodb_dbase.c:927]: db_mongodb_query(): failed to do the query Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:79]: db_free_columns(): freeing 3 columns Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[0] at 0x7fa03e549798 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:92]: db_free_columns(): freeing result names at 0x7fa03e54a798 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:97]: db_free_columns(): freeing result types at 0x7fa03e549848 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:134]: db_free_result(): freeing result set at 0x7fa03e54a6a0 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: avpops [avpops_impl.c:381]: ops_dbload_avps(): db_load failed Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: <script>: bla02
When changing to db_mysql the error does not occur. I got the following record there: MariaDB [kamailio]> select * from usr_preferences; +----+------+-------------+--------+-----------+------+-------------------------------------------+---------------------+ | id | uuid | username | domain | attribute | type | value | last_modified | +----+------+-------------+--------+-----------+------+-------------------------------------------+---------------------+ | 26 | | 0002 | | fwd_blind | 0 | sip:0003@x.x.x;user=phone | 1900-01-01 00:00:01 | +----+------+-------------+--------+-----------+------+-------------------------------------------+---------------------+
With the same kamailio.cfg (except for replacing mongodb with mysql) resulting in:
Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: ERROR: <script>: bla00 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:116]: db_new_result(): allocate 56 bytes for result set at 0x7fd17c349800 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:66]: db_mysql_get_columns(): 3 columns returned from the query Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:154]: db_allocate_columns(): allocate 24 bytes for result names at 0x7fd17c32f400 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:165]: db_allocate_columns(): allocate 12 bytes for result types at 0x7fd17c33fae8 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[0] at 0x7fd17c349350 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7fd17c349350)[0]=[value] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[1] at 0x7fd17c349458 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7fd17c349458)[1]=[attribute] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[2] at 0x7fd17c3493a8 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7fd17c3493a8)[2]=[type] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:99]: db_mysql_get_columns(): use DB1_INT result type Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:184]: db_allocate_rows(): allocate 16 bytes for rows at 0x7fd17c33fb98 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_row.c:117]: db_allocate_row(): allocate 96 bytes for row values at 0x7fd17c33f778 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [sip:0003@x.x.x;user=phone] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [fwd_blind] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_val.c:74]: db_str2val(): converting INT [0] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: avpops [avpops_impl.c:132]: dbrow2avp(): db_flags=3, flags=12 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: avpops [avpops_db.c:265]: db_close_query(): close avp query Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:79]: db_free_columns(): freeing 3 columns Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[0] at 0x7fd17c349350 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[1] at 0x7fd17c349458 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[2] at 0x7fd17c3493a8 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:92]: db_free_columns(): freeing result names at 0x7fd17c32f400 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:97]: db_free_columns(): freeing result types at 0x7fd17c33fae8 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:52]: db_free_rows(): freeing 1 rows Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_row.c:95]: db_free_row(): freeing row values at 0x7fd17c33f778 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:60]: db_free_rows(): freeing rows at 0x7fd17c33fb98 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:134]: db_free_result(): freeing result set at 0x7fd17c349800 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: avpops [avpops_impl.c:415]: ops_dbload_avps(): loaded avps = 1 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: ERROR: <script>: bla01
Hi, thanks, we have a similar error further on after succesfully applying your patch on 4.4.4. The setup is the same as it was before, and the result this time is:
Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: <script>: bla00 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:858]: db_mongodb_query(): query to collection [usr_preferences] Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:892]: db_mongodb_query(): query filter: { "username" : "0002", "attribute" : "fwd_blind" } Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:911]: db_mongodb_query(): columns filter: { "value" : 1, "attribute" : 1, "type" : 1 } Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:116]: db_new_result(): allocate 56 bytes for result set at 0x7f2f3ae70688 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:349]: db_mongodb_get_columns(): 3 columns returned from the query Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:154]: db_allocate_columns(): allocate 24 bytes for result names at 0x7f2f3ae44c90 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:165]: db_allocate_columns(): allocate 12 bytes for result types at 0x7f2f3ae70dc8 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:377]: db_mongodb_get_columns(): Found a field[0] named: value Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:403]: db_mongodb_get_columns(): allocate 16 bytes for RES_NAMES[0] at 0x7f2f3ae70ec8 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:438]: db_mongodb_get_columns(): use DB1_STRING result type Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:467]: db_mongodb_get_columns(): RES_NAMES(0x7f2f3ae70ec8)[0]=[value] (2) Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:377]: db_mongodb_get_columns(): Found a field[1] named: attribute Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:403]: db_mongodb_get_columns(): allocate 16 bytes for RES_NAMES[1] at 0x7f2f3ae70a18 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:438]: db_mongodb_get_columns(): use DB1_STRING result type Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:467]: db_mongodb_get_columns(): RES_NAMES(0x7f2f3ae70a18)[1]=[attribute] (2) Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:377]: db_mongodb_get_columns(): Found a field[2] named: type Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:403]: db_mongodb_get_columns(): allocate 16 bytes for RES_NAMES[2] at 0x7f2f3ae5a2b0 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:413]: db_mongodb_get_columns(): use DB1_INT result type Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:467]: db_mongodb_get_columns(): RES_NAMES(0x7f2f3ae5a2b0)[2]=[type] (16) Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:184]: db_allocate_rows(): allocate 16000 bytes for rows at 0x7f2f3ae73ba0 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:678]: db_mongodb_convert_result(): selected document: { "_id" : { "$oid" : "58beb954e498426da961b121" }, "attribute" : "fwd_blind", "value" : "sip:31203229998@sip.interxs.ch;user=phone", "type" : 0 } Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_row.c:117]: db_allocate_row(): allocate 96 bytes for row values at 0x7f2f3ae70e20 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:529]: db_mongodb_convert_bson(): looking for field[0] named: value Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:617]: db_mongodb_convert_bson(): RES_NAMES(0x7f2f3ae70ec8)[0]=[value] (2) Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:529]: db_mongodb_convert_bson(): looking for field[1] named: attribute Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: db_mongodb [mongodb_dbase.c:533]: db_mongodb_convert_bson(): field [attribute] not found in result iterator Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: db_mongodb [mongodb_dbase.c:682]: db_mongodb_convert_result(): failed to convert bson at pos 0 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: db_mongodb [mongodb_dbase.c:750]: db_mongodb_store_result(): failed to set the rows in result Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: db_mongodb [mongodb_dbase.c:925]: db_mongodb_query(): failed to store result Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: db_mongodb [mongodb_dbase.c:934]: db_mongodb_query(): failed to do the query Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:79]: db_free_columns(): freeing 3 columns Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[0] at 0x7f2f3ae70ec8 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[1] at 0x7f2f3ae70a18 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[2] at 0x7f2f3ae5a2b0 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:92]: db_free_columns(): freeing result names at 0x7f2f3ae44c90 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:97]: db_free_columns(): freeing result types at 0x7f2f3ae70dc8 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:52]: db_free_rows(): freeing 1000 rows Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_row.c:95]: db_free_row(): freeing row values at 0x7f2f3ae70e20 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:60]: db_free_rows(): freeing rows at 0x7f2f3ae73ba0 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:134]: db_free_result(): freeing result set at 0x7f2f3ae70688 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: avpops [avpops_impl.c:381]: ops_dbload_avps(): db_load failed Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: <script>: bla02
Sent: Tuesday, March 07, 2017 at 8:59 AM From: "Daniel-Constantin Mierla" miconda@gmail.com To: "hdssdsdsdsfsdf hdssdsdsdsfsdf" hdssdsdsdsfsdf@mail.com, sr-users@lists.sip-router.org Subject: Re: [SR-Users] problem with avpops and mongodb modules
Hello,
can you try with current master branch or using the patch from next commit in your version?
https://github.com/kamailio/kamailio/commit/501c41dd35fb9f15fdf96f4f37788603...
I am not able to test these days, but if you report it is working fine, then I can backport to stable branches.
Cheers, Daniel
On 06/03/2017 09:48, hdssdsdsdsfsdf hdssdsdsdsfsdf wrote:
On 22/02/2017 14:35, hsdsdssdfsdf dsasd wrote:
I implemented call forwarding according to https://www.kamailio.org/wiki/tutorials/mini-howto-admin/call_forwarding, which is working fine. When I replace db_mysql with db_mongodb however, I receive an error on "if (avp_db_load("$ruri/username", "$avp(s:fwd_blind)")) {":
ERROR: db_mongodb [mongodb_dbase.c:381]: db_mongodb_get_columns(): field [attribute] not found in result iterator ERROR: db_mongodb [mongodb_dbase.c:739]: db_mongodb_store_result(): failed to set the columns ERROR: db_mongodb [mongodb_dbase.c:918]: db_mongodb_query(): failed to store result ERROR: db_mongodb [mongodb_dbase.c:927]: db_mongodb_query(): failed to do the query ERROR: avpops [avpops_impl.c:381]: ops_dbload_avps(): db_load failed
can you set debug=3 in kamailio.cfg, restart kamailio and test again? Then grab the log messages from syslog and send them here. It should provide more debug information.
Is there a record for this query? Or should be an empty response (no record returned)?
Cheers, Daniel
I used the following to store a forward: avp_db_store("$from/username","$avp(s:fwd_blind)");
Which in this case resulted in (after replacing the true forward info): > db.usr_preferences.find() { "_id" : ObjectId("58ac40f7e498420e0703a2e1"), "uuid" : "", "attribute" : "fwd_blind", "value" : "sip:0003@x.x.x;user=phone", "type" : 0, "username" : "0002", "domain" : null }
After setting: debug=3
... xlog("bla00"); if (avp_db_load("$ruri/username", "$avp(s:fwd_blind)")) { xlog("bla01" ... } xlog("bla02"); ...
The syslog shows (after replacing the true username): Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: <script>: bla00 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:851]: db_mongodb_query(): query to collection [usr_preferences] Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:885]: db_mongodb_query(): query filter: { "username" : "0002", "attribute" : "fwd_blind" } Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:904]: db_mongodb_query(): columns filter: { "value" : 1, "attribute" : 1, "type" : 1 } Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:116]: db_new_result(): allocate 56 bytes for result set at 0x7fa03e54a6a0 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:349]: db_mongodb_get_columns(): 3 columns returned from the query Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:154]: db_allocate_columns(): allocate 24 bytes for result names at 0x7fa03e54a798 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:165]: db_allocate_columns(): allocate 12 bytes for result types at 0x7fa03e549848 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:377]: db_mongodb_get_columns(): Found a field[0] named: value Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:396]: db_mongodb_get_columns(): allocate 16 bytes for RES_NAMES[0] at 0x7fa03e549798 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:431]: db_mongodb_get_columns(): use DB1_STRING result type Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:460]: db_mongodb_get_columns(): RES_NAMES(0x7fa03e549798)[0]=[value] (2) Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:377]: db_mongodb_get_columns(): Found a field[1] named: attribute Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: db_mongodb [mongodb_dbase.c:381]: db_mongodb_get_columns(): field [attribute] not found in result iterator Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: db_mongodb [mongodb_dbase.c:739]: db_mongodb_store_result(): failed to set the columns Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: db_mongodb [mongodb_dbase.c:918]: db_mongodb_query(): failed to store result Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: db_mongodb [mongodb_dbase.c:927]: db_mongodb_query(): failed to do the query Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:79]: db_free_columns(): freeing 3 columns Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[0] at 0x7fa03e549798 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:92]: db_free_columns(): freeing result names at 0x7fa03e54a798 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:97]: db_free_columns(): freeing result types at 0x7fa03e549848 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:134]: db_free_result(): freeing result set at 0x7fa03e54a6a0 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: avpops [avpops_impl.c:381]: ops_dbload_avps(): db_load failed Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: <script>: bla02
When changing to db_mysql the error does not occur. I got the following record there: MariaDB [kamailio]> select * from usr_preferences; +----+------+-------------+--------+-----------+------+-------------------------------------------+---------------------+ | id | uuid | username | domain | attribute | type | value | last_modified | +----+------+-------------+--------+-----------+------+-------------------------------------------+---------------------+ | 26 | | 0002 | | fwd_blind | 0 | sip:0003@x.x.x;user=phone | 1900-01-01 00:00:01 | +----+------+-------------+--------+-----------+------+-------------------------------------------+---------------------+
With the same kamailio.cfg (except for replacing mongodb with mysql) resulting in:
Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: ERROR: <script>: bla00 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:116]: db_new_result(): allocate 56 bytes for result set at 0x7fd17c349800 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:66]: db_mysql_get_columns(): 3 columns returned from the query Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:154]: db_allocate_columns(): allocate 24 bytes for result names at 0x7fd17c32f400 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:165]: db_allocate_columns(): allocate 12 bytes for result types at 0x7fd17c33fae8 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[0] at 0x7fd17c349350 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7fd17c349350)[0]=[value] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[1] at 0x7fd17c349458 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7fd17c349458)[1]=[attribute] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[2] at 0x7fd17c3493a8 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7fd17c3493a8)[2]=[type] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:99]: db_mysql_get_columns(): use DB1_INT result type Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:184]: db_allocate_rows(): allocate 16 bytes for rows at 0x7fd17c33fb98 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_row.c:117]: db_allocate_row(): allocate 96 bytes for row values at 0x7fd17c33f778 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [sip:0003@x.x.x;user=phone] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [fwd_blind] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_val.c:74]: db_str2val(): converting INT [0] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: avpops [avpops_impl.c:132]: dbrow2avp(): db_flags=3, flags=12 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: avpops [avpops_db.c:265]: db_close_query(): close avp query Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:79]: db_free_columns(): freeing 3 columns Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[0] at 0x7fd17c349350 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[1] at 0x7fd17c349458 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[2] at 0x7fd17c3493a8 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:92]: db_free_columns(): freeing result names at 0x7fd17c32f400 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:97]: db_free_columns(): freeing result types at 0x7fd17c33fae8 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:52]: db_free_rows(): freeing 1 rows Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_row.c:95]: db_free_row(): freeing row values at 0x7fd17c33f778 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:60]: db_free_rows(): freeing rows at 0x7fd17c33fb98 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:134]: db_free_result(): freeing result set at 0x7fd17c349800 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: avpops [avpops_impl.c:415]: ops_dbload_avps(): loaded avps = 1 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: ERROR: <script>: bla01
-- Daniel-Constantin Mierla www.twitter.com/miconda -- www.linkedin.com/in/miconda Kamailio Advanced Training - Mar 6-8 (Europe) and Mar 20-22 (USA) - www.asipto.com Kamailio World Conference - May 8-10, 2017 - www.kamailioworld.com
Hello,
I pushed another patch to fix a similar case in a different function. Can you try with it (6bd32088de1d7ae816643aea4a60c70911e46b5e)?
Cheers, Daniel
On 07/03/2017 14:50, hdssdsdsdsfsdf hdssdsdsdsfsdf wrote:
Hi, thanks, we have a similar error further on after succesfully applying your patch on 4.4.4. The setup is the same as it was before, and the result this time is:
Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: <script>: bla00 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:858]: db_mongodb_query(): query to collection [usr_preferences] Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:892]: db_mongodb_query(): query filter: { "username" : "0002", "attribute" : "fwd_blind" } Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:911]: db_mongodb_query(): columns filter: { "value" : 1, "attribute" : 1, "type" : 1 } Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:116]: db_new_result(): allocate 56 bytes for result set at 0x7f2f3ae70688 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:349]: db_mongodb_get_columns(): 3 columns returned from the query Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:154]: db_allocate_columns(): allocate 24 bytes for result names at 0x7f2f3ae44c90 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:165]: db_allocate_columns(): allocate 12 bytes for result types at 0x7f2f3ae70dc8 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:377]: db_mongodb_get_columns(): Found a field[0] named: value Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:403]: db_mongodb_get_columns(): allocate 16 bytes for RES_NAMES[0] at 0x7f2f3ae70ec8 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:438]: db_mongodb_get_columns(): use DB1_STRING result type Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:467]: db_mongodb_get_columns(): RES_NAMES(0x7f2f3ae70ec8)[0]=[value] (2) Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:377]: db_mongodb_get_columns(): Found a field[1] named: attribute Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:403]: db_mongodb_get_columns(): allocate 16 bytes for RES_NAMES[1] at 0x7f2f3ae70a18 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:438]: db_mongodb_get_columns(): use DB1_STRING result type Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:467]: db_mongodb_get_columns(): RES_NAMES(0x7f2f3ae70a18)[1]=[attribute] (2) Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:377]: db_mongodb_get_columns(): Found a field[2] named: type Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:403]: db_mongodb_get_columns(): allocate 16 bytes for RES_NAMES[2] at 0x7f2f3ae5a2b0 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:413]: db_mongodb_get_columns(): use DB1_INT result type Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:467]: db_mongodb_get_columns(): RES_NAMES(0x7f2f3ae5a2b0)[2]=[type] (16) Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:184]: db_allocate_rows(): allocate 16000 bytes for rows at 0x7f2f3ae73ba0 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:678]: db_mongodb_convert_result(): selected document: { "_id" : { "$oid" : "58beb954e498426da961b121" }, "attribute" : "fwd_blind", "value" : "sip:31203229998@sip.interxs.ch;user=phone", "type" : 0 } Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_row.c:117]: db_allocate_row(): allocate 96 bytes for row values at 0x7f2f3ae70e20 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:529]: db_mongodb_convert_bson(): looking for field[0] named: value Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:617]: db_mongodb_convert_bson(): RES_NAMES(0x7f2f3ae70ec8)[0]=[value] (2) Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:529]: db_mongodb_convert_bson(): looking for field[1] named: attribute Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: db_mongodb [mongodb_dbase.c:533]: db_mongodb_convert_bson(): field [attribute] not found in result iterator Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: db_mongodb [mongodb_dbase.c:682]: db_mongodb_convert_result(): failed to convert bson at pos 0 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: db_mongodb [mongodb_dbase.c:750]: db_mongodb_store_result(): failed to set the rows in result Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: db_mongodb [mongodb_dbase.c:925]: db_mongodb_query(): failed to store result Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: db_mongodb [mongodb_dbase.c:934]: db_mongodb_query(): failed to do the query Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:79]: db_free_columns(): freeing 3 columns Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[0] at 0x7f2f3ae70ec8 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[1] at 0x7f2f3ae70a18 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[2] at 0x7f2f3ae5a2b0 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:92]: db_free_columns(): freeing result names at 0x7f2f3ae44c90 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:97]: db_free_columns(): freeing result types at 0x7f2f3ae70dc8 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:52]: db_free_rows(): freeing 1000 rows Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_row.c:95]: db_free_row(): freeing row values at 0x7f2f3ae70e20 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:60]: db_free_rows(): freeing rows at 0x7f2f3ae73ba0 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:134]: db_free_result(): freeing result set at 0x7f2f3ae70688 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: avpops [avpops_impl.c:381]: ops_dbload_avps(): db_load failed Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: <script>: bla02
Sent: Tuesday, March 07, 2017 at 8:59 AM From: "Daniel-Constantin Mierla" miconda@gmail.com To: "hdssdsdsdsfsdf hdssdsdsdsfsdf" hdssdsdsdsfsdf@mail.com, sr-users@lists.sip-router.org Subject: Re: [SR-Users] problem with avpops and mongodb modules
Hello,
can you try with current master branch or using the patch from next commit in your version?
https://github.com/kamailio/kamailio/commit/501c41dd35fb9f15fdf96f4f37788603...
I am not able to test these days, but if you report it is working fine, then I can backport to stable branches.
Cheers, Daniel
On 06/03/2017 09:48, hdssdsdsdsfsdf hdssdsdsdsfsdf wrote:
On 22/02/2017 14:35, hsdsdssdfsdf dsasd wrote:
I implemented call forwarding according to https://www.kamailio.org/wiki/tutorials/mini-howto-admin/call_forwarding, which is working fine. When I replace db_mysql with db_mongodb however, I receive an error on "if (avp_db_load("$ruri/username", "$avp(s:fwd_blind)")) {":
ERROR: db_mongodb [mongodb_dbase.c:381]: db_mongodb_get_columns(): field [attribute] not found in result iterator ERROR: db_mongodb [mongodb_dbase.c:739]: db_mongodb_store_result(): failed to set the columns ERROR: db_mongodb [mongodb_dbase.c:918]: db_mongodb_query(): failed to store result ERROR: db_mongodb [mongodb_dbase.c:927]: db_mongodb_query(): failed to do the query ERROR: avpops [avpops_impl.c:381]: ops_dbload_avps(): db_load failed
can you set debug=3 in kamailio.cfg, restart kamailio and test again? Then grab the log messages from syslog and send them here. It should provide more debug information.
Is there a record for this query? Or should be an empty response (no record returned)?
Cheers, Daniel
I used the following to store a forward: avp_db_store("$from/username","$avp(s:fwd_blind)");
Which in this case resulted in (after replacing the true forward info): > db.usr_preferences.find() { "_id" : ObjectId("58ac40f7e498420e0703a2e1"), "uuid" : "", "attribute" : "fwd_blind", "value" : "sip:0003@x.x.x;user=phone", "type" : 0, "username" : "0002", "domain" : null }
After setting: debug=3
... xlog("bla00"); if (avp_db_load("$ruri/username", "$avp(s:fwd_blind)")) { xlog("bla01" ... } xlog("bla02"); ...
The syslog shows (after replacing the true username): Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: <script>: bla00 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:851]: db_mongodb_query(): query to collection [usr_preferences] Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:885]: db_mongodb_query(): query filter: { "username" : "0002", "attribute" : "fwd_blind" } Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:904]: db_mongodb_query(): columns filter: { "value" : 1, "attribute" : 1, "type" : 1 } Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:116]: db_new_result(): allocate 56 bytes for result set at 0x7fa03e54a6a0 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:349]: db_mongodb_get_columns(): 3 columns returned from the query Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:154]: db_allocate_columns(): allocate 24 bytes for result names at 0x7fa03e54a798 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:165]: db_allocate_columns(): allocate 12 bytes for result types at 0x7fa03e549848 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:377]: db_mongodb_get_columns(): Found a field[0] named: value Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:396]: db_mongodb_get_columns(): allocate 16 bytes for RES_NAMES[0] at 0x7fa03e549798 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:431]: db_mongodb_get_columns(): use DB1_STRING result type Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:460]: db_mongodb_get_columns(): RES_NAMES(0x7fa03e549798)[0]=[value] (2) Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:377]: db_mongodb_get_columns(): Found a field[1] named: attribute Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: db_mongodb [mongodb_dbase.c:381]: db_mongodb_get_columns(): field [attribute] not found in result iterator Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: db_mongodb [mongodb_dbase.c:739]: db_mongodb_store_result(): failed to set the columns Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: db_mongodb [mongodb_dbase.c:918]: db_mongodb_query(): failed to store result Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: db_mongodb [mongodb_dbase.c:927]: db_mongodb_query(): failed to do the query Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:79]: db_free_columns(): freeing 3 columns Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[0] at 0x7fa03e549798 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:92]: db_free_columns(): freeing result names at 0x7fa03e54a798 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:97]: db_free_columns(): freeing result types at 0x7fa03e549848 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:134]: db_free_result(): freeing result set at 0x7fa03e54a6a0 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: avpops [avpops_impl.c:381]: ops_dbload_avps(): db_load failed Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: <script>: bla02
When changing to db_mysql the error does not occur. I got the following record there: MariaDB [kamailio]> select * from usr_preferences; +----+------+-------------+--------+-----------+------+-------------------------------------------+---------------------+ | id | uuid | username | domain | attribute | type | value | last_modified | +----+------+-------------+--------+-----------+------+-------------------------------------------+---------------------+ | 26 | | 0002 | | fwd_blind | 0 | sip:0003@x.x.x;user=phone | 1900-01-01 00:00:01 | +----+------+-------------+--------+-----------+------+-------------------------------------------+---------------------+
With the same kamailio.cfg (except for replacing mongodb with mysql) resulting in:
Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: ERROR: <script>: bla00 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:116]: db_new_result(): allocate 56 bytes for result set at 0x7fd17c349800 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:66]: db_mysql_get_columns(): 3 columns returned from the query Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:154]: db_allocate_columns(): allocate 24 bytes for result names at 0x7fd17c32f400 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:165]: db_allocate_columns(): allocate 12 bytes for result types at 0x7fd17c33fae8 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[0] at 0x7fd17c349350 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7fd17c349350)[0]=[value] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[1] at 0x7fd17c349458 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7fd17c349458)[1]=[attribute] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[2] at 0x7fd17c3493a8 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7fd17c3493a8)[2]=[type] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:99]: db_mysql_get_columns(): use DB1_INT result type Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:184]: db_allocate_rows(): allocate 16 bytes for rows at 0x7fd17c33fb98 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_row.c:117]: db_allocate_row(): allocate 96 bytes for row values at 0x7fd17c33f778 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [sip:0003@x.x.x;user=phone] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [fwd_blind] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_val.c:74]: db_str2val(): converting INT [0] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: avpops [avpops_impl.c:132]: dbrow2avp(): db_flags=3, flags=12 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: avpops [avpops_db.c:265]: db_close_query(): close avp query Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:79]: db_free_columns(): freeing 3 columns Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[0] at 0x7fd17c349350 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[1] at 0x7fd17c349458 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[2] at 0x7fd17c3493a8 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:92]: db_free_columns(): freeing result names at 0x7fd17c32f400 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:97]: db_free_columns(): freeing result types at 0x7fd17c33fae8 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:52]: db_free_rows(): freeing 1 rows Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_row.c:95]: db_free_row(): freeing row values at 0x7fd17c33f778 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:60]: db_free_rows(): freeing rows at 0x7fd17c33fb98 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:134]: db_free_result(): freeing result set at 0x7fd17c349800 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: avpops [avpops_impl.c:415]: ops_dbload_avps(): loaded avps = 1 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: ERROR: <script>: bla01
-- Daniel-Constantin Mierla www.twitter.com/miconda -- www.linkedin.com/in/miconda Kamailio Advanced Training - Mar 6-8 (Europe) and Mar 20-22 (USA) - www.asipto.com Kamailio World Conference - May 8-10, 2017 - www.kamailioworld.com
Hi Daniel,
Together, these patches solved the issue.
To be sure, I could not test before, and the configuration is no longer exactly the same and I'm using ipv6 now. Still, the call forwarding code in kamailio.cfg did not change at all and is now working with mongodb too.
Thanks a lot again!
Cheers,
Sent: Wednesday, March 08, 2017 at 12:26 AM From: "Daniel-Constantin Mierla" miconda@gmail.com To: "hdssdsdsdsfsdf hdssdsdsdsfsdf" hdssdsdsdsfsdf@mail.com Cc: sr-users@lists.sip-router.org Subject: Re: [SR-Users] problem with avpops and mongodb modules
Hello,
I pushed another patch to fix a similar case in a different function. Can you try with it (6bd32088de1d7ae816643aea4a60c70911e46b5e)?
Cheers, Daniel
On 07/03/2017 14:50, hdssdsdsdsfsdf hdssdsdsdsfsdf wrote:
Hi, thanks, we have a similar error further on after succesfully applying your patch on 4.4.4. The setup is the same as it was before, and the result this time is:
Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: <script>: bla00 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:858]: db_mongodb_query(): query to collection [usr_preferences] Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:892]: db_mongodb_query(): query filter: { "username" : "0002", "attribute" : "fwd_blind" } Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:911]: db_mongodb_query(): columns filter: { "value" : 1, "attribute" : 1, "type" : 1 } Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:116]: db_new_result(): allocate 56 bytes for result set at 0x7f2f3ae70688 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:349]: db_mongodb_get_columns(): 3 columns returned from the query Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:154]: db_allocate_columns(): allocate 24 bytes for result names at 0x7f2f3ae44c90 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:165]: db_allocate_columns(): allocate 12 bytes for result types at 0x7f2f3ae70dc8 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:377]: db_mongodb_get_columns(): Found a field[0] named: value Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:403]: db_mongodb_get_columns(): allocate 16 bytes for RES_NAMES[0] at 0x7f2f3ae70ec8 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:438]: db_mongodb_get_columns(): use DB1_STRING result type Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:467]: db_mongodb_get_columns(): RES_NAMES(0x7f2f3ae70ec8)[0]=[value] (2) Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:377]: db_mongodb_get_columns(): Found a field[1] named: attribute Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:403]: db_mongodb_get_columns(): allocate 16 bytes for RES_NAMES[1] at 0x7f2f3ae70a18 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:438]: db_mongodb_get_columns(): use DB1_STRING result type Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:467]: db_mongodb_get_columns(): RES_NAMES(0x7f2f3ae70a18)[1]=[attribute] (2) Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:377]: db_mongodb_get_columns(): Found a field[2] named: type Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:403]: db_mongodb_get_columns(): allocate 16 bytes for RES_NAMES[2] at 0x7f2f3ae5a2b0 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:413]: db_mongodb_get_columns(): use DB1_INT result type Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:467]: db_mongodb_get_columns(): RES_NAMES(0x7f2f3ae5a2b0)[2]=[type] (16) Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:184]: db_allocate_rows(): allocate 16000 bytes for rows at 0x7f2f3ae73ba0 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:678]: db_mongodb_convert_result(): selected document: { "_id" : { "$oid" : "58beb954e498426da961b121" }, "attribute" : "fwd_blind", "value" : "sip:31203229998@sip.interxs.ch;user=phone", "type" : 0 } Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_row.c:117]: db_allocate_row(): allocate 96 bytes for row values at 0x7f2f3ae70e20 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:529]: db_mongodb_convert_bson(): looking for field[0] named: value Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:617]: db_mongodb_convert_bson(): RES_NAMES(0x7f2f3ae70ec8)[0]=[value] (2) Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:529]: db_mongodb_convert_bson(): looking for field[1] named: attribute Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: db_mongodb [mongodb_dbase.c:533]: db_mongodb_convert_bson(): field [attribute] not found in result iterator Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: db_mongodb [mongodb_dbase.c:682]: db_mongodb_convert_result(): failed to convert bson at pos 0 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: db_mongodb [mongodb_dbase.c:750]: db_mongodb_store_result(): failed to set the rows in result Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: db_mongodb [mongodb_dbase.c:925]: db_mongodb_query(): failed to store result Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: db_mongodb [mongodb_dbase.c:934]: db_mongodb_query(): failed to do the query Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:79]: db_free_columns(): freeing 3 columns Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[0] at 0x7f2f3ae70ec8 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[1] at 0x7f2f3ae70a18 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[2] at 0x7f2f3ae5a2b0 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:92]: db_free_columns(): freeing result names at 0x7f2f3ae44c90 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:97]: db_free_columns(): freeing result types at 0x7f2f3ae70dc8 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:52]: db_free_rows(): freeing 1000 rows Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_row.c:95]: db_free_row(): freeing row values at 0x7f2f3ae70e20 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:60]: db_free_rows(): freeing rows at 0x7f2f3ae73ba0 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:134]: db_free_result(): freeing result set at 0x7f2f3ae70688 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: avpops [avpops_impl.c:381]: ops_dbload_avps(): db_load failed Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: <script>: bla02
Sent: Tuesday, March 07, 2017 at 8:59 AM From: "Daniel-Constantin Mierla" miconda@gmail.com To: "hdssdsdsdsfsdf hdssdsdsdsfsdf" hdssdsdsdsfsdf@mail.com, sr-users@lists.sip-router.org Subject: Re: [SR-Users] problem with avpops and mongodb modules
Hello,
can you try with current master branch or using the patch from next commit in your version?
https://github.com/kamailio/kamailio/commit/501c41dd35fb9f15fdf96f4f37788603...
I am not able to test these days, but if you report it is working fine, then I can backport to stable branches.
Cheers, Daniel
On 06/03/2017 09:48, hdssdsdsdsfsdf hdssdsdsdsfsdf wrote:
On 22/02/2017 14:35, hsdsdssdfsdf dsasd wrote:
I implemented call forwarding according to https://www.kamailio.org/wiki/tutorials/mini-howto-admin/call_forwarding, which is working fine. When I replace db_mysql with db_mongodb however, I receive an error on "if (avp_db_load("$ruri/username", "$avp(s:fwd_blind)")) {":
ERROR: db_mongodb [mongodb_dbase.c:381]: db_mongodb_get_columns(): field [attribute] not found in result iterator ERROR: db_mongodb [mongodb_dbase.c:739]: db_mongodb_store_result(): failed to set the columns ERROR: db_mongodb [mongodb_dbase.c:918]: db_mongodb_query(): failed to store result ERROR: db_mongodb [mongodb_dbase.c:927]: db_mongodb_query(): failed to do the query ERROR: avpops [avpops_impl.c:381]: ops_dbload_avps(): db_load failed
can you set debug=3 in kamailio.cfg, restart kamailio and test again? Then grab the log messages from syslog and send them here. It should provide more debug information.
Is there a record for this query? Or should be an empty response (no record returned)?
Cheers, Daniel
I used the following to store a forward: avp_db_store("$from/username","$avp(s:fwd_blind)");
Which in this case resulted in (after replacing the true forward info): > db.usr_preferences.find() { "_id" : ObjectId("58ac40f7e498420e0703a2e1"), "uuid" : "", "attribute" : "fwd_blind", "value" : "sip:0003@x.x.x;user=phone", "type" : 0, "username" : "0002", "domain" : null }
After setting: debug=3
... xlog("bla00"); if (avp_db_load("$ruri/username", "$avp(s:fwd_blind)")) { xlog("bla01" ... } xlog("bla02"); ...
The syslog shows (after replacing the true username): Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: <script>: bla00 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:851]: db_mongodb_query(): query to collection [usr_preferences] Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:885]: db_mongodb_query(): query filter: { "username" : "0002", "attribute" : "fwd_blind" } Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:904]: db_mongodb_query(): columns filter: { "value" : 1, "attribute" : 1, "type" : 1 } Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:116]: db_new_result(): allocate 56 bytes for result set at 0x7fa03e54a6a0 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:349]: db_mongodb_get_columns(): 3 columns returned from the query Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:154]: db_allocate_columns(): allocate 24 bytes for result names at 0x7fa03e54a798 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:165]: db_allocate_columns(): allocate 12 bytes for result types at 0x7fa03e549848 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:377]: db_mongodb_get_columns(): Found a field[0] named: value Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:396]: db_mongodb_get_columns(): allocate 16 bytes for RES_NAMES[0] at 0x7fa03e549798 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:431]: db_mongodb_get_columns(): use DB1_STRING result type Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:460]: db_mongodb_get_columns(): RES_NAMES(0x7fa03e549798)[0]=[value] (2) Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:377]: db_mongodb_get_columns(): Found a field[1] named: attribute Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: db_mongodb [mongodb_dbase.c:381]: db_mongodb_get_columns(): field [attribute] not found in result iterator Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: db_mongodb [mongodb_dbase.c:739]: db_mongodb_store_result(): failed to set the columns Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: db_mongodb [mongodb_dbase.c:918]: db_mongodb_query(): failed to store result Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: db_mongodb [mongodb_dbase.c:927]: db_mongodb_query(): failed to do the query Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:79]: db_free_columns(): freeing 3 columns Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[0] at 0x7fa03e549798 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:92]: db_free_columns(): freeing result names at 0x7fa03e54a798 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:97]: db_free_columns(): freeing result types at 0x7fa03e549848 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:134]: db_free_result(): freeing result set at 0x7fa03e54a6a0 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: avpops [avpops_impl.c:381]: ops_dbload_avps(): db_load failed Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: <script>: bla02
When changing to db_mysql the error does not occur. I got the following record there: MariaDB [kamailio]> select * from usr_preferences; +----+------+-------------+--------+-----------+------+-------------------------------------------+---------------------+ | id | uuid | username | domain | attribute | type | value | last_modified | +----+------+-------------+--------+-----------+------+-------------------------------------------+---------------------+ | 26 | | 0002 | | fwd_blind | 0 | sip:0003@x.x.x;user=phone | 1900-01-01 00:00:01 | +----+------+-------------+--------+-----------+------+-------------------------------------------+---------------------+
With the same kamailio.cfg (except for replacing mongodb with mysql) resulting in:
Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: ERROR: <script>: bla00 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:116]: db_new_result(): allocate 56 bytes for result set at 0x7fd17c349800 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:66]: db_mysql_get_columns(): 3 columns returned from the query Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:154]: db_allocate_columns(): allocate 24 bytes for result names at 0x7fd17c32f400 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:165]: db_allocate_columns(): allocate 12 bytes for result types at 0x7fd17c33fae8 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[0] at 0x7fd17c349350 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7fd17c349350)[0]=[value] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[1] at 0x7fd17c349458 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7fd17c349458)[1]=[attribute] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[2] at 0x7fd17c3493a8 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7fd17c3493a8)[2]=[type] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:99]: db_mysql_get_columns(): use DB1_INT result type Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:184]: db_allocate_rows(): allocate 16 bytes for rows at 0x7fd17c33fb98 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_row.c:117]: db_allocate_row(): allocate 96 bytes for row values at 0x7fd17c33f778 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [sip:0003@x.x.x;user=phone] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [fwd_blind] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_val.c:74]: db_str2val(): converting INT [0] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: avpops [avpops_impl.c:132]: dbrow2avp(): db_flags=3, flags=12 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: avpops [avpops_db.c:265]: db_close_query(): close avp query Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:79]: db_free_columns(): freeing 3 columns Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[0] at 0x7fd17c349350 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[1] at 0x7fd17c349458 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[2] at 0x7fd17c3493a8 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:92]: db_free_columns(): freeing result names at 0x7fd17c32f400 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:97]: db_free_columns(): freeing result types at 0x7fd17c33fae8 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:52]: db_free_rows(): freeing 1 rows Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_row.c:95]: db_free_row(): freeing row values at 0x7fd17c33f778 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:60]: db_free_rows(): freeing rows at 0x7fd17c33fb98 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:134]: db_free_result(): freeing result set at 0x7fd17c349800 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: avpops [avpops_impl.c:415]: ops_dbload_avps(): loaded avps = 1 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: ERROR: <script>: bla01
-- Daniel-Constantin Mierla www.twitter.com/miconda -- www.linkedin.com/in/miconda Kamailio Advanced Training - Mar 6-8 (Europe) and Mar 20-22 (USA) - www.asipto.com Kamailio World Conference - May 8-10, 2017 - www.kamailioworld.com
-- Daniel-Constantin Mierla www.twitter.com/miconda -- www.linkedin.com/in/miconda Kamailio Advanced Training - Mar 6-8 (Europe) and Mar 20-22 (USA) - www.asipto.com Kamailio World Conference - May 8-10, 2017 - www.kamailioworld.com
Hello,
thanks for testing and reporting back the results. It helps to know that the issue is solved.
Cheers, Daniel
On 18.04.17 15:46, hdssdsdsdsfsdf hdssdsdsdsfsdf wrote:
Hi Daniel,
Together, these patches solved the issue.
To be sure, I could not test before, and the configuration is no longer exactly the same and I'm using ipv6 now. Still, the call forwarding code in kamailio.cfg did not change at all and is now working with mongodb too.
Thanks a lot again!
Cheers,
Sent: Wednesday, March 08, 2017 at 12:26 AM From: "Daniel-Constantin Mierla" miconda@gmail.com To: "hdssdsdsdsfsdf hdssdsdsdsfsdf" hdssdsdsdsfsdf@mail.com Cc: sr-users@lists.sip-router.org Subject: Re: [SR-Users] problem with avpops and mongodb modules
Hello,
I pushed another patch to fix a similar case in a different function. Can you try with it (6bd32088de1d7ae816643aea4a60c70911e46b5e)?
Cheers, Daniel
On 07/03/2017 14:50, hdssdsdsdsfsdf hdssdsdsdsfsdf wrote:
Hi, thanks, we have a similar error further on after succesfully applying your patch on 4.4.4. The setup is the same as it was before, and the result this time is:
Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: <script>: bla00 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:858]: db_mongodb_query(): query to collection [usr_preferences] Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:892]: db_mongodb_query(): query filter: { "username" : "0002", "attribute" : "fwd_blind" } Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:911]: db_mongodb_query(): columns filter: { "value" : 1, "attribute" : 1, "type" : 1 } Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:116]: db_new_result(): allocate 56 bytes for result set at 0x7f2f3ae70688 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:349]: db_mongodb_get_columns(): 3 columns returned from the query Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:154]: db_allocate_columns(): allocate 24 bytes for result names at 0x7f2f3ae44c90 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:165]: db_allocate_columns(): allocate 12 bytes for result types at 0x7f2f3ae70dc8 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:377]: db_mongodb_get_columns(): Found a field[0] named: value Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:403]: db_mongodb_get_columns(): allocate 16 bytes for RES_NAMES[0] at 0x7f2f3ae70ec8 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:438]: db_mongodb_get_columns(): use DB1_STRING result type Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:467]: db_mongodb_get_columns(): RES_NAMES(0x7f2f3ae70ec8)[0]=[value] (2) Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:377]: db_mongodb_get_columns(): Found a field[1] named: attribute Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:403]: db_mongodb_get_columns(): allocate 16 bytes for RES_NAMES[1] at 0x7f2f3ae70a18 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:438]: db_mongodb_get_columns(): use DB1_STRING result type Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:467]: db_mongodb_get_columns(): RES_NAMES(0x7f2f3ae70a18)[1]=[attribute] (2) Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:377]: db_mongodb_get_columns(): Found a field[2] named: type Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:403]: db_mongodb_get_columns(): allocate 16 bytes for RES_NAMES[2] at 0x7f2f3ae5a2b0 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:413]: db_mongodb_get_columns(): use DB1_INT result type Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:467]: db_mongodb_get_columns(): RES_NAMES(0x7f2f3ae5a2b0)[2]=[type] (16) Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:184]: db_allocate_rows(): allocate 16000 bytes for rows at 0x7f2f3ae73ba0 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:678]: db_mongodb_convert_result(): selected document: { "_id" : { "$oid" : "58beb954e498426da961b121" }, "attribute" : "fwd_blind", "value" : "sip:31203229998@sip.interxs.ch;user=phone", "type" : 0 } Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_row.c:117]: db_allocate_row(): allocate 96 bytes for row values at 0x7f2f3ae70e20 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:529]: db_mongodb_convert_bson(): looking for field[0] named: value Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:617]: db_mongodb_convert_bson(): RES_NAMES(0x7f2f3ae70ec8)[0]=[value] (2) Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: db_mongodb [mongodb_dbase.c:529]: db_mongodb_convert_bson(): looking for field[1] named: attribute Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: db_mongodb [mongodb_dbase.c:533]: db_mongodb_convert_bson(): field [attribute] not found in result iterator Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: db_mongodb [mongodb_dbase.c:682]: db_mongodb_convert_result(): failed to convert bson at pos 0 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: db_mongodb [mongodb_dbase.c:750]: db_mongodb_store_result(): failed to set the rows in result Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: db_mongodb [mongodb_dbase.c:925]: db_mongodb_query(): failed to store result Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: db_mongodb [mongodb_dbase.c:934]: db_mongodb_query(): failed to do the query Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:79]: db_free_columns(): freeing 3 columns Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[0] at 0x7f2f3ae70ec8 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[1] at 0x7f2f3ae70a18 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[2] at 0x7f2f3ae5a2b0 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:92]: db_free_columns(): freeing result names at 0x7f2f3ae44c90 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:97]: db_free_columns(): freeing result types at 0x7f2f3ae70dc8 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:52]: db_free_rows(): freeing 1000 rows Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_row.c:95]: db_free_row(): freeing row values at 0x7f2f3ae70e20 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:60]: db_free_rows(): freeing rows at 0x7f2f3ae73ba0 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: DEBUG: <core> [db_res.c:134]: db_free_result(): freeing result set at 0x7f2f3ae70688 Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: avpops [avpops_impl.c:381]: ops_dbload_avps(): db_load failed Mar 7 14:45:32 slb04 /usr/local/sbin/kamailio[28073]: ERROR: <script>: bla02
Sent: Tuesday, March 07, 2017 at 8:59 AM From: "Daniel-Constantin Mierla" miconda@gmail.com To: "hdssdsdsdsfsdf hdssdsdsdsfsdf" hdssdsdsdsfsdf@mail.com, sr-users@lists.sip-router.org Subject: Re: [SR-Users] problem with avpops and mongodb modules
Hello,
can you try with current master branch or using the patch from next commit in your version?
https://github.com/kamailio/kamailio/commit/501c41dd35fb9f15fdf96f4f37788603...
I am not able to test these days, but if you report it is working fine, then I can backport to stable branches.
Cheers, Daniel
On 06/03/2017 09:48, hdssdsdsdsfsdf hdssdsdsdsfsdf wrote:
On 22/02/2017 14:35, hsdsdssdfsdf dsasd wrote: > I implemented call forwarding according to > https://www.kamailio.org/wiki/tutorials/mini-howto-admin/call_forwarding, > which is working fine. When I replace db_mysql with db_mongodb > however, I receive an error on "if (avp_db_load("$ruri/username", > "$avp(s:fwd_blind)")) {": > > ERROR: db_mongodb [mongodb_dbase.c:381]: db_mongodb_get_columns(): > field [attribute] not found in result iterator > ERROR: db_mongodb [mongodb_dbase.c:739]: db_mongodb_store_result(): > failed to set the columns > ERROR: db_mongodb [mongodb_dbase.c:918]: db_mongodb_query(): failed to > store result > ERROR: db_mongodb [mongodb_dbase.c:927]: db_mongodb_query(): failed to > do the query > ERROR: avpops [avpops_impl.c:381]: ops_dbload_avps(): db_load failed can you set debug=3 in kamailio.cfg, restart kamailio and test again? Then grab the log messages from syslog and send them here. It should provide more debug information.
Is there a record for this query? Or should be an empty response (no record returned)?
Cheers, Daniel
I used the following to store a forward: avp_db_store("$from/username","$avp(s:fwd_blind)");
Which in this case resulted in (after replacing the true forward info): > db.usr_preferences.find() { "_id" : ObjectId("58ac40f7e498420e0703a2e1"), "uuid" : "", "attribute" : "fwd_blind", "value" : "sip:0003@x.x.x;user=phone", "type" : 0, "username" : "0002", "domain" : null }
After setting: debug=3
... xlog("bla00"); if (avp_db_load("$ruri/username", "$avp(s:fwd_blind)")) { xlog("bla01" ... } xlog("bla02"); ...
The syslog shows (after replacing the true username): Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: <script>: bla00 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:851]: db_mongodb_query(): query to collection [usr_preferences] Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:885]: db_mongodb_query(): query filter: { "username" : "0002", "attribute" : "fwd_blind" } Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:904]: db_mongodb_query(): columns filter: { "value" : 1, "attribute" : 1, "type" : 1 } Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:116]: db_new_result(): allocate 56 bytes for result set at 0x7fa03e54a6a0 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:349]: db_mongodb_get_columns(): 3 columns returned from the query Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:154]: db_allocate_columns(): allocate 24 bytes for result names at 0x7fa03e54a798 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:165]: db_allocate_columns(): allocate 12 bytes for result types at 0x7fa03e549848 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:377]: db_mongodb_get_columns(): Found a field[0] named: value Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:396]: db_mongodb_get_columns(): allocate 16 bytes for RES_NAMES[0] at 0x7fa03e549798 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:431]: db_mongodb_get_columns(): use DB1_STRING result type Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:460]: db_mongodb_get_columns(): RES_NAMES(0x7fa03e549798)[0]=[value] (2) Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: db_mongodb [mongodb_dbase.c:377]: db_mongodb_get_columns(): Found a field[1] named: attribute Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: db_mongodb [mongodb_dbase.c:381]: db_mongodb_get_columns(): field [attribute] not found in result iterator Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: db_mongodb [mongodb_dbase.c:739]: db_mongodb_store_result(): failed to set the columns Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: db_mongodb [mongodb_dbase.c:918]: db_mongodb_query(): failed to store result Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: db_mongodb [mongodb_dbase.c:927]: db_mongodb_query(): failed to do the query Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:79]: db_free_columns(): freeing 3 columns Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[0] at 0x7fa03e549798 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:92]: db_free_columns(): freeing result names at 0x7fa03e54a798 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:97]: db_free_columns(): freeing result types at 0x7fa03e549848 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: DEBUG: <core> [db_res.c:134]: db_free_result(): freeing result set at 0x7fa03e54a6a0 Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: avpops [avpops_impl.c:381]: ops_dbload_avps(): db_load failed Feb 24 10:42:18 slb04 /usr/local/sbin/kamailio[20311]: ERROR: <script>: bla02
When changing to db_mysql the error does not occur. I got the following record there: MariaDB [kamailio]> select * from usr_preferences; +----+------+-------------+--------+-----------+------+-------------------------------------------+---------------------+ | id | uuid | username | domain | attribute | type | value | last_modified | +----+------+-------------+--------+-----------+------+-------------------------------------------+---------------------+ | 26 | | 0002 | | fwd_blind | 0 | sip:0003@x.x.x;user=phone | 1900-01-01 00:00:01 | +----+------+-------------+--------+-----------+------+-------------------------------------------+---------------------+
With the same kamailio.cfg (except for replacing mongodb with mysql) resulting in:
Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: ERROR: <script>: bla00 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:116]: db_new_result(): allocate 56 bytes for result set at 0x7fd17c349800 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:66]: db_mysql_get_columns(): 3 columns returned from the query Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:154]: db_allocate_columns(): allocate 24 bytes for result names at 0x7fd17c32f400 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:165]: db_allocate_columns(): allocate 12 bytes for result types at 0x7fd17c33fae8 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[0] at 0x7fd17c349350 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7fd17c349350)[0]=[value] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[1] at 0x7fd17c349458 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7fd17c349458)[1]=[attribute] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[2] at 0x7fd17c3493a8 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7fd17c3493a8)[2]=[type] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: db_mysql [km_res.c:99]: db_mysql_get_columns(): use DB1_INT result type Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:184]: db_allocate_rows(): allocate 16 bytes for rows at 0x7fd17c33fb98 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_row.c:117]: db_allocate_row(): allocate 96 bytes for row values at 0x7fd17c33f778 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [sip:0003@x.x.x;user=phone] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [fwd_blind] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_val.c:74]: db_str2val(): converting INT [0] Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: avpops [avpops_impl.c:132]: dbrow2avp(): db_flags=3, flags=12 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: avpops [avpops_db.c:265]: db_close_query(): close avp query Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:79]: db_free_columns(): freeing 3 columns Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[0] at 0x7fd17c349350 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[1] at 0x7fd17c349458 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[2] at 0x7fd17c3493a8 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:92]: db_free_columns(): freeing result names at 0x7fd17c32f400 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:97]: db_free_columns(): freeing result types at 0x7fd17c33fae8 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:52]: db_free_rows(): freeing 1 rows Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_row.c:95]: db_free_row(): freeing row values at 0x7fd17c33f778 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:60]: db_free_rows(): freeing rows at 0x7fd17c33fb98 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: <core> [db_res.c:134]: db_free_result(): freeing result set at 0x7fd17c349800 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: DEBUG: avpops [avpops_impl.c:415]: ops_dbload_avps(): loaded avps = 1 Feb 24 11:27:51 slb04 /usr/local/sbin/kamailio[21056]: ERROR: <script>: bla01
-- Daniel-Constantin Mierla www.twitter.com/miconda -- www.linkedin.com/in/miconda Kamailio Advanced Training - Mar 6-8 (Europe) and Mar 20-22 (USA) - www.asipto.com Kamailio World Conference - May 8-10, 2017 - www.kamailioworld.com
-- Daniel-Constantin Mierla www.twitter.com/miconda -- www.linkedin.com/in/miconda Kamailio Advanced Training - Mar 6-8 (Europe) and Mar 20-22 (USA) - www.asipto.com Kamailio World Conference - May 8-10, 2017 - www.kamailioworld.com