[MDEV-18854] mariadb fails with timeout, because of apparmor Created: 2019-03-08  Updated: 2021-03-19

Status: Stalled
Project: MariaDB Server
Component/s: Scripts & Clients
Affects Version/s: 10.3.13
Fix Version/s: 10.3

Type: Bug Priority: Major
Reporter: ill Assignee: Sergei Golubchik
Resolution: Unresolved Votes: 0
Labels: apparmor
Environment:

ubuntu 18.04
Linux tuvok 4.15.0-46-generic #49-Ubuntu SMP Wed Feb 6 09:33:07 UTC 2019 x86_64 x86_64 x86_64 GNU/Linux


 Description   

When starting mariadb from a fresh install, it always fails to start with a timeout

Mar 07 19:33:20 compy audit[20923]: AVC apparmor="ALLOWED" operation="sendmsg" info="Failed name lookup - disconnected path" error=-13 profile="/usr/sbin/mysqld" name="run/systemd/notify" pid=20923 comm="mysqld" requested_mask="w" denied_mask="w" fsuid=125 ouid=0
 
Mar 07 19:33:20 compy audit[20923]: AVC apparmor="ALLOWED" operation="create" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="create" denied_mask="create" addr=none
 
Mar 07 19:33:20 compy audit[20923]: AVC apparmor="ALLOWED" operation="getsockopt" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="getopt" denied_mask="getopt" addr=none
 
Mar 07 19:33:20 compy audit[20923]: AVC apparmor="ALLOWED" operation="setsockopt" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="setopt" denied_mask="setopt" addr=none
 
Mar 07 19:33:20 compy audit[20923]: AVC apparmor="ALLOWED" operation="setsockopt" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="setopt" denied_mask="setopt" addr=none
 
Mar 07 19:33:20 compy audit[20923]: AVC apparmor="ALLOWED" operation="sendmsg" info="Failed name lookup - disconnected path" error=-13 profile="/usr/sbin/mysqld" name="run/systemd/notify" pid=20923 comm="mysqld" requested_mask="w" denied_mask="w" fsuid=125 ouid=0
 
Mar 07 19:33:20 compy audit[20923]: AVC apparmor="ALLOWED" operation="create" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="create" denied_mask="create" addr=none
 
Mar 07 19:33:20 compy audit[20923]: AVC apparmor="ALLOWED" operation="getsockopt" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="getopt" denied_mask="getopt" addr=none
 
Mar 07 19:33:20 compy audit[20923]: AVC apparmor="ALLOWED" operation="setsockopt" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="setopt" denied_mask="setopt" addr=none
 
Mar 07 19:33:20 compy audit[20923]: AVC apparmor="ALLOWED" operation="setsockopt" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="setopt" denied_mask="setopt" addr=none
 
Mar 07 19:33:20 compy audit[20923]: AVC apparmor="ALLOWED" operation="sendmsg" info="Failed name lookup - disconnected path" error=-13 profile="/usr/sbin/mysqld" name="run/systemd/notify" pid=20923 comm="mysqld" requested_mask="w" denied_mask="w" fsuid=125 ouid=0
 
Mar 07 19:33:21 compy audit[20923]: AVC apparmor="ALLOWED" operation="create" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="create" denied_mask="create" addr=none
 
Mar 07 19:33:21 compy audit[20923]: AVC apparmor="ALLOWED" operation="getsockopt" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="getopt" denied_mask="getopt" addr=none
 
Mar 07 19:33:21 compy audit[20923]: AVC apparmor="ALLOWED" operation="setsockopt" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="setopt" denied_mask="setopt" addr=none
 
Mar 07 19:33:21 compy audit[20923]: AVC apparmor="ALLOWED" operation="setsockopt" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="setopt" denied_mask="setopt" addr=none
 
Mar 07 19:33:21 compy audit[20923]: AVC apparmor="ALLOWED" operation="sendmsg" info="Failed name lookup - disconnected path" error=-13 profile="/usr/sbin/mysqld" name="run/systemd/notify" pid=20923 comm="mysqld" requested_mask="w" denied_mask="w" fsuid=125 ouid=0
 
Mar 07 19:33:21 compy audit[20923]: AVC apparmor="ALLOWED" operation="create" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="create" denied_mask="create" addr=none
 
