После перезагрузки не корректно стартует fail2ban

[Everstuu]

Всем доброго времени суток, обнаружил что после перезагрузки сервера Ubuntu 16.04.7 LTS криво стартует fail2ban и ничего не блокирует, пишет

Код: [Выделить]

WARNING Command ['start', 'ssh'] has failed. Received OperationalError('database is locked',)Лог fail2ban после перезагрузки сервера

(Нажмите, чтобы показать/скрыть)

...
2021-05-20 10:23:45,362 fail2ban.filter         [1078]: INFO    [postfix-sasl] Found 45.156.29.31
2021-05-20 10:23:45,362 fail2ban.filter         [1078]: INFO    [postfix-sasl] Found 45.156.29.31
2021-05-20 10:23:45,362 fail2ban.filter         [1078]: INFO    [postfix-sasl] Found 45.156.29.31
2021-05-20 10:24:27,029 fail2ban.server         [1078]: INFO    Stopping all jails
2021-05-20 10:24:27,446 fail2ban.server         [2811]: INFO    Changed logging target to /var/log/fail2ban.log for Fail2ban v0.9.3
2021-05-20 10:24:27,447 fail2ban.database       [2811]: INFO    Connected to fail2ban persistent database '/var/lib/fail2ban/fail2ban.sqlite3'
2021-05-20 10:24:32,456 fail2ban.transmitter    [2811]: WARNING Command ['set', 'dbfile', '/var/lib/fail2ban/fail2ban.sqlite3'] has failed. Received OperationalError('database is locked',)
2021-05-20 10:24:32,464 fail2ban.jail           [2811]: INFO    Creating new jail 'sshd'
2021-05-20 10:24:32,493 fail2ban.jail           [2811]: INFO    Jail 'sshd' uses pyinotify
2021-05-20 10:24:32,505 fail2ban.filter         [2811]: INFO    Set jail log file encoding to ANSI_X3.4-1968
2021-05-20 10:24:32,508 fail2ban.jail           [2811]: INFO    Initiated 'pyinotify' backend
2021-05-20 10:24:37,544 fail2ban.transmitter    [2811]: WARNING Command ['add', 'sshd', 'auto'] has failed. Received OperationalError('database is locked',)
2021-05-20 10:24:37,544 fail2ban.filter         [2811]: INFO    Set maxRetry = 5
2021-05-20 10:24:37,545 fail2ban.filter         [2811]: INFO    Set jail log file encoding to ANSI_X3.4-1968
2021-05-20 10:24:37,545 fail2ban.actions        [2811]: INFO    Set banTime = 600
2021-05-20 10:24:42,552 fail2ban.transmitter    [2811]: WARNING Command ['set', 'sshd', 'addlogpath', '/var/log/auth.log', 'head'] has failed. Received OperationalError('database is locked',)
2021-05-20 10:24:42,553 fail2ban.filter         [2811]: INFO    Set findtime = 600
2021-05-20 10:24:42,553 fail2ban.filter         [2811]: INFO    Set maxlines = 10
2021-05-20 10:24:42,587 fail2ban.server         [2811]: INFO    Jail sshd is not a JournalFilter instance
2021-05-20 10:24:42,589 fail2ban.jail           [2811]: INFO    Creating new jail 'postfix-sasl'
2021-05-20 10:24:42,589 fail2ban.jail           [2811]: INFO    Jail 'postfix-sasl' uses pyinotify
2021-05-20 10:24:42,590 fail2ban.filter         [2811]: INFO    Set jail log file encoding to ANSI_X3.4-1968
2021-05-20 10:24:42,592 fail2ban.jail           [2811]: INFO    Initiated 'pyinotify' backend
2021-05-20 10:24:47,601 fail2ban.transmitter    [2811]: WARNING Command ['add', 'postfix-sasl', 'auto'] has failed. Received OperationalError('database is locked',)
2021-05-20 10:24:47,602 fail2ban.filter         [2811]: INFO    Set maxRetry = 5
2021-05-20 10:24:47,602 fail2ban.filter         [2811]: INFO    Set jail log file encoding to ANSI_X3.4-1968
2021-05-20 10:24:47,603 fail2ban.actions        [2811]: INFO    Set banTime = 2592000
2021-05-20 10:24:52,611 fail2ban.transmitter    [2811]: WARNING Command ['set', 'postfix-sasl', 'addlogpath', '/var/log/mail.log', 'head'] has failed. Received OperationalError('database is locked',)
2021-05-20 10:24:52,611 fail2ban.filter         [2811]: INFO    Set findtime = 86400
2021-05-20 10:24:52,620 fail2ban.server         [2811]: INFO    Jail postfix-sasl is not a JournalFilter instance
2021-05-20 10:24:52,637 fail2ban.jail           [2811]: INFO    Creating new jail 'pureftpd'
2021-05-20 10:24:52,637 fail2ban.jail           [2811]: INFO    Jail 'pureftpd' uses pyinotify
2021-05-20 10:24:52,638 fail2ban.filter         [2811]: INFO    Set jail log file encoding to ANSI_X3.4-1968
2021-05-20 10:24:52,644 fail2ban.jail           [2811]: INFO    Initiated 'pyinotify' backend
2021-05-20 10:24:57,654 fail2ban.transmitter    [2811]: WARNING Command ['add', 'pureftpd', 'auto'] has failed. Received OperationalError('database is locked',)апшт
2021-05-20 10:24:57,654 fail2ban.filter         [2811]: INFO    Set maxRetry = 3
2021-05-20 10:24:57,655 fail2ban.filter         [2811]: INFO    Set jail log file encoding to ANSI_X3.4-1968
2021-05-20 10:24:57,655 fail2ban.actions        [2811]: INFO    Set banTime = 600
2021-05-20 10:25:02,663 fail2ban.transmitter    [2811]: WARNING Command ['set', 'pureftpd', 'addlogpath', '/var/log/syslog', 'head'] has failed. Received OperationalError('database is locked',)
2021-05-20 10:25:02,663 fail2ban.filter         [2811]: INFO    Set findtime = 600
2021-05-20 10:25:02,666 fail2ban.jail           [2811]: INFO    Creating new jail 'ssh'
2021-05-20 10:25:02,666 fail2ban.jail           [2811]: INFO    Jail 'ssh' uses pyinotify
2021-05-20 10:25:02,667 fail2ban.filter         [2811]: INFO    Set jail log file encoding to ANSI_X3.4-1968
2021-05-20 10:25:02,669 fail2ban.jail           [2811]: INFO    Initiated 'pyinotify' backend
2021-05-20 10:25:07,703 fail2ban.transmitter    [2811]: WARNING Command ['add', 'ssh', 'auto'] has failed. Received OperationalError('database is locked',)
2021-05-20 10:25:07,703 fail2ban.filter         [2811]: INFO    Set maxRetry = 5
2021-05-20 10:25:07,704 fail2ban.filter         [2811]: INFO    Set jail log file encoding to ANSI_X3.4-1968
2021-05-20 10:25:07,704 fail2ban.actions        [2811]: INFO    Set banTime = -1
2021-05-20 10:25:12,713 fail2ban.transmitter    [2811]: WARNING Command ['set', 'ssh', 'addlogpath', '/var/log/auth.log', 'head'] has failed. Received OperationalError('database is locked',)
2021-05-20 10:25:12,713 fail2ban.filter         [2811]: INFO    Set findtime = 600
2021-05-20 10:25:12,713 fail2ban.filter         [2811]: INFO    Set maxlines = 10
2021-05-20 10:25:12,732 fail2ban.server         [2811]: INFO    Jail ssh is not a JournalFilter instance
2021-05-20 10:25:17,746 fail2ban.transmitter    [2811]: WARNING Command ['start', 'sshd'] has failed. Received OperationalError('database is locked',)
2021-05-20 10:25:22,800 fail2ban.transmitter    [2811]: WARNING Command ['start', 'postfix-sasl'] has failed. Received OperationalError('database is locked',)
2021-05-20 10:25:27,810 fail2ban.transmitter    [2811]: WARNING Command ['start', 'pureftpd'] has failed. Received OperationalError('database is locked',)
2021-05-20 10:25:32,821 fail2ban.transmitter    [2811]: WARNING Command ['start', 'ssh'] has failed. Received OperationalError('database is locked',)

