Uploaded image for project: 'MariaDB Server'
  1. MariaDB Server
  2. MDEV-15441

mysqld started in duble ? (mariadb 10.1.26 + Debian 9.3)

    XMLWordPrintable

Details

    Description

      2018-02-28  9:54:13 140093945811520 [Note] InnoDB: Using mutexes to ref count buffer pool pages
      2018-02-28  9:54:13 140093945811520 [Note] InnoDB: The InnoDB memory heap is disabled
      2018-02-28  9:54:13 140093945811520 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
      2018-02-28  9:54:13 140093945811520 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
      2018-02-28  9:54:13 140093945811520 [Note] InnoDB: Compressed tables use zlib 1.2.8
      2018-02-28  9:54:13 140093945811520 [Note] InnoDB: Using Linux native AIO
      2018-02-28  9:54:13 140093945811520 [Note] InnoDB: Using SSE crc32 instructions
      2018-02-28  9:54:13 140093945811520 [Note] InnoDB: Initializing buffer pool, size = 40.0G
      2018-02-28  9:54:14 140093945811520 [Note] InnoDB: Completed initialization of buffer pool
      2018-02-28  9:54:14 140093945811520 [Note] InnoDB: Highest supported file format is Barracuda.
      2018-02-28  9:54:14 140093945811520 [Note] InnoDB: Starting crash recovery from checkpoint LSN=51522759208
      2018-02-28  9:54:30 140093945811520 [Note] InnoDB: Processed 2178 .ibd/.isl files
      2018-02-28  9:54:46 140093945811520 [Note] InnoDB: Processed 4521 .ibd/.isl files
      2018-02-28  9:55:02 140093945811520 [Note] InnoDB: Processed 6897 .ibd/.isl files
      ...
      2018-02-28 10:03:50 140093945811520 [Note] InnoDB: Processed 88209 .ibd/.isl files
      2018-02-28 10:04:06 140093945811520 [Note] InnoDB: Processed 90530 .ibd/.isl files
      2018-02-28 10:04:11 140544819712576 [ERROR] mysqld: Can't lock aria control file '/data/mysql/data/aria_log_control' for exclusive use, error: 11. Will retry for 30 seconds
      2018-02-28 10:04:22 140093945811520 [Note] InnoDB: Processed 93016 .ibd/.isl files
      2018-02-28 10:04:38 140093945811520 [Note] InnoDB: Processed 95205 .ibd/.isl files
      2018-02-28 10:04:42 140544819712576 [ERROR] mysqld: Got error 'Could not get an exclusive lock; file is probably in use by another process' when trying to use aria control file '/data/mysql/data/aria_log_control'
      2018-02-28 10:04:42 140544819712576 [ERROR] Plugin 'Aria' init function returned error.
      2018-02-28 10:04:42 140544819712576 [ERROR] Plugin 'Aria' registration as a STORAGE ENGINE failed.
      2018-02-28 10:04:42 140544819712576 [Note] InnoDB: Using mutexes to ref count buffer pool pages
      2018-02-28 10:04:42 140544819712576 [Note] InnoDB: The InnoDB memory heap is disabled
      2018-02-28 10:04:42 140544819712576 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
      2018-02-28 10:04:42 140544819712576 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
      2018-02-28 10:04:42 140544819712576 [Note] InnoDB: Compressed tables use zlib 1.2.8
      2018-02-28 10:04:42 140544819712576 [Note] InnoDB: Using Linux native AIO
      2018-02-28 10:04:42 140544819712576 [Note] InnoDB: Using SSE crc32 instructions
      2018-02-28 10:04:42 140544819712576 [Note] InnoDB: Initializing buffer pool, size = 40.0G
      2018-02-28 10:04:43 140544819712576 [Note] InnoDB: Completed initialization of buffer pool
      2018-02-28 10:04:43 140544819712576 [ERROR] InnoDB: Unable to lock ./ibdata1, error: 11
      2018-02-28 10:04:43 140544819712576 [Note] InnoDB: Retrying to lock the first data file
      2018-02-28 10:04:44 140544819712576 [ERROR] InnoDB: Unable to lock ./ibdata1, error: 11
      2018-02-28 10:04:45 140544819712576 [ERROR] InnoDB: Unable to lock ./ibdata1, error: 11
      2018-02-28 10:04:46 140544819712576 [ERROR] InnoDB: Unable to lock ./ibdata1, error: 11
      .2018-02-28 10:05:09 140544819712576 [ERROR] InnoDB: Unable to lock ./ibdata1, error: 11
      ...
      2018-02-28 10:05:10 140093945811520 [Note] InnoDB: Processed 99660 .ibd/.isl files
      2018-02-28 10:05:10 140544819712576 [ERROR] InnoDB: Unable to lock ./ibdata1, error: 11
      201
      ..
      2018-02-28 10:06:23 140544819712576 [ERROR] InnoDB: Unable to lock ./ibdata1, error: 11
      2018-02-28 10:06:23 140544819712576 [Note] InnoDB: Unable to open the first data file
      2018-02-28 10:06:23 7fd3240dd240  InnoDB: Operating system error number 1 in a file operation.
      InnoDB: Error number 1 means 'Operation not permitted'.
      InnoDB: Some operating system error numbers are described at
      InnoDB: http://dev.mysql.com/doc/refman/5.6/en/operating-system-error-codes.html
      2018-02-28 10:06:23 140544819712576 [ERROR] InnoDB: Can't open './ibdata1'
      2018-02-28 10:06:23 140544819712576 [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!
      2018-02-28 10:06:23 140544819712576 [ERROR] Plugin 'InnoDB' init function returned error.
      2018-02-28 10:06:23 140544819712576 [ERROR] Plugin 'InnoDB' registration as a STORAGE ENGINE failed.
      2018-02-28 10:06:23 140544819712576 [Note] Plugin 'FEEDBACK' is disabled.
      2018-02-28 10:06:23 140544819712576 [ERROR] Unknown/unsupported storage engine: InnoDB
      2018-02-28 10:06:23 140544819712576 [ERROR] Aborting
       
      2018-02-28 10:06:30 140093945811520 [Note] InnoDB: Processed 112244 .ibd/.isl files
      2018-02-28 10:06:46 140093945811520 [Note] InnoDB: Processed 114543 .ibd/.isl files
       
      2018-02-28 10:10:14 140093945811520 [Note] InnoDB: Processed 146542 .ibd/.isl files
      2018-02-28 10:10:30 140093945811520 [Note] InnoDB: Processed 148984 .ibd/.isl files
      2018-02-28 10:10:46 140093945811520 [Note] InnoDB: Processed 151360 .ibd/.isl files
      2018-02-28 10:12:38 140165176279616 [Note] InnoDB: Using mutexes to ref count buffer pool pages
      2018-02-28 10:12:38 140165176279616 [Note] InnoDB: The InnoDB memory heap is disabled
      2018-02-28 10:12:38 140165176279616 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
      2018-02-28 10:12:38 140165176279616 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
      2018-02-28 10:12:38 140165176279616 [Note] InnoDB: Compressed tables use zlib 1.2.8
      2018-02-28 10:12:38 140165176279616 [Note] InnoDB: Using Linux native AIO
      2018-02-28 10:12:38 140165176279616 [Note] InnoDB: Using SSE crc32 instructions
      2018-02-28 10:12:38 140165176279616 [Note] InnoDB: Initializing buffer pool, size = 40.0G
      2018-02-28 10:12:38 140165176279616 [Note] InnoDB: Completed initialization of buffer pool
      2018-02-28 10:12:39 140165176279616 [Note] InnoDB: Highest supported file format is Barracuda.
      2018-02-28 10:12:39 140165176279616 [Note] InnoDB: Starting crash recovery from checkpoint LSN=51522759208
      2018-02-28 10:12:55 140165176279616 [Note] InnoDB: Processed 2332 .ibd/.isl files
      2018-02-28 10:13:11 140165176279616 [Note] InnoDB: Processed 4576 .ibd/.isl files
      2018-02-28 10:13:27 140165176279616 [Note] InnoDB: Processed 6996 .ibd/.isl files
      2018-02-28 10:13:43 140165176279616 [Note] InnoDB: Processed 9394 .ibd/.isl files
       
      ok my client decided to reboot server that's was bad idea
      ^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@^@2018-02-28 10:17:27 140436623778368 [Note] InnoDB: Using mutexes to ref count buffer pool pages
      2018-02-28 10:17:27 140436623778368 [Note] InnoDB: The InnoDB memory heap is disabled
      2018-02-28 10:17:27 140436623778368 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
      2018-02-28 10:17:27 140436623778368 [Note] InnoDB: GCC builtin __atomic_threa2018-02-28 10:51:51 140493708309056 [Note] InnoDB: Using mutexes to ref count buffer pool pages
      2018-02-28 10:51:51 140493708309056 [Note] InnoDB: The InnoDB memory heap is disabled
      2018-02-28 10:51:51 140493708309056 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
      2018-02-28 10:51:51 140493708309056 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
      2018-02-28 10:51:51 140493708309056 [Note] InnoDB: Compressed tables use zlib 1.2.8
      2018-02-28 10:51:51 140493708309056 [Note] InnoDB: Using Linux native AIO
      2018-02-28 10:51:51 140493708309056 [Note] InnoDB: Using SSE crc32 instructions
      2018-02-28 10:51:51 140493708309056 [Note] InnoDB: Initializing buffer pool, size = 40.0G
      2018-02-28 10:51:52 140493708309056 [Note] InnoDB: Completed initialization of buffer pool
      2018-02-28 10:51:52 140493708309056 [Note] InnoDB: Highest supported file format is Barracuda.
      2018-02-28 10:51:52 140493708309056 [Note] InnoDB: Starting crash recovery from checkpoint LSN=51522759208
      2018-02-28 10:52:08 140493708309056 [Note] InnoDB: Processed 2222 .ibd/.isl files
      2018-02-28 10:52:24 140493708309056 [Note] InnoDB: Processed 4620 .ibd/.isl files
      2018-02-28 10:52:40 140493708309056 [Note] InnoDB: Processed 7029 .ibd/.isl files
      2018-02-28 10:52:56 140493708309056 [Note] InnoDB: Processed 9427 .ibd/.isl files
      2018-02-28 10:53:12 140493708309056 [Note] InnoDB: Processed 11979 .ibd/.isl files
      2018-02-28 10:53:28 140493708309056 [Note] InnoDB: Processed 14487 .ibd/.isl files
      2018-02-28 10:53:44 140493708309056 [Note] InnoDB: Processed 17006 .ibd/.isl files
      2018-02-28 10:54:00 140493708309056 [Note] InnoDB: Processed 19789 .ibd/.isl files
      ...
      ...
      2018-02-28 11:23:27 140518379704896 [Note] InnoDB: Processed 220000 .ibd/.isl files
      2018-02-28 11:23:42 140518379704896 [Note] InnoDB: Restoring possible half-written data pages from the doublewrite buffer...
      2018-02-28 11:23:43 140518379704896 [Note] InnoDB: Read redo log up to LSN=51522890240
      2018-02-28 11:23:43 140518379704896 [Note] InnoDB: Starting final batch to recover 13 pages from redo log
      InnoDB: Last MySQL binlog file position 0 950671726, file name /data/mysql/binlog/mysql-bin.000022
      2018-02-28 11:33:33 140699591979584 [ERROR] mysqld: Can't lock aria control file '/data/mysql/data/aria_log_control' for exclusive use, error: 11. Will retry for 30 seconds
      2018-02-28 11:34:04 140699591979584 [ERROR] mysqld: Got error 'Could not get an exclusive lock; file is probably in use by another process' when trying to use aria control file '/data/mysql/data/aria_log_control'
      2018-02-28 11:34:04 140699591979584 [ERROR] Plugin 'Aria' init function returned error.
      2018-02-28 11:34:04 140699591979584 [ERROR] Plugin 'Aria' registration as a STORAGE ENGINE failed.
      2018-02-28 11:34:04 140699591979584 [Note] InnoDB: Using mutexes to ref count buffer pool pages
      2018-02-28 11:34:04 140699591979584 [Note] InnoDB: The InnoDB memory heap is disabled
      2018-02-28 11:34:04 140699591979584 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
      2018-02-28 11:34:04 140699591979584 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
      2018-02-28 11:34:04 140699591979584 [Note] InnoDB: Compressed tables use zlib 1.2.8
      2018-02-28 11:34:04 140699591979584 [Note] InnoDB: Using Linux native AIO
      2018-02-28 11:34:04 140699591979584 [Note] InnoDB: Using SSE crc32 instructions
      2018-02-28 11:34:04 140699591979584 [Note] InnoDB: Initializing buffer pool, size = 40.0G
      2018-02-28 11:34:05 140699591979584 [Note] InnoDB: Completed initialization of buffer pool
      2018-02-28 11:34:05 140699591979584 [ERROR] InnoDB: Unable to lock ./ibdata1, error: 11
      2018-02-28 11:34:05 140699591979584 [Note] InnoDB: Retrying to lock the first data file
      2018-02-28 11:34:06 140699591979584 [ERROR] InnoDB: Unable to lock ./ibdata1, error: 11
      2018-02-28 11:34:07 140699591979584 [ERROR] InnoDB: Unable to lock ./ibdata1, error: 11
      2018-02-28 11:34:08 140699591979584 [ERROR] InnoDB: Unable to lock ./ibdata1, error: 1
       
      ...
      2018-02-28 11:35:44 140699591979584 [ERROR] InnoDB: Unable to lock ./ibdata1, error: 11
      2018-02-28 11:35:45 140699591979584 [ERROR] InnoDB: Unable to lock ./ibdata1, error: 11
      2018-02-28 11:35:45 140699591979584 [Note] InnoDB: Unable to open the first data file
      2018-02-28 11:35:45 7ff72d333240  InnoDB: Operating system error number 1 in a file operation.
      InnoDB: Error number 1 means 'Operation not permitted'.
      InnoDB: Some operating system error numbers are described at
      InnoDB: http://dev.mysql.com/doc/refman/5.6/en/operating-system-error-codes.html
      2018-02-28 11:35:45 140699591979584 [ERROR] InnoDB: Can't open './ibdata1'
      2018-02-28 11:35:45 140699591979584 [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!
      2018-02-28 11:35:45 140699591979584 [ERROR] Plugin 'InnoDB' init function returned error.
      2018-02-28 11:35:45 140699591979584 [ERROR] Plugin 'InnoDB' registration as a STORAGE ENGINE failed.
      2018-02-28 11:35:45 140699591979584 [Note] Plugin 'FEEDBACK' is disabled.
      2018-02-28 11:35:45 140699591979584 [ERROR] Unknown/unsupported storage engine: InnoDB
      2018-02-28 11:35:45 140699591979584 [ERROR] Aborting
       
      2018-02-28 11:35:58 140518379704896 [Note] InnoDB: 128 rollback segment(s) are active.
      2018-02-28 11:35:58 140518379704896 [Note] InnoDB: Waiting for purge to start
      2018-02-28 11:35:58 140518379704896 [Note] InnoDB:  Percona XtraDB (http://www.percona.com) 5.6.36-82.1 started; log sequence number 51522825808
      2018-02-28 11:35:59 140470139193088 [Note] InnoDB: Dumping buffer pool(s) not yet started
      2018-02-28 11:35:59 140518379704896 [Note] Plugin 'FEEDBACK' is disabled.
      2018-02-28 11:35:59 140518379704896 [Note] Recovering after a crash using /data/mysql/binlog/mysql-bin
      2018-02-28 11:36:05 140518379704896 [ERROR] Error in Log_event::read_log_event(): 'Event invalid', data_len: 0, event_type: 0
      2018-02-28 11:36:05 140518379704896 [Note] Starting crash recovery...
      2018-02-28 11:36:05 140518379704896 [Note] Crash recovery finished.
      2018-02-28 11:36:05 140518379704896 [Note] Server socket created on IP: '::'.
      2018-02-28 11:36:05 140518379083520 [Note] /usr/sbin/mysqld: Normal shutdown
       
      2018-02-28 11:36:06 140518379704896 [Warning] 'user' entry 'pmacontrol@178.*' ignored in --skip-name-resolve mode.
      2018-02-28 11:36:06 140518379704896 [Note] /usr/sbin/mysqld: ready for connections.
      Version: '10.1.26-MariaDB-0+deb9u1'  socket: '/var/run/mysqld/mysqld.sock'  port: 3306  Debian 9.1
      2018-02-28 11:36:06 140518379083520 [Note] Event Scheduler: Purging the queue. 0 events
      2018-02-28 11:36:06 140470172763904 [Note] InnoDB: FTS optimize thread exiting.
      2018-02-28 11:36:06 140518379083520 [Note] InnoDB: Starting shutdown...
      2018-02-28 11:36:06 140518379083520 [Note] InnoDB: Waiting for page_cleaner to finish flushing of buffer pool
      2018-02-28 11:36:09 140518379083520 [Note] InnoDB: Shutdown completed; log sequence number 51522825818
      2018-02-28 11:36:09 140518379083520 [Note] /usr/sbin/mysqld: Shutdown complete
       
      2018-02-28 11:36:53 139791898899008 [Note] InnoDB: Using mutexes to ref count buffer pool pages
      2018-02-28 11:36:53 139791898899008 [Note] InnoDB: The InnoDB memory heap is disabled
      2018-02-28 11:36:53 139791898899008 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
      2018-02-28 11:36:53 139791898899008 [Note] InnoDB: GCC builtin __atomic_thread_fence() is used for memory barrier
      2018-02-28 11:36:53 139791898899008 [Note] InnoDB: Compressed tables use zlib 1.2.8
      2018-02-28 11:36:53 139791898899008 [Note] InnoDB: Using Linux native AIO
      2018-02-28 11:36:53 139791898899008 [Note] InnoDB: Using SSE crc32 instructions
      2018-02-28 11:36:53 139791898899008 [Note] InnoDB: Initializing buffer pool, size = 40.0G
      2018-02-28 11:36:53 139791898899008 [Note] InnoDB: Completed initialization of buffer pool
      2018-02-28 11:36:54 139791898899008 [Note] InnoDB: Highest supported file format is Barracuda.
      2018-02-28 11:37:01 139791898899008 [Note] InnoDB: 128 rollback segment(s) are active.
      2018-02-28 11:37:01 139791898899008 [Note] InnoDB: Waiting for purge to start
      2018-02-28 11:37:01 139791898899008 [Note] InnoDB:  Percona XtraDB (http://www.percona.com) 5.6.36-82.1 started; log sequence number 51522825818
      2018-02-28 11:37:01 139791898899008 [Note] Plugin 'FEEDBACK' is disabled.
      2018-02-28 11:37:01 139744054834944 [Note] InnoDB: Dumping buffer pool(s) not yet started
      2018-02-28 11:37:02 139791898899008 [Note] Server socket created on IP: '::'.
      2018-02-28 11:37:02 139791898899008 [Warning] 'user' entry 'pmacontrol@178.*' ignored in --skip-name-resolve mode.
      

      and in syslog

      Feb 28 09:53:59 dba systemd[1]: Started Create Static Device Nodes in /dev.
      Feb 28 09:53:59 dba systemd-fsck[371]: /: clean, 170531/1281120 files, 2567037/5119728 blocks
      Feb 28 09:53:59 dba systemd[1]: Starting udev Kernel Device Manager...
      Feb 28 09:53:59 dba systemd[1]: Started File System Check on Root Device.
      Feb 28 09:53:59 dba systemd[1]: Starting Remount Root and Kernel File Systems...
      Feb 28 09:53:59 dba kernel: Linux version 4.9.33-mod-std-ipv6-64 (kernel@kernel.ovh.net) (gcc version 6.3.0 20170516 (Debian 6.3.0-18) ) #1 SMP Tue Jun 20 11:36:21 CEST 2017
      Feb 28 09:53:59 dba kernel: Command line: BOOT_IMAGE=/bzImage-4.9.33-mod-std-ipv6-64 root=/dev/md3 ro rootdelay=10 noquiet nosplash net.ifnames=0 biosdevname=0
      Feb 28 09:53:59 dba kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
      Feb 28 09:53:59 dba kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
      Feb 28 09:53:59 dba systemd-udevd[390]: Network interface NamePolicy= disabled on kernel command line, ignoring.
      Feb 28 09:53:59 dba kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
      Feb 28 09:53:59 dba kernel: x86/fpu: Supporting XSAVE feature 0x008: 'MPX bounds registers'
      Feb 28 09:53:59 dba kernel: x86/fpu: Supporting XSAVE feature 0x010: 'MPX CSR'
      Feb 28 09:53:59 dba kernel: x86/fpu: xstate_offset[2]:  576, xstate_sizes[2]:  256
      Feb 28 09:53:59 dba keyboard-setup.sh[370]: cannot open file /tmp/tmpkbd.OUbjnw
      Feb 28 09:53:59 dba kernel: x86/fpu: xstate_offset[3]:  832, xstate_sizes[3]:   64
      Feb 28 09:53:59 dba kernel: x86/fpu: xstate_offset[4]:  896, xstate_sizes[4]:   64
      Feb 28 09:53:59 dba kernel: x86/fpu: Enabled xstate features 0x1f, context size is 960 bytes, using 'compacted' format.
      Feb 28 09:53:59 dba kernel: x86/fpu: Using 'eager' FPU context switches.
      Feb 28 09:53:59 dba systemd[1]: Started Remount Root and Kernel File Systems.
      Feb 28 09:53:59 dba kernel: e820: BIOS-provided physical RAM map:
      Feb 28 09:53:59 dba kernel: BIOS-e820: [mem 0x0000000000000000-0x0000000000057fff] usable
      Feb 28 09:53:59 dba kernel: BIOS-e820: [mem 0x0000000000058000-0x0000000000058fff] reserved
      Feb 28 09:53:59 dba systemd[1]: Starting Flush Journal to Persistent Storage...
      Feb 28 09:53:59 dba kernel: BIOS-e820: [mem 0x0000000000059000-0x000000000009dfff] usable
      Feb 28 09:53:59 dba kernel: BIOS-e820: [mem 0x000000000009e000-0x000000000009efff] reserved
      Feb 28 09:53:59 dba kernel: BIOS-e820: [mem 0x000000000009f000-0x000000000009ffff] usable
      Feb 28 09:53:59 dba systemd[1]: Starting Load/Save Random Seed...
      Feb 28 09:53:59 dba kernel: BIOS-e820: [mem 0x00000000000a0000-0x00000000000fffff] reserved
      Feb 28 09:53:59 dba systemd[1]: Starting udev Coldplug all Devices...
      Feb 28 09:53:59 dba kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000881c5fff] usable
      Feb 28 09:53:59 dba kernel: BIOS-e820: [mem 0x00000000881c6000-0x00000000881c6fff] ACPI NVS
      Feb 28 09:53:59 dba systemd[1]: Started Load/Save Random Seed.
      Feb 28 09:53:59 dba kernel: BIOS-e820: [mem 0x00000000881c7000-0x0000000088210fff] reserved
      Feb 28 09:53:59 dba kernel: BIOS-e820: [mem 0x0000000088211000-0x0000000088282fff] usable
      Feb 28 09:53:59 dba kernel: BIOS-e820: [mem 0x0000000088283000-0x0000000088302fff] type 20
      Feb 28 09:53:59 dba kernel: BIOS-e820: [mem 0x0000000088303000-0x0000000089ec1fff] reserved
      Feb 28 09:53:59 dba kernel: e820: remove [mem 0x000a0000-0x000fffff] usable
      Feb 28 09:53:59 dba kernel: e820: last_pfn = 0x1062000 max_arch_pfn = 0x400000000
      Feb 28 09:53:59 dba kernel: MTRR default type: write-back
      Feb 28 09:53:59 dba kernel: MTRR fixed ranges enabled:
      Feb 28 09:53:59 dba systemd[1]: Found device /dev/md2.
      Feb 28 09:53:59 dba kernel:  00000-9FFFF write-back
      Feb 28 09:53:59 dba kernel:  A0000-BFFFF uncachable
      Feb 28 09:53:59 dba kernel:  C0000-FFFFF write-protect
      Feb 28 09:53:59 dba systemd[1]: Started MD array monitor.
      Feb 28 09:53:59 dba kernel: MTRR variable ranges enabled:
      Feb 28 09:53:59 dba kernel:  0 base 00C0000000 mask 7FC0000000 uncachable
      Feb 28 09:53:59 dba kernel:  1 base 00A0000000 mask 7FE0000000 uncachable
      Feb 28 09:53:59 dba systemd[1]: Found device HGST_HUS726020ALA610 swap-sdb5.
      Feb 28 09:53:59 dba kernel:  2 base 009E000000 mask 7FFE000000 uncachable
      Feb 28 09:53:59 dba kernel:  3 base 1080000000 mask 7FC0000000 uncachable
      Feb 28 09:53:59 dba kernel:  4 disabled
      Feb 28 09:53:59 dba systemd[1]: Activating swap /dev/sdb5...
      Feb 28 09:53:59 dba kernel:  5 disabled
      Feb 28 09:53:59 dba kernel:  6 disabled
      Feb 28 09:53:59 dba kernel:  7 disabled
      Feb 28 09:53:59 dba kernel:  8 disabled
      Feb 28 09:53:59 dba systemd[1]: Found device /dev/md4.
      Feb 28 09:53:59 dba kernel:  9 disabled
      Feb 28 09:53:59 dba kernel: x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WC  UC- WT
      Feb 28 09:53:59 dba kernel: e820: last_pfn = 0x8a000 max_arch_pfn = 0x400000000
      Feb 28 09:53:59 dba systemd[1]: Found device HGST_HUS726020ALA610 swap-sda5.
      Feb 28 09:53:59 dba kernel: Base memory trampoline at [ffff880000094000] 94000 size 24576
      Feb 28 09:53:59 dba kernel: Using GB pages for direct mapping
      Feb 28 09:53:59 dba kernel: BRK [0x02ce3000, 0x02ce3fff] PGTABLE
      Feb 28 09:53:59 dba systemd[1]: Activating swap /dev/sda5...
      Feb 28 09:53:59 dba kernel: BRK [0x02ce4000, 0x02ce4fff] PGTABLE
      Feb 28 09:53:59 dba kernel: BRK [0x02ce5000, 0x02ce5fff] PGTABLE
      Feb 28 09:53:59 dba kernel: BRK [0x02ce6000, 0x02ce6fff] PGTABLE
      Feb 28 09:53:59 dba kernel: BRK [0x02ce7000, 0x02ce7fff] PGTABLE
      Feb 28 09:53:59 dba kernel: BRK [0x02ce8000, 0x02ce8fff] PGTABLE
      Feb 28 09:53:59 dba systemd[1]: Activated swap /dev/sda5.
      Feb 28 09:53:59 dba kernel: ACPI: Early table checksum verification disabled
      Feb 28 09:53:59 dba kernel: ACPI: RSDP 0x0000000089FFE014 000024 (v02 INTEL )
      Feb 28 09:53:59 dba kernel: ACPI: XSDT 0x0000000089FB7188 0000D4 (v01 INTEL  S1200SPL 00000000 INTL 01000013)
      Feb 28 09:53:59 dba kernel: ACPI: FACP 0x0000000089FF6000 0000F4 (v05 INTEL  S1200SPL 00000000 INTL 20091013)
      Feb 28 09:53:59 dba kernel: ACPI: DSDT 0x0000000089FC6000 029241 (v02 INTEL  S1200SPL 00000000 INTL 20091013)
      Feb 28 09:53:59 dba kernel: ACPI: FACS 0x0000000089F7E000 000040
      Feb 28 09:53:59 dba systemd[1]: Started udev Wait for Complete Device Initialization.
      Feb 28 09:53:59 dba kernel: ACPI: HPET 0x0000000089FF5000 000038 (v01 INTEL  S1200SPL 00000001 INTL 20091013)
      Feb 28 09:53:59 dba kernel: ACPI: APIC 0x0000000089FF4000 0000BC (v03 INTEL  S1200SPL 00000001 INTL 20091013)
      Feb 28 09:53:59 dba kernel: ACPI: MCFG 0x0000000089FF3000 00003C (v01 INTEL  S1200SPL 00000001 INTL 20091013)
      Feb 28 09:53:59 dba systemd[1]: Activated swap /dev/sdb5.
      Feb 28 09:53:59 dba kernel: ACPI: SPMI 0x0000000089FF1000 000042 (v05 INTEL  S1200SPL 00000000 INTL 20091013)
      Feb 28 09:53:59 dba kernel: ACPI: WDDT 0x0000000089FF0000 000040 (v01 INTEL  S1200SPL 00000000 INTL 20091013)
      Feb 28 09:53:59 dba kernel: ACPI: SSDT 0x0000000089FC3000 002BAE (v02 INTEL  S1200SPL 00001000 INTL 20091013)
      Feb 28 09:53:59 dba kernel: ACPI: SSDT 0x0000000089FC2000 000BE3 (v02 INTEL  S1200SPL 00001000 INTL 20091013)
      Feb 28 09:53:59 dba kernel:  DMA zone: 64 pages used for memmap
      Feb 28 09:53:59 dba kernel:  DMA zone: 1091 pages reserved
      Feb 28 09:53:59 dba systemd[1]: Starting Monitoring of LVM2 mirrors, snapshots etc. using dmeventd or progress polling...
      Feb 28 09:53:59 dba kernel:  DMA zone: 3997 pages, LIFO batch:0
      Feb 28 09:53:59 dba kernel:  DMA32 zone: 8649 pages used for memmap
      Feb 28 09:53:59 dba kernel:  DMA32 zone: 553529 pages, LIFO batch:31
      Feb 28 09:53:59 dba kernel:  Normal zone: 252032 pages used for memmap
      Feb 28 09:53:59 dba systemd[1]: Started Monitoring of LVM2 mirrors, snapshots etc. using dmeventd or progress polling.
      Feb 28 09:53:59 dba kernel:  Normal zone: 16130048 pages, LIFO batch:31
      Feb 28 09:53:59 dba kernel: ACPI: PM-Timer IO Port: 0x1808
      Feb 28 09:53:59 dba kernel: ACPI: Local APIC address 0xfee00000
      Feb 28 09:53:59 dba systemd[1]: Reached target Local File Systems (Pre).
      Feb 28 09:53:59 dba kernel: ACPI: LAPIC_NMI (acpi_id[0x01] high edge lint[0x1])
      Feb 28 09:53:59 dba kernel: ACPI: LAPIC_NMI (acpi_id[0x02] high edge lint[0x1])
      Feb 28 09:53:59 dba kernel: ACPI: LAPIC_NMI (acpi_id[0x03] high edge lint[0x1])
      Feb 28 09:53:59 dba systemd[1]: Starting File System Check on /dev/md4...
      Feb 28 09:53:59 dba kernel: ACPI: LAPIC_NMI (acpi_id[0x04] high edge lint[0x1])
      Feb 28 09:53:59 dba kernel: ACPI: LAPIC_NMI (acpi_id[0x05] high edge lint[0x1])
      Feb 28 09:53:59 dba kernel: ACPI: LAPIC_NMI (acpi_id[0x06] high edge lint[0x1])
      Feb 28 09:53:59 dba systemd[1]: Starting File System Check on /dev/md2...
      Feb 28 09:53:59 dba kernel: ACPI: LAPIC_NMI (acpi_id[0x07] high edge lint[0x1])
      Feb 28 09:53:59 dba kernel: ACPI: LAPIC_NMI (acpi_id[0x08] high edge lint[0x1])
      Feb 28 09:53:59 dba kernel: IOAPIC[0]: apic_id 2, version 32, address 0xfec00000, GSI 0-119
      Feb 28 09:53:59 dba systemd-fsck[600]: /boot: recovering journal
      Feb 28 09:53:59 dba kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
      Feb 28 09:53:59 dba kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
      Feb 28 09:53:59 dba systemd-fsck[599]: /data: recovering journal
      Feb 28 09:53:59 dba kernel: ACPI: IRQ0 used by override.
      Feb 28 09:53:59 dba kernel: ACPI: IRQ9 used by override.
      Feb 28 09:53:59 dba systemd-fsck[600]: /boot: clean, 603/131072 files, 52758/523200 blocks
      Feb 28 09:53:59 dba systemd[1]: Started File System Check on /dev/md2.
      Feb 28 09:53:59 dba systemd[1]: Mounting /boot...
      Feb 28 09:53:59 dba systemd[1]: Mounted /boot.
      Feb 28 09:53:59 dba systemd[1]: Mounting /boot/efi...
      Feb 28 09:53:59 dba systemd[1]: Mounted /boot/efi.
      Feb 28 09:53:59 dba systemd-fsck[599]: /data: clean, 454929/120717312 files, 17098739/482864368 blocks
      Feb 28 09:53:59 dba systemd[1]: Started File System Check on /dev/md4.
      Feb 28 09:53:59 dba systemd[1]: Mounting /data...
      Feb 28 09:53:59 dba systemd[1]: Mounted /data.
      Feb 28 09:53:59 dba systemd[1]: Reached target Local File Systems.
      Feb 28 09:53:59 dba systemd[1]: Starting Raise network interfaces...
      Feb 28 09:53:59 dba systemd[1]: Starting Set console font and keymap...
      Feb 28 09:53:59 dba systemd[1]: Starting Create Volatile Files and Directories...
      Feb 28 09:53:59 dba systemd[1]: Started Set console font and keymap.
      Feb 28 09:53:59 dba kernel: Using ACPI (MADT) for SMP configuration information
      Feb 28 09:53:59 dba systemd[1]: Started Create Volatile Files and Directories.
      Feb 28 09:53:59 dba kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000
      Feb 28 09:53:59 dba kernel: smpboot: Allowing 8 CPUs, 0 hotplug CPUs
      Feb 28 09:53:59 dba kernel: e820: [mem 0x9e000000-0xe00f9fff] available for PCI devices
      Feb 28 09:53:59 dba systemd[1]: Starting Update UTMP about System Boot/Shutdown...
      eb 28 09:53:59 dba kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns
      Feb 28 09:53:59 dba kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:512 nr_cpu_ids:8 nr_node_ids:1
      Feb 28 09:53:59 dba systemd[1]: Starting Network Time Synchronization...
      Feb 28 09:53:59 dba kernel: percpu: Embedded 33 pages/cpu @ffff881061c00000 s97048 r8192 d29928 u262144
      Feb 28 09:53:59 dba kernel: pcpu-alloc: s97048 r8192 d29928 u262144 alloc=1*2097152
      Feb 28 09:53:59 dba systemd[1]: Started Update UTMP about System Boot/Shutdown.
      Feb 28 09:53:59 dba kernel: pcpu-alloc: [0] 0 1 2 3 4 5 6 7
      Feb 28 09:53:59 dba kernel: Built 1 zonelists in Node order, mobility grouping on.  Total pages: 16425738
      Feb 28 09:53:59 dba systemd[1]: Started Network Time Synchronization.
      Feb 28 09:53:59 dba kernel: Policy zone: Normal
      Feb 28 09:53:59 dba kernel: Kernel command line: BOOT_IMAGE=/bzImage-4.9.33-mod-std-ipv6-64 root=/dev/md3 ro rootdelay=10 noquiet nosplash net.ifnames=0 biosdevname=0
      Feb 28 09:53:59 dba systemd[1]: Reached target System Time Synchronized.
      Feb 28 09:53:59 dba kernel: PID hash table entries: 4096 (order: 3, 32768 bytes)
      Feb 28 09:53:59 dba kernel: Memory: 65527836K/66750296K available (16496K kernel code, 1024K rwdata, 4936K rodata, 1092K init, 2812K bss, 1222460K reserved, 0K cma-reserved)
      Feb 28 09:53:59 dba kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=8, Nodes=1
      Feb 28 09:53:59 dba systemd[1]: Reached target System Initialization.
      Feb 28 09:53:59 dba kernel: Hierarchical RCU implementation.
      Feb 28 09:53:59 dba kernel:     Build-time adjustment of leaf fanout to 64.
      Feb 28 09:53:59 dba kernel:     RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=8.
      Feb 28 09:53:59 dba systemd[1]: Listening on D-Bus System Message Bus Socket.
      Feb 28 09:53:59 dba kernel: RCU: Adjusting geometry for rcu_fanout_leaf=64, nr_cpu_ids=8
      Feb 28 09:53:59 dba systemd[1]: Reached target Sockets.
      Feb 28 09:53:59 dba kernel: NR_IRQS:33024 nr_irqs:2048 16
      Feb 28 09:53:59 dba kernel: Console: colour dummy device 80x25
      Feb 28 09:53:59 dba kernel: console [tty0] enabled
      Feb 28 09:53:59 dba systemd[1]: Reached target Basic System.
      Feb 28 09:53:59 dba kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 79635855245 ns
      Feb 28 09:53:59 dba kernel: hpet clockevent registered
      Feb 28 09:53:59 dba systemd[1]: Started Regular background program processing daemon.
      Feb 28 09:53:59 dba kernel: tsc: Detected 3800.000 MHz processor
      Feb 28 09:53:59 dba kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 7584.00 BogoMIPS (lpj=15168000)
      Feb 28 09:53:59 dba systemd-timesyncd[654]: Synchronized to time server 95.81.173.155:123 (0.debian.pool.ntp.org).
      Feb 28 09:53:59 dba kernel: pid_max: default: 32768 minimum: 301
      Feb 28 09:53:59 dba kernel: EXT4-fs (md3): mounted filesystem with ordered data mode. Opts: (null)
      Feb 28 09:53:59 dba kernel: VFS: Mounted root (ext4 filesystem) readonly on device 9:3.
      Feb 28 09:53:59 dba kernel: devtmpfs: mounted
      Feb 28 09:53:59 dba kernel: Freeing unused kernel memory: 1092K (ffffffff82902000 - ffffffff82a13000)
      Feb 28 09:53:59 dba kernel: Write protecting the kernel read-only data: 24576k
      Feb 28 09:53:59 dba kernel: Freeing unused kernel memory: 1908K (ffff880002023000 - ffff880002200000)
      Feb 28 09:53:59 dba kernel: Freeing unused kernel memory: 1208K (ffff8800026d2000 - ffff880002800000)
      Feb 28 09:53:59 dba kernel: x86/mm: Checked W+X mappings: passed, no W+X pages found.
      Feb 28 09:53:59 dba kernel: EXT4-fs (md3): re-mounted. Opts: errors=remount-ro
      Feb 28 09:53:59 dba kernel: Adding 523260k swap on /dev/sda5.  Priority:-1 extents:1 across:523260k
      Feb 28 09:53:59 dba kernel: Adding 523260k swap on /dev/sdb5.  Priority:-2 extents:1 across:523260k
      Feb 28 09:53:59 dba kernel: EXT4-fs (md2): mounted filesystem with ordered data mode. Opts: errors=remount-ro
      Feb 28 09:53:59 dba kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
      Feb 28 09:53:59 dba kernel: EXT4-fs (md4): barriers disabled
      Feb 28 09:53:59 dba kernel: EXT4-fs (md4): mounted filesystem with ordered data mode. Opts: nobarrier,data=ordered
      Feb 28 09:53:59 dba kernel: IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
      Feb 28 09:53:59 dba kernel: 8021q: adding VLAN 0 to HW filter on device eth0
      Feb 28 09:53:59 dba kernel: igb 0000:02:00.0 eth0: igb: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX
      Feb 28 09:53:59 dba kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
      Feb 28 09:53:59 dba kernel: Process accounting resumed
      Feb 28 09:53:59 dba systemd[1]: Started System Logging Service.
      Feb 28 09:53:59 dba systemd[1]: Started Atop process accounting daemon.
      Feb 28 09:53:59 dba smartd[714]: Device: /dev/sda [SAT], is SMART capable. Adding to "monitor" list.
      Feb 28 09:53:59 dba systemd[1]: Started Login Service.
      Feb 28 09:53:59 dba smartd[714]: Device: /dev/sda [SAT], state read from /var/lib/smartmontools/smartd.HGST_HUS726020ALA610-K5H88L5A.ata.state
      Feb 28 09:53:59 dba systemd[1]: Started Atop advanced performance monitor.
      Feb 28 09:53:59 dba smartd[714]: Device: /dev/sdb, type changed from 'scsi' to 'sat'
      Feb 28 09:53:59 dba smartd[714]: Device: /dev/sdb [SAT], opened
      Feb 28 09:53:59 dba smartd[714]: Device: /dev/sdb [SAT], HGST HUS726020ALA610, S/N:K5H88KVA, WWN:5-000cca-25ed1daaa, FW:A5GNT920, 2.00 TB
      Feb 28 09:53:59 dba smartd[714]: Device: /dev/sdb [SAT], not found in smartd database.
      Feb 28 09:53:59 dba smartd[714]: Device: /dev/sdb [SAT], is SMART capable. Adding to "monitor" list.
      Feb 28 09:53:59 dba smartd[714]: Device: /dev/sdb [SAT], state read from /var/lib/smartmontools/smartd.HGST_HUS726020ALA610-K5H88KVA.ata.state
      Feb 28 09:53:59 dba smartd[714]: Monitoring 2 ATA/SATA, 0 SCSI/SAS and 0 NVMe devices
      Feb 28 09:53:59 dba smartd[714]: Device: /dev/sda [SAT], state written to /var/lib/smartmontools/smartd.HGST_HUS726020ALA610-K5H88L5A.ata.state
      Feb 28 09:53:59 dba smartd[714]: Device: /dev/sdb [SAT], state written to /var/lib/smartmontools/smartd.HGST_HUS726020ALA610-K5H88KVA.ata.state
      Feb 28 09:54:01 dba CRON[811]: (root) CMD (/usr/local/rtm/bin/rtm 2 > /dev/null 2> /dev/null)
      Feb 28 09:54:01 dba ifup[635]: Waiting for DAD... Done
      Feb 28 09:54:08 dba systemd[1]: Time has been changed
      Feb 28 09:54:08 dba ntpdate[710]: step time server 92.222.117.115 offset -0.013647 sec
      Feb 28 09:54:08 dba systemd[1]: apt-daily-upgrade.timer: Adding 23min 32.397333s random time.
      Feb 28 09:54:11 dba systemd[1]: Started Raise network interfaces.
      Feb 28 09:54:11 dba systemd[1]: Reached target Network.
      Feb 28 09:54:11 dba systemd[1]: Started BIND Domain Name Server.
      Feb 28 09:54:11 dba systemd[1]: Reached target Host and Network Name Lookups.
      Feb 28 09:54:11 dba systemd[1]: Starting Permit User Sessions...
      Feb 28 09:54:11 dba systemd[1]: Starting MariaDB database server...
      Feb 28 09:54:11 dba systemd[1]: Starting OpenBSD Secure Shell server...
      Feb 28 09:54:11 dba systemd[1]: Reached target Network is Online.
      Feb 28 09:54:11 dba systemd[1]: Starting Daily apt download activities...
      Feb 28 09:54:11 dba systemd[1]: Starting LSB: disk temperature monitoring daemon...
      Feb 28 09:54:11 dba systemd[1]: Started Permit User Sessions.
      Feb 28 09:54:11 dba named[977]: starting BIND 9.10.3-P4-Debian <id:ebd72b3> -f -u bind
      Feb 28 09:54:11 dba named[977]: built with '--prefix=/usr' '--mandir=/usr/share/man' '--libdir=/usr/lib/x86_64-linux-gnu' '--infodir=/usr/share/info' '--sysconfdir=/etc/bind' '--with-python=python3' '--localstatedir=/' '--enable-threads' '--enable-largefile' '--with-libtool' '--enable-shared' '--enable-static' '--with-gost=no' '--with-openssl=/usr' '--with-gssapi=/usr' '--with-gnu-ld' '--with-geoip=/usr' '--with-atf=no' '--enable-ipv6' '--enable-rrl' '--enable-filter-aaaa' '--enable-native-pkcs11' '--with-pkcs11=/usr/lib/x86_64-linux-gnu/softhsm/libsofthsm2.so' '--with-randomdev=/dev/urandom' 'CFLAGS=-g -O2 -fdebug-prefix-map=/build/bind9-VypbYM/bind9-9.10.3.dfsg.P4=. -fstack-protector-strong -Wformat -Werror=format-security -fno-strict-aliasing -fno-delete-null-pointer-checks -DNO_VERSION_DATE -DDIG_SIGCHASE' 'LDFLAGS=-Wl,-z,relro -Wl,-z,now' 'CPPFLAGS=-Wdate-time -D_FORTIFY_SOURCE=2'
      Feb 28 09:54:11 dba named[977]: ----------------------------------------------------
      Feb 28 09:54:11 dba named[977]: BIND 9 is maintained by Internet Systems Consortium,
      Feb 28 09:54:11 dba named[977]: Inc. (ISC), a non-profit 501(c)(3) public-benefit
      Feb 28 09:54:11 dba systemd[1]: Started Getty on tty1.
      Feb 28 09:54:11 dba named[977]: corporation.  Support and training for BIND 9 are
      Feb 28 09:54:11 dba named[977]: available at https://www.isc.org/support
      Feb 28 09:54:11 dba named[977]: ----------------------------------------------------
      Feb 28 09:54:11 dba named[977]: adjusted limit on open files from 4096 to 1048576
      Feb 28 09:54:11 dba systemd[1]: Reached target Login Prompts.
      Feb 28 09:54:11 dba named[977]: zone 255.in-addr.arpa/IN: loaded serial 1
      Feb 28 09:54:11 dba named[977]: zone 127.in-addr.arpa/IN: loaded serial 1
      Feb 28 09:54:11 dba named[977]: all zones loaded
      Feb 28 09:54:11 dba named[977]: running
      Feb 28 09:54:13 dba mysqld[1198]: 2018-02-28  9:54:13 140093945811520 [Note] Using unique option prefix 'log-slave-update' is error-prone and can break in the future. Please use the full name 'log_slave_updates' instead.
      Feb 28 09:54:13 dba mysqld[1198]: 2018-02-28  9:54:13 140093945811520 [Note] /usr/sbin/mysqld (mysqld 10.1.26-MariaDB-0+deb9u1) starting as process 1198 ...
      Feb 28 09:54:15 dba systemd[1]: Started Daily apt download activities.
      Feb 28 09:54:15 dba systemd[1]: apt-daily.timer: Adding 8h 53min 48.228706s random time.
      Feb 28 09:54:15 dba systemd[1]: apt-daily.timer: Adding 7h 1min 16.528137s random time.
      Feb 28 09:54:21 dba systemd[1]: Time has been changed
      Feb 28 09:54:21 dba systemd[1]: apt-daily-upgrade.timer: Adding 2min 47.694402s random time.
      Feb 28 09:54:21 dba ntpdate[941]: step time server 5.196.192.58 offset 0.000021 sec
      Feb 28 09:54:21 dba systemd[1]: apt-daily.timer: Adding 7h 5min 12.028169s random time.
      Feb 28 09:55:00 dba CRON[1437]: (root) CMD (/usr/local/rtm/bin/rtm 2 > /dev/null 2> /dev/null)
      Feb 28 09:55:42 dba systemd[1]: mariadb.service: Start operation timed out. Terminating.
      Feb 28 09:56:01 dba CRON[1536]: (root) CMD (/usr/local/rtm/bin/rtm 2 > /dev/null 2> /dev/null)
      Feb 28 09:57:01 dba CRON[1635]: (root) CMD (/usr/local/rtm/bin/rtm 2 > /dev/null 2> /dev/null)
      Feb 28 09:57:12 dba systemd[1]: mariadb.service: State 'stop-final-sigterm' timed out. Skipping SIGKILL. Entering failed mode.
      Feb 28 09:57:12 dba systemd[1]: Failed to start MariaDB database server.
      Feb 28 09:57:12 dba systemd[1]: mariadb.service: Unit entered failed state.
      Feb 28 09:57:12 dba systemd[1]: mariadb.service: Failed with result 'timeout'.
      Feb 28 09:57:12 dba systemd[1]: Reached target Multi-User System.
      Feb 28 09:57:12 dba systemd[1]: Reached target Graphical Interface.
      Feb 28 09:57:12 dba systemd[1]: Starting Update UTMP about System Runlevel Changes...
      Feb 28 09:57:12 dba systemd[1]: Started Update UTMP about System Runlevel Changes.
      Feb 28 09:57:12 dba systemd[1]: Startup finished in 17.191s (kernel) + 3min 17.756s (userspace) = 3min 34.947s.
      Feb 28 09:58:01 dba CRON[1738]: (root) CMD (/usr/local/rtm/bin/rtm 2 > /dev/null 2> /dev/null)
      Feb 28 09:59:01 dba CRON[1837]: (root) CMD (/usr/local/rtm/bin/rtm 2 > /dev/null 2> /dev/null)
      Feb 28 10:00:01 dba CRON[1952]: (root) CMD (/usr/local/rtm/bin/rtm 2 > /dev/null 2> /dev/null)
      Feb 28 10:01:01 dba CRON[2051]: (root) CMD (/usr/local/rtm/bin/rtm 2 > /dev/null 2> /dev/null)
      Feb 28 10:02:01 dba CRON[2152]: (root) CMD (/usr/local/rtm/bin/rtm 2 > /dev/null 2> /dev/null)
      Feb 28 10:03:01 dba CRON[2251]: (root) CMD (/usr/local/rtm/bin/rtm 2 > /dev/null 2> /dev/null)
      Feb 28 10:04:01 dba CRON[2363]: (root) CMD (/usr/local/rtm/bin/rtm 2 > /dev/null 2> /dev/null)
      Feb 28 10:04:10 dba systemd[1]: Starting MariaDB database server...
      Feb 28 10:04:11 dba mysqld[2687]: 2018-02-28 10:04:11 140544819712576 [Note] Using unique option prefix 'log-slave-update' is error-prone and can break in the future. Please use the full name 'log_slave_updates' instead.
      Feb 28 10:04:11 dba mysqld[2687]: 2018-02-28 10:04:11 140544819712576 [Note] /usr/sbin/mysqld (mysqld 10.1.26-MariaDB-0+deb9u1) starting as process 2687 ...
      Feb 28 10:05:01 dba CRON[2704]: (root) CMD (/usr/local/rtm/bin/rtm 2 > /dev/null 2> /dev/null)
      Feb 28 10:06:01 dba CRON[2826]: (root) CMD (/usr/local/rtm/bin/rtm 2 > /dev/null 2> /dev/null)
      Feb 28 10:06:23 dba systemd[1]: mariadb.service: Main process exited, code=exited, status=1/FAILURE
      Feb 28 10:06:23 dba systemd[1]: Stopped MariaDB database server.
      Feb 28 10:06:23 dba systemd[1]: mariadb.service: Unit entered failed state.
      Feb 28 10:06:23 dba systemd[1]: mariadb.service: Failed with result 'exit-code'.
      Feb 28 10:07:01 dba CRON[2927]: (root) CMD (/usr/local/rtm/bin/rtm 2 > /dev/null 2> /dev/null)
      Feb 28 10:08:01 dba CRON[3026]: (root) CMD (/usr/local/rtm/bin/rtm 2 > /dev/null 2> /dev/null)
      Feb 28 10:08:44 dba systemd[1]: Starting Cleanup of Temporary Directories...
      Feb 28 10:08:44 dba systemd[1]: Started Cleanup of Temporary Directories.
      Feb 28 10:09:01 dba CRON[3128]: (root) CMD (/usr/local/rtm/bin/rtm 2 > /dev/null 2> /dev/null)
      Feb 28 10:09:20 dba systemd[1]: Stopped target Timers.
      Feb 28 10:09:20 dba systemd[1]: Stopped target Graphical Interface.
      Feb 28 10:09:20 dba systemd[1]: Stopped target Multi-User System.
      Feb 28 10:09:20 dba systemd[1]: Stopping Login Service...
      Feb 28 10:09:20 dba systemd[1]: Stopping irqbalance daemon...
       
      
      

      look like some trouble and mariadb started 2 times (problem with systemctl ?)

      Attachments

        Activity

          People

            Unassigned Unassigned
            Aurelien_LEQUOY Aurélien LEQUOY
            Votes:
            0 Vote for this issue
            Watchers:
            3 Start watching this issue

            Dates

              Created:
              Updated:
              Resolved:

              Git Integration

                Error rendering 'com.xiplink.jira.git.jira_git_plugin:git-issue-webpanel'. Please contact your Jira administrators.