Mar 07 19:33:21 compy audit[20923]: AVC apparmor="ALLOWED" operation="getsockopt" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="getopt" denied_mask="getopt" addr=none
 
Mar 07 19:33:21 compy audit[20923]: AVC apparmor="ALLOWED" operation="setsockopt" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="setopt" denied_mask="setopt" addr=none
 
Mar 07 19:33:21 compy audit[20923]: AVC apparmor="ALLOWED" operation="setsockopt" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="setopt" denied_mask="setopt" addr=none
 
Mar 07 19:33:21 compy audit[20923]: AVC apparmor="ALLOWED" operation="sendmsg" info="Failed name lookup - disconnected path" error=-13 profile="/usr/sbin/mysqld" name="run/systemd/notify" pid=20923 comm="mysqld" requested_mask="w" denied_mask="w" fsuid=125 ouid=0
 
Mar 07 19:33:21 compy audit[20923]: AVC apparmor="ALLOWED" operation="create" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="create" denied_mask="create" addr=none
 
Mar 07 19:33:21 compy audit[20923]: AVC apparmor="ALLOWED" operation="getsockopt" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="getopt" denied_mask="getopt" addr=none
 
Mar 07 19:33:21 compy audit[20923]: AVC apparmor="ALLOWED" operation="setsockopt" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="setopt" denied_mask="setopt" addr=none
 
Mar 07 19:33:21 compy audit[20923]: AVC apparmor="ALLOWED" operation="setsockopt" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="setopt" denied_mask="setopt" addr=none
 
Mar 07 19:33:21 compy audit[20923]: AVC apparmor="ALLOWED" operation="sendmsg" info="Failed name lookup - disconnected path" error=-13 profile="/usr/sbin/mysqld" name="run/systemd/notify" pid=20923 comm="mysqld" requested_mask="w" denied_mask="w" fsuid=125 ouid=0
 
Mar 07 19:33:22 compy audit[20923]: AVC apparmor="ALLOWED" operation="unlink" profile="/usr/sbin/mysqld" name="/var/lib/mysql/tc.log" pid=20923 comm="mysqld" requested_mask="d" denied_mask="d" fsuid=125 ouid=125
 
Mar 07 19:33:22 compy audit[20923]: AVC apparmor="ALLOWED" operation="unlink" profile="/usr/sbin/mysqld" name="/run/mysqld/mysqld.pid" pid=20923 comm="mysqld" requested_mask="d" denied_mask="d" fsuid=125 ouid=125
 
Mar 07 19:33:22 compy audit[20923]: AVC apparmor="ALLOWED" operation="create" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="create" denied_mask="create" addr=none
 
Mar 07 19:33:22 compy audit[20923]: AVC apparmor="ALLOWED" operation="getsockopt" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="getopt" denied_mask="getopt" addr=none
 
Mar 07 19:33:22 compy audit[20923]: AVC apparmor="ALLOWED" operation="setsockopt" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="setopt" denied_mask="setopt" addr=none
 
Mar 07 19:33:22 compy audit[20923]: AVC apparmor="ALLOWED" operation="setsockopt" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="setopt" denied_mask="setopt" addr=none
 
Mar 07 19:33:22 compy audit[20923]: AVC apparmor="ALLOWED" operation="sendmsg" info="Failed name lookup - disconnected path" error=-13 profile="/usr/sbin/mysqld" name="run/systemd/notify" pid=20923 comm="mysqld" requested_mask="w" denied_mask="w" fsuid=125 ouid=0
 
Mar 07 19:33:22 compy audit[20923]: AVC apparmor="ALLOWED" operation="signal" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" requested_mask="send" denied_mask="send" signal=term peer="/usr/sbin/mysqld"
 
Mar 07 19:33:22 compy audit[20923]: AVC apparmor="ALLOWED" operation="signal" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" requested_mask="receive" denied_mask="receive" signal=term peer="/usr/sbin/mysqld"
 
Mar 07 19:33:22 compy audit[20923]: AVC apparmor="ALLOWED" operation="create" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="create" denied_mask="create" addr=none
 
Mar 07 19:33:22 compy audit[20923]: AVC apparmor="ALLOWED" operation="getsockopt" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="getopt" denied_mask="getopt" addr=none
 
