Ми використовуємо файли cookies для оптимізації контенту та швидкодії сайту. Продовжуючи відвідування сайту, ви погоджуєтесь на використання файлів cookies.
Добрий день. Судячи з логів на VPS спостерігаються проблеми або з апаратною частиною червера, або з БД. Зверніться до хостера, хай перевірять ваш сервер. Помилки виявилися Feb 27 03:07:35, потім Feb 27 03:09:44 з'явилися помилки БД, о 03:14:22 помилки перестали з'являтися. Feb 27 14:32:43 Знову з'явилися помилки БД. Feb 27 14:49:30 система перезапустила сервіс БД і помилки зникли. Feb 27 16:21:01 все повторилося Feb 27 16:43:06 система перезапустила сервіс БД знову помилки та Feb 27 19:50:02 система перезапустила сервіс БД. Feb 27 03:06:15 box systemd: Started Session 929500 user root. Feb 27 03:07:35 box kernel: INFO: task nginx:22158 blocked for more than 120 seconds. Feb 27 03:07:35 box kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Feb 27 03:07:35 box kernel: nginx D 0000000000000000 0 22158 27029 0x00000080 Feb 27 03:07:35 box kernel: ffff88000f127eb0 0000000000000282 ffff88003aefde20 ffff88000f127fd8 Feb 27 03:07:35 box kernel: ffff88000f127fd8 ffff88000f127fd8 ffff88003aefde20 ffff880002bfb6d8 Feb 27 03:07:35 box kernel: ffff880002bfb6dc ffff88003aefde20 00000000ffffffff ffff880002bfb6e0 Feb 27 03:07:35 box kernel: Call Trace: Feb 27 03:07:35 box kernel: [<ffffffffff8168d8e9>] schedule_preempt_disabled+0x29/0x70 Feb 27 03:07:35 box kernel: [<ffffffff8168b535>] __mutex_lock_slowpath+0xc5/0x1d0 Feb 27 03:07:35 box kernel: [<ffffffff8168a98f>] mutex_lock+0x1f/0x2f Feb 27 03:07:35 box kernel: [<ffffffffff811ff505>] SyS_write+0x65/0xe0 Feb 27 03:07:35 box kernel: [<ffffffff81697809>] system_call_fastpath+0x16/0x1b ... Feb 27 03:09:37 box kernel: Call Trace: Feb 27 03:09:37 box kernel: [<ffffffff8168d8e9>] schedule_preempt_disabled+0x29/0x70 Feb 27 03:09:37 box kernel: [<ffffffff8168b535>] __mutex_lock_slowpath+0xc5/0x1d0 Feb 27 03:09:37 box kernel: [<ffffffff8168a98f>] mutex_lock+0x1f/0x2f Feb 27 03:09:37 box kernel: [<ffffffff812ca326>] ima_file_check+0xa6/0x1b0 Feb 27 03:09:37 box kernel: [<ffffffff8120d76a>] do_last+0x58a/0x12a0 Feb 27 03:09:37 box kernel: [<ffffffff8120e542>] path_openat+0xc2/0x490 Feb 27 03:09:37 box kernel: [<ffffffff81180c2b>] ? unlock_page+0x2b/0x30 Feb 27 03:09:37 box kernel: [<ffffffff812106bb>] do_filp_open+0x4b/0xb0 Feb 27 03:09:37 box kernel: [<ffffffff8121d337>] ? __alloc_fd+0xa7/0x130 Feb 27 03:09:37 box kernel: [<ffffffff811fdbc3>] do_sys_open+0xf3/0x1f0 Feb 27 03:09:37 box kernel: [<ffffffffff811fdcde>] SyS_open+0x1e/0x20 Feb 27 03:09:37 box kernel: [<ffffffff81697809>] system_call_fastpath+0x16/0x1b Feb 27 03:09:44 box mysqld: 2021-02-27 3:09:44 140608296249088 [Warning] InnoDB: A long semaphore wait: Feb 27 03:09:44 box mysqld: --Thread 140608094070528 waited at log0log.cc line 1090 for 241.00 seconds the semaphore: Feb 27 03:09:44 box mysqld: Mutex at 0x7fe249ac2740, Mutex LOG_WRITE created log0log.cc:661, lock var 2 Feb 27 03:09:44 box mysqld: 2021-02-27 3:09:44 140608296249088 [Warning] InnoDB: A long semaphore wait: Feb 27 03:09:44 box mysqld: --Thread 140608185423616 waited at log0log.cc line 1090 for 241.00 seconds the semaphore: Feb 27 03:09:44 box mysqld: Mutex at 0x7fe249ac2740, Mutex LOG_WRITE created log0log.cc:661, lock var 2 Feb 27 03:09:44 box mysqld: 2021-02-27 3:09:44 140608296249088 [Warning] InnoDB: A long semaphore wait: ... Feb 27 03:14:22 box mysqld: 0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 1609.08 reads/s Feb 27 03:14:22 box mysqld: ---------------------------- Feb 27 03:14:22 box mysqld: END OF INNODB MONITOR OUTPUT Feb 27 03:14:22 box mysqld: ============================ Feb 27 03:14:22 box mysqld: InnoDB: ###### Diagnostic info printed to the standard error stream ... Feb 27 14:32:43 box mysqld: 2021-02-27 14:32:43 140608296249088 [Warning] InnoDB: A long semaphore wait: Feb 27 14:32:43 box mysqld: --Thread 140608170895104 waited at log0log.cc line 1090 for 241.00 seconds the semaphore: Feb 27 14:32:43 box mysqld: Mutex at 0x7fe249ac2740, Mutex LOG_WRITE created log0log.cc:661, lock var 2 Feb 27 14:32:43 box mysqld: 2021-02-27 14:32:43 140608296249088 [Note] InnoDB: A semaphore wait: Feb 27 14:32:43 box mysqld: --Thread 140608094070528 waited at log0log.cc line 1090 for 240.00 seconds the semaphore: Feb 27 14:32:43 box mysqld: Mutex at 0x7fe249ac2740, Mutex LOG_WRITE created log0log.cc:661, lock var 2 Feb 27 14:32:43 box mysqld: 2021-02-27 14:32:43 140608296249088 [Note] InnoDB: A semaphore wait: Feb 27 14:32:43 box mysqld: --Thread 140608085677824 waited at log0log.cc line 1090 for 231.00 seconds the semaphore: Feb 27 14:32:43 box mysqld: Mutex at 0x7fe249ac2740, Mutex LOG_WRITE created log0log.cc:661, lock var 2 Feb 27 14:32:43 box mysqld: 2021-02-27 14:32:43 140608296249088 [Note] InnoDB: A semaphore wait: Feb 27 14:32:43 box mysqld: --Thread 140608172738304 waited at dict0dict.cc line 1148 for 210.00 seconds the semaphore: Feb 27 14:32:43 box mysqld: Mutex на 0x7fe249ad2b10, Mutex DICT_SYS створений dict0dict.cc:1084, lock var 2 Feb 27 14:32:43 box mysqld: 2021-02-27 14:32:43 140608296249088 [Note] InnoDB: A semaphore wait: Feb 27 14:32:43 box mysqld: --Thread 140608277927680 waited at dict0dict.cc line 1148 for 231.00 seconds the semaphore: ... Feb 27 14:49:24 box mysqld: Fatal signal 11 while backtracing Feb 27 14:49:25 box systemd: mariadb.service: main process exited, code=killed, status=11/SEGV Feb 27 14:49:25 box systemd: Unit mariadb.service entered failed state. Feb 27 14:49:25 box systemd: mariadb.service failed. Feb 27 14:49:27 box systemd: Started Session 930278 of user root. Feb 27 14:49:28 box systemd: Removed slice user-0.slice. Feb 27 14:49:29 box systemd: Created slice user-0.slice. Feb 27 14:49:29 box systemd: Started Session 930280 user root. Feb 27 14:49:30 box systemd: Removed slice user-0.slice. Feb 27 14:49:30 box systemd: mariadb.service holdoff time over, scheduling restart. Feb 27 14:49:30 box systemd: Stopped MariaDB 10.2.31 database server. Feb 27 14:49:30 box systemd: Starting MariaDB 10.2.31 database server... ... Feb 27 16:21:01 box systemd: Started Session 930386 of user root. Feb 27 16:21:48 box mysqld: 2021-02-27 16:21:48 139650684249856 [Warning] InnoDB: A long semaphore wait: Feb 27 16:21:48 box mysqld: --Thread 139650589792000 waited at log0log.cc line 1090 for 241.00 seconds the semaphore: Feb 27 16:21:48 box mysqld: Mutex at 0x7f0354c75740, Mutex LOG_WRITE created log0log.cc:661, lock var 2 Feb 27 16:21:48 box mysqld: 2021-02-27 16:21:48 139650684249856 [Warning] InnoDB: A long semaphore wait: Feb 27 16:21:48 box mysqld: --Thread 139650573006592 waited at log0log.cc line 1090 for 241.00 seconds the semaphore: ... Feb 27 16:43:01 box systemd: mariadb.service failed. Feb 27 16:43:04 box systemd: Removed slice user-0.slice. Feb 27 16:43:06 box systemd: mariadb.service holdoff time over, scheduling restart. Feb 27 16:43:06 box systemd: Stopped MariaDB 10.2.31 database server. Feb 27 16:43:06 box systemd: Starting MariaDB 10.2.31 database server... ... Feb 27 17:05:01 box systemd: Started Session 930436 of user root. Feb 27 17:05:03 box mysqld: 2021-02-27 17:05:03 140274492507904 [Warning] InnoDB: A long semaphore wait: Feb 27 17:05:03 box mysqld: --Thread 140274500900608 waited at log0log.cc line 1090 for 241.00 seconds the semaphore: Feb 27 17:05:03 box mysqld: Mutex at 0x7f9499533740, Mutex LOG_WRITE created log0log.cc:661, lock var 2 Feb 27 17:05:03 box mysqld: 2021-02-27 17:05:03 140274492507904 [Warning] InnoDB: A long semaphore wait: Feb 27 17:05:03 box mysqld: --Thread 140274484115200 has waited at srv0srv.cc line 2084 for 241.00 seconds the semaphore: ... Feb 27 19:50:02 box systemd: Removed slice user-0.slice. Feb 27 19:50:02 box systemd: mariadb.service holdoff time over, scheduling restart. Feb 27 19:50:02 box systemd: Stopped MariaDB 10.2.31 database server. Feb 27 19:50:02 box systemd: Starting MariaDB 10.2.31 database server...
Добрий день.
Судячи з логів на VPS спостерігаються проблеми або з апаратною частиною червера, або з БД.
Зверніться до хостера, хай перевірять ваш сервер.
Помилки виявилися Feb 27 03:07:35,
потім Feb 27 03:09:44 з'явилися помилки БД, о 03:14:22 помилки перестали з'являтися.
Feb 27 14:32:43 Знову з'явилися помилки БД.
Feb 27 14:49:30 система перезапустила сервіс БД і помилки зникли.
Feb 27 16:21:01 все повторилося Feb 27 16:43:06 система перезапустила сервіс БД
знову помилки та Feb 27 19:50:02 система перезапустила сервіс БД.
Feb 27 03:06:15 box systemd: Started Session 929500 user root.
Feb 27 03:07:35 box kernel: INFO: task nginx:22158 blocked for more than 120 seconds.
Feb 27 03:07:35 box kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Feb 27 03:07:35 box kernel: nginx D 0000000000000000 0 22158 27029 0x00000080
Feb 27 03:07:35 box kernel: ffff88000f127eb0 0000000000000282 ffff88003aefde20 ffff88000f127fd8
Feb 27 03:07:35 box kernel: ffff88000f127fd8 ffff88000f127fd8 ffff88003aefde20 ffff880002bfb6d8
Feb 27 03:07:35 box kernel: ffff880002bfb6dc ffff88003aefde20 00000000ffffffff ffff880002bfb6e0
Feb 27 03:07:35 box kernel: Call Trace:
Feb 27 03:07:35 box kernel: [<ffffffffff8168d8e9>] schedule_preempt_disabled+0x29/0x70
Feb 27 03:07:35 box kernel: [<ffffffff8168b535>] __mutex_lock_slowpath+0xc5/0x1d0
Feb 27 03:07:35 box kernel: [<ffffffff8168a98f>] mutex_lock+0x1f/0x2f
Feb 27 03:07:35 box kernel: [<ffffffffff811ff505>] SyS_write+0x65/0xe0
Feb 27 03:07:35 box kernel: [<ffffffff81697809>] system_call_fastpath+0x16/0x1b
...
Feb 27 03:09:37 box kernel: Call Trace:
Feb 27 03:09:37 box kernel: [<ffffffff8168d8e9>] schedule_preempt_disabled+0x29/0x70
Feb 27 03:09:37 box kernel: [<ffffffff8168b535>] __mutex_lock_slowpath+0xc5/0x1d0
Feb 27 03:09:37 box kernel: [<ffffffff8168a98f>] mutex_lock+0x1f/0x2f
Feb 27 03:09:37 box kernel: [<ffffffff812ca326>] ima_file_check+0xa6/0x1b0
Feb 27 03:09:37 box kernel: [<ffffffff8120d76a>] do_last+0x58a/0x12a0
Feb 27 03:09:37 box kernel: [<ffffffff8120e542>] path_openat+0xc2/0x490
Feb 27 03:09:37 box kernel: [<ffffffff81180c2b>] ? unlock_page+0x2b/0x30
Feb 27 03:09:37 box kernel: [<ffffffff812106bb>] do_filp_open+0x4b/0xb0
Feb 27 03:09:37 box kernel: [<ffffffff8121d337>] ? __alloc_fd+0xa7/0x130
Feb 27 03:09:37 box kernel: [<ffffffff811fdbc3>] do_sys_open+0xf3/0x1f0
Feb 27 03:09:37 box kernel: [<ffffffffff811fdcde>] SyS_open+0x1e/0x20
Feb 27 03:09:37 box kernel: [<ffffffff81697809>] system_call_fastpath+0x16/0x1b
Feb 27 03:09:44 box mysqld: 2021-02-27 3:09:44 140608296249088 [Warning] InnoDB: A long semaphore wait:
Feb 27 03:09:44 box mysqld: --Thread 140608094070528 waited at log0log.cc line 1090 for 241.00 seconds the semaphore:
Feb 27 03:09:44 box mysqld: Mutex at 0x7fe249ac2740, Mutex LOG_WRITE created log0log.cc:661, lock var 2
Feb 27 03:09:44 box mysqld: 2021-02-27 3:09:44 140608296249088 [Warning] InnoDB: A long semaphore wait:
Feb 27 03:09:44 box mysqld: --Thread 140608185423616 waited at log0log.cc line 1090 for 241.00 seconds the semaphore:
Feb 27 03:09:44 box mysqld: Mutex at 0x7fe249ac2740, Mutex LOG_WRITE created log0log.cc:661, lock var 2
Feb 27 03:09:44 box mysqld: 2021-02-27 3:09:44 140608296249088 [Warning] InnoDB: A long semaphore wait:
...
Feb 27 03:14:22 box mysqld: 0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 1609.08 reads/s
Feb 27 03:14:22 box mysqld: ----------------------------
Feb 27 03:14:22 box mysqld: END OF INNODB MONITOR OUTPUT
Feb 27 03:14:22 box mysqld: ============================
Feb 27 03:14:22 box mysqld: InnoDB: ###### Diagnostic info printed to the standard error stream
...
Feb 27 14:32:43 box mysqld: 2021-02-27 14:32:43 140608296249088 [Warning] InnoDB: A long semaphore wait:
Feb 27 14:32:43 box mysqld: --Thread 140608170895104 waited at log0log.cc line 1090 for 241.00 seconds the semaphore:
Feb 27 14:32:43 box mysqld: Mutex at 0x7fe249ac2740, Mutex LOG_WRITE created log0log.cc:661, lock var 2
Feb 27 14:32:43 box mysqld: 2021-02-27 14:32:43 140608296249088 [Note] InnoDB: A semaphore wait:
Feb 27 14:32:43 box mysqld: --Thread 140608094070528 waited at log0log.cc line 1090 for 240.00 seconds the semaphore:
Feb 27 14:32:43 box mysqld: Mutex at 0x7fe249ac2740, Mutex LOG_WRITE created log0log.cc:661, lock var 2
Feb 27 14:32:43 box mysqld: 2021-02-27 14:32:43 140608296249088 [Note] InnoDB: A semaphore wait:
Feb 27 14:32:43 box mysqld: --Thread 140608085677824 waited at log0log.cc line 1090 for 231.00 seconds the semaphore:
Feb 27 14:32:43 box mysqld: Mutex at 0x7fe249ac2740, Mutex LOG_WRITE created log0log.cc:661, lock var 2
Feb 27 14:32:43 box mysqld: 2021-02-27 14:32:43 140608296249088 [Note] InnoDB: A semaphore wait:
Feb 27 14:32:43 box mysqld: --Thread 140608172738304 waited at dict0dict.cc line 1148 for 210.00 seconds the semaphore:
Feb 27 14:32:43 box mysqld: Mutex на 0x7fe249ad2b10, Mutex DICT_SYS створений dict0dict.cc:1084, lock var 2
Feb 27 14:32:43 box mysqld: 2021-02-27 14:32:43 140608296249088 [Note] InnoDB: A semaphore wait:
Feb 27 14:32:43 box mysqld: --Thread 140608277927680 waited at dict0dict.cc line 1148 for 231.00 seconds the semaphore:
...
Feb 27 14:49:24 box mysqld: Fatal signal 11 while backtracing
Feb 27 14:49:25 box systemd: mariadb.service: main process exited, code=killed, status=11/SEGV
Feb 27 14:49:25 box systemd: Unit mariadb.service entered failed state.
Feb 27 14:49:25 box systemd: mariadb.service failed.
Feb 27 14:49:27 box systemd: Started Session 930278 of user root.
Feb 27 14:49:28 box systemd: Removed slice user-0.slice.
Feb 27 14:49:29 box systemd: Created slice user-0.slice.
Feb 27 14:49:29 box systemd: Started Session 930280 user root.
Feb 27 14:49:30 box systemd: Removed slice user-0.slice.
Feb 27 14:49:30 box systemd: mariadb.service holdoff time over, scheduling restart.
Feb 27 14:49:30 box systemd: Stopped MariaDB 10.2.31 database server.
Feb 27 14:49:30 box systemd: Starting MariaDB 10.2.31 database server...
...
Feb 27 16:21:01 box systemd: Started Session 930386 of user root.
Feb 27 16:21:48 box mysqld: 2021-02-27 16:21:48 139650684249856 [Warning] InnoDB: A long semaphore wait:
Feb 27 16:21:48 box mysqld: --Thread 139650589792000 waited at log0log.cc line 1090 for 241.00 seconds the semaphore:
Feb 27 16:21:48 box mysqld: Mutex at 0x7f0354c75740, Mutex LOG_WRITE created log0log.cc:661, lock var 2
Feb 27 16:21:48 box mysqld: 2021-02-27 16:21:48 139650684249856 [Warning] InnoDB: A long semaphore wait:
Feb 27 16:21:48 box mysqld: --Thread 139650573006592 waited at log0log.cc line 1090 for 241.00 seconds the semaphore:
...
Feb 27 16:43:01 box systemd: mariadb.service failed.
Feb 27 16:43:04 box systemd: Removed slice user-0.slice.
Feb 27 16:43:06 box systemd: mariadb.service holdoff time over, scheduling restart.
Feb 27 16:43:06 box systemd: Stopped MariaDB 10.2.31 database server.
Feb 27 16:43:06 box systemd: Starting MariaDB 10.2.31 database server...
...
Feb 27 17:05:01 box systemd: Started Session 930436 of user root.
Feb 27 17:05:03 box mysqld: 2021-02-27 17:05:03 140274492507904 [Warning] InnoDB: A long semaphore wait:
Feb 27 17:05:03 box mysqld: --Thread 140274500900608 waited at log0log.cc line 1090 for 241.00 seconds the semaphore:
Feb 27 17:05:03 box mysqld: Mutex at 0x7f9499533740, Mutex LOG_WRITE created log0log.cc:661, lock var 2
Feb 27 17:05:03 box mysqld: 2021-02-27 17:05:03 140274492507904 [Warning] InnoDB: A long semaphore wait:
Feb 27 17:05:03 box mysqld: --Thread 140274484115200 has waited at srv0srv.cc line 2084 for 241.00 seconds the semaphore:
...
Feb 27 19:50:02 box systemd: Removed slice user-0.slice.
Feb 27 19:50:02 box systemd: mariadb.service holdoff time over, scheduling restart.
Feb 27 19:50:02 box systemd: Stopped MariaDB 10.2.31 database server.
Feb 27 19:50:02 box systemd: Starting MariaDB 10.2.31 database server...
Отримав відповідь із сапорта:
З сервером все добре.
Тут, ймовірно, опис ваш випадок:
https://stackoverflow.com/questions/24860111/warning-a-long-semaphore-wait
Добрий день. Якщо з залізом все вряду, значить проблема з БД. Потрібно відновлювати БД. Але щось мені підказує, що не все так добре з сервером, як про це сказав хостер. Зараз до сервера підключиться неможливо, відповідь від сервера: ssh_exchange_identification: Connection closed by remote host Можливо проблеми з БД виникли через проблеми з дисковою підсистемою, тому я і рекомендував звернеться до хостера.
Добрий день.
Якщо з залізом все вряду, значить проблема з БД. Потрібно відновлювати БД.
Але щось мені підказує, що не все так добре з сервером, як про це сказав хостер.
Зараз до сервера підключиться неможливо, відповідь від сервера:
ssh_exchange_identification: Connection closed by remote host
Можливо проблеми з БД виникли через проблеми з дисковою підсистемою, тому я і рекомендував
звернеться до хостера.
Відповідь сапорта хостера: Ну, у нас у логах немає нічого, що вказує на проблеми з дисковою підсистемою. Але не можна виключати такої можливості. Зараз вас переселимо на інший вузол, а на цьому проженемо тести. Потрібно кілька перезавантажень.
Відповідь сапорта хостера:
Ну, у нас у логах немає нічого, що вказує на проблеми з дисковою підсистемою.
Але не можна виключати такої можливості.
Зараз вас переселимо на інший вузол, а на цьому проженемо тести.
Потрібно кілька перезавантажень.
Добрий день. Наскільки я можу судити, після перенесення Вашого VPS на новий вузол помилки більше не вникають (пройшло більше 40 годин). Мабуть, проблема була в залозі.
Добрий день.
Наскільки я можу судити, після перенесення Вашого VPS на новий вузол помилки більше не вникають (пройшло більше 40 годин).
Мабуть, проблема була в залозі.
Будь ласка, приєднуйтесь до діалогу. Якщо вам є що сказати – будь ласка, напишіть коментар. Для входу потрібний мобільний телефон та смс-код для ідентифікації.
Увійти та написати коментар