Bug 15401 - My Music is empty after physical server reboot
: My Music is empty after physical server reboot
Status: NEW
Product: Logitech Media Server
Classification: Unclassified
Component: Database
: 7.4.1
: PC Linux (other)
: P3 normal (vote)
: Investigating
Assigned To: Squeezebox QA Team email alias
: TestCase
Depends on:
Blocks:
  Show dependency treegraph
 
Reported: 2010-01-03 20:01 UTC by AndrewL733
Modified: 2011-03-16 04:19 UTC (History)
0 users

See Also:
Category: ---


Attachments

Note You need to log in before you can comment on or make changes to this bug.
Description AndrewL733 2010-01-03 20:01:47 UTC
I am running Squeezebox Server on Mandriva 2010 64-bit. 

Version: 7.4.1 - r28947 @ Tue Oct 20 07:59:38 PDT 2009
Hostname: localhost.localdomain
Server IP Address: 192.168.15.96
Server HTTP Port Number: 9000
Operating system: Red Hat - EN - utf8
Platform Architecture: x86_64-linux
Perl Version: 5.10.1 - x86_64-linux-thread-multi
MySQL Version: 5.1.40
Total Players Recognized: 2

After a physical reboot of the server, I am unable to play any music that is stored locally on my server hard drive.  In other words, the My Music listing does not appear in the Squeezebox Web GUI, nor does it appear on my Squeezecenter Remote or on my original Squeezebox Classic.  After each boot, in the Squeezebox GUI/Settings/Information page it says that I haven't defined a Music folder. 

Only after rescanning my music files am I able to see the My Music listing and play my local music. 

Once I am up and running, typing at the command line: 
/sbin/service squeezeboxserver restart OR 
/sbin/service squeezeboxserver stop  and then  start

does NOT cause this problem.  ONLY physical rebooting.  And the problem is NOT related to squeezeboxserver starting at boot up.  It is set in chkconfig to start at boot, and indeed it does -- after a reboot I can get to the Web GUI just fine, and I can play Internet or Pandora sources on my Squeezebox devices.  I just cannot see my local music until doing a rescan. 

My guess is that the location of the Music libary somehow isn't getting saved where it persists after reboots. If that's true, what can I do about it? 

However, I AM seeing some errors in /var/lib/squeezeboxserver/cache/mysql-error.log.  Could these be related?  

091218 22:42:01  InnoDB: Started; log sequence number 0 61807091
091218 22:42:01 [ERROR] Can't open and lock privilege tables: Table 'mysql.servers' doesn't exist
091218 22:42:01 [Note] /usr/sbin/mysqld: ready for connections.
Version: '5.1.40'  socket: '/var/lib/squeezeboxserver/cache/squeezebox-mysql.sock'  port: 9092  Mandriva Linux - MySQL Standard Edition (GPL)
091219  8:00:09 [Note] /usr/sbin/mysqld: Normal shutdown

091219  8:00:09  InnoDB: Starting shutdown...
091219  8:00:11  InnoDB: Shutdown completed; log sequence number 0 62282161
091219  8:00:11 [Note] /usr/sbin/mysqld: Shutdown complete

091219  8:00:19  InnoDB: Started; log sequence number 0 62282161
091219  8:00:19 [ERROR] Can't open and lock privilege tables: Table 'mysql.servers' doesn't exist
091219  8:00:19 [Note] /usr/sbin/mysqld: ready for connections.
Version: '5.1.40'  socket: '/var/lib/squeezeboxserver/cache/squeezebox-mysql.sock'  port: 9092  Mandriva Linux - MySQL Standard Edition (GPL)
091228  0:04:38 [Note] /usr/sbin/mysqld: Normal shutdown

091228  0:04:38  InnoDB: Starting shutdown...
091228  0:04:41  InnoDB: Shutdown completed; log sequence number 0 62572212
091228  0:04:41 [Note] /usr/sbin/mysqld: Shutdown complete

091228  0:04:52  InnoDB: Started; log sequence number 0 62572212
091228  0:04:52 [ERROR] Can't open and lock privilege tables: Table 'mysql.servers' doesn't exist
091228  0:04:52 [Note] /usr/sbin/mysqld: ready for connections.
Version: '5.1.40'  socket: '/var/lib/squeezeboxserver/cache/squeezebox-mysql.sock'  port: 9092  Mandriva Linux - MySQL Standard Edition (GPL)
091228  6:51:42 [Note] /usr/sbin/mysqld: Normal shutdown

InnoDB: The log sequence number in ibdata files does not match
InnoDB: the log sequence number in the ib_logfiles!
091228  6:53:32  InnoDB: Database was not shut down normally!
InnoDB: Starting crash recovery.
InnoDB: Reading tablespace information from the .ibd files...
InnoDB: Restoring possible half-written data pages from the doublewrite
InnoDB: buffer...
091228  6:53:34  InnoDB: Started; log sequence number 0 62592970
091228  6:53:34 [ERROR] Can't open and lock privilege tables: Table 'mysql.servers' doesn't exist
091228  6:53:34 [Note] /usr/sbin/mysqld: ready for connections.
Version: '5.1.40'  socket: '/var/lib/squeezeboxserver/cache/squeezebox-mysql.sock'  port: 9092  Mandriva Linux - MySQL Standard Edition (GPL)
091231 16:57:52 [Note] /usr/sbin/mysqld: Normal shutdown

091231 16:57:52  InnoDB: Starting shutdown...
091231 16:57:54  InnoDB: Shutdown completed; log sequence number 0 62592970
091231 16:57:54 [Note] /usr/sbin/mysqld: Shutdown complete

091231 16:59:33  InnoDB: Started; log sequence number 0 62592970
091231 16:59:33 [ERROR] Can't open and lock privilege tables: Table 'mysql.servers' doesn't exist
091231 16:59:33 [Note] /usr/sbin/mysqld: ready for connections.
Version: '5.1.40'  socket: '/var/lib/squeezeboxserver/cache/squeezebox-mysql.sock'  port: 9092  Mandriva Linux - MySQL Standard Edition (GPL)
Comment 1 AndrewL733 2010-02-01 13:18:33 UTC
Update to this case.  I found a workaround for this issue by re-starting squeezeboxserver 20 seconds after booting up.  I think it must be starting too early during the boot process.  Maybe the issue is Mandriva's quickboot process that allows multiple services to start in parallel, unless they are otherwise constrained to depend on each other. 

My workaround was to just add the following lines to rc.local

sleep 20
service squeezeboxserver restart


I suppose I could have also just DISABLED the squeezeboxserver initscript with "chkconfig --del squeezeboxserver" and then simply started it as above in rc.local: 

sleep 20
service squeezeboxserver start


So, a "start for the first time" rather than a "restart"
Comment 2 Chris Owens 2010-02-02 10:16:13 UTC
That's great information.  Thanks!