Mar 07 19:33:22 compy audit[20923]: AVC apparmor="ALLOWED" operation="setsockopt" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="setopt" denied_mask="setopt" addr=none
 
Mar 07 19:33:22 compy audit[20923]: AVC apparmor="ALLOWED" operation="setsockopt" profile="/usr/sbin/mysqld" pid=20923 comm="mysqld" family="unix" sock_type="dgram" protocol=0 requested_mask="setopt" denied_mask="setopt" addr=none
 
Mar 07 19:33:22 compy audit[20923]: AVC apparmor="ALLOWED" operation="sendmsg" info="Failed name lookup - disconnected path" error=-13 profile="/usr/sbin/mysqld" name="run/systemd/notify" pid=20923 comm="mysqld" requested_mask="w" denied_mask="w" fsuid=125 ouid=0
 
Mar 07 19:33:22 compy systemd[1]: mariadb.service: Failed with result 'timeout'.
 
Mar 07 19:33:22 compy systemd[1]: Failed to start MariaDB 10.1.38 database server.
 
-- Subject: Unit mariadb.service has failed
 
-- Defined-By: systemd
 
-- Support: http://www.ubuntu.com/support
 
-- 
-- Unit mariadb.service has failed.
 
-- 
-- The result is RESULT.



 Comments   
Comment by Daniel Black [ 2019-03-08 ]

can you include `systemctl show mariadb.service` and `journalctl -u mariadb.service`?

Comment by ill [ 2019-03-08 ]

