[mythtv-users] Erratic failure. Wonky database connexion? Memory issues? Any suggestions?

Jonathan Sambrook jonathan at hmmn.org
Sat Jul 5 17:01:24 UTC 2008 

And a crash with backtrace this time:
[New Thread 0xa7b4ab90 (LWP 25486)]
[New Thread 0xa834bb90 (LWP 25487)]
2008-07-05 10:18:51.318 Reschedule requested for id -1.
2008-07-05 10:18:51.639 Scheduled 25 items in 0.3 = 0.01 match + 0.31 place
2008-07-05 10:18:51.644 scheduler: Scheduled items: Scheduled 25 items in 0.3 = 0.01 match + 0.31 place
2008-07-05 10:20:02.795 MainServer::HandleAnnounce Monitor
2008-07-05 10:20:02.795 adding: soprano as a client (events: 0)
[Thread 0xa8dfdb90 (LWP 25483) exited]
[Thread 0xa95feb90 (LWP 25484) exited]
[New Thread 0xa95feb90 (LWP 25520)]
[New Thread 0xa8dfdb90 (LWP 25521)]
[Thread 0xa7b4ab90 (LWP 25486) exited]
[Thread 0xa834bb90 (LWP 25487) exited]
[New Thread 0xa834bb90 (LWP 25523)]
[New Thread 0xa7b4ab90 (LWP 25524)]
2008-07-05 10:25:50.780 AutoExpire: CalcParams(): Max required Free Space: 0.0 GB w/freq: 15 min
2008-07-05 10:26:04.878 Reschedule requested for id -1.
2008-07-05 10:26:05.163 Scheduled 25 items in 0.3 = 0.01 match + 0.27 place
2008-07-05 10:26:05.167 scheduler: Scheduled items: Scheduled 25 items in 0.3 = 0.01 match + 0.27 place
[Thread 0xa95feb90 (LWP 25520) exited]
[Thread 0xa8dfdb90 (LWP 25521) exited]
[New Thread 0xa8dfdb90 (LWP 25552)]
[New Thread 0xa95feb90 (LWP 25553)]
[Thread 0xa834bb90 (LWP 25523) exited]
[Thread 0xa7b4ab90 (LWP 25524) exited]
[New Thread 0xa7b4ab90 (LWP 25555)]
[New Thread 0xa834bb90 (LWP 25556)]
2008-07-05 10:29:13.692 DB Error (change_program):
Query was:
UPDATE program SET starttime = '2008-07-05T14:00:00',     endtime   = '2008-07-05T15:30:00' WHERE chanid    = 1081 AND       starttime = '2008-07-05T13:30:00'
Driver error was [2/1062]:
QMYSQL3: Unable to execute query
Database error was:
Duplicate entry '1081-2008-07-05 14:00:00-0' for key 1

