[mythtv-users] Erratic failure. Wonky database connexion?

Jonathan Sambrook jonathan at hmmn.org
Sat Jul 5 08:38:23 UTC 2008


I'm not sure whether this is a MySQL problem or a MythTV one.

Running under GDB I'm getting the following output:

2008-07-05 09:25:27.514 Using runtime prefix = /opt/mythtv
2008-07-05 09:25:27.515 Empty LocalHostName.
2008-07-05 09:25:27.515 Using localhost value of soprano
2008-07-05 09:25:27.531 New DB connection, total: 1
2008-07-05 09:25:27.537 Connected to database 'mythconverg' at host: localhost
2008-07-05 09:25:27.539 Closing DB connection named 'DBManager0'
2008-07-05 09:25:27.540 Connected to database 'mythconverg' at host: localhost
2008-07-05 09:25:27.550 New DB connection, total: 2
2008-07-05 09:25:27.550 Connected to database 'mythconverg' at host: localhost
2008-07-05 09:25:27.552 mythfilldatabase: Listings Download Started
2008-07-05 09:25:27.748 Source 1 configured to use only the broadcasted guide data. Skipping.
2008-07-05 09:25:27.749 Data fetching complete.
2008-07-05 09:25:27.750 Adjusting program database end times.
2008-07-05 09:25:28.102     0 replacements made
2008-07-05 09:25:28.105 mythfilldatabase: Listings Download Finished
2008-07-05 09:25:28.105 Marking generic episodes.
2008-07-05 09:25:28.282     Found 0
2008-07-05 09:25:28.282 Marking repeats.
2008-07-05 09:25:28.559     Found 0
2008-07-05 09:25:28.559 Unmarking new episode rebroadcast repeats.
2008-07-05 09:25:28.564     Found 0
2008-07-05 09:25:29.245 Marking episode first showings.
2008-07-05 09:25:38.200     Found 8591
2008-07-05 09:25:38.200 Marking episode last showings.
2008-07-05 09:25:46.259     Found 8591
2008-07-05 09:25:46.261 
===============================================================
| Attempting to contact the master backend for rescheduling.  |
| If the master is not running, rescheduling will happen when |
| the master backend is restarted.                            |
===============================================================
2008-07-05 09:25:46.265 Connecting to backend server: 172.20.10.6:6543 (try 1 of 5)
2008-07-05 09:25:46.267 Unexpected response to MYTH_PROTO_VERSION: 2ACCEPT
2008-07-05 09:25:46.267 Error rescheduling id -1 in ScheduledRecording::signalChange
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz Unknown socket closing
2008-07-05 09:25:46.267 Connecting to backend server: 172.20.10.6:6543 (try 1 of 5)
2008-07-05 09:25:46.268 Unexpected response to MYTH_PROTO_VERSION: 2ACCEPT
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz Unknown socket closing
2008-07-05 09:25:46.269 mythfilldatabase run complete.
2008-07-05 09:25:46.270 DataDirect: Deleting temporary files
[Thread 0xa9ff9b90 (LWP 21518) exited]
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz AutoExpire: ERROR: Filesystem Info cache is empty, unable to calculate necessary parameters.
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz DB Error (LogEntry):
Query was:
INSERT INTO mythlog (module, priority, logdate, host, message, details) values (:MODULE, :PRIORITY, now(), :HOSTNAME, :MESSAGE, :DETAILS );
Driver error was [2/1064]:
QMYSQL3: Unable to execute query
Database error was:
You have an error in your SQL syntax; check the manual that corresponds to your MySQL server version for the right syntax to use near ':MODULE, :PRIORITY, now(), :HOSTNAME, :MESSAGE, :DETAILS )' at line 1

