Comment 38 for bug 1969247

Revision history for this message
Martin Richtarsky (mrichtarsky) wrote :

I ran into this today on jammy, which I understand should have the fix? Here are my symptoms:

- unattended-upgrades upgraded mysql server:
$ grep upgrade /var/log/dpkg.log | grep mysql
2022-07-30 06:38:00 upgrade mysql-server:all 8.0.29-0ubuntu0.22.04.2 8.0.30-0ubuntu0.22.04.1
2022-07-30 06:38:05 upgrade mysql-client-8.0:amd64 8.0.29-0ubuntu0.22.04.2 8.0.30-0ubuntu0.22.04.1
2022-07-30 06:38:09 upgrade mysql-client-core-8.0:amd64 8.0.29-0ubuntu0.22.04.2 8.0.30-0ubuntu0.22.04.1
2022-07-30 06:38:15 upgrade libmysqlclient21:amd64 8.0.29-0ubuntu0.22.04.2 8.0.30-0ubuntu0.22.04.1
2022-07-30 06:38:20 upgrade mysql-server-8.0:amd64 8.0.29-0ubuntu0.22.04.2 8.0.30-0ubuntu0.22.04.1
2022-07-30 06:38:25 upgrade mysql-server-core-8.0:amd64 8.0.29-0ubuntu0.22.04.2 8.0.30-0ubuntu0.22.04.1

- however, the restart failed:
$ /var/log/mysql/error.log
2022-07-30T06:38:31.591223Z 0 [System] [MY-010116] [Server] /usr/sbin/mysqld (mysqld 8.0.30-0ubuntu0.22.04.1) starting as process 457250
2022-07-30T06:38:31.646707Z 1 [System] [MY-013576] [InnoDB] InnoDB initialization has started.
2022-07-30T06:38:35.237627Z 1 [System] [MY-013577] [InnoDB] InnoDB initialization has ended.
2022-07-30T06:38:38.804696Z 4 [System] [MY-013381] [Server] Server upgrade from '80029' to '80030' started.
2022-07-30T06:38:44.914043Z 4 [System] [MY-013381] [Server] Server upgrade from '80029' to '80030' completed.
2022-07-30T06:38:45.097152Z 0 [Warning] [MY-010068] [Server] CA certificate ca.pem is self signed.
2022-07-30T06:38:45.097223Z 0 [System] [MY-013602] [Server] Channel mysql_main configured to support TLS. Encrypted connections are now supported for this channel.
2022-07-30T06:38:45.108326Z 0 [Warning] [MY-011810] [Server] Insecure configuration for --pid-file: Location '/tmp' in the path is accessible to all OS users. Consider choosing a different directory.
2022-07-30T06:38:45.156661Z 0 [System] [MY-011323] [Server] X Plugin ready for connections. Socket: /var/run/mysqld/mysqlx.sock
2022-07-30T06:38:45.156821Z 0 [System] [MY-010931] [Server] /usr/sbin/mysqld: ready for connections. Version: '8.0.30-0ubuntu0.22.04.1' socket: '/tmp/tmp.hmxTqM13bi/mysqld.sock' port: 0 (Ubuntu).
2022-07-30T06:38:45.190816Z 0 [System] [MY-013172] [Server] Received SHUTDOWN from user <via user signal>. Shutting down mysqld (Version: 8.0.30-0ubuntu0.22.04.1).
2022-07-30T06:38:47.795072Z 0 [System] [MY-010910] [Server] /usr/sbin/mysqld: Shutdown complete (mysqld 8.0.30-0ubuntu0.22.04.1) (Ubuntu).
2022-07-30T06:38:49.617486Z 0 [System] [MY-010116] [Server] /usr/sbin/mysqld (mysqld 8.0.30-0ubuntu0.22.04.1) starting as process 458616
2022-07-30T06:38:49.628355Z 1 [System] [MY-013576] [InnoDB] InnoDB initialization has started.
2022-07-30T06:38:49.749634Z 1 [ERROR] [MY-012962] [InnoDB] The redo log file ./#innodb_redo/#ib_redo6 size 1712128 is not a multiple of innodb_page_size
2022-07-30T06:38:49.749689Z 1 [ERROR] [MY-012930] [InnoDB] Plugin initialization aborted with error Generic error.
2022-07-30T06:38:50.180894Z 1 [ERROR] [MY-010334] [Server] Failed to initialize DD Storage Engine
2022-07-30T06:38:50.181389Z 0 [ERROR] [MY-010020] [Server] Data Dictionary initialization failed.
2022-07-30T06:38:50.182614Z 0 [ERROR] [MY-010119] [Server] Aborting
2022-07-30T06:38:50.184018Z 0 [System] [MY-010910] [Server] /usr/sbin/mysqld: Shutdown complete (mysqld 8.0.30-0ubuntu0.22.04.1) (Ubuntu).

Error is the same as in this bug.

- zfs package versions:

libzfs4linux/jammy-updates,now 2.1.4-0ubuntu0.1 amd64 [installed,automatic]
zfs-zed/jammy-updates,now 2.1.4-0ubuntu0.1 amd64 [installed,automatic]
zfsutils-linux/jammy-updates,now 2.1.4-0ubuntu0.1 amd64 [installed]