A series of Error messages

[hec1152]

Recently I upgraded to HS 2 v2.4 (from v2.2.0.66) and seem to have lost many of my Events via a corrupted database. I'm not sure that's the issue with the following error message since I recreated all the HSTV events and the downloads appear to be working ok. But, since this erros is comes up at times when download isn't going on, I wanted to see what might be the root cause. Here are the messages that I found in the log which happen every day (or so it seems):

11/24/2009 12:13:30 AM ~!~UltraLog Error~!~An unexpected error occured in the PurgeLogs() function/subroutine: [System.InvalidCastException: Unable to cast object of type 'System.Data.OleDb.OleDbException' to type 'System.Data.Odbc.OdbcException'. at HSPI_ULTRALOG.Database.PurgeLogs(Hashtable PurgeHash)]
11/24/2009 12:13:30 AM ~!~HSTV~!~Error Query: SELECT top 1 c.channelID, c.channelNickName, c.channelName, c.channelNumber, s.starttime, l.endtime, l.title, l.episode, l.category, l.description FROM scheduledFavs s, tvListings l, tvChannels c WHERE s.starttime > Now() And s.channelID = l.channelID And s.starttime = l.starttime And l.channelID = c.channelID And s.isActive = 1 ORDER BY s.starttime
11/24/2009 12:13:30 AM ~!~HSTV~!~Error Query: SELECT s.scheduledID, s.favID FROM userFavs u, scheduledFavs s WHERE u.favID = s.favID AND u.repeatType = 0 AND s.starttime < Now()
11/24/2009 12:13:30 AM ~!~HSTV~!~Error Query: SELECT s.scheduledID, s.favID FROM userFavs u, scheduledFavs s WHERE u.favID = s.favID AND u.repeatType = 0 AND s.starttime < Now()
11/24/2009 12:13:30 AM ~!~HSTV~!~Error Select Query: Operation is not allowed when the object is open.
11/24/2009 12:13:30 AM ~!~HSTV~!~Error Select Query: Operation is not allowed when the object is open.
11/24/2009 12:13:30 AM ~!~HSTV~!~Error Select Query: Operation is not allowed when the object is open.
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Delete Old User Favs: Operation is not allowed when the object is closed.
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Delete Old User Favs: Operation is not allowed when the object is closed.
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Query: SELECT top 1 c.channelID, c.channelNickName, c.channelName, c.channelNumber, s.starttime, l.endtime, l.title, l.episode, l.category, l.description FROM scheduledFavs s, tvListings l, tvChannels c WHERE s.starttime > Now() And s.channelID = l.channelID And s.starttime = l.starttime And l.channelID = c.channelID And s.isActive = 1 ORDER BY s.starttime
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Query: SELECT top 1 c.channelID, c.channelNickName, c.channelName, c.channelNumber, s.starttime, l.endtime, l.title, l.episode, l.category, l.description FROM scheduledFavs s, tvListings l, tvChannels c WHERE s.starttime > Now() And s.channelID = l.channelID And s.starttime = l.starttime And l.channelID = c.channelID And s.isActive = 1 ORDER BY s.starttime
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Query: SELECT top 1 c.channelID, c.channelNickName, c.channelName, c.channelNumber, s.starttime, l.endtime, l.title, l.episode, l.category, l.description FROM scheduledFavs s, tvListings l, tvChannels c WHERE s.starttime > Now() And s.channelID = l.channelID And s.starttime = l.starttime And l.channelID = c.channelID And s.isActive = 1 ORDER BY s.starttime
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Query: SELECT top 1 c.channelID, c.channelNickName, c.channelName, c.channelNumber, s.starttime, l.endtime, l.title, l.episode, l.category, l.description FROM scheduledFavs s, tvListings l, tvChannels c WHERE s.starttime > Now() And s.channelID = l.channelID And s.starttime = l.starttime And l.channelID = c.channelID And s.isActive = 1 ORDER BY s.starttime
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Query: SELECT top 1 c.channelID, c.channelNickName, c.channelName, c.channelNumber, s.starttime, l.endtime, l.title, l.episode, l.category, l.description FROM scheduledFavs s, tvListings l, tvChannels c WHERE s.starttime > Now() And s.channelID = l.channelID And s.starttime = l.starttime And l.channelID = c.channelID And s.isActive = 1 ORDER BY s.starttime
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Query: SELECT top 1 c.channelID, c.channelNickName, c.channelName, c.channelNumber, s.starttime, l.endtime, l.title, l.episode, l.category, l.description FROM scheduledFavs s, tvListings l, tvChannels c WHERE s.starttime > Now() And s.channelID = l.channelID And s.starttime = l.starttime And l.channelID = c.channelID And s.isActive = 1 ORDER BY s.starttime
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Query: SELECT top 1 c.channelID, c.channelNickName, c.channelName, c.channelNumber, s.starttime, l.endtime, l.title, l.episode, l.category, l.description FROM scheduledFavs s, tvListings l, tvChannels c WHERE s.starttime > Now() And s.channelID = l.channelID And s.starttime = l.starttime And l.channelID = c.channelID And s.isActive = 1 ORDER BY s.starttime
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Query: SELECT top 1 c.channelID, c.channelNickName, c.channelName, c.channelNumber, s.starttime, l.endtime, l.title, l.episode, l.category, l.description FROM scheduledFavs s, tvListings l, tvChannels c WHERE s.starttime > Now() And s.channelID = l.channelID And s.starttime = l.starttime And l.channelID = c.channelID And s.isActive = 1 ORDER BY s.starttime
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Query: SELECT top 1 c.channelID, c.channelNickName, c.channelName, c.channelNumber, s.starttime, l.endtime, l.title, l.episode, l.category, l.description FROM scheduledFavs s, tvListings l, tvChannels c WHERE s.starttime > Now() And s.channelID = l.channelID And s.starttime = l.starttime And l.channelID = c.channelID And s.isActive = 1 ORDER BY s.starttime
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Query: SELECT top 1 c.channelID, c.channelNickName, c.channelName, c.channelNumber, s.starttime, l.endtime, l.title, l.episode, l.category, l.description FROM scheduledFavs s, tvListings l, tvChannels c WHERE s.starttime > Now() And s.channelID = l.channelID And s.starttime = l.starttime And l.channelID = c.channelID And s.isActive = 1 ORDER BY s.starttime
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Select Query: Operation is not allowed when the object is open.
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Select Query: Operation is not allowed when the object is open.
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Select Query: Operation is not allowed when the object is open.
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Select Query: Operation is not allowed when the object is open.
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Select Query: Operation is not allowed when the object is open.
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Select Query: Operation is not allowed when the object is open.
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Select Query: Operation is not allowed when the object is open.
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Select Query: Operation is not allowed when the object is closed.
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Select Query: Operation is not allowed when the object is open.
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Select Query: Operation is not allowed when the object is open.
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Next Scheduled: Operation is not allowed when the object is closed.
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Next Scheduled: Operation is not allowed when the object is closed.
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Next Scheduled: Operation is not allowed when the object is closed.
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Next Scheduled: Operation is not allowed when the object is closed.
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Next Scheduled: Operation is not allowed when the object is closed.
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Next Scheduled: Operation is not allowed when the object is closed.
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Next Scheduled: Operation is not allowed when the object is closed.
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Query: SELECT top 1 c.channelID, c.channelNickName, c.channelName, c.channelNumber, s.starttime, l.endtime, l.title, l.episode, l.category, l.description FROM scheduledFavs s, tvListings l, tvChannels c WHERE s.starttime > Now() And s.channelID = l.channelID And s.starttime = l.starttime And l.channelID = c.channelID And s.isActive = 1 ORDER BY s.starttime
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Next Scheduled: Operation is not allowed when the object is closed.
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Query: SELECT top 1 c.channelID, c.channelNickName, c.channelName, c.channelNumber, s.starttime, l.endtime, l.title, l.episode, l.category, l.description FROM scheduledFavs s, tvListings l, tvChannels c WHERE s.starttime > Now() And s.channelID = l.channelID And s.starttime = l.starttime And l.channelID = c.channelID And s.isActive = 1 ORDER BY s.starttime
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Select Query: Operation is not allowed when the object is closed.
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Select Query: Operation is not allowed when the object is closed.
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Next Scheduled: Operation is not allowed when the object is closed.
11/24/2009 12:13:31 AM ~!~HSTV~!~Error Next Scheduled: Operation is not allowed when the object is closed.
11/24/2009 4:46:00 AM ~!~Event~!~Event Trigger "HSTV Download XML Files"
11/24/2009 4:46:00 AM ~!~Event~!~Running script statement immediately: &hs.Plugin("HSTV").dataDownload()
11/24/2009 4:46:01 AM ~!~HSTV~!~tv_grab_na_dd20091124.xml already exists. Skipping download.
11/24/2009 4:46:01 AM ~!~HSTV~!~tv_grab_na_dd20091125.xml already exists. Skipping download.
11/24/2009 4:46:01 AM ~!~HSTV~!~tv_grab_na_dd20091126.xml already exists. Skipping download.
11/24/2009 4:46:01 AM ~!~HSTV~!~Running xmltv.exe tv_grab_na_dd --days 1 --offset 3 --output "C:\Program Files\HomeSeer 2\data\hstv\listings\tv_grab_na_dd20091127.xml
11/24/2009 4:47:31 AM ~!~HSTV~!~Running xmltv.exe tv_grab_na_dd --dd-data "C:\Program Files\HomeSeer 2\data\hstv\ddmessages.xml " --list-lineups

