Разработчикам

Упал mysql. Нужна помощь

RSS

Пользователь 364535

Заглянувший

Сообщений: 13 Регистрация: 26.08.2015

25.07.2018 11:31:00

Добрый день.

Имеем BitrixVM 7.3.0
На виртуалке закончилось свободное место. В результате сайт стал выдавать такое:

[Bitrix\Main\DB\ConnectionException] Mysql connect error [localhost]: (2002) Connection refused (400)
/home/bitrix/www/bitrix/modules/main/lib/db/mysqliconnection.php:65
#0: Bitrix\Main\DB\MysqliConnection->connectInternal()
/home/bitrix/www/bitrix/modules/main/lib/db/mysqliconnection.php:122
#1: Bitrix\Main\DB\MysqliConnection->queryInternal(string, array, NULL)
/home/bitrix/www/bitrix/modules/main/lib/db/connection.php:330
#2: Bitrix\Main\DB\Connection->query(string)
/home/bitrix/www/bitrix/modules/main/lib/config/option.php:226
#3: Bitrix\Main\Config\Option::load(string, NULL)
/home/bitrix/www/bitrix/modules/main/lib/config/option.php:53
#4: Bitrix\Main\Config\Option::get(string, string, string)
/home/bitrix/www/bitrix/modules/main/lib/httprequest.php:370
#5: Bitrix\Main\HttpRequest->prepareCookie(array)
/home/bitrix/www/bitrix/modules/main/lib/httprequest.php:68
#6: Bitrix\Main\HttpRequest->__construct(object, array, array, array, array)
/home/bitrix/www/bitrix/modules/main/lib/httpapplication.php:46
#7: Bitrix\Main\HttpApplication->initializeContext(array)
/home/bitrix/www/bitrix/modules/main/lib/application.php:122
#8: Bitrix\Main\Application->initializeExtendedKernel(array)
/home/bitrix/www/bitrix/modules/main/include.php:23
#9: require_once(string)
/home/bitrix/www/bitrix/modules/main/include/prolog_before.php:14
#10: require_once(string)
/home/bitrix/www/bitrix/modules/main/include/prolog.php:10
#11: require_once(string)
/home/bitrix/www/bitrix/header.php:1
#12: require(string)
/home/bitrix/www/crm/deal/index.php:2
#13: include_once(string)
/home/bitrix/www/bitrix/modules/main/include/urlrewrite.php:159
#14: include_once(string)
/home/bitrix/www/bitrix/urlrewrite.php:2

В консоль доступ есть. Диск расширили, места достаточно.

Но Mysql не стартует.

systemctl status mysql говорит:

● mysqld.service - MySQL Server
Loaded: loaded (/usr/lib/systemd/system/mysqld.service; enabled; vendor preset: disabled)
Active: activating (start) since Wed 2018-07-25 11:28:59 MSK; 2s ago
Docs: man:mysqld(8)
http://dev.mysql.com/doc/refman/en/using-systemd.html
Process: 18166 ExecStartPre=/usr/bin/mysqld_pre_systemd (code=exited, status=0/SUCCESS)
Control: 18184 (mysqld)
CGroup: /system.slice/mysqld.service
├─18184 /usr/sbin/mysqld --daemonize --pid-file=/var/run/mysqld/mysqld.pid
└─18187 /usr/sbin/mysqld --daemonize --pid-file=/var/run/mysqld/mysqld.pid

Jul 25 11:28:59 bitrix systemd[1]: Starting MySQL Server...

journalctl -xe говорит:

-- Unit mysqld.service has failed.
--
Jul 25 11:26:08 bitrix systemd[1]: mysqld.service failed.
Jul 25 11:26:08 bitrix systemd[1]: mysqld.service holdoff time over, scheduling restart.
Jul 25 11:26:08 bitrix systemd[1]: Starting MySQL Server...
-- Subject: Unit mysqld.service has begun start-up
-- Defined-By: systemd
-- Support: http://lists.freedesktop.org/mailman/listinfo/systemd-devel
--
-- Unit mysqld.service has begun starting up.
Jul 25 11:26:12 bitrix mysqld[15962]: Unable to determine if daemon is running: Success
Jul 25 11:26:12 bitrix systemd[1]: mysqld.service: control process exited, code=exited status=1
Jul 25 11:26:12 bitrix systemd[1]: Failed to start MySQL Server.
-- Subject: Unit mysqld.service has failed
-- Defined-By: systemd
-- Support: http://lists.freedesktop.org/mailman/listinfo/systemd-devel

Подскажите, куда дальше копать?

Пользователь 136059 Гуру Сообщений: 5443 Баллов: 649 Регистрация: 16.07.2012	#2 25.07.2018 11:59:02 юрий белов, а в логах mysql что? Голосуй за идеи по развитию API Bitrix: https://idea.1c-bitrix.ru/26707/ https://idea.1c-bitrix.ru/26709/ https://idea.1c-bitrix.ru/the-local-extension-folder-js/