Type=notify
Restart=on-abort
NotifyAccess=main
RestartUSec=5s
TimeoutStartUSec=1min 30s
TimeoutStopUSec=1min 30s
RuntimeMaxUSec=infinity
WatchdogUSec=0
WatchdogTimestampMonotonic=0
PermissionsStartOnly=yes
RootDirectoryStartOnly=no
RemainAfterExit=no
GuessMainPID=yes
MainPID=0
ControlPID=0
FileDescriptorStoreMax=0
NFileDescriptorStore=0
StatusErrno=0
Result=timeout
UID=[not set]
GID=[not set]
NRestarts=0
ExecMainStartTimestamp=Thu 2019-03-07 19:31:50 MST
ExecMainStartTimestampMonotonic=11279037386
ExecMainExitTimestamp=Thu 2019-03-07 19:33:22 MST
ExecMainExitTimestampMonotonic=11371364706
ExecMainPID=20923
ExecMainCode=1
ExecMainStatus=0
ExecStartPre={ path=/usr/bin/install ; argv[]=/usr/bin/install -m 755 -o mysql -g root -d /var/run/mysqld ; ignore_errors=no ; start_time=[Thu 2019-03-07 19:31:49 MST] ; stop_time=[Thu 2019-03-07 19:31:49 MST] ; pid=20845 ; code
ExecStartPre={ path=/bin/sh ; argv[]=/bin/sh -c systemctl unset-environment _WSREP_START_POSITION ; ignore_errors=no ; start_time=[Thu 2019-03-07 19:31:49 MST] ; stop_time=[Thu 2019-03-07 19:31:50 MST] ; pid=20846 ; code=exited
ExecStartPre={ path=/bin/sh ; argv[]=/bin/sh -c [ ! -e /usr/bin/galera_recovery ] && VAR= || VAR=`/usr/bin/galera_recovery`; [ $? -eq 0 ] && systemctl set-environment _WSREP_START_POSITION=$VAR || exit 1 ; ignore_errors=no ;
ExecStart={ path=/usr/sbin/mysqld ; argv[]=/usr/sbin/mysqld $MYSQLD_OPTS $_WSREP_NEW_CLUSTER $_WSREP_START_POSITION ; ignore_errors=no ; start_time=[Thu 2019-03-07 19:31:50 MST] ; stop_time=[Thu 2019-03-07 19:33:22 MST] ; pid=20
ExecStartPost=

{ path=/etc/mysql/debian-start ; argv[]=/etc/mysql/debian-start ; ignore_errors=no ; start_time=[n/a] ; stop_time=[n/a] ; pid=0 ; code=(null) ; status=0/0 }

ExecStartPost=

{ path=/bin/sh ; argv[]=/bin/sh -c systemctl unset-environment _WSREP_START_POSITION ; ignore_errors=no ; start_time=[n/a] ; stop_time=[n/a] ; pid=0 ; code=(null) ; status=0/0 }

Slice=system.slice
MemoryCurrent=[not set]
CPUUsageNSec=[not set]
TasksCurrent=[not set]
IPIngressBytes=18446744073709551615
IPIngressPackets=18446744073709551615
IPEgressBytes=18446744073709551615
IPEgressPackets=18446744073709551615
Delegate=no
CPUAccounting=no
CPUWeight=[not set]
StartupCPUWeight=[not set]
CPUShares=[not set]
StartupCPUShares=[not set]
CPUQuotaPerSecUSec=infinity
IOAccounting=no
IOWeight=[not set]
StartupIOWeight=[not set]
BlockIOAccounting=no
BlockIOWeight=[not set]
StartupBlockIOWeight=[not set]
MemoryAccounting=no
MemoryLow=0
MemoryHigh=infinity
MemoryMax=infinity
MemorySwapMax=infinity
MemoryLimit=infinity
DevicePolicy=closed
TasksAccounting=yes
TasksMax=4915
IPAccounting=no
UMask=0007
LimitCPU=infinity
LimitCPUSoft=infinity
LimitFSIZE=infinity
LimitFSIZESoft=infinity
LimitDATA=infinity
LimitDATASoft=infinity
LimitSTACK=infinity
LimitSTACKSoft=8388608
LimitCORE=infinity
LimitCORESoft=0
LimitRSS=infinity
LimitRSSSoft=infinity
LimitNOFILE=16364
LimitNOFILESoft=16364
LimitAS=infinity
LimitASSoft=infinity
LimitNPROC=31468
LimitNPROCSoft=31468
LimitMEMLOCK=16777216
LimitMEMLOCKSoft=16777216
LimitLOCKS=infinity
LimitLOCKSSoft=infinity
LimitSIGPENDING=31468
LimitSIGPENDINGSoft=31468
LimitMSGQUEUE=819200
LimitMSGQUEUESoft=819200
LimitNICE=0
LimitNICESoft=0
LimitRTPRIO=0
LimitRTPRIOSoft=0
LimitRTTIME=infinity
LimitRTTIMESoft=infinity
OOMScoreAdjust=0
Nice=0
IOSchedulingClass=0
IOSchedulingPriority=0
CPUSchedulingPolicy=0
CPUSchedulingPriority=0
TimerSlackNSec=50000
CPUSchedulingResetOnFork=no
NonBlocking=no
StandardInput=null
StandardInputData=
StandardOutput=journal
StandardError=inherit
TTYReset=no
TTYVHangup=no
TTYVTDisallocate=no
SyslogPriority=30
SyslogLevelPrefix=yes
SyslogLevel=6
SyslogFacility=3
LogLevelMax=-1
SecureBits=0
CapabilityBoundingSet=cap_ipc_lock
AmbientCapabilities=
User=mysql
Group=mysql
DynamicUser=no
RemoveIPC=no
MountFlags=
PrivateTmp=no
PrivateDevices=yes
ProtectKernelTunables=no
ProtectKernelModules=no
ProtectControlGroups=no
PrivateNetwork=no
PrivateUsers=no
ProtectHome=yes
ProtectSystem=full
SameProcessGroup=no
UtmpMode=init
IgnoreSIGPIPE=yes
NoNewPrivileges=no
SystemCallErrorNumber=0
LockPersonality=no
RuntimeDirectoryPreserve=no
RuntimeDirectoryMode=0755
StateDirectoryMode=0755
CacheDirectoryMode=0755
LogsDirectoryMode=0755
ConfigurationDirectoryMode=0755
MemoryDenyWriteExecute=no
RestrictRealtime=no
RestrictNamespaces=no
MountAPIVFS=no
KeyringMode=private
KillMode=control-group
KillSignal=15
SendSIGKILL=no
SendSIGHUP=no
Id=mariadb.service
Names=mariadb.service
Requires=system.slice sysinit.target
WantedBy=multi-user.target
Conflicts=shutdown.target
Before=multi-user.target shutdown.target
After=network.target system.slice systemd-journald.socket sysinit.target basic.target
Documentation=man:mysqld(8) https://mariadb.com/kb/en/library/systemd/
Description=MariaDB 10.1.38 database server
LoadState=loaded
ActiveState=failed
SubState=failed
FragmentPath=/lib/systemd/system/mariadb.service
UnitFileState=enabled
UnitFilePreset=enabled
StateChangeTimestamp=Thu 2019-03-07 19:33:22 MST
StateChangeTimestampMonotonic=11371364899
InactiveExitTimestamp=Thu 2019-03-07 19:31:49 MST
InactiveExitTimestampMonotonic=11278561118
ActiveEnterTimestampMonotonic=0
ActiveExitTimestampMonotonic=0
InactiveEnterTimestamp=Thu 2019-03-07 19:33:22 MST
InactiveEnterTimestampMonotonic=11371364899
CanStart=yes
CanStop=yes
CanReload=no
CanIsolate=no
StopWhenUnneeded=no
RefuseManualStart=no
RefuseManualStop=no
AllowIsolate=no
DefaultDependencies=yes
OnFailureJobMode=replace
IgnoreOnIsolate=no
NeedDaemonReload=no
JobTimeoutUSec=infinity
JobRunningTimeoutUSec=infinity
JobTimeoutAction=none
ConditionResult=yes
AssertResult=yes
ConditionTimestamp=Thu 2019-03-07 19:31:49 MST
ConditionTimestampMonotonic=11278559543
AssertTimestamp=Thu 2019-03-07 19:31:49 MST
AssertTimestampMonotonic=11278559543
Transient=no
Perpetual=no
StartLimitIntervalUSec=10s
StartLimitBurst=5
StartLimitAction=none
FailureAction=none
SuccessAction=none
InvocationID=bfbbedf42f5349b094c0e52f024e0d45
CollectMode=inactive

Comment by ill [ 2019-03-08 ]

– Reboot –
Mar 07 17:32:20 compy systemd[1]: Starting MariaDB 10.1.38 database server...
Mar 07 17:32:21 compy mysqld[7268]: 2019-03-07 17:32:21 139623115062400 [Note] /usr/sbin/mysqld (mysqld 10.1.38-MariaDB-0ubuntu0.18.04.1) starting as process 7268 ...
Mar 07 17:33:51 compy systemd[1]: mariadb.service: Start operation timed out. Terminating.
Mar 07 17:33:53 compy systemd[1]: mariadb.service: Failed with result 'timeout'.
Mar 07 17:33:53 compy systemd[1]: Failed to start MariaDB 10.1.38 database server.
Mar 07 17:54:55 compy systemd[1]: Starting MariaDB 10.1.38 database server...
Mar 07 17:54:56 compy mysqld[8077]: 2019-03-07 17:54:56 140472027610240 [Note] /usr/sbin/mysqld (mysqld 10.1.38-MariaDB-0ubuntu0.18.04.1) starting as process 8077 ...
Mar 07 17:56:25 compy systemd[1]: mariadb.service: Start operation timed out. Terminating.
Mar 07 17:56:28 compy systemd[1]: mariadb.service: Failed with result 'timeout'.
Mar 07 17:56:28 compy systemd[1]: Failed to start MariaDB 10.1.38 database server.
Mar 07 18:03:19 compy systemd[1]: Starting MariaDB 10.1.38 database server...
Mar 07 18:03:20 compy mysqld[11017]: 2019-03-07 18:03:20 140420308352128 [Note] /usr/sbin/mysqld (mysqld 10.1.38-MariaDB-0ubuntu0.18.04.1) starting as process 11017 ...
Mar 07 18:04:50 compy systemd[1]: mariadb.service: Start operation timed out. Terminating.
Mar 07 18:04:52 compy systemd[1]: mariadb.service: Failed with result 'timeout'.
Mar 07 18:04:52 compy systemd[1]: Failed to start MariaDB 10.1.38 database server.
Mar 07 18:09:35 compy systemd[1]: Starting MariaDB 10.1.38 database server...
Mar 07 18:09:36 compy mysqld[11663]: 2019-03-07 18:09:36 139668278099072 [Note] /usr/sbin/mysqld (mysqld 10.1.38-MariaDB-0ubuntu0.18.04.1) starting as process 11663 ...
Mar 07 18:11:06 compy systemd[1]: mariadb.service: Start operation timed out. Terminating.
Mar 07 18:11:08 compy systemd[1]: mariadb.service: Failed with result 'timeout'.
Mar 07 18:11:08 compy systemd[1]: Failed to start MariaDB 10.1.38 database server.
Mar 07 18:16:04 compy systemd[1]: Starting MariaDB 10.1.38 database server...
Mar 07 18:16:05 compy mysqld[12174]: 2019-03-07 18:16:05 140494982544512 [Note] /usr/sbin/mysqld (mysqld 10.1.38-MariaDB-0ubuntu0.18.04.1) starting as process 12174 ...
Mar 07 18:17:34 compy systemd[1]: mariadb.service: Start operation timed out. Terminating.
Mar 07 18:17:37 compy systemd[1]: mariadb.service: Failed with result 'timeout'.
Mar 07 18:17:37 compy systemd[1]: Failed to start MariaDB 10.1.38 database server.
Mar 07 18:24:50 compy systemd[1]: Starting MariaDB 10.1.38 database server...
Mar 07 18:24:51 compy mysqld[12578]: 2019-03-07 18:24:51 140296309116032 [Note] /usr/sbin/mysqld (mysqld 10.1.38-MariaDB-0ubuntu0.18.04.1) starting as process 12578 ...
Mar 07 18:26:20 compy systemd[1]: mariadb.service: Start operation timed out. Terminating.
Mar 07 18:26:23 compy systemd[1]: mariadb.service: Failed with result 'timeout'.
Mar 07 18:26:23 compy systemd[1]: Failed to start MariaDB 10.1.38 database server.
Mar 07 18:30:44 compy systemd[1]: Starting MariaDB 10.1.38 database server...
Mar 07 18:30:44 compy mysqld[13044]: 2019-03-07 18:30:44 140581408369792 [Note] /usr/sbin/mysqld (mysqld 10.1.38-MariaDB-0ubuntu0.18.04.1) starting as process 13044 ...
Mar 07 18:32:14 compy systemd[1]: mariadb.service: Start operation timed out. Terminating.
Mar 07 18:32:16 compy systemd[1]: mariadb.service: Failed with result 'timeout'.
Mar 07 18:32:16 compy systemd[1]: Failed to start MariaDB 10.1.38 database server.
Mar 07 19:05:58 compy systemd[1]: Starting MariaDB 10.1.38 database server...
Mar 07 19:05:59 compy mysqld[13876]: 2019-03-07 19:05:59 140606018460800 [Note] /usr/sbin/mysqld (mysqld 10.1.38-MariaDB-0ubuntu0.18.04.1) starting as process 13876 ...

Comment by Elena Stepanova [ 2019-04-06 ]

Does the server actually start?

Comment by ill [ 2019-06-10 ]

No it never seems to start

Comment by Stefan Beckers [ 2019-12-04 ]

The issue here for me was that the apparmor configuration deployed with mariadb is not a valid apparmor configuration.

I did install mariadb as a dropin replacement, which lead to a running mariadb just after the install via .deb /mariadb Repos. After reboot (say: restart of apparmor and reread of the new apparmor config) the
mariadb instance did fail to start.

For me the solution was to:
a) correct /etc/apparmor.d/usr.sbin.mysqld by appending "/usr/sbin/mysqld { }" to the file (empty config)
b) create a link from /etc/apparmor.d/disable/usr.sbin.mysqld -> /etc/apparmor.d/usr.sbin.mysqld
c) reload apparmor configuration (e.g. using systemctl restart)

Comment by Daniel Black [ 2021-03-19 ]

Event ubuntu https://git.launchpad.net/ubuntu/+source/mariadb-10.1/tree/debian/apparmor-profile?h=ubuntu/bionic-security appears empty.

A restrictive apparmor profile base of unbound example

edit /etc/apparmor.d/usr.sbin.mysqld to contain

 
 
 
  /{,var/}run/systemd/notify w

Generated at Thu Feb 08 08:47:14 UTC 2024 using Jira 8.20.16#820016-sha1:9d11dbea5f4be3d4cc21f03a88dd11d8c8687422.