[OpenSIPS-Users] Opensips crash while connecting mariadb

Virendra Bhati virendra at cloud-connect.in
Wed Oct 30 03:56:44 EDT 2019 

Dear Team,

We are using opensips 3.0.1 with mariadb 10.4.8 . We are facing issue at
starting opensips. As opensips crash with below given message:

Oct 15 03:27:17 [22849] DBG:core:find_mod_export: found <db_bind_api> in
module db_mysql [/usr/local/lib64/opensips/modules/]
Oct 15 03:27:17 [22849] DBG:core:db_bind_mod: using db bind api for db_mysql
Oct 15 03:27:17 [22849] DBG:core:db_do_init: connection 0x7fba0e093510 not
found in pool
Got ERROR: "InnoDB: Unable to lock /var/lib/mysql/ibdata1 error: 11" errno:
2000

I have attached logs and backtrace from core  so please provide your
suggestions. Please note credentials given in db_url are working while
using from mysql client


--
Regards
Virendra Bhati
Lead- Architecture and Software Solutions
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.opensips.org/pipermail/users/attachments/20191030/dfb9da26/attachment.html>
-------------- next part --------------
Oct 15 03:27:17 [22849] INFO:core:evi_publish_event: Registered event <E_DLG_STATE_CHANGED(11)>
Oct 15 03:27:17 [22849] DBG:core:find_cmd_export_t: found <load_tm> in module tm [/usr/local/lib64/opensips/modules/]
Oct 15 03:27:17 [22849] DBG:core:find_cmd_export_t: found <load_rr> in module rr [/usr/local/lib64/opensips/modules/]
Oct 15 03:27:17 [22849] DBG:core:find_mod_export: found <db_bind_api> in module db_mysql [/usr/local/lib64/opensips/modules/]
Oct 15 03:27:17 [22849] DBG:core:db_bind_mod: using db bind api for db_mysql
Oct 15 03:27:17 [22849] DBG:core:db_do_init: connection 0x7fba0e093510 not found in pool
Got ERROR: "InnoDB: Unable to lock /var/lib/mysql/ibdata1 error: 11" errno: 2000
Got ERROR: "InnoDB: Unable to lock /var/lib/mysql/ibdata1 error: 11" errno: 2000
Got ERROR: "InnoDB: Unable to lock /var/lib/mysql/ibdata1 error: 11" errno: 2000
Got ERROR: "InnoDB: Unable to lock /var/lib/mysql/ibdata1 error: 11" errno: 2000
Got ERROR: "InnoDB: Unable to lock /var/lib/mysql/ibdata1 error: 11" errno: 2000
Got ERROR: "InnoDB: Unable to lock /var/lib/mysql/ibdata1 error: 11" errno: 2000
Got ERROR: "InnoDB: Unable to lock /var/lib/mysql/ibdata1 error: 11" errno: 2000

Got ERROR: "InnoDB: Operating system error number 11 in a file operation." errno: 2000
Got ERROR: "InnoDB: Error number 11 means 'Resource temporarily unavailable'" errno: 2000
Got ERROR: "InnoDB: Cannot open datafile '/var/lib/mysql/ibdata1'" errno: 2000
Got ERROR: "InnoDB: Could not open or create the system tablespace. If you tried to add new data files to the system tablespace, and it failed here, you should now edit innodb_data_file_path in my.cnf back to what it was, and remove the new ibdata files InnoDB created in this failed attempt. InnoDB only wrote those files full of zeros, but did not yet use them in any way. But be careful: do not remove old data files which contain your precious data!" errno: 2000
Got ERROR: "InnoDB: Plugin initialization aborted with error Cannot open a file" errno: 2000
Got ERROR: "Plugin 'InnoDB' init function returned error." errno: 2000
Got ERROR: "Plugin 'InnoDB' registration as a STORAGE ENGINE failed." errno: 2000
Got ERROR: "unknown: Can't lock aria control file '/var/lib/mysql/aria_log_control' for exclusive use, error: 11. Will retry for 30 seconds" errno: 2000