Пользователь 364535 Заглянувший Сообщений: 13 Регистрация: 26.08.2015	#3 25.07.2018 12:29:51 Логи mysql - https://cloud.mail.ru/public/9Er8/YMXvj8hVw

Пользователь 136059

Гуру

Сообщений: 5443 Баллов: 649 Регистрация: 16.07.2012

25.07.2018 12:49:47

юрий белов, попробуйте остановить nginx, httpd и запустить: mysql, httpd, nginx.
Либо у Вас памяти нехватает на запуск, либо

Скрытый текст

Цитата

06:27:23 UTC - mysqld got signal 6 ;
This could be because you hit a bug. It is also possible that this binary
or one of the libraries it was linked against is corrupt, improperly built,
or misconfigured. This error can also be caused by malfunctioning hardware.
Attempting to collect some information that could help diagnose the problem.
As this is a crash and something is definitely wrong, the information
collection process might fail.
Please help us make Percona Server better by reporting any
bugs at http://bugs.percona.com/

key_buffer_size=12582912
read_buffer_size=131072
max_used_connections=0
max_threads=34
thread_count=0
connection_count=0
It is possible that mysqld could use up to
key_buffer_size + (read_buffer_size + sort_buffer_size)*max_threads = 152160 K bytes of memory
Hope that's ok; if not, decrease some variables in the equation.

Thread pointer: 0x7f8b34000900
Attempting backtrace. You can use the following information to find out
where mysqld died. If you see no messages after this, something went
terribly wrong...
stack_bottom = 7f8b3a7fbcb0 thread_stack 0x20000
/usr/sbin/mysqld(my_print_stacktrace+0x3b)[0xef5c1b]
/usr/sbin/mysqld(handle_fatal_signal+0x471)[0x79b061]
/lib64/libpthread.so.0(+0xf6d0)[0x7f8b6d4ae6d0]
/lib64/libc.so.6(gsignal+0x37)[0x7f8b6b5af277]
/lib64/libc.so.6(abort+0x148)[0x7f8b6b5b0968]
/usr/sbin/mysqld[0x7687ec]
/usr/sbin/mysqld[0x1250067]
/usr/sbin/mysqld(_Z14fseg_free_pagePhmmbP5mtr_t+0x213)[0x12523b3]
/usr/sbin/mysqld(_Z12btr_compressP9btr_cur_tmP5mtr_t+0xdcc)[0x1193dcc]
/usr/sbin/mysqld(_Z26btr_cur_compress_if_usefulP9btr_cur_tmP5mtr_t+0x1cc)[0x11a1c9c]
2018-07-25T06:27:23.546797Z 0 [Note] InnoDB: Loading buffer pool(s) from /var/lib/mysql/ib_buffer_pool
2018-07-25T06:27:23.547405Z 0 [Note] Plugin 'FEDERATED' is disabled.
/usr/sbin/mysqld(_Z26btr_cur_pessimistic_deleteP7dberr_tmP9btr_cur_tmbP5mtr_t+0x659)[0x11a7cf9]
/usr/sbin/mysqld[0x10e4855]
/usr/sbin/mysqld(_Z14row_purge_stepP9que_thr_t+0x7c1)[0x10e72a1]
/usr/sbin/mysqld(_Z15que_run_threadsP9que_thr_t+0x87f)[0x10901cf]
/usr/sbin/mysqld(_Z9trx_purgemmb+0x679)[0x1149fc9]
/usr/sbin/mysqld(srv_purge_coordinator_thread+0xa47)[0x1120b07]
/lib64/libpthread.so.0(+0x7e25)[0x7f8b6d4a6e25]
/lib64/libc.so.6(clone+0x6d)[0x7f8b6b677bad]

Trying to get some variables.
Some pointers may be invalid and cause the dump to abort.
Query (0): Connection ID (thread ID): 0
Status: NOT_KILLED

You may download the Percona Server operations manual by visiting
http://www.percona.com/software/percona-server/. You may find information
in the manual which will help you identify the cause of the crash.

Голосуй за идеи по развитию API Bitrix:
https://idea.1c-bitrix.ru/26707/
https://idea.1c-bitrix.ru/26709/
https://idea.1c-bitrix.ru/the-local-extension-folder-js/

Пользователь 364535

Заглянувший

Сообщений: 13 Регистрация: 26.08.2015

25.07.2018 13:31:20

Цитата
Андрей Николаев написал: попробуйте остановить nginx, httpd и запустить: mysql, httpd, nginx.

Попробовал - скуль не стартует.

Память имеется ввиду оперативная? Как это проверить?

Про выдержку из лога не совсем понял - предлагается уменьшить значения в конфиге?

Пользователь 136059

