Stability issues with mythtv 0.24+fixes20110121-0.0

Top Page

Reply to this message
Author: Jim Dishaw
Date:  
To: dmo-discussion
Subject: Stability issues with mythtv 0.24+fixes20110121-0.0
With the release of squeeze, I dist-upgraded. Prior to the upgrade, my
myth installation was very stable (I never needed to restart myth on a
frontend). After the dist-upgrade, the player locks up on a frontend,
which requires a restart of the frontend via a kill command.

I have the suspicion that the problem might be on the backend machine
because of a "PlaybackBoxHelper Error: CHECK_AVAILABILITY" entry in the
log. The file that is reported not found does exist and is local to the
backend machine. I think at the time of the lockup, the backend machine
had just finished recording and started a mythcommflag. The backend had
also been upgraded to squeeze and is a dual core AMD, 2GB memory and 2
500 GB SATA drives for recordings. The mythconverg database is on a
separate machine. I do notice that when I ssh into the backend machine
when mythcommflag is running, ssh seems to pause for about a second
every now and then.

Has anyone else experienced any issues?

The log from the frontend starting prior to the lockup is

2011-02-08 19:53:52.430 MSqlQuery::exec(DBManager0) SELECT count(*) FROM 
inuseprograms WHERE chanid   = '2186'   AND starttime = 
'2011-02-07T04:00:00' AND       hostname = 'familyroom' AND recusage  = 
'player' <<<< Returns 1 row(s)
2011-02-08 19:53:52.432 MSqlQuery::exec(DBManager0) UPDATE inuseprograms 
SET lastupdatetime = '2011-02-08T19:53:52' WHERE chanid   = '2186'   AND 
starttime = '2011-02-07T04:00:00' AND       hostname = 'familyroom' AND 
recusage  = 'player'
2011-02-08 19:59:32.420 TV: ASK_RECORDING 2 29 0 0 hasrec: 0 haslater: 0
2011-02-08 20:00:08.517 MSqlQuery::exec(DBManager1) SELECT recordid, 
type, maxepisodes, avg_delay, next_record, last_record, last_delete FROM 
record; <<<< Returns 64 row(s)
2011-02-08 20:00:08.530 MSqlQuery::exec(DBManager0) SELECT distinct 
recgroup from recorded WHERE deletepending = 0 ORDER BY recgroup <<<< 
Returns 5 row(s)
2011-02-08 20:00:08.535 MSqlQuery::exec(DBManager1) SELECT DISTINCT 
dirname FROM storagegroup WHERE groupname = 'Default' <<<< Returns 5 row(s)
2011-02-08 20:00:08.537 MSqlQuery::exec(DBManager0) SELECT DISTINCT 
dirname FROM storagegroup <<<< Returns 13 row(s)
2011-02-08 20:00:08.575 PlaybackBoxHelper Error: CHECK_AVAILABILITY 
'myth://10.47.0.240:6543/2006_20110208200000.mpg' file not found
2011-02-08 20:00:09.342 MSqlQuery::exec(DBManager1) SELECT status FROM 
jobqueue WHERE type = '1' AND chanid = '2186' AND starttime = 
'2011-02-07T04:00:00'; <<<< Returns 0 row(s)
2011-02-08 20:00:09.343 MSqlQuery::exec(DBManager0) SELECT status FROM 
jobqueue WHERE type = '2' AND chanid = '2186' AND starttime = 
'2011-02-07T04:00:00'; <<<< Returns 0 row(s)
2011-02-08 20:00:09.348 MSqlQuery::exec(DBManager1) SELECT 
bookmarkupdate FROM recorded WHERE chanid    = '2186' AND      starttime 
= '2011-02-07T04:00:00' <<<< Returns 1 row(s)
2011-02-08 20:01:20.930 AFD Warning: ScanATSCCaptionStreams() called 
with no PMT
2011-02-08 20:01:20.939 [mpegvideo_vdpau @ 0xb4c9af60]warning: first 
frame is no keyframe
2011-02-08 20:01:21.338 [mpegvideo_vdpau @ 0xb4c9af60]warning: first 
frame is no keyframe
2011-02-08 20:01:21.601 [mpegvideo_vdpau @ 0xb4c9af60]warning: first 
frame is no keyframe
2011-02-08 20:01:21.970 [mpegvideo_vdpau @ 0xb4c9af60]warning: first 
frame is no keyframe
2011-02-08 20:01:33.257 ScreenSaverX11Private: DPMS Deactivated 1
2011-02-08 20:01:40.429 AFD Warning: ScanATSCCaptionStreams() called 
with no PMT
2011-02-08 20:01:56.061 AFD Warning: ScanATSCCaptionStreams() called 
with no PMT
2011-02-08 20:01:57.794 AFD Warning: ScanATSCCaptionStreams() called 
with no PMT
2011-02-08 20:03:40.030 AFD Warning: ScanATSCCaptionStreams() called 
with no PMT
2011-02-08 20:03:50.212 AFD Warning: ScanATSCCaptionStreams() called 
with no PMT
2011-02-08 20:08:19.288 MSqlQuery::exec(DBManager0) SELECT recordid, 
type, maxepisodes, avg_delay, next_record, last_record, last_delete FROM 
record; <<<< Returns 64 row(s)
2011-02-08 20:08:19.300 MSqlQuery::exec(DBManager1) SELECT distinct 
recgroup from recorded WHERE deletepending = 0 ORDER BY recgroup <<<< 
Returns 5 row(s)
2011-02-08 20:08:19.314 MSqlQuery::exec(DBManager0) SELECT 
bookmarkupdate FROM recorded WHERE chanid    = '2006' AND      starttime 
= '2011-02-08T20:00:00' <<<< Returns 1 row(s)
2011-02-08 20:08:21.377 MSqlQuery::exec(DBManager1) SELECT status FROM 
jobqueue WHERE type = '1' AND chanid = '2186' AND starttime = 
'2011-02-07T04:00:00'; <<<< Returns 0 row(s)
2011-02-08 20:08:21.379 MSqlQuery::exec(DBManager0) SELECT status FROM 
jobqueue WHERE type = '2' AND chanid = '2186' AND starttime = 
'2011-02-07T04:00:00'; <<<< Returns 0 row(s)
2011-02-08 20:08:21.385 MSqlQuery::exec(DBManager1) SELECT 
bookmarkupdate FROM recorded WHERE chanid    = '2186' AND      starttime 
= '2011-02-07T04:00:00' <<<< Returns 1 row(s)
2011-02-08 20:08:21.458 PlaybackBox: Ignoring PREVIEW_SUCCESS, item no 
longer on screen.
2011-02-08 20:08:21.463 ALSA, Error: WriteAudio: buffer underrun
2011-02-08 20:08:21.604 Player(2): Waited 100ms for video buffers 
AALAAAAAAAALAAAaA
2011-02-08 20:08:21.613 Player(2): Waited 100ms for video buffers 
AALAAAAAAAALAAAaA
2011-02-08 20:08:21.623 Player(2): Waited 100ms for video buffers 
AALAAAAAAAALAAAaA
2011-02-08 20:08:21.631 Player(2): Waited 100ms for video buffers 
AALAAAAAAAALAAAaA
2011-02-08 20:08:24.296 MSqlQuery::exec(DBManager0) SELECT recordid, 
type, maxepisodes, avg_delay, next_record, last_record, last_delete FROM 
record; <<<< Returns 64 row(s)
2011-02-08 20:08:24.308 MSqlQuery::exec(DBManager1) SELECT distinct 
recgroup from recorded WHERE deletepending = 0 ORDER BY recgroup <<<< 
Returns 5 row(s)
2011-02-08 20:08:24.316 MSqlQuery::exec(DBManager0) SELECT 
bookmarkupdate FROM recorded WHERE chanid    = '2006' AND      starttime 
= '2011-02-08T20:00:00' <<<< Returns 1 row(s)
2011-02-08 20:08:25.705 MSqlQuery::exec(DBManager1) SELECT status FROM 
jobqueue WHERE type = '1' AND chanid = '2186' AND starttime = 
'2011-02-07T04:00:00'; <<<< Returns 0 row(s)
2011-02-08 20:08:25.707 MSqlQuery::exec(DBManager0) SELECT status FROM 
jobqueue WHERE type = '2' AND chanid = '2186' AND starttime = 
'2011-02-07T04:00:00'; <<<< Returns 0 row(s)
2011-02-08 20:08:25.713 MSqlQuery::exec(DBManager1) SELECT 
bookmarkupdate FROM recorded WHERE chanid    = '2186' AND      starttime 
= '2011-02-07T04:00:00' <<<< Returns 1 row(s)
2011-02-08 20:08:25.788 PlaybackBox: Ignoring PREVIEW_SUCCESS, item no 
longer on screen.
2011-02-08 20:08:25.794 ALSA, Error: WriteAudio: buffer underrun
2011-02-08 20:08:54.011 MSqlQuery::exec(DBManager0) SELECT count(*) FROM 
inuseprograms WHERE chanid   = '2186'   AND starttime = 
'2011-02-07T04:00:00' AND       hostname = 'familyroom' AND recusage  = 
'player' <<<< Returns 1 row(s)
2011-02-08 20:08:54.012 MSqlQuery::exec(DBManager0) UPDATE inuseprograms 
SET lastupdatetime = '2011-02-08T20:08:53' WHERE chanid   = '2186'   AND 
starttime = '2011-02-07T04:00:00' AND       hostname = 'familyroom' AND 
recusage  = 'player'
2011-02-08 20:08:54.029 ALSA, Error: WriteAudio: buffer underrun
2011-02-08 20:09:28.066 AFD Warning: ScanATSCCaptionStreams() called 
with no PMT
2011-02-08 20:09:31.403 AFD Warning: ScanATSCCaptionStreams() called 
with no PMT
2011-02-08 20:09:54.471 Dec: DoFastForward(): desiredFrame(32066) > 
last_frame(32065)
2011-02-08 20:09:54.600 Player(2), Warning: Waited 100ms for decoder to 
unpause
2011-02-08 20:09:54.700 Player(2), Warning: Waited 100ms for decoder to 
unpause
2011-02-08 20:09:54.801 Player(2), Warning: Waited 100ms for decoder to 
unpause
... repeated many times ...
2011-02-08 20:10:04.531 Player(2), Warning: Waited 100ms for decoder to 
unpause
2011-02-08 20:10:06.712 NVP::AddTextData(): Text buffer overflow
2011-02-08 20:10:06.949 NVP::AddTextData(): Text buffer overflow
... repeated many times ...
2011-02-08 20:10:29.964 NVP::AddTextData(): Text buffer overflow
2011-02-08 20:10:45.079 AFD Warning: ScanATSCCaptionStreams() called 
with no PMT
2011-02-08 20:10:49.927 NVP::AddTextData(): Text buffer overflow
2011-02-08 20:10:49.927 AFD Warning: ScanATSCCaptionStreams() called 
with no PMT
2011-02-08 20:10:50.257 NVP::AddTextData(): Text buffer overflow
... repeated many times