Any help or advice would be appreciated. Thanks in advance.

[Rupp]

HEC,
There's an issue when going from HS 2.2.66 to 2.4. You need to do an interim update to HS 2.3 first to allow your HS database to upgrade correctly. If you still have your original HS 2.2.66 install I would roll back to that and do the update in steps.

[hec1152]

I don't have the older version readily available (if at all). Any other options?

[hec1152]

Maybe a dumb question that I should know but where could I get version 2.3? Or, how could I do a rollback to this version? I found a really old installation of v2.2.0.66 that I'm hoping I can use but I don't know how to rollback to v2.3 without replacing the current HS 2 directory with the older one and then updating to v2.3 followed by another update to v2.4. Is that what you are suggesting? Thanks.

[hec1152]

I decided to move to v2.4 instead of backing up to my old version or looking for v2.3. I was also advised that these messages were not coming from HSTV and were instead from Ultralog. So, I've started a thread there http://board.homeseer.com/showthread.php?t=138880

But, I still have a message from HSTV that I cannot figure out. Here's the log entry with some before and after entries as well.

11/27/2009 5:02:00 AM ~!~Event~!~Event Trigger "HSTV Import XML Files"
11/27/2009 5:02:00 AM ~!~Event~!~Running script statement immediately: &hs.Plugin("HSTV").dataImport()
11/27/2009 5:02:00 AM ~!~HSTV~!~Deleting records from tvImport table.
11/27/2009 5:02:00 AM ~!~HSTV~!~Starting import of file: C:\Program Files\Homeseer 2\data\hstv\listings\tv_grab_na_dd20091127.xml
11/27/2009 5:02:29 AM ~!~HSTV~!~Import file, tv_grab_na_dd20091127.xml imported 4058 records.
11/27/2009 5:02:29 AM ~!~HSTV~!~Starting import of file: C:\Program Files\Homeseer 2\data\hstv\listings\tv_grab_na_dd20091128.xml
11/27/2009 5:02:56 AM ~!~HSTV~!~Import file, tv_grab_na_dd20091128.xml imported 3907 records.
11/27/2009 5:02:56 AM ~!~HSTV~!~Starting import of file: C:\Program Files\Homeseer 2\data\hstv\listings\tv_grab_na_dd20091129.xml
11/27/2009 5:03:23 AM ~!~HSTV~!~Import file, tv_grab_na_dd20091129.xml imported 3804 records.
11/27/2009 5:03:23 AM ~!~HSTV~!~Starting import of file: C:\Program Files\Homeseer 2\data\hstv\listings\tv_grab_na_dd20091130.xml
11/27/2009 5:03:52 AM ~!~HSTV~!~Import file, tv_grab_na_dd20091130.xml imported 4013 records.
11/27/2009 5:03:52 AM ~!~HSTV~!~Imported 15782 in 1 minutes.
11/27/2009 5:30:52 AM ~!~Event~!~Event Trigger "HSTV Set Device Strings"
11/27/2009 5:30:52 AM ~!~Event~!~Running script statement immediately: &hs.Plugin("HSTV").setDeviceStrings()
11/27/2009 5:30:52 AM ~!~HSTV~!~Finished setting HSTV devices
11/27/2009 5:32:00 AM ~!~Event~!~Event Trigger "HSTV Import Data"
11/27/2009 5:32:00 AM ~!~Event~!~Running script statement immediately: &hs.Plugin("HSTV").dataInsert()
11/27/2009 5:32:00 AM ~!~HSTV~!~Starting data cleanup and listings import.
11/27/2009 5:32:00 AM ~!~HSTV~!~Deleting 1081 records.
11/27/2009 5:32:00 AM ~!~HSTV~!~Error Query: SELECT Distinct channelID, channelname, channelnum, configfile FROM tvImport WHERE channelID NOT In (SELECT channelID FROM tvChannels) ORDER BY channelID
11/27/2009 5:32:00 AM ~!~HSTV~!~Error Select Query: Operation is not allowed when the object is open.
11/27/2009 5:32:00 AM ~!~HSTV~!~Error Import Cleanup: Operation is not allowed when the object is closed.
11/27/2009 6:00:52 AM ~!~Event~!~Event Trigger "HSTV Set Device Strings"
11/27/2009 6:00:52 AM ~!~Event~!~Running script statement immediately: &hs.Plugin("HSTV").setDeviceStrings()
11/27/2009 6:00:52 AM ~!~HSTV~!~Finished setting HSTV devices