Гуру

Сообщений: 5443 Баллов: 649 Регистрация: 16.07.2012

25.07.2018 14:54:06

Цитата
юрий белов написал: Попробовал - скуль не стартует.

Т.е. если их потушить (stop), а потом запустить mysql то тоже не стартует?

Цитата
юрий белов написал: Память имеется ввиду оперативная?

Да.

Голосуй за идеи по развитию API Bitrix:
https://idea.1c-bitrix.ru/26707/
https://idea.1c-bitrix.ru/26709/
https://idea.1c-bitrix.ru/the-local-extension-folder-js/

Пользователь 364535

Заглянувший

Сообщений: 13 Регистрация: 26.08.2015

25.07.2018 15:15:38

Цитата
Андрей Николаев написал: Т.е. если их потушить (stop), а потом запустить mysql то тоже не стартует?

именно

Пользователь 364535

Заглянувший

Сообщений: 13 Регистрация: 26.08.2015

25.07.2018 15:16:50

Цитата
Андрей Николаев написал: Память имеется ввиду оперативная?Да.

На 12 пользователей установлено 4 Гб оперы. Может не хватать?
Как можно проверить?

Пользователь 364535 Заглянувший Сообщений: 13 Регистрация: 26.08.2015	#9 25.07.2018 16:53:08 Посыпалась БД. Восстанавливали из дампа руками. Вопрос закрыт.

Пользователь 103705 Постоянный посетитель Сообщений: 153 Баллов: 24 Регистрация: 07.10.2011	#10 08.08.2018 14:08:33 Сегодня получили такую же ошибку! После ночного бекапа. Наткнулся на эту тему, проверил, оказалось нет свободного места на hdd, почистил все заработало! Автору спасибо!

Пользователь 2338003

Заглянувший

Сообщений: 25 Баллов: 1 Регистрация: 26.07.2018

#11

04.09.2018 11:37:01

[Bitrix\Main\DB\ConnectionException]
Mysql connect error [localhost]: (2002) Connection refused (400)
/home/bitrix/www/bitrix/modules/main/lib/db/mysqliconnection.php:65
#0: Bitrix\Main\DB\MysqliConnection->connectInternal()
/home/bitrix/www/bitrix/modules/main/lib/db/mysqliconnection.php:122
#1: Bitrix\Main\DB\MysqliConnection->queryInternal(string, array, NULL)
/home/bitrix/www/bitrix/modules/main/lib/db/connection.php:330
#2: Bitrix\Main\DB\Connection->query(string)
/home/bitrix/www/bitrix/modules/main/lib/config/option.php:226
#3: Bitrix\Main\Config\Option::load(string, NULL)
/home/bitrix/www/bitrix/modules/main/lib/config/option.php:53
#4: Bitrix\Main\Config\Option::get(string, string, string)
/home/bitrix/www/bitrix/modules/main/lib/httprequest.php:370
#5: Bitrix\Main\HttpRequest->prepareCookie(array)
/home/bitrix/www/bitrix/modules/main/lib/httprequest.php:68
#6: Bitrix\Main\HttpRequest->__construct(object, array, array, array, array)
/home/bitrix/www/bitrix/modules/main/lib/httpapplication.php:46
#7: Bitrix\Main\HttpApplication->initializeContext(array)
/home/bitrix/www/bitrix/modules/main/lib/application.php:122
#8: Bitrix\Main\Application->initializeExtendedKernel(array)
/home/bitrix/www/bitrix/modules/main/include.php:23
#9: require_once(string)
/home/bitrix/www/bitrix/modules/main/include/prolog_before.php:14
#10: require_once(string)
/home/bitrix/www/index.php:8

Такая же ошибка, диска хватает, но на всякий случай увеличил. DF показывает, что в загрузочной области занято 70% и это тоже нормально. MySQL не стартует. ЛОГ НЕ ПИШЕТСЯ (/var/log/mysql.log)!!! Как включить логирование?

Екатерина Шемаева

Администратор

Сообщений: 144 Баллов: 18 Регистрация: 08.08.2013

#12

04.09.2018 12:28:14

Цитата

Андрей Лебедев написал:
Такая же ошибка, диска хватает, но на всякий случай увеличил. DF показывает, что в загрузочной области занято 70% и это тоже нормально. MySQL не стартует. ЛОГ НЕ ПИШЕТСЯ (/var/log/mysql.log)!!! Как включить логирование?

В последних версиях вирт. машины лог вынесен в

Код
/var/log/mysql/error.log

Конфиг файл:

Код
/etc/mysql/conf.d/logging.cnf

Посмотрите там.
Если окружение стоит на Centos7, то последние логи можно получить через команду:

Код
journalctl -u mysqld.service

Пользователь 2338003

Заглянувший

Сообщений: 25 Баллов: 1 Регистрация: 26.07.2018

