[mythtv-users] LiveTV locks up and crashes

Marc Chamberlin marc at marcchamberlin.com
Fri Jan 23 06:42:20 UTC 2009


Hi -  I am experiencing an occasional problem with watching live TV in 
that it will suddenly freeze up and stop. I have a Hauppauge 350 PVR 
card, running under SuSE11.1 linux. This is a single computer so both 
the backend and the frontend are running on the same computer. Often 
(but not always) I can hit the escape key and after a minute or so 
MythTV will return to the main menu. From there sometimes (but again not 
always) I can click on Watch TV and it will start back up. Sometimes it 
will just exit completely and sometimes when I try that it fails to 
restart and comes back to the main screen. When that happens I can often 
just restart the backend and it will work for awhile....

Below is a copy of the MythTV log file for the backend taken around the 
time when a few of these freezes occurred. Could some kind guru take a 
look at it and decipher it for me? I could make some guesses but 
probably better if an expert takes a look instead... Dunno what other 
info is needed but will be glad to supply... Thanks in advance for any 
and all help offered!

   Marc...

more crashlog.txt
Starting up as the master server.
2009-01-22 21:05:01.554 New DB connection, total: 3
2009-01-22 21:05:01.590 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 21:05:01.670 New DB scheduler connection
2009-01-22 21:05:01.707 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 21:05:02.975 Main::Registering HttpStatus Extension
2009-01-22 21:05:03.006 mythbackend version: 0.21.20080304-1 www.mythtv.org
2009-01-22 21:05:03.039 Enabled verbose msgs:  important general
2009-01-22 21:05:03.074 AutoExpire: CalcParams(): Max required Free 
Space: 1.0 GB w/freq: 15
 min
2009-01-22 21:05:04.745 Reschedule requested for id -1.
2009-01-22 21:05:04.819 Scheduled 17 items in 0.1 = 0.04 match + 0.03 place
2009-01-22 21:05:04.869 Seem to be woken up by USER
2009-01-22 21:05:11.775 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/share/Movies/dvd:
2009-01-22 21:05:11.808 UPnpMedia: BuildMediaMap Done. Found 0 objects
2009-01-22 21:05:17.566 MainServer::HandleAnnounce Monitor
2009-01-22 21:05:17.599 adding: nova as a client (events: 0)
2009-01-22 21:05:17.633 MainServer::HandleAnnounce Monitor
2009-01-22 21:05:17.666 adding: nova as a client (events: 1)
2009-01-22 21:05:17.705 MainServer::HandleAnnounce Playback
2009-01-22 21:05:17.733 adding: nova as a client (events: 0)
2009-01-22 21:05:17.768 TVRec(1): Changing from None to WatchingLiveTV
2009-01-22 21:05:17.804 TVRec(1): HW Tuner: 1->1
2009-01-22 21:05:18.962 AutoExpire: CalcParams(): Max required Free 
Space: 2.0 GB w/freq: 15
 min
2009-01-22 21:05:18.974 MPEGRec(/dev/video0) Warning: Audio sample rate 
32000 Hz
                        is not supported by ivtv driver, using 48000 Hz 
instead.
2009-01-22 21:05:30.119 TFW, Error: Write() -- IOBOUND begin cnt(2048) 
free(2047)
2009-01-22 21:05:38.669 TVRec(1): Changing from WatchingLiveTV to None
2009-01-22 21:06:07.936 TFW, Error: Write() -- IOBOUND end
2009-01-22 21:06:08.171 Finished recording Supernatural "Criss Angel Is 
a Douche Bag": chann
el 1005
2009-01-22 21:06:08.252 MythSocket(b1f0c070:-1): writeStringList: Error, 
socket went unconne
cted.
Mutex destroy failure: Device or resource busy
2009-01-22 21:06:28.517 DB Error (Error in JobQueue::GetJobCmd()):
Query was:
SELECT cmds FROM jobqueue WHERE id = 13;
Driver error was [2/2006]:
QMYSQL3: Unable to execute query
Database error was:
MySQL server has gone away

2009-01-22 21:06:28.568 DB Error (Error in JobQueue::ChangeJobStatus()):
Query was:
UPDATE jobqueue SET status = 4, comment = '15% Completed @ 56.4388 fps.' 
WHERE id = 13;
Driver error was [2/2006]:
QMYSQL3: Unable to execute query
Database error was:
MySQL server has gone away

