Version >= 8.0.20: Log file ./ib_logfile0 size 17768448 is not a multiple of innodb_page_size

[schwarmco]

I am unable to start containers with image mysql >= 8.0.20 due to the error:

Log file ./ib_logfile0 size 17768448 is not a multiple of innodb_page_size

I have tried all available tags from 8.0.20 up until 8.0.29 with the same result.

$ docker run --name my8028 -e MYSQL_ROOT_PASSWORD=root mysql:8.0.28
2022-06-01 12:33:25+00:00 [Note] [Entrypoint]: Entrypoint script for MySQL Server 8.0.28-1debian10 started.
2022-06-01 12:33:25+00:00 [Note] [Entrypoint]: Switching to dedicated user 'mysql'
2022-06-01 12:33:25+00:00 [Note] [Entrypoint]: Entrypoint script for MySQL Server 8.0.28-1debian10 started.
2022-06-01 12:33:25+00:00 [Note] [Entrypoint]: Initializing database files
2022-06-01T12:33:25.903471Z 0 [System] [MY-013169] [Server] /usr/sbin/mysqld (mysqld 8.0.28) initializing of server in progress as process 41
2022-06-01T12:33:25.914611Z 1 [System] [MY-013576] [InnoDB] InnoDB initialization has started.
2022-06-01T12:33:26.157812Z 1 [System] [MY-013577] [InnoDB] InnoDB initialization has ended.
2022-06-01T12:33:26.677023Z 6 [Warning] [MY-010453] [Server] root@localhost is created with an empty password ! Please consider switching off the --initialize-insecure option.
2022-06-01 12:33:28+00:00 [Note] [Entrypoint]: Database files initialized
2022-06-01 12:33:28+00:00 [Note] [Entrypoint]: Starting temporary server
2022-06-01T12:33:28.569577Z 0 [System] [MY-010116] [Server] /usr/sbin/mysqld (mysqld 8.0.28) starting as process 90
2022-06-01T12:33:28.590364Z 1 [System] [MY-013576] [InnoDB] InnoDB initialization has started.
2022-06-01T12:33:28.611620Z 1 [ERROR] [MY-012963] [InnoDB] Log file ./ib_logfile1 is of different size 0 bytes than other log files 17793024 bytes!
2022-06-01T12:33:28.611657Z 1 [ERROR] [MY-012930] [InnoDB] Plugin initialization aborted with error Generic error.
2022-06-01T12:33:29.102256Z 1 [ERROR] [MY-010334] [Server] Failed to initialize DD Storage Engine
2022-06-01T12:33:29.102565Z 0 [ERROR] [MY-010020] [Server] Data Dictionary initialization failed.
2022-06-01T12:33:29.102693Z 0 [ERROR] [MY-010119] [Server] Aborting
2022-06-01T12:33:29.102759Z 0 [ERROR] [MY-010946] [Server] Failed to start mysqld daemon. Check mysqld error log.
2022-06-01T12:33:29.103359Z 0 [System] [MY-010910] [Server] /usr/sbin/mysqld: Shutdown complete (mysqld 8.0.28)  MySQL Community Server - GPL.
2022-06-01 12:33:29+00:00 [ERROR] [Entrypoint]: Unable to start server.

Last correctly launching container:

$ docker run --name my8019 -e MYSQL_ROOT_PASSWORD=root mysql:8.0.19
2022-06-01 12:35:35+00:00 [Note] [Entrypoint]: Entrypoint script for MySQL Server 8.0.19-1debian10 started.
2022-06-01 12:35:35+00:00 [Note] [Entrypoint]: Switching to dedicated user 'mysql'
2022-06-01 12:35:35+00:00 [Note] [Entrypoint]: Entrypoint script for MySQL Server 8.0.19-1debian10 started.
2022-06-01 12:35:36+00:00 [Note] [Entrypoint]: Initializing database files
2022-06-01T12:35:36.008289Z 0 [Warning] [MY-011070] [Server] 'Disabling symbolic links using --skip-symbolic-links (or equivalent) is the default. Consider not using this option as it' is deprecated and will be removed in a future release.
2022-06-01T12:35:36.008331Z 0 [System] [MY-013169] [Server] /usr/sbin/mysqld (mysqld 8.0.19) initializing of server in progress as process 43
2022-06-01T12:35:36.736622Z 5 [Warning] [MY-010453] [Server] root@localhost is created with an empty password ! Please consider switching off the --initialize-insecure option.
2022-06-01 12:35:38+00:00 [Note] [Entrypoint]: Database files initialized
2022-06-01 12:35:38+00:00 [Note] [Entrypoint]: Starting temporary server
2022-06-01T12:35:38.864641Z 0 [Warning] [MY-011070] [Server] 'Disabling symbolic links using --skip-symbolic-links (or equivalent) is the default. Consider not using this option as it' is deprecated and will be removed in a future release.
2022-06-01T12:35:38.864727Z 0 [System] [MY-010116] [Server] /usr/sbin/mysqld (mysqld 8.0.19) starting as process 93
2022-06-01T12:35:39.134182Z 0 [Warning] [MY-010068] [Server] CA certificate ca.pem is self signed.
2022-06-01T12:35:39.137680Z 0 [Warning] [MY-011810] [Server] Insecure configuration for --pid-file: Location '/var/run/mysqld' in the path is accessible to all OS users. Consider choosing a different directory.
2022-06-01T12:35:39.146649Z 0 [System] [MY-010931] [Server] /usr/sbin/mysqld: ready for connections. Version: '8.0.19'  socket: '/var/run/mysqld/mysqld.sock'  port: 0  MySQL Community Server - GPL.
2022-06-01 12:35:39+00:00 [Note] [Entrypoint]: Temporary server started.
2022-06-01T12:35:39.292148Z 0 [System] [MY-011323] [Server] X Plugin ready for connections. Socket: '/var/run/mysqld/mysqlx.sock'
Warning: Unable to load '/usr/share/zoneinfo/iso3166.tab' as time zone. Skipping it.
Warning: Unable to load '/usr/share/zoneinfo/leap-seconds.list' as time zone. Skipping it.
Warning: Unable to load '/usr/share/zoneinfo/zone.tab' as time zone. Skipping it.
Warning: Unable to load '/usr/share/zoneinfo/zone1970.tab' as time zone. Skipping it.

2022-06-01 12:35:40+00:00 [Note] [Entrypoint]: Stopping temporary server
2022-06-01T12:35:40.039124Z 10 [System] [MY-013172] [Server] Received SHUTDOWN from user root. Shutting down mysqld (Version: 8.0.19).
2022-06-01T12:35:41.594068Z 0 [System] [MY-010910] [Server] /usr/sbin/mysqld: Shutdown complete (mysqld 8.0.19)  MySQL Community Server - GPL.
2022-06-01 12:35:42+00:00 [Note] [Entrypoint]: Temporary server stopped

2022-06-01 12:35:42+00:00 [Note] [Entrypoint]: MySQL init process done. Ready for start up.

2022-06-01T12:35:42.268024Z 0 [Warning] [MY-011070] [Server] 'Disabling symbolic links using --skip-symbolic-links (or equivalent) is the default. Consider not using this option as it' is deprecated and will be removed in a future release.
2022-06-01T12:35:42.268107Z 0 [System] [MY-010116] [Server] /usr/sbin/mysqld (mysqld 8.0.19) starting as process 1
2022-06-01T12:35:42.524442Z 0 [Warning] [MY-010068] [Server] CA certificate ca.pem is self signed.
2022-06-01T12:35:42.529564Z 0 [Warning] [MY-011810] [Server] Insecure configuration for --pid-file: Location '/var/run/mysqld' in the path is accessible to all OS users. Consider choosing a different directory.
2022-06-01T12:35:42.539465Z 0 [System] [MY-010931] [Server] /usr/sbin/mysqld: ready for connections. Version: '8.0.19'  socket: '/var/run/mysqld/mysqld.sock'  port: 3306  MySQL Community Server - GPL.
2022-06-01T12:35:42.701222Z 0 [System] [MY-011323] [Server] X Plugin ready for connections. Socket: '/var/run/mysqld/mysqlx.sock' bind-address: '::' port: 33060

My Environment:

$ docker version
Client:
 Version:           20.10.14
 API version:       1.41
 Go version:        go1.16.13
 Git commit:        v20.10.14
 Built:             Thu Jan  1 00:00:00 1970
 OS/Arch:           linux/amd64
 Context:           default
 Experimental:      true

Server:
 Engine:
  Version:          20.10.14
  API version:      1.41 (minimum version 1.12)
  Go version:       go1.16.13
  Git commit:       v20.10.14
  Built:            Tue Jan  1 00:00:00 1980
  OS/Arch:          linux/amd64
  Experimental:     false
 containerd:
  Version:          v1.5.9
  GitCommit:        v1.5.9
 runc:
  Version:          1.0.3
  GitCommit:
 docker-init:
  Version:          0.19.0
  GitCommit:

[wglambert]

Are you using ZFS? openzfs/zfs#13329

I can't reproduce the issue and from searching around this is a fairly rare error to run into, especially in Docker

[schwarmco]

I do indeed use ZFS (2.1.4). I didn't stumble across this issue while researching this error (and neither was this the direction i expected this issue to go).
Thank you for pointing out! It seems, this will be fixed in ZFS 2.1.5