Any idea what's causing this?

[nightwalker]

I get those same errors a couple of days a week. It doesn't seem to effect operation any but I've never been able to figure out what it wants me to do either.

[hec1152]

So I guess I just ignor them?

[johnnybwis]

I had my HSTV log go nuts last night. I think it caused it to lock up H/S. My log was filled with the same type of entries you now think are attributed to Ultra Log but I do not run Ultra Log. I'm running version Standard Edition 2.3.0.60

11/27/2009 12:45:46 AM ~!~JRiver MC~!~Warning: Queue item was not processed within 2 minutes.
11/27/2009 12:47:50 AM ~!~JRiver MC~!~Warning: Queue item was not processed within 2 minutes.
11/27/2009 12:49:54 AM ~!~JRiver MC~!~Warning: Queue item was not processed within 2 minutes.
11/27/2009 12:51:01 AM ~!~HSTV~!~Error Query: SELECT top 1 c.channelID, c.channelNickName, c.channelName, c.channelNumber, s.starttime, l.endtime, l.title, l.episode, l.category, l.description FROM scheduledFavs s, tvListings l, tvChannels c WHERE s.starttime > Now() And s.channelID = l.channelID And s.starttime = l.starttime And l.channelID = c.channelID And s.isActive = 1 ORDER BY s.starttime
11/27/2009 12:51:02 AM ~!~HSTV~!~Error Select Query: Unspecified error
11/27/2009 12:51:02 AM ~!~HSTV~!~Error Next Scheduled: Operation is not allowed when the object is closed.
11/27/2009 12:51:58 AM ~!~JRiver MC~!~Warning: Queue item was not