2009-01-22 21:07:35.492 Using runtime prefix = /usr
2009-01-22 21:07:36.727 Empty LocalHostName.
2009-01-22 21:07:37.217 Using localhost value of nova
2009-01-22 21:07:37.647 New DB connection, total: 1
2009-01-22 21:07:37.911 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 21:07:38.246 Closing DB connection named 'DBManager0'
2009-01-22 21:07:38.315 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 21:07:38.410 New DB connection, total: 2
2009-01-22 21:07:38.508 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 21:07:38.753 Current Schema Version: 1214
Starting up as the master server.
2009-01-22 21:07:39.951 New DB connection, total: 3
2009-01-22 21:07:40.194 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 21:07:40.689 New DB scheduler connection
2009-01-22 21:07:40.726 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 21:07:42.097 Main::Registering HttpStatus Extension
2009-01-22 21:07:42.318 mythbackend version: 0.21.20080304-1 www.mythtv.org
2009-01-22 21:07:42.369 Enabled verbose msgs:  important general
2009-01-22 21:07:42.445 AutoExpire: CalcParams(): Max required Free 
Space: 1.0 GB w/freq: 15
 min
2009-01-22 21:07:43.837 Reschedule requested for id -1.
2009-01-22 21:07:44.361 Scheduled 17 items in 0.5 = 0.37 match + 0.15 place
2009-01-22 21:07:44.543 Seem to be woken up by USER
2009-01-22 21:07:50.968 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/share/Movies/dvd:
2009-01-22 21:07:51.086 UPnpMedia: BuildMediaMap Done. Found 0 objects
2009-01-22 21:08:00.823 Expiring 6 MBytes for 1005 @ Thu Jan 22 21:00:00 
2009 => Supernatura
l "Criss Angel Is a Douche Bag"
2009-01-22 21:08:18.340 MainServer::HandleAnnounce Monitor
2009-01-22 21:08:18.408 adding: nova as a client (events: 0)
2009-01-22 21:08:18.434 MainServer::HandleAnnounce Monitor
2009-01-22 21:08:18.459 adding: nova as a client (events: 1)
2009-01-22 21:08:18.487 MainServer::HandleAnnounce Playback
2009-01-22 21:08:18.542 adding: nova as a client (events: 0)
2009-01-22 21:08:18.591 TVRec(1): Changing from None to WatchingLiveTV
2009-01-22 21:08:18.623 TVRec(1): HW Tuner: 1->1
2009-01-22 21:08:20.112 AutoExpire: CalcParams(): Max required Free 
Space: 2.0 GB w/freq: 15
 min
2009-01-22 21:08:20.126 MPEGRec(/dev/video0) Warning: Audio sample rate 
32000 Hz
                        is not supported by ivtv driver, using 48000 Hz 
instead.
2009-01-22 21:08:50.872 JobQueue: Commercial Flagging Starting for 
Smallville "Bulletproof"
recorded from channel 1005 at Thu Jan 22 20:00:00 2009
2009-01-22 21:08:51.090 Using runtime prefix = /usr
2009-01-22 21:08:51.206 Empty LocalHostName.
2009-01-22 21:08:51.284 Using localhost value of nova
2009-01-22 21:08:51.340 New DB connection, total: 1
2009-01-22 21:08:51.375 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 21:08:51.404 Closing DB connection named 'DBManager0'
2009-01-22 21:08:51.438 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 21:08:51.475 New DB connection, total: 2
2009-01-22 21:08:51.505 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 21:08:51.646 Connecting to backend server: 192.168.2.20:6543 
(try 1 of 5)
2009-01-22 21:08:51.689 Using protocol version 40
2009-01-22 21:08:51.723 MainServer::HandleAnnounce Monitor
2009-01-22 21:08:51.756 adding: nova as a client (events: 0)
2009-01-22 21:08:51.791 MainServer::HandleAnnounce Monitor
2009-01-22 21:08:51.823 adding: nova as a client (events: 1)
2009-01-22 21:08:54.361 AFD: Opened codec 0x821b4e0, id(MPEG2VIDEO) 
type(Video)
2009-01-22 21:08:54.413 AFD: codec MP2 has 2 channels
2009-01-22 21:08:54.438 AFD: Opened codec 0x821b960, id(MP2) type(Audio)
2009-01-22 21:09:01.157 AutoExpire: CalcParams(): Max required Free 
Space: 2.0 GB w/freq: 15
 min