^C^CGot ERROR: "unknown: Got error 'Could not get an exclusive lock; file is probably in use by another process' when trying to use aria control file '/var/lib/mysql/aria_log_control'" errno: 2000
Got ERROR: "Plugin 'Aria' init function returned error." errno: 2000
Got ERROR: "Plugin 'Aria' registration as a STORAGE ENGINE failed." errno: 2000
Got ERROR: "Unknown/unsupported storage engine: InnoDB" errno: 2000
 DBG:db_mysql:db_mysql_connect: opening connection: mysql://xxxx:xxxx@localhost/cc_master
CRITICAL:core:sig_usr: segfault in attendant (starter) process!
DBG:core:restore_segv_handler: restoring SIGSEGV handler...
 DBG:core:restore_segv_handler: successfully restored system SIGSEGV handler
^CSegmentation fault (core dumped)

-------------- next part --------------
(gdb) bt full
#0  intern_plugin_lock (lex=0x0, state_mask=14, rc=0x0)
    at /usr/src/debug/MariaDB-10.3.18/src_0/sql/sql_plugin.cc:948
        pi = 0x0
#1  plugin_thdvar_init (thd=0x28af578) at /usr/src/debug/MariaDB-10.3.18/src_0/sql/sql_plugin.cc:3155
        old_table_plugin = 0x0
        old_tmp_table_plugin = 0x0
        old_enforced_table_plugin = 0x0
#2  0x00007fc7d58722b1 in THD::init (this=this at entry=0x28af578)
    at /usr/src/debug/MariaDB-10.3.18/src_0/sql/sql_class.cc:1177
No locals.
#3  0x00007fc7d587310a in THD::THD (this=0x28af578, id=<optimized out>, is_wsrep_applier=<optimized out>)
    at /usr/src/debug/MariaDB-10.3.18/src_0/sql/sql_class.cc:798
        tmp = <optimized out>
#4  0x00007fc7d57f2bdc in create_embedded_thd (client_flag=client_flag at entry=-2143837683)
    at /usr/src/debug/MariaDB-10.3.18/src_0/libmysqld/lib_sql.cc:685
        thd = 0x7fff689c20b0
#5  0x00007fc7d57fa1e4 in mysql_real_connect (mysql=0x7fc7da7190b0, host=<optimized out>, user=<optimized out>, 
    passwd=<optimized out>, db=0x7fc7da717620 "cc_master", port=port at entry=0, unix_socket=unix_socket at entry=0x0, 
    client_flag=2151129613, client_flag at entry=2147549184)
    at /usr/src/debug/MariaDB-10.3.18/src_0/libmysqld/libmysqld.c:179
        name_buff = "\200\314|\326\307\177\000\000\060!\234h\377\177\000\000 !\234h\377\177\000\000\060!\234h\377\177\000\000\200\314|\326\307\177\000\000\001\000\000\000\000\000\000\000\340r\242\000\000\000\000\000p\251\215\000\000\000\000\000\340r\242\000\000\000\000\000\270\"\234h\377\177\000\000 vq\332\307\177\000\000\362\344s\333\307\177\000\000\000\000\000\000\000\000\000\000\060\000\000\000\060\000\000\000\060\"\234h\377\177\000\000P!\234h\377\177", '\000' <repeats 26 times>, "\224*\207\333\307\177\000\000\005+\207\333\307\177\000\000\300\061\253\333\307\177\000\000\200\363\252\333\307\177\000\000c\226u\333\307\177\000\000 vq\332\307\177\000\000"...
#6  0x00007fc7d70e8a63 in db_mysql_connect (ptr=ptr at entry=0x7fc7da717668) at my_con.c:105
        reconnect = 0 '\000'
---Type <return> to continue, or q <return> to quit---
        __FUNCTION__ = "db_mysql_connect"
#7  0x00007fc7d70e94ff in db_mysql_new_connection (id=0x7fc7da717510) at my_con.c:165
        ptr = 0x7fc7da717668
        __FUNCTION__ = "db_mysql_new_connection"
