Bug#663000: [debian-mysql] Bug#663000: mysql-server: MySQL fails to start, after 5.1.61 upgrade, incorrect permissions
I've also experienced the same problem today as I tried to upgrade to mysql-server-5.1 5.1.63-0+squeeze1. I've managed to debug the postinstall script and the problem was caused by the line 144: bash /usr/bin/mysql_install_db --rpm 21 | $ERR_LOGGER I didn't had the time to look very deeply in this script, but at least I could install mysql-server-5.1 properly by substituting the previous line with this: bash /usr/bin/mysql_install_db --user mysql --rpm 21 | $ERR_LOGGER Another option is to edit /usr/bin/mysql_install_db and put user=mysql in the line 30. So you can avoid this issue in future upgrades also. I hope this can help. -- To UNSUBSCRIBE, email to debian-bugs-dist-requ...@lists.debian.org with a subject of unsubscribe. Trouble? Contact listmas...@lists.debian.org
Bug#663000: [debian-mysql] Bug#663000: mysql-server: MySQL fails to start after 5.1.61 upgrade, incorrect permissions
Hey Clint, Unfortunately there are no symlinks regarding those. Just to note that it wasn't all /var/lib/mysql/mysql-bin.* files that had incorrect permissions, only a few (the latest that it would have generated). Maybe there is some kind of race condition between MySQL stopping and the postinst file running? I can't replicate it any more, because I worked around it by running while true; do chown mysql:mysql /var/lib/mysql/mysql-bin.*; sleep 0.1; done in another shell whilst I was doing apt-get upgrade. Would it also not be best to change chown -R mysql $mysql_statedir to include setting the group to mysql too? It's an odd one that's for sure, but easily workaround-able. Thanks On 9 March 2012 07:51, Clint Byrum cl...@ubuntu.com wrote: Excerpts from Alex Cartwright's message of Thu Mar 08 13:00:23 -0800 2012: Is there any more information that I can provide to help debug this? I was talking with someone in #debian irc.freenode.net earlier on today and they had the same problem. They resolved it by managing to chown said files just before it tried to start MySQL again. Right now I'm not sure what extra info I can get for you. Alex, I'm kind of at a loss for how this is happening. The postinst directly calls this code on configuring mysql-server-5.1: mysql_statedir=/var/lib/mysql ... chown -R mysql $mysql_statedir So you can see where the fact that the binlogs are being chown'ed to root is rather confusing! There is one chown that might lead to this: mysql_datadir=/usr/share/mysql chown -R 0:0 $mysql_datadir Perhaps there are links in /usr/share/mysql to your binlogs? Also is it possible /var/lib/mysql is a symlink? Regards On 7 March 2012 23:44, Clint Byrum cl...@ubuntu.com wrote: Excerpts from Alex Cartwright's message of Wed Mar 07 13:32:44 -0800 2012: Package: mysql-server Version: 5.1.61-0+squeeze1 Severity: important After the recent security upgrade to MySQL 5.1.61, MySQL failed to start during the apt-get update apt-get upgrade process due to incorrect permissions being set on the /var/lib/mysql/mysql-bin.* files. Instead of being mysql:mysql they were set to root:root, causing MySQL to fail starting with errors such as: Mar 7 20:52:37 lon1 mysqld_safe[16756]: 120307 20:52:37 [ERROR] Failed to open log (file './mysql-bin.000397', errno 13) Mar 7 20:52:37 lon1 mysqld_safe[16756]: 120307 20:52:37 [ERROR] Could not open log file Mar 7 20:52:37 lon1 mysqld_safe[16756]: 120307 20:52:37 [ERROR] Can't init tc log Mar 7 20:52:37 lon1 mysqld_safe[16756]: 120307 20:52:37 [ERROR] Aborting Changing the owner/group to mysql:mysql manually and starting the mysql service got things working, however running update upgrade again causes the issue again. Hi Alex, sorry this is causing you trouble. I was not able to reproduce this in a clean squeeze chroot: (squeeze-amd64)root@clint-MacBookPro:/home/clint# ls -l /var/lib/mysql total 20532 -rw-r--r-- 1 root root 0 Mar 7 15:36 debian-5.1.flag -rw-rw 1 mysql mysql 5242880 Mar 7 15:37 ib_logfile0 -rw-rw 1 mysql mysql 5242880 Mar 7 15:36 ib_logfile1 -rw-rw 1 mysql mysql 10485760 Mar 7 15:37 ibdata1 drwx-- 2 mysql root 4096 Mar 7 15:37 mysql -rw--- 1 root root 6 Mar 7 15:37 mysql_upgrade_info -rw-rw 1 mysql mysql 37810 Mar 7 15:37 mysqld-bin.01 -rw-rw 1 mysql mysql 20 Mar 7 15:37 mysqld-bin.index (squeeze-amd64)root@clint-MacBookPro:/home/clint# apt-get upgrade Reading package lists... Done Building dependency tree Reading state information... Done The following packages will be upgraded: libmysqlclient16 mysql-client-5.1 mysql-common mysql-server-5.1 mysql-server-core-5.1 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. Need to get 22.8 MB of archives. After this operation, 307 kB disk space will be freed. Do you want to continue [Y/n]? Get:1 http://security.debian.org/ squeeze/updates/main mysql-common all 5.1.61-0+squeeze1 [69.6 kB] Get:2 http://security.debian.org/ squeeze/updates/main libmysqlclient16 amd64 5.1.61-0+squeeze1 [1976 kB] Get:3 http://security.debian.org/ squeeze/updates/main mysql-client-5.1 amd64 5.1.61-0+squeeze1 [10.0 MB] Get:4 http://security.debian.org/ squeeze/updates/main mysql-server-5.1 amd64 5.1.61-0+squeeze1 [6587 kB] Get:5 http://security.debian.org/ squeeze/updates/main mysql-server-core-5.1 amd64 5.1.61-0+squeeze1 [4130 kB] Fetched 22.8 MB in 15s (1432 kB/s) Preconfiguring packages ... (Reading database ... 12360 files and directories currently installed.) Preparing to replace mysql-common 5.1.49-3 (using .../mysql-common_5.1.61-0+squeeze1_all.deb) ... Unpacking replacement mysql-common ... Preparing to replace libmysqlclient16 5.1.49-3 (using .../libmysqlclient16_5.1.61-0+squeeze1_amd64.deb) ... Unpacking replacement libmysqlclient16 ... Preparing
Bug#663000: [debian-mysql] Bug#663000: mysql-server: MySQL fails to start after 5.1.61 upgrade, incorrect permissions
Is there any more information that I can provide to help debug this? I was talking with someone in #debian irc.freenode.net earlier on today and they had the same problem. They resolved it by managing to chown said files just before it tried to start MySQL again. Right now I'm not sure what extra info I can get for you. Regards On 7 March 2012 23:44, Clint Byrum cl...@ubuntu.com wrote: Excerpts from Alex Cartwright's message of Wed Mar 07 13:32:44 -0800 2012: Package: mysql-server Version: 5.1.61-0+squeeze1 Severity: important After the recent security upgrade to MySQL 5.1.61, MySQL failed to start during the apt-get update apt-get upgrade process due to incorrect permissions being set on the /var/lib/mysql/mysql-bin.* files. Instead of being mysql:mysql they were set to root:root, causing MySQL to fail starting with errors such as: Mar 7 20:52:37 lon1 mysqld_safe[16756]: 120307 20:52:37 [ERROR] Failed to open log (file './mysql-bin.000397', errno 13) Mar 7 20:52:37 lon1 mysqld_safe[16756]: 120307 20:52:37 [ERROR] Could not open log file Mar 7 20:52:37 lon1 mysqld_safe[16756]: 120307 20:52:37 [ERROR] Can't init tc log Mar 7 20:52:37 lon1 mysqld_safe[16756]: 120307 20:52:37 [ERROR] Aborting Changing the owner/group to mysql:mysql manually and starting the mysql service got things working, however running update upgrade again causes the issue again. Hi Alex, sorry this is causing you trouble. I was not able to reproduce this in a clean squeeze chroot: (squeeze-amd64)root@clint-MacBookPro:/home/clint# ls -l /var/lib/mysql total 20532 -rw-r--r-- 1 root root 0 Mar 7 15:36 debian-5.1.flag -rw-rw 1 mysql mysql 5242880 Mar 7 15:37 ib_logfile0 -rw-rw 1 mysql mysql 5242880 Mar 7 15:36 ib_logfile1 -rw-rw 1 mysql mysql 10485760 Mar 7 15:37 ibdata1 drwx-- 2 mysql root 4096 Mar 7 15:37 mysql -rw--- 1 root root 6 Mar 7 15:37 mysql_upgrade_info -rw-rw 1 mysql mysql 37810 Mar 7 15:37 mysqld-bin.01 -rw-rw 1 mysql mysql 20 Mar 7 15:37 mysqld-bin.index (squeeze-amd64)root@clint-MacBookPro:/home/clint# apt-get upgrade Reading package lists... Done Building dependency tree Reading state information... Done The following packages will be upgraded: libmysqlclient16 mysql-client-5.1 mysql-common mysql-server-5.1 mysql-server-core-5.1 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. Need to get 22.8 MB of archives. After this operation, 307 kB disk space will be freed. Do you want to continue [Y/n]? Get:1 http://security.debian.org/ squeeze/updates/main mysql-common all 5.1.61-0+squeeze1 [69.6 kB] Get:2 http://security.debian.org/ squeeze/updates/main libmysqlclient16 amd64 5.1.61-0+squeeze1 [1976 kB] Get:3 http://security.debian.org/ squeeze/updates/main mysql-client-5.1 amd64 5.1.61-0+squeeze1 [10.0 MB] Get:4 http://security.debian.org/ squeeze/updates/main mysql-server-5.1 amd64 5.1.61-0+squeeze1 [6587 kB] Get:5 http://security.debian.org/ squeeze/updates/main mysql-server-core-5.1 amd64 5.1.61-0+squeeze1 [4130 kB] Fetched 22.8 MB in 15s (1432 kB/s) Preconfiguring packages ... (Reading database ... 12360 files and directories currently installed.) Preparing to replace mysql-common 5.1.49-3 (using .../mysql-common_5.1.61-0+squeeze1_all.deb) ... Unpacking replacement mysql-common ... Preparing to replace libmysqlclient16 5.1.49-3 (using .../libmysqlclient16_5.1.61-0+squeeze1_amd64.deb) ... Unpacking replacement libmysqlclient16 ... Preparing to replace mysql-client-5.1 5.1.49-3 (using .../mysql-client-5.1_5.1.61-0+squeeze1_amd64.deb) ... Unpacking replacement mysql-client-5.1 ... Setting up mysql-common (5.1.61-0+squeeze1) ... (Reading database ... 12361 files and directories currently installed.) Preparing to replace mysql-server-5.1 5.1.49-3 (using .../mysql-server-5.1_5.1.61-0+squeeze1_amd64.deb) ... invoke-rc.d: policy-rc.d denied execution of stop. invoke-rc.d: policy-rc.d denied execution of stop. df: Warning: cannot read table of mounted file systems: No such file or directory Unpacking replacement mysql-server-5.1 ... Preparing to replace mysql-server-core-5.1 5.1.49-3 (using .../mysql-server-core-5.1_5.1.61-0+squeeze1_amd64.deb) ... Unpacking replacement mysql-server-core-5.1 ... Setting up libmysqlclient16 (5.1.61-0+squeeze1) ... Setting up mysql-client-5.1 (5.1.61-0+squeeze1) ... Setting up mysql-server-core-5.1 (5.1.61-0+squeeze1) ... Setting up mysql-server-5.1 (5.1.61-0+squeeze1) ... invoke-rc.d: policy-rc.d denied execution of stop. invoke-rc.d: policy-rc.d denied execution of start. (squeeze-amd64)root@clint-MacBookPro:/home/clint# ls -l /var/lib/mysql total 21288 -rw-r--r-- 1 mysql mysql 0 Mar 7 15:38 debian-5.1.flag -rw-rw 1 mysql mysql 5242880 Mar 7 15:39 ib_logfile0 -rw-rw 1 mysql mysql 5242880 Mar 7 15:36 ib_logfile1 -rw-rw 1 mysql mysql 10485760 Mar 7 15:39 ibdata1 drwx-- 2
Bug#663000: [debian-mysql] Bug#663000: mysql-server: MySQL fails to start after 5.1.61 upgrade, incorrect permissions
Excerpts from Alex Cartwright's message of Thu Mar 08 13:00:23 -0800 2012: Is there any more information that I can provide to help debug this? I was talking with someone in #debian irc.freenode.net earlier on today and they had the same problem. They resolved it by managing to chown said files just before it tried to start MySQL again. Right now I'm not sure what extra info I can get for you. Alex, I'm kind of at a loss for how this is happening. The postinst directly calls this code on configuring mysql-server-5.1: mysql_statedir=/var/lib/mysql ... chown -R mysql $mysql_statedir So you can see where the fact that the binlogs are being chown'ed to root is rather confusing! There is one chown that might lead to this: mysql_datadir=/usr/share/mysql chown -R 0:0 $mysql_datadir Perhaps there are links in /usr/share/mysql to your binlogs? Also is it possible /var/lib/mysql is a symlink? Regards On 7 March 2012 23:44, Clint Byrum cl...@ubuntu.com wrote: Excerpts from Alex Cartwright's message of Wed Mar 07 13:32:44 -0800 2012: Package: mysql-server Version: 5.1.61-0+squeeze1 Severity: important After the recent security upgrade to MySQL 5.1.61, MySQL failed to start during the apt-get update apt-get upgrade process due to incorrect permissions being set on the /var/lib/mysql/mysql-bin.* files. Instead of being mysql:mysql they were set to root:root, causing MySQL to fail starting with errors such as: Mar 7 20:52:37 lon1 mysqld_safe[16756]: 120307 20:52:37 [ERROR] Failed to open log (file './mysql-bin.000397', errno 13) Mar 7 20:52:37 lon1 mysqld_safe[16756]: 120307 20:52:37 [ERROR] Could not open log file Mar 7 20:52:37 lon1 mysqld_safe[16756]: 120307 20:52:37 [ERROR] Can't init tc log Mar 7 20:52:37 lon1 mysqld_safe[16756]: 120307 20:52:37 [ERROR] Aborting Changing the owner/group to mysql:mysql manually and starting the mysql service got things working, however running update upgrade again causes the issue again. Hi Alex, sorry this is causing you trouble. I was not able to reproduce this in a clean squeeze chroot: (squeeze-amd64)root@clint-MacBookPro:/home/clint# ls -l /var/lib/mysql total 20532 -rw-r--r-- 1 root root 0 Mar 7 15:36 debian-5.1.flag -rw-rw 1 mysql mysql 5242880 Mar 7 15:37 ib_logfile0 -rw-rw 1 mysql mysql 5242880 Mar 7 15:36 ib_logfile1 -rw-rw 1 mysql mysql 10485760 Mar 7 15:37 ibdata1 drwx-- 2 mysql root 4096 Mar 7 15:37 mysql -rw--- 1 root root 6 Mar 7 15:37 mysql_upgrade_info -rw-rw 1 mysql mysql 37810 Mar 7 15:37 mysqld-bin.01 -rw-rw 1 mysql mysql 20 Mar 7 15:37 mysqld-bin.index (squeeze-amd64)root@clint-MacBookPro:/home/clint# apt-get upgrade Reading package lists... Done Building dependency tree Reading state information... Done The following packages will be upgraded: libmysqlclient16 mysql-client-5.1 mysql-common mysql-server-5.1 mysql-server-core-5.1 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. Need to get 22.8 MB of archives. After this operation, 307 kB disk space will be freed. Do you want to continue [Y/n]? Get:1 http://security.debian.org/ squeeze/updates/main mysql-common all 5.1.61-0+squeeze1 [69.6 kB] Get:2 http://security.debian.org/ squeeze/updates/main libmysqlclient16 amd64 5.1.61-0+squeeze1 [1976 kB] Get:3 http://security.debian.org/ squeeze/updates/main mysql-client-5.1 amd64 5.1.61-0+squeeze1 [10.0 MB] Get:4 http://security.debian.org/ squeeze/updates/main mysql-server-5.1 amd64 5.1.61-0+squeeze1 [6587 kB] Get:5 http://security.debian.org/ squeeze/updates/main mysql-server-core-5.1 amd64 5.1.61-0+squeeze1 [4130 kB] Fetched 22.8 MB in 15s (1432 kB/s) Preconfiguring packages ... (Reading database ... 12360 files and directories currently installed.) Preparing to replace mysql-common 5.1.49-3 (using .../mysql-common_5.1.61-0+squeeze1_all.deb) ... Unpacking replacement mysql-common ... Preparing to replace libmysqlclient16 5.1.49-3 (using .../libmysqlclient16_5.1.61-0+squeeze1_amd64.deb) ... Unpacking replacement libmysqlclient16 ... Preparing to replace mysql-client-5.1 5.1.49-3 (using .../mysql-client-5.1_5.1.61-0+squeeze1_amd64.deb) ... Unpacking replacement mysql-client-5.1 ... Setting up mysql-common (5.1.61-0+squeeze1) ... (Reading database ... 12361 files and directories currently installed.) Preparing to replace mysql-server-5.1 5.1.49-3 (using .../mysql-server-5.1_5.1.61-0+squeeze1_amd64.deb) ... invoke-rc.d: policy-rc.d denied execution of stop. invoke-rc.d: policy-rc.d denied execution of stop. df: Warning: cannot read table of mounted file systems: No such file or directory Unpacking replacement mysql-server-5.1 ... Preparing to replace mysql-server-core-5.1 5.1.49-3 (using .../mysql-server-core-5.1_5.1.61-0+squeeze1_amd64.deb) ... Unpacking
Bug#663000: [debian-mysql] Bug#663000: mysql-server: MySQL fails to start after 5.1.61 upgrade, incorrect permissions
I did experience the same issue Alex had this morning. apt-get update failed at starting the MySQL server after updating the package. The last 3 mysql-bin logs had root:root as owner and this prevented the mysql server from starting. I tried resetting the permissions and the run upt-get upgrade again, but this resulted in the same issue. I have been able to succesfully run the update by runnign chmod -R mysql: /var/lib/mysql from another console at the moment the upgrade script tried to restart the mysql server. After that the server starts without problems and apt-get reported a succesfull update. -- To UNSUBSCRIBE, email to debian-bugs-dist-requ...@lists.debian.org with a subject of unsubscribe. Trouble? Contact listmas...@lists.debian.org
Bug#663000: [debian-mysql] Bug#663000: mysql-server: MySQL fails to start after 5.1.61 upgrade, incorrect permissions
Excerpts from Alex Cartwright's message of Wed Mar 07 13:32:44 -0800 2012: Package: mysql-server Version: 5.1.61-0+squeeze1 Severity: important After the recent security upgrade to MySQL 5.1.61, MySQL failed to start during the apt-get update apt-get upgrade process due to incorrect permissions being set on the /var/lib/mysql/mysql-bin.* files. Instead of being mysql:mysql they were set to root:root, causing MySQL to fail starting with errors such as: Mar 7 20:52:37 lon1 mysqld_safe[16756]: 120307 20:52:37 [ERROR] Failed to open log (file './mysql-bin.000397', errno 13) Mar 7 20:52:37 lon1 mysqld_safe[16756]: 120307 20:52:37 [ERROR] Could not open log file Mar 7 20:52:37 lon1 mysqld_safe[16756]: 120307 20:52:37 [ERROR] Can't init tc log Mar 7 20:52:37 lon1 mysqld_safe[16756]: 120307 20:52:37 [ERROR] Aborting Changing the owner/group to mysql:mysql manually and starting the mysql service got things working, however running update upgrade again causes the issue again. Hi Alex, sorry this is causing you trouble. I was not able to reproduce this in a clean squeeze chroot: (squeeze-amd64)root@clint-MacBookPro:/home/clint# ls -l /var/lib/mysql total 20532 -rw-r--r-- 1 root root 0 Mar 7 15:36 debian-5.1.flag -rw-rw 1 mysql mysql 5242880 Mar 7 15:37 ib_logfile0 -rw-rw 1 mysql mysql 5242880 Mar 7 15:36 ib_logfile1 -rw-rw 1 mysql mysql 10485760 Mar 7 15:37 ibdata1 drwx-- 2 mysql root 4096 Mar 7 15:37 mysql -rw--- 1 root root 6 Mar 7 15:37 mysql_upgrade_info -rw-rw 1 mysql mysql37810 Mar 7 15:37 mysqld-bin.01 -rw-rw 1 mysql mysql 20 Mar 7 15:37 mysqld-bin.index (squeeze-amd64)root@clint-MacBookPro:/home/clint# apt-get upgrade Reading package lists... Done Building dependency tree Reading state information... Done The following packages will be upgraded: libmysqlclient16 mysql-client-5.1 mysql-common mysql-server-5.1 mysql-server-core-5.1 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. Need to get 22.8 MB of archives. After this operation, 307 kB disk space will be freed. Do you want to continue [Y/n]? Get:1 http://security.debian.org/ squeeze/updates/main mysql-common all 5.1.61-0+squeeze1 [69.6 kB] Get:2 http://security.debian.org/ squeeze/updates/main libmysqlclient16 amd64 5.1.61-0+squeeze1 [1976 kB] Get:3 http://security.debian.org/ squeeze/updates/main mysql-client-5.1 amd64 5.1.61-0+squeeze1 [10.0 MB] Get:4 http://security.debian.org/ squeeze/updates/main mysql-server-5.1 amd64 5.1.61-0+squeeze1 [6587 kB] Get:5 http://security.debian.org/ squeeze/updates/main mysql-server-core-5.1 amd64 5.1.61-0+squeeze1 [4130 kB] Fetched 22.8 MB in 15s (1432 kB/s) Preconfiguring packages ... (Reading database ... 12360 files and directories currently installed.) Preparing to replace mysql-common 5.1.49-3 (using .../mysql-common_5.1.61-0+squeeze1_all.deb) ... Unpacking replacement mysql-common ... Preparing to replace libmysqlclient16 5.1.49-3 (using .../libmysqlclient16_5.1.61-0+squeeze1_amd64.deb) ... Unpacking replacement libmysqlclient16 ... Preparing to replace mysql-client-5.1 5.1.49-3 (using .../mysql-client-5.1_5.1.61-0+squeeze1_amd64.deb) ... Unpacking replacement mysql-client-5.1 ... Setting up mysql-common (5.1.61-0+squeeze1) ... (Reading database ... 12361 files and directories currently installed.) Preparing to replace mysql-server-5.1 5.1.49-3 (using .../mysql-server-5.1_5.1.61-0+squeeze1_amd64.deb) ... invoke-rc.d: policy-rc.d denied execution of stop. invoke-rc.d: policy-rc.d denied execution of stop. df: Warning: cannot read table of mounted file systems: No such file or directory Unpacking replacement mysql-server-5.1 ... Preparing to replace mysql-server-core-5.1 5.1.49-3 (using .../mysql-server-core-5.1_5.1.61-0+squeeze1_amd64.deb) ... Unpacking replacement mysql-server-core-5.1 ... Setting up libmysqlclient16 (5.1.61-0+squeeze1) ... Setting up mysql-client-5.1 (5.1.61-0+squeeze1) ... Setting up mysql-server-core-5.1 (5.1.61-0+squeeze1) ... Setting up mysql-server-5.1 (5.1.61-0+squeeze1) ... invoke-rc.d: policy-rc.d denied execution of stop. invoke-rc.d: policy-rc.d denied execution of start. (squeeze-amd64)root@clint-MacBookPro:/home/clint# ls -l /var/lib/mysql total 21288 -rw-r--r-- 1 mysql mysql0 Mar 7 15:38 debian-5.1.flag -rw-rw 1 mysql mysql 5242880 Mar 7 15:39 ib_logfile0 -rw-rw 1 mysql mysql 5242880 Mar 7 15:36 ib_logfile1 -rw-rw 1 mysql mysql 10485760 Mar 7 15:39 ibdata1 drwx-- 2 mysql mysql 4096 Mar 7 15:38 mysql -rw--- 1 mysql mysql6 Mar 7 15:37 mysql_upgrade_info -rw-rw 1 mysql mysql37810 Mar 7 15:37 mysqld-bin.01 -rw-rw 1 mysql mysql19048 Mar 7 15:38 mysqld-bin.02 -rw-rw 1 mysql mysql 736801 Mar 7 15:38 mysqld-bin.03 -rw-rw 1 mysql mysql 300 Mar 7 15:38 mysqld-bin.04 -rw-rw 1