Команда  service fail2ban status после перезагрузки сервера выдает:

Код: [Выделить]

● fail2ban.service - Fail2Ban Service
   Loaded: loaded (/lib/systemd/system/fail2ban.service; enabled; vendor preset: enabled)
   Active: active (running) since Thu 2021-05-20 10:25:32 MSK; 22min ago
     Docs: man:fail2ban(1)
  Process: 2808 ExecStart=/usr/bin/fail2ban-client -x start (code=exited, status=0/SUCCESS)
 Main PID: 2811 (fail2ban-server)
   CGroup: /system.slice/fail2ban.service
           ├─1078 /usr/bin/python3 /usr/bin/fail2ban-server -s /var/run/fail2ban/fail2ban.sock -p /var/run/fail2ban/fail2ban.pid -x -b
           └─2811 /usr/bin/python3 /usr/bin/fail2ban-server -s /var/run/fail2ban/fail2ban.sock -p /var/run/fail2ban/fail2ban.pid -x -b

May 20 10:24:52 web1.xxx.com fail2ban-client[2808]: ERROR  NOK: ('database is locked',)
May 20 10:24:57 web1.xxx.com fail2ban-client[2808]: ERROR  NOK: ('database is locked',)
May 20 10:25:02 web1.xxx.com fail2ban-client[2808]: ERROR  NOK: ('database is locked',)
May 20 10:25:07 web1.xxx.com fail2ban-client[2808]: ERROR  NOK: ('database is locked',)
May 20 10:25:12 web1.xxx.com fail2ban-client[2808]: ERROR  NOK: ('database is locked',)
May 20 10:25:17 web1.xxx.com fail2ban-client[2808]: ERROR  NOK: ('database is locked',)
May 20 10:25:22 web1.xxx.com fail2ban-client[2808]: ERROR  NOK: ('database is locked',)
May 20 10:25:27 web1.xxx.com fail2ban-client[2808]: ERROR  NOK: ('database is locked',)
May 20 10:25:32 web1.xxx.com fail2ban-client[2808]: ERROR  NOK: ('database is locked',)
May 20 10:25:32 web1.xxx.com systemd[1]: Started Fail2Ban Service.
Команда fuser '/var/lib/fail2ban/fail2ban.sqlite3' выдает что имеется два процесса, которые обращаются к базе:

Код: [Выделить]

/var/lib/fail2ban/fail2ban.sqlite3:  1078  2811
Приходится вручную останавливать service fail2ban stop потом service fail2ban start чтобы он начал нормально работать.
С чем это может быть связано и как исправить чтобы нормально стартовал после reboot?

[Everstuu]

Не ужели ни у кого нет никаких мыслей?

[Dzhoser]

Проблема с БД fail2ban.
Что касается "база данных заблокирована":

Есть ли у вас какие-либо "расширения", которые могли бы открыть fail2ban-базу данных по каким-либо причинам?
Если вы не знаете, просто попробуйте изменить путь к базе данных в вашем fail2ban.local на другой путь и повторите попытку.

Вы также можете попытаться найти, какой процесс точно блокирует базу данных, например:

Код: [Выделить]

sudo fuser '/var/lib/fail2ban/fail2ban.sqlite3'покажет вам идентификатор процесса, где он открыт.

Кроме того, обратите внимание, что версия 0.9.3 слишком старая