Marcin89 0 Zgłoś post Napisano Styczeń 26, 2013 Witam,skonfigurowałem sobie jakiś czas temu mysql'a, wszystko ładnie pięknie chodziło, nie wprowadzałem żadnych zmian do konfiguracji. Ostatnio zauważyłem, że serwer restartuje się co jakiś czas.Zajrzałem do logów i o to co znalazłem : 130125 13:16:31 mysqld started InnoDB: The log sequence number in ibdata files does not match InnoDB: the log sequence number in the ib_logfiles! 130125 13:16:31 InnoDB: Database was not shut down normally! InnoDB: Starting crash recovery. InnoDB: Reading tablespace information from the .ibd files... InnoDB: Restoring possible half-written data pages from the doublewrite InnoDB: buffer... 130125 13:16:34 InnoDB: Started; log sequence number 0 2157956960 130125 13:16:34 [Note] /usr/libexec/mysqld: ready for connections. Czy mógł by mi ktoś wytłumaczyć o co chodzi ?Znalazłem parę informacji na ten temat, ale nie jestem pewien czy to wina złej konfiguracji użytkownika czy też coś nie tak z serwerem od strony firmy hostingowej ? Udostępnij ten post Link to postu Udostępnij na innych stronach
Pan Kot 1535 Zgłoś post Napisano Styczeń 26, 2013 Ten log mówi tyle co "proces mysqla nie został właściwie zamknięty". Wcześniejsze logi by tu dużo więcej powiedziały. Udostępnij ten post Link to postu Udostępnij na innych stronach
Marcin89 0 Zgłoś post Napisano Styczeń 26, 2013 Wcześniejsze logi by tu dużo więcej powiedziały. 121120 00:29:12 mysqld started 121120 0:29:12 InnoDB: Started; log sequence number 0 1766857543 121120 0:29:12 [Note] /usr/libexec/mysqld: ready for connections. Version: '5.0.95-log' socket: '/var/lib/mysql/mysql.sock' port: 3306 Source distribution 121121 0:58:40 [Note] /usr/libexec/mysqld: Normal shutdown 121121 0:58:40 InnoDB: Starting shutdown... 121121 0:58:42 InnoDB: Shutdown completed; log sequence number 0 1771333038 121121 0:58:42 [Note] /usr/libexec/mysqld: Shutdown complete 121121 00:58:42 mysqld ended 121121 00:58:43 mysqld started 121121 0:58:43 InnoDB: Started; log sequence number 0 1771333038 121121 0:58:43 [Note] /usr/libexec/mysqld: ready for connections. Version: '5.0.95-log' socket: '/var/lib/mysql/mysql.sock' port: 3306 Source distribution 121128 1:00:01 [Note] /usr/libexec/mysqld: Normal shutdown 121128 1:00:01 InnoDB: Starting shutdown... 121128 1:00:03 InnoDB: Shutdown completed; log sequence number 0 1835379267 121128 1:00:03 [Note] /usr/libexec/mysqld: Shutdown complete 121128 01:00:03 mysqld ended 121128 01:00:04 mysqld started 121128 1:00:04 InnoDB: Started; log sequence number 0 1835379267 121128 1:00:04 [Note] /usr/libexec/mysqld: ready for connections. Version: '5.0.95' socket: '/var/lib/mysql/mysql.sock' port: 3306 Source distribution 121128 1:02:43 [Note] /usr/libexec/mysqld: Normal shutdown 121128 1:02:43 InnoDB: Starting shutdown... 121128 1:02:44 InnoDB: Shutdown completed; log sequence number 0 1835379277 121128 1:02:44 [Note] /usr/libexec/mysqld: Shutdown complete 121128 01:02:44 mysqld ended 121128 01:02:45 mysqld started 121128 1:02:45 InnoDB: Started; log sequence number 0 1835379277 121128 1:02:45 [Note] /usr/libexec/mysqld: ready for connections. Version: '5.0.95' socket: '/var/lib/mysql/mysql.sock' port: 3306 Source distribution 121128 1:04:49 [Note] /usr/libexec/mysqld: Normal shutdown 121128 1:04:49 InnoDB: Starting shutdown... 121128 1:04:50 InnoDB: Shutdown completed; log sequence number 0 1835379287 121128 1:04:50 [Note] /usr/libexec/mysqld: Shutdown complete 121128 01:04:50 mysqld ended 121128 01:04:51 mysqld started 121128 1:04:51 InnoDB: Started; log sequence number 0 1835379287 121128 1:04:51 [Note] /usr/libexec/mysqld: ready for connections. Version: '5.0.95' socket: '/var/lib/mysql/mysql.sock' port: 3306 Source distribution 121128 1:06:13 [Note] /usr/libexec/mysqld: Normal shutdown 121128 1:06:13 InnoDB: Starting shutdown... 121128 1:06:14 InnoDB: Shutdown completed; log sequence number 0 1835379297 121128 1:06:14 [Note] /usr/libexec/mysqld: Shutdown complete 121128 01:06:14 mysqld ended 121128 01:06:15 mysqld started 121128 1:06:15 InnoDB: Started; log sequence number 0 1835379297 121128 1:06:15 [Note] /usr/libexec/mysqld: ready for connections. Version: '5.0.95' socket: '/var/lib/mysql/mysql.sock' port: 3306 Source distribution 121128 1:08:30 [Note] /usr/libexec/mysqld: Normal shutdown 121128 1:08:30 InnoDB: Starting shutdown... 121128 1:08:31 InnoDB: Shutdown completed; log sequence number 0 1835379307 121128 1:08:31 [Note] /usr/libexec/mysqld: Shutdown complete 121128 01:08:31 mysqld ended 121128 01:08:32 mysqld started 121128 1:08:32 InnoDB: Started; log sequence number 0 1835379307 121128 1:08:32 [Note] /usr/libexec/mysqld: ready for connections. Version: '5.0.95' socket: '/var/lib/mysql/mysql.sock' port: 3306 Source distribution 121128 1:09:26 [Note] /usr/libexec/mysqld: Normal shutdown 121128 1:09:26 InnoDB: Starting shutdown... 121128 1:09:27 InnoDB: Shutdown completed; log sequence number 0 1835379317 121128 1:09:27 [Note] /usr/libexec/mysqld: Shutdown complete 121128 01:09:27 mysqld ended 121128 01:09:28 mysqld started 121128 1:09:28 InnoDB: Started; log sequence number 0 1835379317 121128 1:09:28 [Note] /usr/libexec/mysqld: ready for connections. Version: '5.0.95' socket: '/var/lib/mysql/mysql.sock' port: 3306 Source distribution 121128 1:10:53 [Note] /usr/libexec/mysqld: Normal shutdown 121128 1:10:53 InnoDB: Starting shutdown... 121128 1:10:54 InnoDB: Shutdown completed; log sequence number 0 1835379327 121128 1:10:54 [Note] /usr/libexec/mysqld: Shutdown complete 121128 01:10:54 mysqld ended 121128 01:10:55 mysqld started 121128 1:10:55 InnoDB: Started; log sequence number 0 1835379327 121128 1:10:55 [Note] /usr/libexec/mysqld: ready for connections. Version: '5.0.95' socket: '/var/lib/mysql/mysql.sock' port: 3306 Source distribution 121128 1:13:52 [Note] /usr/libexec/mysqld: Normal shutdown 121128 1:13:52 InnoDB: Starting shutdown... 121128 1:13:53 InnoDB: Shutdown completed; log sequence number 0 1835403698 121128 1:13:53 [Note] /usr/libexec/mysqld: Shutdown complete 121128 01:13:53 mysqld ended 121128 01:13:54 mysqld started 121128 1:13:54 InnoDB: Started; log sequence number 0 1835403698 121128 1:13:54 [Note] /usr/libexec/mysqld: ready for connections. Version: '5.0.95' socket: '/var/lib/mysql/mysql.sock' port: 3306 Source distribution 121128 1:14:49 [Note] /usr/libexec/mysqld: Normal shutdown 121128 1:14:49 InnoDB: Starting shutdown... 121128 1:14:50 InnoDB: Shutdown completed; log sequence number 0 1835403708 121128 1:14:50 [Note] /usr/libexec/mysqld: Shutdown complete 121128 01:14:50 mysqld ended 121128 01:14:51 mysqld started 121128 1:14:51 InnoDB: Started; log sequence number 0 1835403708 121128 1:14:51 [Note] /usr/libexec/mysqld: ready for connections. Version: '5.0.95' socket: '/var/lib/mysql/mysql.sock' port: 3306 Source distribution 121128 1:16:13 [Note] /usr/libexec/mysqld: Normal shutdown 121128 1:16:13 InnoDB: Starting shutdown... 121128 1:16:14 InnoDB: Shutdown completed; log sequence number 0 1835403718 121128 1:16:14 [Note] /usr/libexec/mysqld: Shutdown complete 121128 01:16:14 mysqld ended 121128 01:16:15 mysqld started 121128 1:16:16 InnoDB: Started; log sequence number 0 1835403718 121128 1:16:16 [Note] /usr/libexec/mysqld: ready for connections. Version: '5.0.95' socket: '/var/lib/mysql/mysql.sock' port: 3306 Source distribution 121128 1:17:15 [Note] /usr/libexec/mysqld: Normal shutdown 121128 1:17:15 InnoDB: Starting shutdown... 121128 1:17:16 InnoDB: Shutdown completed; log sequence number 0 1835403728 121128 1:17:16 [Note] /usr/libexec/mysqld: Shutdown complete 121128 01:17:16 mysqld ended 121128 01:17:17 mysqld started 121128 1:17:17 InnoDB: Started; log sequence number 0 1835403728 121128 1:17:17 [Note] /usr/libexec/mysqld: ready for connections. Version: '5.0.95' socket: '/var/lib/mysql/mysql.sock' port: 3306 Source distribution 121128 1:17:20 [Note] /usr/libexec/mysqld: Normal shutdown 121128 1:17:20 InnoDB: Starting shutdown... 121128 1:17:21 InnoDB: Shutdown completed; log sequence number 0 1835403728 121128 1:17:21 [Note] /usr/libexec/mysqld: Shutdown complete 121128 01:17:21 mysqld ended 121128 01:17:21 mysqld started 121128 1:17:21 InnoDB: Started; log sequence number 0 1835403728 121128 1:17:21 [Note] /usr/libexec/mysqld: ready for connections. Version: '5.0.95' socket: '/var/lib/mysql/mysql.sock' port: 3306 Source distribution 121128 1:19:38 [Note] /usr/libexec/mysqld: Normal shutdown 121128 1:19:38 InnoDB: Starting shutdown... 121128 1:19:39 InnoDB: Shutdown completed; log sequence number 0 1835403738 121128 1:19:39 [Note] /usr/libexec/mysqld: Shutdown complete 121128 01:19:39 mysqld ended 121128 01:19:40 mysqld started 121128 1:19:40 InnoDB: Started; log sequence number 0 1835403738 121128 1:19:40 [Note] /usr/libexec/mysqld: ready for connections. Version: '5.0.95' socket: '/var/lib/mysql/mysql.sock' port: 3306 Source distribution 121129 23:58:34 [Note] /usr/libexec/mysqld: Normal shutdown 121129 23:58:34 InnoDB: Starting shutdown... 121129 23:58:36 InnoDB: Shutdown completed; log sequence number 0 1845350228 121129 23:58:36 [Note] /usr/libexec/mysqld: Shutdown complete 121129 23:58:36 mysqld ended 121129 23:58:37 mysqld started 121129 23:58:38 InnoDB: Started; log sequence number 0 1845350228 121129 23:58:38 [Note] /usr/libexec/mysqld: ready for connections. Version: '5.0.95' socket: '/var/lib/mysql/mysql.sock' port: 3306 Source distribution 121130 0:07:20 [Note] /usr/libexec/mysqld: Normal shutdown 121130 0:07:20 InnoDB: Starting shutdown... 121130 0:07:22 InnoDB: Shutdown completed; log sequence number 0 1845365261 121130 0:07:22 [Note] /usr/libexec/mysqld: Shutdown complete 121130 00:07:22 mysqld ended 121130 00:07:22 mysqld started 121130 0:07:23 InnoDB: Started; log sequence number 0 1845365261 121130 0:07:23 [Note] /usr/libexec/mysqld: ready for connections. Version: '5.0.95' socket: '/var/lib/mysql/mysql.sock' port: 3306 Source distribution 121130 0:34:47 [Note] /usr/libexec/mysqld: Normal shutdown 121130 0:34:47 InnoDB: Starting shutdown... 121130 0:34:48 InnoDB: Shutdown completed; log sequence number 0 1845484662 121130 0:34:48 [Note] /usr/libexec/mysqld: Shutdown complete 121130 00:34:48 mysqld ended 121130 00:34:49 mysqld started 121130 0:34:49 InnoDB: Started; log sequence number 0 1845484662 121130 0:34:49 [Note] /usr/libexec/mysqld: ready for connections. Version: '5.0.95' socket: '/var/lib/mysql/mysql.sock' port: 3306 Source distribution 121130 1:02:57 [Note] /usr/libexec/mysqld: Normal shutdown 121130 1:02:57 InnoDB: Starting shutdown... 121130 1:02:58 InnoDB: Shutdown completed; log sequence number 0 1845574598 121130 1:02:58 [Note] /usr/libexec/mysqld: Shutdown complete 121130 01:02:58 mysqld ended 121130 01:02:59 mysqld started 121130 1:02:59 InnoDB: Started; log sequence number 0 1845574598 121130 1:02:59 [Note] /usr/libexec/mysqld: ready for connections. Version: '5.0.95' socket: '/var/lib/mysql/mysql.sock' port: 3306 Source distribution 121211 15:56:39 mysqld started InnoDB: The log sequence number in ibdata files does not match InnoDB: the log sequence number in the ib_logfiles! 121211 15:56:40 InnoDB: Database was not shut down normally! InnoDB: Starting crash recovery. InnoDB: Reading tablespace information from the .ibd files... InnoDB: Restoring possible half-written data pages from the doublewrite InnoDB: buffer... 121211 15:56:41 InnoDB: Started; log sequence number 0 1904136531 121211 15:56:41 [Note] /usr/libexec/mysqld: ready for connections. Version: '5.0.95' socket: '/var/lib/mysql/mysql.sock' port: 3306 Source distribution 121213 23:17:40 [Note] /usr/libexec/mysqld: Normal shutdown 121213 23:17:41 InnoDB: Starting shutdown... 121213 23:17:43 InnoDB: Shutdown completed; log sequence number 0 1917887232 121213 23:17:43 [Note] /usr/libexec/mysqld: Shutdown complete 121213 23:17:43 mysqld ended 121213 23:17:44 mysqld started 121213 23:17:44 InnoDB: Started; log sequence number 0 1917887232 121213 23:17:44 [Note] /usr/libexec/mysqld: ready for connections. Version: '5.0.95' socket: '/var/lib/mysql/mysql.sock' port: 3306 Source distribution 130125 13:16:31 mysqld started InnoDB: The log sequence number in ibdata files does not match InnoDB: the log sequence number in the ib_logfiles! 130125 13:16:31 InnoDB: Database was not shut down normally! InnoDB: Starting crash recovery. InnoDB: Reading tablespace information from the .ibd files... InnoDB: Restoring possible half-written data pages from the doublewrite InnoDB: buffer... 130125 13:16:34 InnoDB: Started; log sequence number 0 2157956960 130125 13:16:34 [Note] /usr/libexec/mysqld: ready for connections. Version: '5.0.95' socket: '/var/lib/mysql/mysql.sock' port: 3306 Source distribution Udostępnij ten post Link to postu Udostępnij na innych stronach
Pan Kot 1535 Zgłoś post Napisano Styczeń 26, 2013 Chodziło mi bardziej o sysloga, sam widzisz że mysql.log niewiele nam tu pomoże . W ciemno strzelam na problemy z ramem. Możliwe, że na VPS'ie (bądź na matce! ) jest za mało ramu i MySQL nie ma gdzie ulokować swoich narzędzi. Tak jak mówię - syslog nam tu więcej powie. Udostępnij ten post Link to postu Udostępnij na innych stronach
Gość squeezer Zgłoś post Napisano Styczeń 26, 2013 Wbrew pozorom, mysqld.log powiedział sporo. Mianowicie to, że MySQL za każdym razem był zamykany w sposób normalny, proces nie był zabijany. Nie był to oom-killer, bo on po prostu ubiłby mysqld a nie starał się go grzecznie zastopować. Nadal może to być kwestia konfiguracji MySQL, ale skontaktowałbym się wcześniej z firmą hostingową i dopytał czy to nie jest skutek działania jakiegoś ich narzędzia. Udostępnij ten post Link to postu Udostępnij na innych stronach
Marcin89 0 Zgłoś post Napisano Styczeń 26, 2013 Chodziło mi bardziej o sysloga, sam widzisz że mysql.log niewiele nam tu pomoże . Zatem przejrzałem inne logi : Jan 25 12:51:57 vz10487 pure-ftpd: (?@93.132.2.3) [INFO] New connection from 93.132.2.3 Jan 25 12:52:03 vz10487 pure-ftpd: (?@93.132.2.3) [WARNING] Authentication failed for user [anonymous] Jan 25 12:52:03 vz10487 pure-ftpd: (?@93.132.2.3) [INFO] Logout. Jan 25 12:52:43 vz10487 pure-ftpd: (?@127.0.0.1) [INFO] New connection from 127.0.0.1 Jan 25 12:52:43 vz10487 pure-ftpd: (?@127.0.0.1) [INFO] Logout. Jan 25 12:57:43 vz10487 pure-ftpd: (?@127.0.0.1) [INFO] New connection from 127.0.0.1 Jan 25 12:57:43 vz10487 pure-ftpd: (?@127.0.0.1) [INFO] Logout. Jan 25 13:16:30 vz10487 sshd[1506]: Server listening on 0.0.0.0 port ----. Jan 25 13:27:12 vz10487 pure-ftpd: (?@127.0.0.1) [INFO] New connection from 127.0.0.1 Ten logo może dużo nie mówi, ale widzę tu próbę logowanie z adresu IP którego nie znam. O 13:16 - w czasie kiedy serwer mysql się zrestartował ktoś logował się przez ssh. Nie pamiętam czy to bylem ja : ) Natomiast, może to coś więcej powie : Jan 25 13:16:23 vz10487 syslogd 1.4.1: restart. Jan 25 13:16:26 vz10487 named[1457]: starting BIND 9.3.6-P1-RedHat-9.3.6-20.P1.el5 -u named -t /var/named/chroot Jan 25 13:16:26 vz10487 named[1457]: adjusted limit on open files from 1024 to 1048576 Jan 25 13:16:26 vz10487 named[1457]: found 1 CPU, using 1 worker thread Jan 25 13:16:26 vz10487 named[1457]: using up to 4096 sockets Jan 25 13:16:26 vz10487 named[1457]: loading configuration from '/etc/named.conf' Jan 25 13:16:26 vz10487 named[1457]: using default UDP/IPv4 port range: [1024, 65535] Jan 25 13:16:26 vz10487 named[1457]: using default UDP/IPv6 port range: [1024, 65535] Jan 25 13:16:26 vz10487 named[1457]: no IPv6 interfaces found Jan 25 13:16:26 vz10487 named[1457]: listening on IPv4 interface lo, 127.0.0.1#53 Jan 25 13:16:26 vz10487 named[1457]: listening on IPv4 interface venet0:0, 91.--.--.--#53 Jan 25 13:16:26 vz10487 named[1457]: command channel listening on 127.0.0.1#953 Jan 25 13:16:26 vz10487 named[1457]: zone --.biz/IN: loading master file /var/named/--.biz: permission denied Jan 25 13:16:26 vz10487 named[1457]: zone --.pl/IN: loading master file /var/named/--.pl: permission denied Jan 25 13:16:26 vz10487 named[1457]: zone --.pl/IN: loading master file /var/named/--.pl: permission denied Jan 25 13:16:26 vz10487 named[1457]: zone --.pl/IN: loading master file /var/named/---: permission denied Jan 25 13:16:26 vz10487 named[1457]: zone --.pl/IN: loading master file /var/named/--: permission denied Jan 25 13:16:26 vz10487 named[1457]: zone --.pl/IN: loading master file /var/named/---: permission denied Jan 25 13:16:26 vz10487 named[1457]: zone --.pl/IN: loading master file /var/named/--.pl: permission denied Jan 25 13:16:26 vz10487 named[1457]: running Jan 25 13:16:26 vz10487 pcscd: pcscdaemon.c:507:main() pcsc-lite 1.4.4 daemon ready. Jan 25 13:16:27 vz10487 pcscd: hotplug_libusb.c:402:HPEstablishUSBNotifications() Driver ifd-egate.bundle does not support IFD_GENERATE_HOTPLUG. Using active polling instead. Jan 25 13:16:27 vz10487 pcscd: hotplug_libusb.c:411:HPEstablishUSBNotifications() Polling forced every 1 second(s) Jan 25 13:16:30 vz10487 xinetd[1514]: xinetd Version 2.3.14 started with libwrap loadavg labeled-networking options compiled in. Jan 25 13:16:30 vz10487 xinetd[1514]: Started working: 2 available services Jan 25 13:16:49 vz10487 saslauthd[1792]: detach_tty : master pid is: 1792 Jan 25 13:16:49 vz10487 saslauthd[1792]: ipc_init : listening on socket: /var/run/saslauthd/mux Jan 25 13:16:50 vz10487 avahi-daemon[1802]: Found user 'avahi' (UID 70) and group 'avahi' (GID 70). Jan 25 13:16:50 vz10487 avahi-daemon[1802]: Successfully dropped root privileges. Jan 25 13:16:50 vz10487 avahi-daemon[1802]: avahi-daemon 0.6.16 starting up. Jan 25 13:16:50 vz10487 avahi-daemon[1802]: WARNING: No NSS support for mDNS detected, consider installing nss-mdns! Jan 25 13:16:50 vz10487 avahi-daemon[1802]: dbus_bus_get(): Failed to connect to socket /var/run/dbus/system_bus_socket: No such file or directory Jan 25 13:16:50 vz10487 avahi-daemon[1802]: WARNING: Failed to contact D-Bus daemon. Jan 25 13:16:50 vz10487 init: no more processes left in this runlevel Pewne dane zastąpiłem znakami "--" z wiadomych względów Wbrew pozorom, mysqld.log powiedział sporo. Mianowicie to, że MySQL za każdym razem był zamykany w sposób normalny, proces nie był zabijany. Nie był to oom-killer, bo on po prostu ubiłby mysqld a nie starał się go grzecznie zastopować. Nadal może to być kwestia konfiguracji MySQL, ale skontaktowałbym się wcześniej z firmą hostingową i dopytał czy to nie jest skutek działania jakiegoś ich narzędzia. Owszem był zamykany poprawnie, gdyż to są jeszcze wcześniejsze logi, kiedy to restartowałem serwer przy konfiguracji. Udostępnij ten post Link to postu Udostępnij na innych stronach
Pan Kot 1535 Zgłoś post Napisano Styczeń 26, 2013 Restartowałeś system o tej 13:16? Jeśli nie to możliwe, że serwer-matka był restartowany. Po logach definitywnie widać, że albo coś restartowało jakieś usługi (przynajmniej kilka z nich) albo był reboot. Udostępnij ten post Link to postu Udostępnij na innych stronach
Marcin89 0 Zgłoś post Napisano Styczeń 26, 2013 Nie restartowałem systemu. Przynajmniej wiem, że to nie zła konfiguracja. Dziękuje Panowie za odpowiedzi. Skontaktuję się zatem z firmą hostingową. Udostępnij ten post Link to postu Udostępnij na innych stronach