#13

05.09.2018 16:53:07

Цитата

Конфиг файл:

Код
/etc/mysql/conf.d/logging.cnf

Его там не было. Скопировал с рабочей машины - его обнулило. Есть подозрение что он генерируется.

Цитата
Посмотрите там.Если окружение стоит на Centos7, то последние логи можно получить через команду: journalctl -u mysqld.service

Sep 05 16:44:13 ip-192-168-0-10.is74.loc systemd[1]: Starting MySQL Server...
Sep 05 16:44:15 ip-192-168-0-10.is74.loc mysqld[855]: 2018-09-05T13:44:14.183176
Sep 05 16:44:15 ip-192-168-0-10.is74.loc mysqld[855]: 2018-09-05T13:44:14.188026
Sep 05 16:44:15 ip-192-168-0-10.is74.loc mysqld[855]: 2018-09-05T13:44:15.093432

Через некоторое время

Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: InnoDB: Failing assertion:
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: InnoDB: We intentionally g
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: InnoDB: Submit a detailed
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: InnoDB: If you get repeate
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: InnoDB: immediately after
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: InnoDB: corruption in the
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: InnoDB: http://dev.mysql.c
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: InnoDB: about forcing reco
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: 13:44:02 UTC - mysqld got
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: This could be because you
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: or one of the libraries it
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: or misconfigured. This err
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: Attempting to collect some
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: As this is a crash and som
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: collection process might f
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: Please help us make Percon
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: bugs at http://bugs.percon
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: key_buffer_size=25165824
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: read_buffer_size=131072
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: max_used_connections=0
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: max_threads=36
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: thread_count=0
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: connection_count=0
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: It is possible that mysqld
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: key_buffer_size + (read_bu
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: Hope that's ok; if not, de
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: Thread pointer: 0x7f550800
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: Attempting backtrace. You
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: where mysqld died. If you
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: terribly wrong...
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: 2018-09-05T13:44:02.036378
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: 2018-09-05T13:44:02.037834
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: 2018-09-05T13:44:02.040425
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: stack_bottom = 7f5514a31cb
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: /usr/sbin/mysqld(my_print_
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: /usr/sbin/mysqld(handle_fa
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: /lib64/libpthread.so.0(+0x
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: /lib64/libc.so.6(gsignal+0
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: /lib64/libc.so.6(abort+0x1
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: /usr/sbin/mysqld[0x7687ec]
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: /usr/sbin/mysqld[0x7682da]
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: /usr/sbin/mysqld[0x11452f5
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: /usr/sbin/mysqld[0x114740e
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: /usr/sbin/mysqld(_Z9trx_pu
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: /usr/sbin/mysqld(srv_purge
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: /lib64/libpthread.so.0(+0x
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: /lib64/libc.so.6(clone+0x6
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: Trying to get some variabl
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: Some pointers may be inval
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: Query (0): Connection ID (
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: Status: NOT_KILLED
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: You may download the Perco
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: http://www.percona.com/sof
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: in the manual which will h
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: /usr/sbin/mysqld[0x114740e
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: /usr/sbin/mysqld(_Z9trx_pu
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: /usr/sbin/mysqld(srv_purge
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: /lib64/libpthread.so.0(+0x
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: /lib64/libc.so.6(clone+0x6
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: Trying to get some variabl
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: Some pointers may be inval
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: Query (0): Connection ID (
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: Status: NOT_KILLED
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: You may download the Perco

Sep 05 16:44:02 ip-192-168-0-10.is74.loc systemd[1]: Starting MySQL Server...

Что это такое?

Пользователь 2338003

Заглянувший

Сообщений: 25 Баллов: 1 Регистрация: 26.07.2018

#14

12.09.2018 13:08:22

Цитата

Андрей Лебедев написал:

Цитата

Конфиг файл:

Код
/etc/mysql/conf.d/logging.cnf

Его там не было. Скопировал с рабочей машины - его обнулило. Есть подозрение что он генерируется.

Цитата
Посмотрите там.Если окружение стоит на Centos7, то последние логи можно получить через команду: journalctl -u mysqld.service

Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: Trying to get some variabl
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: Some pointers may be inval
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: Query (0): Connection ID (
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: Status: NOT_KILLED
Sep 05 16:44:02 ip-192-168-0-10.is74.loc mysqld[855]: You may download the Perco

Sep 05 16:44:02 ip-192-168-0-10.is74.loc systemd[1]: Starting MySQL Server...

Что это такое?

Рухнула системная таблица и пользовательские таблицы - сообщил мне опытный коллега. Бэкапов нет -

Упал mysql. Нужна помощь

Продукты

Управление сайтом

Битрикс24

Интернет-магазин + CRM

Решения

Для интернет-магазинов

Каталог готовых решений

Внедрение

Выбрать партнера

Проверить партнера

Стать партнером