#8  0x00000000005ec4ba in db_do_init (url=<optimized out>, 
    new_connection=0x7fc7d70e9417 <db_mysql_new_connection>) at db/db.c:338
        id = 0x7fc7da717510
        con = <optimized out>
        res = 0x7fc7da717468
        con_size = <optimized out>
        __FUNCTION__ = "db_do_init"
#9  0x00007fc7d01044cd in dlg_connect_db (db_url=db_url at entry=0x7fc7d0340610 <db_url>) at dlg_db_handler.c:135
        __FUNCTION__ = "dlg_connect_db"
#10 0x00007fc7d0104511 in init_dlg_db (db_url=db_url at entry=0x7fc7d0340610 <db_url>, 
    dlg_hash_size=<optimized out>, db_update_period=60) at dlg_db_handler.c:176
        __FUNCTION__ = "init_dlg_db"
#11 0x00007fc7d0100c27 in mod_init () at dialog.c:900
        n = <optimized out>
        __FUNCTION__ = "mod_init"
#12 0x000000000050bfa7 in init_mod (m=0x7fc7da6face0, skip_others=skip_others at entry=0) at sr_module.c:697
        dep = <optimized out>
        __FUNCTION__ = "init_mod"
#13 0x000000000050c028 in init_mod (m=0x7fc7da6fb970, skip_others=skip_others at entry=0) at sr_module.c:678
        dep = <optimized out>
        __FUNCTION__ = "init_mod"
#14 0x000000000050c028 in init_mod (m=0x7fc7da6fbd28, skip_others=skip_others at entry=0) at sr_module.c:678
        dep = <optimized out>
        __FUNCTION__ = "init_mod"
---Type <return> to continue, or q <return> to quit---
#15 0x000000000050c028 in init_mod (m=0x7fc7da6fbeb8, skip_others=skip_others at entry=0) at sr_module.c:678
        dep = <optimized out>
        __FUNCTION__ = "init_mod"
#16 0x000000000050c028 in init_mod (m=0x7fc7da6fc0c0, skip_others=skip_others at entry=0) at sr_module.c:678
        dep = <optimized out>
        __FUNCTION__ = "init_mod"
#17 0x000000000050c028 in init_mod (m=0x7fc7da6fc340, skip_others=skip_others at entry=0) at sr_module.c:678
        dep = <optimized out>
        __FUNCTION__ = "init_mod"
#18 0x000000000050c028 in init_mod (m=0x7fc7da6fc4d8, skip_others=skip_others at entry=0) at sr_module.c:678
        dep = <optimized out>
        __FUNCTION__ = "init_mod"
#19 0x000000000050c028 in init_mod (m=0x7fc7da6fd488, skip_others=skip_others at entry=0) at sr_module.c:678
        dep = <optimized out>
        __FUNCTION__ = "init_mod"
#20 0x000000000050c028 in init_mod (m=0x7fc7da6fde20, skip_others=skip_others at entry=0) at sr_module.c:678
        dep = <optimized out>
        __FUNCTION__ = "init_mod"
#21 0x000000000050f45d in init_modules () at sr_module.c:759
        currentMod = 0x0
        ret = <optimized out>
        __FUNCTION__ = "init_modules"
#22 0x0000000000420351 in main (argc=<optimized out>, argv=<optimized out>) at main.c:1421
        c = <optimized out>
        r = <optimized out>
        tmp = 0x1 <Address 0x1 out of bounds>
        tmp_len = <optimized out>
        port = <optimized out>
---Type <return> to continue, or q <return> to quit---
        proto = <optimized out>
        protos_no = <optimized out>
        options = 0x67e9f8 "f:cCm:M:b:l:n:N:rRvdDFEVhw:t:u:g:p:P:G:W:o:a:k:s:"
        ret = -1
        seed = 961253727
        rfd = <optimized out>
        __FUNCTION__ = "main"

More information about the Users mailing list