2008-07-05 10:30:02.775 MainServer::HandleAnnounce Monitor
2008-07-05 10:30:02.775 adding: soprano as a client (events: 0)
2008-07-05 10:30:15.110 Reschedule requested for id -1.
2008-07-05 10:30:15.418 Scheduled 25 items in 0.3 = 0.01 match + 0.30 place
2008-07-05 10:30:15.423 scheduler: Scheduled items: Scheduled 25 items in 0.3 = 0.01 match + 0.30 place
[Thread 0xa8dfdb90 (LWP 25552) exited]
[Thread 0xa95feb90 (LWP 25553) exited]
[New Thread 0xa95feb90 (LWP 25587)]
[New Thread 0xa8dfdb90 (LWP 25588)]
2008-07-05 10:33:41.166 Reschedule requested for id -1.
2008-07-05 10:33:41.459 Scheduled 25 items in 0.3 = 0.01 match + 0.28 place
2008-07-05 10:33:41.464 scheduler: Scheduled items: Scheduled 25 items in 0.3 = 0.01 match + 0.28 place
[Thread 0xa7b4ab90 (LWP 25555) exited]
[Thread 0xa834bb90 (LWP 25556) exited]
[New Thread 0xa834bb90 (LWP 25590)]
[New Thread 0xa7b4ab90 (LWP 25591)]
2008-07-05 10:36:23.062 Reschedule requested for id -1.
2008-07-05 10:36:23.343 Scheduled 25 items in 0.3 = 0.01 match + 0.27 place
2008-07-05 10:36:23.348 scheduler: Scheduled items: Scheduled 25 items in 0.3 = 0.01 match + 0.27 place
[Thread 0xa95feb90 (LWP 25587) exited]
[Thread 0xa8dfdb90 (LWP 25588) exited]
[New Thread 0xa8dfdb90 (LWP 25611)]
[New Thread 0xa95feb90 (LWP 25612)]
[Thread 0xa834bb90 (LWP 25590) exited]
[Thread 0xa7b4ab90 (LWP 25591) exited]
[New Thread 0xa7b4ab90 (LWP 25629)]
[New Thread 0xa834bb90 (LWP 25630)]
2008-07-05 10:39:43.703 UPnpMedia: BuildMediaMap - no VideoStartupDir set,  skipping scan.
2008-07-05 10:40:02.737 MainServer::HandleAnnounce Monitor
2008-07-05 10:40:02.737 adding: soprano as a client (events: 0)
2008-07-05 10:40:50.818 AutoExpire: CalcParams(): Max required Free Space: 0.0 GB w/freq: 15 min
2008-07-05 10:41:04.887 Reschedule requested for id -1.
2008-07-05 10:41:05.192 Scheduled 25 items in 0.3 = 0.01 match + 0.30 place
2008-07-05 10:41:05.197 scheduler: Scheduled items: Scheduled 25 items in 0.3 = 0.01 match + 0.30 place
[Thread 0xa8dfdb90 (LWP 25611) exited]
[Thread 0xa95feb90 (LWP 25612) exited]
[New Thread 0xa95feb90 (LWP 25663)]
[New Thread 0xa8dfdb90 (LWP 25664)]
2008-07-05 10:43:47.264 Reschedule requested for id -1.
2008-07-05 10:43:47.546 Scheduled 25 items in 0.3 = 0.01 match + 0.27 place
2008-07-05 10:43:47.551 scheduler: Scheduled items: Scheduled 25 items in 0.3 = 0.01 match + 0.27 place
[Thread 0xa7b4ab90 (LWP 25629) exited]
[Thread 0xa834bb90 (LWP 25630) exited]
[New Thread 0xa834bb90 (LWP 25667)]
[New Thread 0xa7b4ab90 (LWP 25668)]
[Thread 0xa95feb90 (LWP 25663) exited]
[Thread 0xa8dfdb90 (LWP 25664) exited]
[New Thread 0xa8dfdb90 (LWP 25688)]
[New Thread 0xa95feb90 (LWP 25689)]
2008-07-05 10:48:52.099 Reschedule requested for id -1.
2008-07-05 10:48:52.420 Scheduled 25 items in 0.3 = 0.01 match + 0.31 place
2008-07-05 10:48:52.425 scheduler: Scheduled items: Scheduled 25 items in 0.3 = 0.01 match + 0.31 place
[Thread 0xa834bb90 (LWP 25667) exited]
[Thread 0xa7b4ab90 (LWP 25668) exited]
[New Thread 0xa7b4ab90 (LWP 25693)]
[New Thread 0xa834bb90 (LWP 25694)]
2008-07-05 10:50:02.626 MainServer::HandleAnnounce Monitor
2008-07-05 10:50:02.626 adding: soprano as a client (events: 0)
[Thread 0xa8dfdb90 (LWP 25688) exited]
[Thread 0xa95feb90 (LWP 25689) exited]
[New Thread 0xa95feb90 (LWP 25728)]
[New Thread 0xa8dfdb90 (LWP 25729)]
[Thread 0xa7b4ab90 (LWP 25693) exited]
[Thread 0xa834bb90 (LWP 25694) exited]
[New Thread 0xa834bb90 (LWP 25731)]
[New Thread 0xa7b4ab90 (LWP 25732)]
2008-07-05 10:55:50.859 AutoExpire: CalcParams(): Max required Free Space: 0.0 GB w/freq: 15 min
2008-07-05 10:56:39.285 Reschedule requested for id -1.
2008-07-05 10:56:39.597 Scheduled 25 items in 0.3 = 0.01 match + 0.30 place
2008-07-05 10:56:39.601 scheduler: Scheduled items: Scheduled 25 items in 0.3 = 0.01 match + 0.30 place
[Thread 0xa95feb90 (LWP 25728) exited]
[Thread 0xa8dfdb90 (LWP 25729) exited]
[New Thread 0xa8dfdb90 (LWP 25753)]
[New Thread 0xa95feb90 (LWP 25754)]
2008-07-05 10:59:43.821 Reschedule requested for id -1.
[Thread 0xa834bb90 (LWP 25731) exited]
[Thread 0xa7b4ab90 (LWP 25732) exited]
2008-07-05 10:59:44.279 Scheduled 25 items in 0.5 = 0.01 match + 0.44 place
2008-07-05 10:59:44.286 scheduler: Scheduled items: Scheduled 25 items in 0.5 = 0.01 match + 0.44 place
[New Thread 0xa7b4ab90 (LWP 25757)]
[New Thread 0xa834bb90 (LWP 25758)]
2008-07-05 11:00:02.487 MainServer::HandleAnnounce Monitor
2008-07-05 11:00:02.487 adding: soprano as a client (events: 0)
[Thread 0xa8dfdb90 (LWP 25753) exited]
[Thread 0xa95feb90 (LWP 25754) exited]
[New Thread 0xa95feb90 (LWP 25789)]
[New Thread 0xa8dfdb90 (LWP 25790)]
2008-07-05 11:04:10.264 Reschedule requested for id -1.
2008-07-05 11:04:10.565 Scheduled 25 items in 0.3 = 0.01 match + 0.29 place
2008-07-05 11:04:10.570 scheduler: Scheduled items: Scheduled 25 items in 0.3 = 0.01 match + 0.29 place
[Thread 0xa7b4ab90 (LWP 25757) exited]
[Thread 0xa834bb90 (LWP 25758) exited]
[New Thread 0xa834bb90 (LWP 25792)]
[New Thread 0xa7b4ab90 (LWP 25793)]
[Thread 0xa95feb90 (LWP 25789) exited]
[Thread 0xa8dfdb90 (LWP 25790) exited]
[New Thread 0xa8dfdb90 (LWP 25819)]
[New Thread 0xa95feb90 (LWP 25820)]
2008-07-05 11:09:12.707 Reschedule requested for id -1.
2008-07-05 11:09:13.000 Scheduled 25 items in 0.3 = 0.01 match + 0.28 place
2008-07-05 11:09:13.004 scheduler: Scheduled items: Scheduled 25 items in 0.3 = 0.01 match + 0.28 place
2008-07-05 11:09:45.703 UPnpMedia: BuildMediaMap - no VideoStartupDir set,  skipping scan.
[Thread 0xa834bb90 (LWP 25792) exited]
[Thread 0xa7b4ab90 (LWP 25793) exited]
[New Thread 0xa7b4ab90 (LWP 25857)]
[New Thread 0xa834bb90 (LWP 25858)]
2008-07-05 11:10:02.857 MainServer::HandleAnnounce Monitor
2008-07-05 11:10:02.857 adding: soprano as a client (events: 0)
2008-07-05 11:10:50.898 AutoExpire: CalcParams(): Max required Free Space: 0.0 GB w/freq: 15 min
[Thread 0xa8dfdb90 (LWP 25819) exited]
[Thread 0xa95feb90 (LWP 25820) exited]
[New Thread 0xa95feb90 (LWP 25864)]
[New Thread 0xa8dfdb90 (LWP 25865)]
[Thread 0xa7b4ab90 (LWP 25857) exited]
[Thread 0xa834bb90 (LWP 25858) exited]
[New Thread 0xa834bb90 (LWP 25883)]
[New Thread 0xa7b4ab90 (LWP 25884)]
2008-07-05 11:15:35.909 Reschedule requested for id -1.
2008-07-05 11:15:36.197 Scheduled 25 items in 0.3 = 0.01 match + 0.28 place
[Thread 0xa95feb90 (LWP 25864) exited]
[Thread 0xa8dfdb90 (LWP 25865) exited]
[New Thread 0xa8dfdb90 (LWP 25895)]
[New Thread 0xa95feb90 (LWP 25896)]
2008-07-05 11:19:21.499 Reschedule requested for id -1.
2008-07-05 11:19:21.799 Scheduled 25 items in 0.3 = 0.01 match + 0.29 place
2008-07-05 11:19:21.805 scheduler: Last message repeated 1 times: Scheduled items: Scheduled 25 items in 0.3 = 0.01 match + 0.28 place
2008-07-05 11:19:21.809 scheduler: Scheduled items: Scheduled 25 items in 0.3 = 0.01 match + 0.29 place
2008-07-05 11:20:02.719 MainServer::HandleAnnounce Monitor
2008-07-05 11:20:02.719 adding: soprano as a client (events: 0)
[Thread 0xa834bb90 (LWP 25883) exited]
[Thread 0xa7b4ab90 (LWP 25884) exited]
[New Thread 0xa7b4ab90 (LWP 25929)]
[New Thread 0xa834bb90 (LWP 25930)]
2008-07-05 11:23:23.175 Reschedule requested for id -1.
[Thread 0xa8dfdb90 (LWP 25895) exited]
[Thread 0xa95feb90 (LWP 25896) exited]
2008-07-05 11:23:23.659 Scheduled 25 items in 0.5 = 0.01 match + 0.47 place
2008-07-05 11:23:23.663 scheduler: Scheduled items: Scheduled 25 items in 0.5 = 0.01 match + 0.47 place
[New Thread 0xa95feb90 (LWP 25934)]
[New Thread 0xa8dfdb90 (LWP 25935)]
[Thread 0xa7b4ab90 (LWP 25929) exited]
[Thread 0xa834bb90 (LWP 25930) exited]
[New Thread 0xa834bb90 (LWP 25958)]
[New Thread 0xa7b4ab90 (LWP 25959)]
2008-07-05 11:25:50.941 AutoExpire: CalcParams(): Max required Free Space: 0.0 GB w/freq: 15 min
2008-07-05 11:27:27.014 Reschedule requested for id -1.
2008-07-05 11:27:27.304 Scheduled 25 items in 0.3 = 0.01 match + 0.28 place
2008-07-05 11:27:27.309 scheduler: Scheduled items: Scheduled 25 items in 0.3 = 0.01 match + 0.28 place
[Thread 0xa95feb90 (LWP 25934) exited]
[Thread 0xa8dfdb90 (LWP 25935) exited]
[New Thread 0xa8dfdb90 (LWP 25962)]
[New Thread 0xa95feb90 (LWP 25963)]
2008-07-05 11:30:02.577 MainServer::HandleAnnounce Monitor
2008-07-05 11:30:02.577 adding: soprano as a client (events: 0)
2008-07-05 11:30:37.110 Reschedule requested for id -1.
[Thread 0xa834bb90 (LWP 25958) exited]
[Thread 0xa7b4ab90 (LWP 25959) exited]
2008-07-05 11:30:37.542 Scheduled 25 items in 0.4 = 0.01 match + 0.42 place
2008-07-05 11:30:37.548 scheduler: Scheduled items: Scheduled 25 items in 0.4 = 0.01 match + 0.42 place
[New Thread 0xa7b4ab90 (LWP 25996)]
[New Thread 0xa834bb90 (LWP 25997)]
2008-07-05 11:33:32.879 Reschedule requested for id -1.
[Thread 0xa8dfdb90 (LWP 25962) exited]
[Thread 0xa95feb90 (LWP 25963) exited]
[New Thread 0xa95feb90 (LWP 26003)]
2008-07-05 11:33:33.402 Scheduled 25 items in 0.5 = 0.01 match + 0.51 place
2008-07-05 11:33:33.408 scheduler: Scheduled items: Scheduled 25 items in 0.5 = 0.01 match + 0.51 place
[New Thread 0xa8dfdb90 (LWP 26004)]
[Thread 0xa7b4ab90 (LWP 25996) exited]
[Thread 0xa834bb90 (LWP 25997) exited]
[New Thread 0xa834bb90 (LWP 26024)]
[New Thread 0xa7b4ab90 (LWP 26025)]
2008-07-05 11:36:51.645 Reschedule requested for id -1.
2008-07-05 11:36:51.928 Scheduled 25 items in 0.3 = 0.01 match + 0.27 place
2008-07-05 11:36:51.933 scheduler: Scheduled items: Scheduled 25 items in 0.3 = 0.01 match + 0.27 place
[Thread 0xa95feb90 (LWP 26003) exited]
[Thread 0xa8dfdb90 (LWP 26004) exited]
[New Thread 0xa8dfdb90 (LWP 26029)]
[New Thread 0xa95feb90 (LWP 26030)]
2008-07-05 11:39:40.930 Reschedule requested for id -1.
2008-07-05 11:39:41.219 Scheduled 25 items in 0.3 = 0.01 match + 0.28 place
2008-07-05 11:39:41.224 scheduler: Scheduled items: Scheduled 25 items in 0.3 = 0.01 match + 0.28 place
2008-07-05 11:39:52.703 UPnpMedia: BuildMediaMap - no VideoStartupDir set,  skipping scan.
2008-07-05 11:40:02.441 MainServer::HandleAnnounce Monitor
2008-07-05 11:40:02.441 adding: soprano as a client (events: 0)
2008-07-05 11:40:50.993 AutoExpire: CalcParams(): Max required Free Space: 0.0 GB w/freq: 15 min
[Thread 0xa834bb90 (LWP 26024) exited]
[Thread 0xa7b4ab90 (LWP 26025) exited]
[New Thread 0xa7b4ab90 (LWP 26074)]
[New Thread 0xa834bb90 (LWP 26075)]
2008-07-05 11:43:18.984 Reschedule requested for id -1.
2008-07-05 11:43:19.272 Scheduled 25 items in 0.3 = 0.01 match + 0.28 place
[Thread 0xa8dfdb90 (LWP 26029) exited]
[Thread 0xa95feb90 (LWP 26030) exited]
[New Thread 0xa95feb90 (LWP 26078)]
[New Thread 0xa8dfdb90 (LWP 26079)]
2008-07-05 11:46:03.705 Reschedule requested for id -1.
[Thread 0xa7b4ab90 (LWP 26074) exited]
[Thread 0xa834bb90 (LWP 26075) exited]
2008-07-05 11:46:04.157 Scheduled 25 items in 0.4 = 0.01 match + 0.44 place
2008-07-05 11:46:04.162 scheduler: Last message repeated 1 times: Scheduled items: Scheduled 25 items in 0.3 = 0.01 match + 0.28 place
2008-07-05 11:46:04.169 scheduler: Scheduled items: Scheduled 25 items in 0.4 = 0.01 match + 0.44 place
[New Thread 0xa834bb90 (LWP 26102)]
[New Thread 0xa7b4ab90 (LWP 26103)]
2008-07-05 11:47:10.068 DB Error (Looking up chanID):
Query was:

No error type from QSqlError?  Strange...
2008-07-05 11:47:10.088 DB Error (Looking up chanID):
Query was:

No error type from QSqlError?  Strange...
2008-07-05 11:47:10.122 DB Error (Looking up chanID):
Query was:

No error type from QSqlError?  Strange...
2008-07-05 11:47:10.123 DB Error (Looking up chanID):
Query was:

No error type from QSqlError?  Strange...
2008-07-05 11:47:10.141 DB Error (Looking up chanID):
Query was:

No error type from QSqlError?  Strange...
2008-07-05 11:47:12.577 DB Error (Looking up chanID):
Query was:
SELECT chanid, useonairguide FROM channel, dtv_multiplex WHERE serviceid        = 14784   AND       networkid        = 9018   AND       transportid      = 12290 AND       channel.mplexid  = dtv_multiplex.mplexid
No error type from QSqlError?  Strange...

Program received signal SIGSEGV, Segmentation fault.
[Switching to Thread 0xa8dfdb90 (LWP 26079)]
0xb5b1bdf3 in ?? () from /lib/tls/i686/cmov/libc.so.6
(gdb) bt
#0  0xb5b1bdf3 in ?? () from /lib/tls/i686/cmov/libc.so.6
#1  0xb5b1dedd in ?? () from /lib/tls/i686/cmov/libc.so.6
#2  0xb5b1fcad in malloc () from /lib/tls/i686/cmov/libc.so.6
#3  0xb49bbacd in my_malloc () from /usr/lib/libmysqlclient.so.15
#4  0xb49bebf2 in alloc_root () from /usr/lib/libmysqlclient.so.15
#5  0xb49e15d0 in cli_read_rows () from /usr/lib/libmysqlclient.so.15
#6  0xb49e18fe in ?? () from /usr/lib/libmysqlclient.so.15
#7  0xb49e01f4 in mysql_real_query () from /usr/lib/libmysqlclient.so.15
#8  0xb4b648f6 in QMYSQLResult::reset () from /usr/lib/qt3/plugins/sqldrivers/libqsqlmysql.so
#9  0xb653fdee in QSqlQuery::exec () from /usr/lib/libqt-mt.so.3
#10 0xb6c080db in MSqlQuery::exec (this=0xa8dfcd70, query=@0xa8dfcd14) at mythdbcon.cpp:390
#11 0xb653e7e2 in QSqlQuery::exec () from /usr/lib/libqt-mt.so.3
#12 0xb76feff5 in MSqlQuery::exec (this=0xa8dfcd70) at ../libmyth/mythdbcon.h:111
#13 0xb7be127c in get_chan_id_from_db (sourceid=0, serviceid=14976, networkid=9018, transportid=12290) at eithelper.cpp:662
#14 0xb7be15b9 in EITHelper::GetChanID (this=0x825ea18, serviceid=14976, networkid=9018, tsid=12290) at eithelper.cpp:604
#15 0xb7be344d in EITHelper::AddEIT (this=0x825ea18, eit=0xa8dfcff0) at eithelper.cpp:314
#16 0xb78fdb29 in DVBStreamData::HandleTables (this=0xa9e01678, pid=18, psip=@0x8304300) at mpeg/dvbstreamdata.cpp:347
#17 0xb78d4034 in MPEGStreamData::HandleTSTables (this=0xa9e016f8, tspacket=0xa834d554) at mpeg/mpegstreamdata.cpp:920
#18 0xb78cde1d in MPEGStreamData::ProcessTSPacket (this=0xa9e016f8, tspacket=@0xa834d554) at mpeg/mpegstreamdata.cpp:991
#19 0xb78cac4b in MPEGStreamData::ProcessData (this=0xa9e016f8, buffer=0xa834c008 "G\tC\021", len=25568) at mpeg/mpegstreamdata.cpp:944
#20 0xb7cfd430 in DVBStreamHandler::RunTS (this=0xa9e3e7f0) at dvbstreamhandler.cpp:334
#21 0xb7cfdb84 in DVBStreamHandler::Run (this=0xa9e3e7f0) at dvbstreamhandler.cpp:221
#22 0xb7cfdb9d in run_dvb_stream_handler_thunk (param=0xa9e3e7f0) at dvbstreamhandler.cpp:173
#23 0xb5d294fb in start_thread () from /lib/tls/i686/cmov/libpthread.so.0
#24 0xb5b88e5e in clone () from /lib/tls/i686/cmov/libc.so.6

More information about the mythtv-users mailing list