2009-01-22 21:24:01.231 AutoExpire: CalcParams(): Max required Free 
Space: 2.0 GB w/freq: 15
 min
2009-01-22 21:24:01.274 Expiring 2081 MBytes for 1010 @ Wed Jan 21 
20:00:00 2009 => Make 'em
 Laugh: The Funny Business of America "The Knockabouts: Slip on a Banana 
Peel; The Groundbre
akers: When I'm Bad, I'm Better"
2009-01-22 21:37:30.123 Using runtime prefix = /usr
2009-01-22 21:37:30.229 Empty LocalHostName.
2009-01-22 21:37:30.257 Using localhost value of nova
2009-01-22 21:37:30.397 New DB connection, total: 1
2009-01-22 21:37:30.523 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 21:37:30.558 Closing DB connection named 'DBManager0'
2009-01-22 21:37:30.592 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 21:37:30.632 New DB connection, total: 2
2009-01-22 21:37:30.675 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 21:37:30.724 Current Schema Version: 1214
2009-01-22 21:37:31.045 AFD: Opened codec 0x82aeae0, id(MPEG2VIDEO) 
type(Video)
2009-01-22 21:37:31.085 AFD: codec MP2 has 2 channels
2009-01-22 21:37:31.110 AFD: Opened codec 0x82aef60, id(MP2) type(Audio)
2009-01-22 21:37:31.330 Preview: Grabbed preview 
'/mediacenter/tv/1005_20090122200000.mpg' 7
20x480 at 64s
2009-01-22 21:37:54.237 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/share/Movies/dvd:
2009-01-22 21:37:54.338 UPnpMedia: BuildMediaMap Done. Found 0 objects
2009-01-22 21:39:01.362 AutoExpire: CalcParams(): Max required Free 
Space: 2.0 GB w/freq: 15
 min
2009-01-22 21:54:01.430 AutoExpire: CalcParams(): Max required Free 
Space: 2.0 GB w/freq: 15
 min
2009-01-22 21:56:08.080 TFW, Error: Write() -- IOBOUND begin cnt(2048) 
free(2047)
2009-01-22 21:56:47.796 TVRec(1): Changing from WatchingLiveTV to None
2009-01-22 21:56:56.785 MainServer::HandleAnnounce Playback
2009-01-22 21:56:56.816 adding: nova as a client (events: 0)
2009-01-22 21:57:31.966 Using runtime prefix = /usr
2009-01-22 21:57:32.023 Empty LocalHostName.
2009-01-22 21:57:32.064 Using localhost value of nova
2009-01-22 21:57:32.125 New DB connection, total: 1
2009-01-22 21:57:32.203 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 21:57:32.267 Closing DB connection named 'DBManager0'
2009-01-22 21:57:32.317 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 21:57:32.351 New DB connection, total: 2
2009-01-22 21:57:32.384 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 21:57:32.454 Current Schema Version: 1214
Starting up as the master server.
2009-01-22 21:57:32.637 New DB connection, total: 3
2009-01-22 21:57:32.687 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 21:57:32.860 New DB scheduler connection
2009-01-22 21:57:32.879 Connected to database 'mythconverg' at host: 
localhost
QServerSocket: failed to bind or listen to the socket
2009-01-22 21:57:32.951 MediaServer::HttpServer Create Error
2009-01-22 21:57:32.972 mythbackend version: 0.21.20080304-1 www.mythtv.org
2009-01-22 21:57:33.055 Enabled verbose msgs:  important general
2009-01-22 21:57:33.099 AutoExpire: CalcParams(): Max required Free 
Space: 1.0 GB w/freq: 15
 min