222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz DB Error (DelLogEntry#1):
Query was:
SELECT logid FROM mythlog WHERE module= :MODULE ORDER BY logdate ASC ;
Driver error was [2/1064]:
QMYSQL3: Unable to execute query
Database error was:
You have an error in your SQL syntax; check the manual that corresponds to your MySQL server version for the right syntax to use near ':MODULE ORDER BY logdate ASC' at line 1

222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz mythbackend: Autoexpire CalcParams: ERROR: Filesystem Info cache is empty, unable to calculate necessary parameters.
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz DB Error (AutoExpire query failed!):
Query was:
SELECT chanid, starttime, title, progstart, progend, filesize, duplicate FROM recorded WHERE recordid = :RECID AND preserve = 0 AND recgroup <> 'LiveTV' ORDER BY starttime DESC;
Driver error was [2/1064]:
QMYSQL3: Unable to execute query
Database error was:
You have an error in your SQL syntax; check the manual that corresponds to your MySQL server version for the right syntax to use near ':RECID AND preserve = 0 AND recgroup <> 'LiveTV' ORDER BY starttime DESC' at line 1

222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz DB Error (AutoExpire query failed!):
Query was:
SELECT chanid, starttime, title, progstart, progend, filesize, duplicate FROM recorded WHERE recordid = :RECID AND preserve = 0 AND recgroup <> 'LiveTV' ORDER BY starttime DESC;
Driver error was [2/1064]:
QMYSQL3: Unable to execute query
Database error was:
You have an error in your SQL syntax; check the manual that corresponds to your MySQL server version for the right syntax to use near ':RECID AND preserve = 0 AND recgroup <> 'LiveTV' ORDER BY starttime DESC' at line 1

222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz DB Error (AutoExpire query failed!):
Query was:
SELECT chanid, starttime, title, progstart, progend, filesize, duplicate FROM recorded WHERE recordid = :RECID AND preserve = 0 AND recgroup <> 'LiveTV' ORDER BY starttime DESC;
Driver error was [2/1064]:
QMYSQL3: Unable to execute query
Database error was:
You have an error in your SQL syntax; check the manual that corresponds to your MySQL server version for the right syntax to use near ':RECID AND preserve = 0 AND recgroup <> 'LiveTV' ORDER BY starttime DESC' at line 1

222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz DB Error (AutoExpire query failed!):
Query was:
SELECT chanid, starttime, title, progstart, progend, filesize, duplicate FROM recorded WHERE recordid = :RECID AND preserve = 0 AND recgroup <> 'LiveTV' ORDER BY starttime DESC;
Driver error was [2/1064]:
QMYSQL3: Unable to execute query
Database error was:
You have an error in your SQL syntax; check the manual that corresponds to your MySQL server version for the right syntax to use near ':RECID AND preserve = 0 AND recgroup <> 'LiveTV' ORDER BY starttime DESC' at line 1

222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz DB Error (AutoExpire query failed!):
Query was:
SELECT chanid, starttime, title, progstart, progend, filesize, duplicate FROM recorded WHERE recordid = :RECID AND preserve = 0 AND recgroup <> 'LiveTV' ORDER BY starttime DESC;
Driver error was [2/1064]:
QMYSQL3: Unable to execute query
Database error was:
You have an error in your SQL syntax; check the manual that corresponds to your MySQL server version for the right syntax to use near ':RECID AND preserve = 0 AND recgroup <> 'LiveTV' ORDER BY starttime DESC' at line 1

222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz DB Error (AutoExpire query failed!):
Query was:
SELECT chanid, starttime, title, progstart, progend, filesize, duplicate FROM recorded WHERE recordid = :RECID AND preserve = 0 AND recgroup <> 'LiveTV' ORDER BY starttime DESC;
Driver error was [2/1064]:
QMYSQL3: Unable to execute query
Database error was:
You have an error in your SQL syntax; check the manual that corresponds to your MySQL server version for the right syntax to use near ':RECID AND preserve = 0 AND recgroup <> 'LiveTV' ORDER BY starttime DESC' at line 1

222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz AutoExpire: ERROR: Filesystem Info cache is empty, unable to determine what Recordings to expire
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz DB Error (LogEntry):
Query was:
INSERT INTO mythlog (module, priority, logdate, host, message, details) values (:MODULE, :PRIORITY, now(), :HOSTNAME, :MESSAGE, :DETAILS );
Driver error was [2/1064]:
QMYSQL3: Unable to execute query
Database error was:
You have an error in your SQL syntax; check the manual that corresponds to your MySQL server version for the right syntax to use near ':MODULE, :PRIORITY, now(), :HOSTNAME, :MESSAGE, :DETAILS )' at line 1

222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz DB Error (DelLogEntry#1):
Query was:
SELECT logid FROM mythlog WHERE module= :MODULE ORDER BY logdate ASC ;
Driver error was [2/1064]:
QMYSQL3: Unable to execute query
Database error was:
You have an error in your SQL syntax; check the manual that corresponds to your MySQL server version for the right syntax to use near ':MODULE ORDER BY logdate ASC' at line 1

222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz mythbackend: Autoexpire Recording: ERROR: Filesystem Info cache is empty, unable to determine what Recordings to expire
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz DB Error (LogEntry):
Query was:
INSERT INTO mythlog (module, priority, logdate, host, message, details) values (:MODULE, :PRIORITY, now(), :HOSTNAME, :MESSAGE, :DETAILS );
Driver error was [2/1064]:
QMYSQL3: Unable to execute query
Database error was:
You have an error in your SQL syntax; check the manual that corresponds to your MySQL server version for the right syntax to use near ':MODULE, :PRIORITY, now(), :HOSTNAME, :MESSAGE, :DETAILS )' at line 1

222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz DB Error (DelLogEntry#1):
Query was:
SELECT logid FROM mythlog WHERE module= :MODULE ORDER BY logdate ASC ;
Driver error was [2/1064]:
QMYSQL3: Unable to execute query
Database error was:
You have an error in your SQL syntax; check the manual that corresponds to your MySQL server version for the right syntax to use near ':MODULE ORDER BY logdate ASC' at line 1

222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz mythbackend: Running housekeeping thread
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz DB Error (LogEntry):
Query was:
INSERT INTO mythlog (module, priority, logdate, host, message, details) values (:MODULE, :PRIORITY, now(), :HOSTNAME, :MESSAGE, :DETAILS );
Driver error was [2/1064]:
QMYSQL3: Unable to execute query
Database error was:
You have an error in your SQL syntax; check the manual that corresponds to your MySQL server version for the right syntax to use near ':MODULE, :PRIORITY, now(), :HOSTNAME, :MESSAGE, :DETAILS )' at line 1

222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz DB Error (DelLogEntry#1):
Query was:
SELECT logid FROM mythlog WHERE module= :MODULE ORDER BY logdate ASC ;
Driver error was [2/1064]:
QMYSQL3: Unable to execute query
Database error was:
You have an error in your SQL syntax; check the manual that corresponds to your MySQL server version for the right syntax to use near ':MODULE ORDER BY logdate ASC' at line 1

222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz mythbackend: Running mythfilldatabase
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz Running mythfilldatabase
[New Thread 0xa9ff9b90 (LWP 21563)]
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz Invalid mythfilldatabase log path: /var/log/mythfilldatabase.log is not writable.
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz DB Error (JobQueue::CleanupOldJobsInQueue: Error deleting old finished jobs.):
Query was:
DELETE FROM jobqueue WHERE (status in (:FINISHED, :ABORTED, :CANCELLED) AND statustime < :DONEPURGEDATE) OR (status in (:ERRORED) AND statustime < :ERRORSPURGEDATE)
Driver error was [2/1064]:
QMYSQL3: Unable to execute query
Database error was:
You have an error in your SQL syntax; check the manual that corresponds to your MySQL server version for the right syntax to use near ':FINISHED, :ABORTED, :CANCELLED) AND statustime < :DONEPURGEDATE) OR (status in ' at line 1

222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz DB Error (HouseKeeper Cleaning TVChain Table):
Query was:
SELECT DISTINCT chainid FROM tvchain WHERE endtime > :FOURHOURSAGO ;
Driver error was [2/1064]:
QMYSQL3: Unable to execute query
Database error was:
You have an error in your SQL syntax; check the manual that corresponds to your MySQL server version for the right syntax to use near ':FOURHOURSAGO' at line 1

2008-07-05 09:30:28.967 Using runtime prefix = /opt/mythtv
2008-07-05 09:30:28.968 Empty LocalHostName.
2008-07-05 09:30:28.968 Using localhost value of soprano
2008-07-05 09:30:28.983 New DB connection, total: 1
2008-07-05 09:30:28.989 Connected to database 'mythconverg' at host: localhost
2008-07-05 09:30:28.990 Closing DB connection named 'DBManager0'
2008-07-05 09:30:28.997 Connected to database 'mythconverg' at host: localhost
2008-07-05 09:30:29.005 New DB connection, total: 2
2008-07-05 09:30:29.006 Connected to database 'mythconverg' at host: localhost
2008-07-05 09:30:29.007 mythfilldatabase: Listings Download Started
2008-07-05 09:30:29.216 Source 1 configured to use only the broadcasted guide data. Skipping.
2008-07-05 09:30:29.217 Data fetching complete.
2008-07-05 09:30:29.218 Adjusting program database end times.
2008-07-05 09:30:29.626     0 replacements made
2008-07-05 09:30:29.629 mythfilldatabase: Listings Download Finished
2008-07-05 09:30:29.629 Marking generic episodes.
2008-07-05 09:30:29.808     Found 0
2008-07-05 09:30:29.808 Marking repeats.
2008-07-05 09:30:29.976     Found 0
2008-07-05 09:30:29.976 Unmarking new episode rebroadcast repeats.
2008-07-05 09:30:29.980     Found 0
2008-07-05 09:30:30.488 Marking episode first showings.
2008-07-05 09:30:38.325     Found 8591
2008-07-05 09:30:38.326 Marking episode last showings.
2008-07-05 09:30:47.614     Found 8591
2008-07-05 09:30:47.617 
===============================================================
| Attempting to contact the master backend for rescheduling.  |
| If the master is not running, rescheduling will happen when |
| the master backend is restarted.                            |
===============================================================
2008-07-05 09:30:47.624 Connecting to backend server: 172.20.10.6:6543 (try 1 of 5)
2008-07-05 09:30:47.626 Unexpected response to MYTH_PROTO_VERSION: 2ACCEPT
2008-07-05 09:30:47.627 Error rescheduling id -1 in ScheduledRecording::signalChange
2008-07-05 09:30:47.627 Connecting to backend server: 172.20.10.6:6543 (try 1 of 5)
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz Unknown socket closing
2008-07-05 09:30:47.629 Unexpected response to MYTH_PROTO_VERSION: 2ACCEPT
2008-07-05 09:30:47.630 mythfilldatabase run complete.
2008-07-05 09:30:47.630 DataDirect: Deleting temporary files
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz Unknown socket closing
[Thread 0xa9ff9b90 (LWP 21563) exited]
 222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz GetRecordBasename found no entry
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz GetRecordBasename found no entry
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz GetRecordBasename found no entry
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz GetRecordBasename found no entry
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz GetRecordBasename found no entry
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz GetRecordBasename found no entry
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz GetRecordBasename found no entry
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz GetRecordBasename found no entry
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz GetRecordBasename found no entry
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz GetRecordBasename found no entry
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz GetRecordBasename found no entry
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz GetRecordBasename found no entry
QMYSQLDriver::open: Unknown connect option '2'
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz GetRecordBasename found no entry
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz GetRecordBasename found no entry
222yyyy-22MM-22dd 22hh:22mm:22ss.22zzz GetRecordBasename found no entry



More information about the mythtv-users mailing list