[nightwalker]

So I guess I just ignor them?

I'm out of ideas on it and since it doesn't seem to be causing me any grief I try not to look at them. Maybe Jeff will have a thought the next time he pops by.

[gelessor]

sounds like the database has grown too large. Try doing the compact thing...

[johnnybwis]

sounds like the database has grown too large. Try doing the compact thing...

Thanks, forgot about needing to do that once in a while. it was quite large. Hope that helps.

[johnnybwis]

I get those same errors a couple of days a week. It doesn't seem to effect operation any but I've never been able to figure out what it wants me to do either.

Same here, I'm wondering if this could be my anti virus, AVG

[nightwalker]

Same here, I'm wondering if this could be my anti virus, AVG

I can't really pin it down, it goes for days with no errors and then all of the sudden they're there. I don't run any anti virus on the HS server.

[hec1152]

I'm not running AVG and I still get these about once per day at varying times. Always around HSTV set device strings" event, or so it seems.

[hec1152]

Corrupt database

For the past week or more, I've been running HSTV (and the rest of my HS2 installation w/o any errors). Now all of a sudden, I get this with HSTV:

12/4/2009 7:41:00 PM ~!~HSTV~!~Error Select: SELECT d.appID as ID, 'app' as runTable, d.runOrder, s.favID, s.starttime, s.channelID, s.scheduledID, u.RepeatType FROM scheduledFavs s, userFavs u, deviceApp d WHERE s.favID = u.favID AND u.deviceID = d.deviceID AND s.isActive = 1 AND u.isActive = 1 AND DateAdd('n',-(d.padTime),s.starttime) = '12/4/2009 7:41:00 PM' UNION SELECT d.irID, 'ir', d.runOrder, s.favID, s.starttime, s.channelID, s.scheduledID, u.RepeatType FROM scheduledFavs s, userFavs u, deviceIR d WHERE s.favID = u.favID AND u.deviceID = d.deviceID AND s.isActive = 1 AND u.isActive = 1 AND DateAdd('n',-(d.padTime),s.starttime) = '12/4/2009 7:41:00 PM' UNION SELECT d.scriptID, 'script', d.runOrder, s.favID, s.starttime, s.channelID, s.scheduledID, u.RepeatType FROM scheduledFavs s, userFavs u, deviceScript d WHERE s.favID = u.favID AND u.deviceID = d.deviceID AND s.isActive = 1 AND u.isActive = 1 AND DateAdd('n',-(d.padTime),s.starttime) = '12/4/2009 7:41:00 PM' UNION SELECT d.speakID, 'speak', d.runOrder, s.favID, s.starttime, s.channelID, s.scheduledID, u.RepeatType FROM scheduledFavs s, userFavs u, deviceSpeak d WHERE s.favID = u.favID AND u.deviceID = d.deviceID AND s.isActive = 1 AND u.isActive = 1 AND DateAdd('n',-(d.speakEarly),s.starttime) = '12/4/2009 7:41:00 PM' UNION SELECT d.pluginID, 'plugin', d.runOrder, s.favID, s.starttime, s.channelID, s.scheduledID, u.RepeatType FROM scheduledFavs s, userFavs u, devicePlugin d WHERE s.favID = u.favID AND u.deviceID = d.deviceID AND s.isActive = 1 AND u.isActive = 1 AND DateAdd('n',-(d.padTime),s.starttime) = '12/4/2009 7:41:00 PM' UNION SELECT d.irID, 'irstop', d.runOrder, s.favID, s.starttime, s.channelID, s.scheduledID, u.RepeatType FROM tvListings l, scheduledFavs s, userFavs u, deviceIR d WHERE l.starttime = s.starttime And l.channelID = s.channelID And s.favID = u.favID And u.deviceID = d.deviceID AND s.isActive = 1 AND u.isActive = 1 AND DateAdd('n',d.padTime,l.endtime) = '12/4/2009 7:41:00 PM' ORDER BY s.scheduledID, s.FavID, d.runOrder
12/4/2009 7:41:00 PM ~!~HSTV~!~Error HSTV Select: Unrecognized database format 'C:\Program Files\HomeSeer 2\data\hstv\hstv.mdb'.

This looks different than the other messages in this post. It would seem that something's happened to the hstv.mdb database. Possibly a file corruption, so I ran chkdsk and it did do some clean-up. Not sure it was HSTV specific but the coincidence makes me wonder. Is there someway to correct this error by rebuilding/reseting the database or am I better off just ripping HSTV out using instructions in one of the posts in the forum and then reinstalling (or not)?