[mythtv-commits] Ticket #9883: Slave backend crash after writeStringList error

[MythTV]

#9883: Slave backend crash after writeStringList error
----------------------------+--------------------------------------
 Reporter:  mythtv@…        |           Type:  Bug Report - General
   Status:  new             |       Priority:  blocker
Milestone:  unknown         |      Component:  MythTV - General
  Version:  0.24-fixes      |       Severity:  high
 Keywords:                  |  Ticket locked:  0
----------------------------+--------------------------------------
 I have installed v0.24.1-36-gd06878a on both master and slave backend
 (which is also a frontend).

 About 30 seconds after a restart of both backends the slave backend always
 crashes. Restarting the master backend recovers the slave temporarily -
 until it breaks again.

 I have been suffering from the same problem since weeks now - but it used
 to happen once or twice a week only... After the latest upgrade, my Mythtv
 system is not usable any more.


 The slave backend reports the following log lines:

 {{{
 2011-06-29 21:58:59.102 Main::Registering HttpStatus Extension
 2011-06-29 21:58:59.148 Enabled verbose msgs:  important general
 2011-06-29 21:59:00.186 Connecting to master server: homeserver:6543
 2011-06-29 21:59:00.233 Connected successfully
 2011-06-29 21:59:01.158 Received GO_TO_SLEEP command from master, running
 SleepCommand. sh: xx: not found
 2011-06-29 21:59:06.284 No directories found for file storage. Please
 check the Storage Groups setting for this backend.
 2011-06-29 21:59:06.341 MythSocket(9618ca8:38): writeStringList: Error,
 invalid string list.
 2011-06-29 21:59:16.221 Connecting to master server: homeserver:6543
 2011-06-29 21:59:16.292 Connection to master server timed out.
 2011-06-29 21:59:17.333 Connecting to master server: homeserver:6543
 2011-06-29 21:59:17.384 Connection to master server timed out.
 }}}

 The master backend shows the following log lines:

 {{{
 2011-06-29 21:59:05.428 Got data on select
 2011-06-29 21:59:05.428 MythSocket(ffffffffb18d1540:33): UpRef: 2
 2011-06-29 21:59:05.428 Processing ready reads
 2011-06-29 21:59:05.428 MythSocket(ffffffffb18d1540:33): write -> 33 40
 QUERY_REMOTEENCODER 10[]:[]IS_BUSY[]:[]5
 2011-06-29 21:59:05.428 MythSocketThread: Total read time: 0ms, on sockets
 2011-06-29 21:59:05.428 MythSocket(ffffffffb18d1540:33):
 writeBlock(0x18446744072393324552, 48)
 2011-06-29 21:59:05.428 Reacquired ready read lock
 2011-06-29 21:59:05.428 ProcessAddRemoveQueues
 2011-06-29 21:59:05.428 Construct FD_SET
 2011-06-29 21:59:05.428 Waiting on select..
 2011-06-29 21:59:05.429 MythSocket(ffffffffb18d1540:33):
 readBlock(0x18446744072392843744, 8) called
 2011-06-29 21:59:05.429 MythSocket(ffffffffb18d1540:33):
 readBlock(0x18446744072393222816, 43) called
 2011-06-29 21:59:05.429 MythSocket(ffffffffb18d1540:33): read  <- 33 43
 0[]:[]<EMPTY>[]:[]0[]:[]0[]:[]0[]:[]0[]:[]0
 2011-06-29 21:59:05.429 MythSocket(ffffffffb18d1540:33): DownRef: 1
 2011-06-29 21:59:05.429 Got data on select
 2011-06-29 21:59:05.429 Processing ready reads
 2011-06-29 21:59:05.429 MythSocketThread: Total read time: 0ms, on sockets
 2011-06-29 21:59:05.429 Reacquired ready read lock
 2011-06-29 21:59:05.429 ProcessAddRemoveQueues
 2011-06-29 21:59:05.429 Construct FD_SET
 2011-06-29 21:59:05.429 Waiting on select..
 2011-06-29 21:59:06.305 AutoExpire: CalcParams()
 2011-06-29 21:59:06.306 MSqlQuery::exec(DBManager2) SELECT MIN(id),dirname
 FROM storagegroup WHERE hostname = 'homeserver' AND groupname NOT IN ( 'DB
 Backups', 'Videos', 'Trailers', 'Coverart', 'Fanart', 'Screenshots',
 'Banners' ) GROUP BY dirname; <<<< Returns 2 row(s)
 2011-06-29 21:59:06.306 MSqlQuery::next(DBManager2) Result: "MIN(id) = 26,
 dirname = /raid_tank/mythtv/livetv/"
 2011-06-29 21:59:06.307 MSqlQuery::next(DBManager2) Result: "MIN(id) = 23,
 dirname = /raid_tank/mythtv/recordings/"
 2011-06-29 21:59:06.307 MythSocket(ffffffffb18d1540:33): UpRef: 2
 2011-06-29 21:59:06.307 Got data on select
 2011-06-29 21:59:06.307 MythSocket(ffffffffb18d1540:33): write -> 33 16
 QUERY_FREE_SPACE
 2011-06-29 21:59:06.307 Processing ready reads
 2011-06-29 21:59:06.307 MythSocket(ffffffffb18d1540:33):
 writeBlock(0x169329024, 24)
 2011-06-29 21:59:06.307 MythSocketThread: Total read time: 0ms, on sockets
 2011-06-29 21:59:06.307 Reacquired ready read lock
 2011-06-29 21:59:06.307 ProcessAddRemoveQueues
 2011-06-29 21:59:06.307 Construct FD_SET
 2011-06-29 21:59:06.307 Waiting on select..
 }}}

-- 
Ticket URL: <http://code.mythtv.org/trac/ticket/9883>
MythTV <http://code.mythtv.org/trac>
MythTV Media Center