QServerSocket: failed to bind or listen to the socket
2009-01-22 21:57:33.148 Failed to bind port 6543. Exiting.
2009-01-22 21:57:36.436 Using runtime prefix = /usr
2009-01-22 21:57:36.467 Empty LocalHostName.
2009-01-22 21:57:36.541 Using localhost value of nova
2009-01-22 21:57:36.592 New DB connection, total: 1
2009-01-22 21:57:36.622 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 21:57:36.643 Closing DB connection named 'DBManager0'
2009-01-22 21:57:36.668 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 21:57:36.694 New DB connection, total: 2
2009-01-22 21:57:36.719 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 21:57:36.754 Current Schema Version: 1214
Starting up as the master server.
2009-01-22 21:57:36.825 New DB connection, total: 3
2009-01-22 21:57:36.853 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 21:57:37.012 New DB scheduler connection
2009-01-22 21:57:37.063 Connected to database 'mythconverg' at host: 
localhost
QServerSocket: failed to bind or listen to the socket
2009-01-22 21:57:37.134 MediaServer::HttpServer Create Error
2009-01-22 21:57:37.156 mythbackend version: 0.21.20080304-1 www.mythtv.org
2009-01-22 21:57:37.181 Enabled verbose msgs:  important general
2009-01-22 21:57:37.208 AutoExpire: CalcParams(): Max required Free 
Space: 1.0 GB w/freq: 15
 min
QServerSocket: failed to bind or listen to the socket
2009-01-22 21:57:37.257 Failed to bind port 6543. Exiting.
2009-01-22 21:58:14.707 Using runtime prefix = /usr
2009-01-22 21:58:14.747 Empty LocalHostName.
2009-01-22 21:58:14.780 Using localhost value of nova
2009-01-22 21:58:14.821 New DB connection, total: 1
2009-01-22 21:58:14.861 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 21:58:14.891 Closing DB connection named 'DBManager0'
2009-01-22 21:58:14.924 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 21:58:14.958 New DB connection, total: 2
2009-01-22 21:58:14.991 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 21:58:15.027 Current Schema Version: 1214
Starting up as the master server.
2009-01-22 21:58:15.133 New DB connection, total: 3
2009-01-22 21:58:15.159 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 21:58:15.337 New DB scheduler connection
2009-01-22 21:58:15.360 Connected to database 'mythconverg' at host: 
localhost
QServerSocket: failed to bind or listen to the socket
2009-01-22 21:58:15.415 MediaServer::HttpServer Create Error
2009-01-22 21:58:15.445 mythbackend version: 0.21.20080304-1 www.mythtv.org
2009-01-22 21:58:15.478 Enabled verbose msgs:  important general
2009-01-22 21:58:15.520 AutoExpire: CalcParams(): Max required Free 
Space: 1.0 GB w/freq: 15
 min
QServerSocket: failed to bind or listen to the socket
2009-01-22 21:58:15.654 Failed to bind port 6543. Exiting.
2009-01-22 22:01:26.402 Using runtime prefix = /usr
2009-01-22 22:01:26.887 Empty LocalHostName.
2009-01-22 22:01:27.075 Using localhost value of nova
2009-01-22 22:01:27.509 New DB connection, total: 1
2009-01-22 22:01:27.814 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 22:01:28.157 Closing DB connection named 'DBManager0'
2009-01-22 22:01:28.257 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 22:01:28.494 New DB connection, total: 2
2009-01-22 22:01:28.768 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 22:01:28.948 Current Schema Version: 1214
Starting up as the master server.
2009-01-22 22:01:29.738 New DB connection, total: 3
2009-01-22 22:01:29.839 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 22:01:30.170 New DB scheduler connection
2009-01-22 22:01:30.792 Connected to database 'mythconverg' at host: 
localhost
2009-01-22 22:01:32.685 Main::Registering HttpStatus Extension
2009-01-22 22:01:33.091 mythbackend version: 0.21.20080304-1 www.mythtv.org
2009-01-22 22:01:33.234 Enabled verbose msgs:  important general
2009-01-22 22:01:33.494 AutoExpire: CalcParams(): Max required Free 
Space: 1.0 GB w/freq: 15
 min
2009-01-22 22:01:34.239 Reschedule requested for id -1.
2009-01-22 22:01:35.203 Scheduled 17 items in 1.0 = 0.60 match + 0.36 place
2009-01-22 22:01:35.354 Seem to be woken up by USER
2009-01-22 22:01:41.520 UPnpMedia: BuildMediaMap VIDEO scan starting in 
:/share/Movies/dvd:
2009-01-22 22:01:43.806 UPnpMedia: BuildMediaMap Done. Found 0 objects
2009-01-22 22:02:51.212 AutoExpire: CalcParams(): Max required Free 
Space: 1.0 GB w/freq: 15
 min




More information about the mythtv-users mailing list