TiVo Community
TiVo Community
TiVo Community
Go Back   TiVo Community > Main TiVo Forums > TiVo Series3 HDTV DVRs
TiVo Community
Reply
Forum Jump
 
Thread Tools
Old 10-09-2011, 02:43 PM   #151
WO312
Registered User
 
Join Date: Jan 2003
Location: Wilmington, NC
Posts: 1,259
Quote:
Originally Posted by ravingfans View Post
thanks Trackie, The hyperlink you inserted has a lot of clutter and doesn't load. Could you type the link out?
You have to delete the "(remove this)" from the link and it will load.
WO312 is offline   Reply With Quote
Old 10-09-2011, 03:23 PM   #152
Teeps
Registered User
 
Teeps's Avatar
 
Join Date: Aug 2001
Location: Torrance,Cal. 90503
Posts: 1,038
Quote:
Originally Posted by WO312 View Post
Total BS. I have proven that my system runs great with the tuning adapter disconnected.
Which is the point, as I pointed "them" to this thread as proof.

Since I last did the channel fix and disconnect from the internet. The GC updated after about 3 days. Then hung on that date. I gave it 3 days, disconnected the internet. On the third day GC updated. The last GC update (result from internet disconnect) last Wed appeared stuck, but yesterday evening I noticed that GC HAD updated on its own!!!!

So the GC clock is ticking again 8Oct2011.
Teeps is offline   Reply With Quote
Old 10-09-2011, 08:05 PM   #153
lrhorer
Registered User
 
Join Date: Aug 2003
Location: San Antonio, Texas, USA
Posts: 6,893
Quote:
Originally Posted by MC Hammer View Post
The only theory I can come up with is that channel map updates from the TA adversely affect the box's ability to run GC. However, not knowing where on the hard drive the map updates are stored, I can't offer any quantifiable information that would support this theory.
They aren't. The Channel Map is stored within the CableCards. The TA overwrites this (I'm not certain if it is overwritten in memory or on the CableCards) dynamically.
lrhorer is offline   Reply With Quote
Old 10-09-2011, 08:10 PM   #154
lrhorer
Registered User
 
Join Date: Aug 2003
Location: San Antonio, Texas, USA
Posts: 6,893
Quote:
Originally Posted by WO312 View Post
Total BS. I have proven that my system runs great with the tuning adapter disconnected.
Agreed. TA issues aside, any DB corruption of the schedule data should be over-written with the next phone home. I find it unlikely any persistent issues would be related to a hard drive problem, unless accompanied by very significant other issues. The guide data and the setup data are all kept in the MFS areas.
lrhorer is offline   Reply With Quote
Old 10-09-2011, 08:12 PM   #155
lrhorer
Registered User
 
Join Date: Aug 2003
Location: San Antonio, Texas, USA
Posts: 6,893
Quote:
Originally Posted by WO312 View Post
So it appears any tuning adapter is an issue. I still haven't seen anybody from a non-TWC system say they have the problem.
OTOH, I know for a fact most people on TWC systems are not having the issue. Certainly I am not, and I have 3 TWC TAs.
lrhorer is offline   Reply With Quote
Old 10-09-2011, 08:15 PM   #156
MC Hammer
Registered User
 
MC Hammer's Avatar
 
Join Date: Jul 2011
Posts: 177
Quote:
Originally Posted by lrhorer View Post
They aren't. The Channel Map is stored within the CableCards. The TA overwrites this (I'm not certain if it is overwritten in memory or on the CableCards) dynamically.
Incorrect. The map is provided real-time by the card but a copy of the most recent version is stored on the hard drive.
MC Hammer is offline   Reply With Quote
Old 10-09-2011, 09:30 PM   #157
lrhorer
Registered User
 
Join Date: Aug 2003
Location: San Antonio, Texas, USA
Posts: 6,893
Quote:
Originally Posted by MC Hammer View Post
Incorrect. The map is provided real-time by the card but a copy of the most recent version is stored on the hard drive.
I don't see where:

Code:
Directory listing of /
Name					Type	Id	Date	 	Time	Size
AdContent				tyDir	49569	10/03/11	22:17	4
Anchor					tyDir	314739	10/07/11	02:59	2712
AreaCode				tyDir	7499	06/14/07	17:08	16
AuxInfo					tyDir	54110	02/09/07	16:38	68
CaptureRequest				tyDir	9679	10/20/06	08:44	92
Clips					tyDir	7286	06/20/07	05:00	64
Component				tyDir	4912	07/27/06	19:07	40
Config					tyDir	7372	07/27/06	19:42	56
CorrelationIndexPart			tyDir	15994	10/04/07	08:22	20
DataSet					tyDir	4690	10/09/11	08:09	1408
DataSetVersion				tyDir	4691	10/09/11	08:09	1500
Database				tyDir	4683	10/09/11	15:39	4144
DiskUsed				tyDir	15	09/12/11	22:57	44
Drm					tyDir	1833514	12/05/08 	02:21	16
Genre					tyDir	4693	06/20/08 	03:12	2440
GuideIndexV3				tyDir	264421	10/09/11	14:06	376
GuideIndexV3.temp			tyDir	264288	10/09/11 	14:06	4
Headend					tyDir	7882	01/17/09 	06:10	68
HeadendPostalCode			tyDir	7883	01/17/09 	06:10	84
HeadendTms				tyDir	7884	01/17/09 	06:10	68
LeadGeneration				tyDir	16947	10/08/11	15:23	664
LinkTag					tyDir	85112	03/02/07 	04:22	4
Log					tyDir	489050	08/19/07 	20:31	20
LogoGroup				tyDir	7237	06/14/07 	18:30	52
MenuItem				tyDir	16934	03/30/11	18:48	176
MessageItem				tyDir	19554	01/13/07	18:32	48
Package					tyDir	49688	09/06/11 	05:43	4
ParentalControls			tyDir	104866	06/11/07 	17:12	32
Person					tyDir	17006	02/28/07 	02:22	4
PostalCode				tyDir	7891	06/14/07 	17:09	16
Preference				tyDir	16113	10/18/06 	20:29	12
Psip					tyDir	104878	08/19/11 	18:42	1436
RRT					tyDir	9702	06/14/07 	17:19	20
Recording				tyDir	7253	10/03/11 	09:47	316
Resource				tyDir	16	07/27/06 	19:08	68
Rubbish					tyDir	7370	10/09/11 	05:56	1044
Schedule				tyDir	2	09/09/11 	17:55	2872
SeasonPass				tyDir	7368	10/18/06 	20:29	96
Server					tyDir	7	10/09/11 	07:35	3904
Setup					tyDb	253315	10/09/11 	19:01	80284
Showcase				tyDir	16949	10/18/06 	20:32	12
ShowcaseIndex				tyDir	7296	10/09/11 	08:14	376
ShowcaseIndex.temp			tyDir	9705	10/09/11 	08:14	4
SpigotMap				tyDir	4670	07/27/06	19:02	48
State					tyDir	4	08/22/09	22:44	548
StationTms				tyDir	7514	01/22/09 	16:59	52
SwModule				tyDir	8	03/13/11 	19:14	100
SwSystem				tyDir	4685	03/11/11 	11:12	44
Table					tyDir	4687	10/05/11 	19:39	140
Theme					tyDir	340328	09/06/11	07:35	688
Tivo_Retail_HD_ColorCorrected.ts	tyStream7280	07/27/06 	19:26	131072 x 3328(3263)
Trio					tyDir	104849	12/05/08 	02:17	216
TuikRes					tyDir	70	07/27/06 	19:01	44
Welcome_Eiger_1_HD.ts			tyStream7248	09/14/06 	15:21	131072 x 1440(1361)
Welcome_Eiger_2_HD.ts			tyStream7260	09/14/06 	15:21	131072 x 1352(1347)
Welcome_Eiger_3_HD.ts			tyStream7264	09/14/06 	15:21	131072 x 1680(1632)
Welcome_Eiger_4_HD.ts			tyStream7268	09/14/06 	15:21	131072 x 1632(1601)
Welcome_Eiger_5_HD.ts			tyStream7272	09/14/06 	15:21	131072 x 2224(2219)
Welcome_Eiger_6_HD.ts			tyStream7276	09/14/06 	15:21	131072 x 1760(1729)

lrhorer is offline   Reply With Quote
Old 10-09-2011, 11:18 PM   #158
WO312
Registered User
 
Join Date: Jan 2003
Location: Wilmington, NC
Posts: 1,259
Quote:
Originally Posted by Teeps View Post
Which is the point, as I pointed "them" to this thread as proof.

Since I last did the channel fix and disconnect from the internet. The GC updated after about 3 days. Then hung on that date. I gave it 3 days, disconnected the internet. On the third day GC updated. The last GC update (result from internet disconnect) last Wed appeared stuck, but yesterday evening I noticed that GC HAD updated on its own!!!!

So the GC clock is ticking again 8Oct2011.
I'm going to experiment with my system. This is what I will do:

1. I just disconnected the internet and I will leave it off until the GC updates by itself.

2. I will reconnect, let the new data download automatically, and wait for the GC to not update for 3 days.

3. Repeat steps 1 and 2 until I can get a natural GC change with the internet connected.

We will see. Teeps, let us know if your system continues to function properly. You should know in the next day or so.
WO312 is offline   Reply With Quote
Old 10-10-2011, 08:10 AM   #159
trackie999
Registered User
 
trackie999's Avatar
 
Join Date: Sep 2009
Posts: 89
My dbgc is still running after 101 hours, it is still spitting out rubbish info once in a while...

This test confirms my theory that the daily call is what kills of dbgc after ~24 hours. No wonder dbgc never completed before if it needs 4+ days.

I am going to let it run for a couple more days, chances are it will finish.

Quote:
Originally Posted by WO312 View Post
I'm going to experiment with my system. This is what I will do:

1. I just disconnected the internet and I will leave it off until the GC updates by itself.

2. I will reconnect, let the new data download automatically, and wait for the GC to not update for 3 days.

3. Repeat steps 1 and 2 until I can get a natural GC change with the internet connected.

We will see. Teeps, let us know if your system continues to function properly. You should know in the next day or so.

trackie999 is offline   Reply With Quote
Old 10-10-2011, 10:55 AM   #160
WO312
Registered User
 
Join Date: Jan 2003
Location: Wilmington, NC
Posts: 1,259
Quote:
Originally Posted by WO312 View Post
I'm going to experiment with my system. This is what I will do:

1. I just disconnected the internet and I will leave it off until the GC updates by itself.

2. I will reconnect, let the new data download automatically, and wait for the GC to not update for 3 days.

3. Repeat steps 1 and 2 until I can get a natural GC change with the internet connected.

We will see. Teeps, let us know if your system continues to function properly. You should know in the next day or so.
This morning I checked the Tivo and I had the disconnected tuning adapter message. Seems that while I was fumbling around with the internet disconnect I separated the tuning adapter brick from its power cord. I have very tight quarters back there.

At any rate, there was a failed call but also a GC update. Not sure why the GC updated - was it because the tuning adapter was disconnected or because there was a failed call?

I now have the tuning adapter connected, I forced a call, and I will leave it alone for a few days until the GC doesn't update. Then I will disconnect the internet again.
WO312 is offline   Reply With Quote
Old 10-10-2011, 10:59 AM   #161
WO312
Registered User
 
Join Date: Jan 2003
Location: Wilmington, NC
Posts: 1,259
Quote:
Originally Posted by trackie999 View Post
My dbgc is still running after 101 hours, it is still spitting out rubbish info once in a while...

This test confirms my theory that the daily call is what kills of dbgc after ~24 hours. No wonder dbgc never completed before if it needs 4+ days.

I am going to let it run for a couple more days, chances are it will finish.
You are well beyond my technical capability. If your theory proves out, can we use this to do something to help our situation?? Or is this something Tivo could use to fix the situation. Not that they would. All new efforts seem to be focused on Premier only.
WO312 is offline   Reply With Quote
Old 10-10-2011, 12:07 PM   #162
chrisdfw
Registered User
 
Join Date: Dec 2008
Posts: 15
Just to add some data points. This is happening for users with TWC, upgraded drives and tuning adaptors. I was able to get GC to update with only allowing the TiVo to talk on Wednesdays. I have now rebuilt the TiVo with a 2GB swap file to test. I am Dallas with TWC, with a moto TA and a TiVo HD with a 2TB drives
chrisdfw is offline   Reply With Quote
Old 10-10-2011, 02:57 PM   #163
Teeps
Registered User
 
Teeps's Avatar
 
Join Date: Aug 2001
Location: Torrance,Cal. 90503
Posts: 1,038
Quote:
Originally Posted by chrisdfw View Post
Just to add some data points. This is happening for users with TWC, upgraded drives and tuning adaptors.
Not entirely true, as my S3 had the problem with standard HDD, before installing a DVR_Dude 2tb drive.

My S3 developed this problem, with standard HDD, about 1 month after the Cisco Tuning Adapter (Time Warner) was put online here in Torrance,CA.
First sign of problem was the "running out of guide data" message.
Then after several forced connections S03 error occurs.
Teeps is offline   Reply With Quote
Old 10-10-2011, 04:00 PM   #164
trackie999
Registered User
 
trackie999's Avatar
 
Join Date: Sep 2009
Posts: 89
Long rant/answer:
Spoiler:

I am getting tired of baby sitting my Tivos just so they can do their most basic function: Record a TV show.

How would you feel if you got a news paper subscription and the paperboy wouldn't drop your paper off unless you're waiting at the end of your driveway at 5 o'clock in the morning?

I don't know how many times I pulled up a show on Now Playing List and it was another show. Tivo thought it was the right show because it never loaded updated guide data.

How do you feel when Tivo refuses to record anything because it has run out of guide data, yet when I pull up the guide I have days of guide data.

I am just dumbstruck when I go into the To Do List and it shows that it is currently recording TV Show A. When I go to Live TV the Guide Info is for TV Show B. My Tivo either has a split personality or faulty software!

This is a serious flaw that is not being acknowledged by Tivo. I have very little faith that they will attempt to resolve as all support is funneled into fixing their half baked premiere products.

So, my options are:
1) Get my cable company's DVR
2) Build a MythTV Box
3) Class action suit anyone?
4) Figure it out myself

TWC's DVRs came a long way. They are on par with Tivos on speed, but the UI is just puke.
MythTV is looking better every year, it's now a viable solution with cable card & TA support. It's a lot of money to replicate what my Tivo should be doing.
We could go to court, but even if we win (in 2-5 years) Tivo would probably just go bankrupt. (And my Tivo would still not work)

I am going with Option #4.

My primary goal is to come up with a workaround that is fully automated.
We may or may not be able to identify the root cause of the issue, but we will be able to eliminate a bunch of potential causes and this can help Tivo with providing a permanent fix.

Quote:
Originally Posted by WO312 View Post
You are well beyond my technical capability. If your theory proves out, can we use this to do something to help our situation?? Or is this something Tivo could use to fix the situation. Not that they would. All new efforts seem to be focused on Premier only.

trackie999 is offline   Reply With Quote
Old 10-10-2011, 04:03 PM   #165
trackie999
Registered User
 
trackie999's Avatar
 
Join Date: Sep 2009
Posts: 89
lrhorer: Please tell me you're having the same issue!
Your insights would be greatly appreciated in resolving this matter!

Quote:
Originally Posted by lrhorer View Post
I don't see where:

Code:
Directory listing of /
Name					Type	Id	Date	 	Time	Size
AdContent				tyDir	49569	10/03/11	22:17	4
Anchor					tyDir	314739	10/07/11	02:59	2712
15:21	131072 x 1760(1729)

trackie999 is offline   Reply With Quote
Old 10-10-2011, 04:08 PM   #166
chrisdfw
Registered User
 
Join Date: Dec 2008
Posts: 15
Quote:
Originally Posted by Teeps View Post
Not entirely true, as my S3 had the problem with standard HDD, before installing a DVR_Dude 2tb drive.

My S3 developed this problem, with standard HDD, about 1 month after the Cisco Tuning Adapter (Time Warner) was put online here in Torrance,CA.
First sign of problem was the "running out of guide data" message.
Then after several forced connections S03 error occurs.
If its happening on a stock drive,Please keep after tivo support. Those of us with upgraded drives have no hope of getting them to fix it.
chrisdfw is offline   Reply With Quote
Old 10-10-2011, 04:11 PM   #167
WO312
Registered User
 
Join Date: Jan 2003
Location: Wilmington, NC
Posts: 1,259
If it is true that it only affects TWC, how could that be? What could be different in the TWC implementation of SDV compared to everybody else??

And I'll never understand why this only affects what must be a relatively small number of people, or there would be an uproar.

And why my 1 TB upgrade worked great, and the problem only started with the 2 TB upgrade.

And why the sun rises in the east. (O.K. , I know that one. That's the way the sun circles the earth.)
WO312 is offline   Reply With Quote
Old 10-10-2011, 05:40 PM   #168
wtherrell
Registered User
 
Join Date: Dec 2004
Location: Huntersville, NC
Posts: 331
Quote:
Originally Posted by WO312 View Post
If it is true that it only affects TWC, how could that be? What could be different in the TWC implementation of SDV compared to everybody else??

And I'll never understand why this only affects what must be a relatively small number of people, or there would be an uproar.

And why my 1 TB upgrade worked great, and the problem only started with the 2 TB upgrade.

And why the sun rises in the east. (O.K. , I know that one. That's the way the sun circles the earth.)
Sun circles the earth?? From what century have you time-traveled here ??

It is now October 10. My system shows last GC was August 10. 2 months-wow. I unplugged internet connection on Oct. 8 but no GC update yet.
wtherrell is offline   Reply With Quote
Old 10-10-2011, 07:13 PM   #169
lrhorer
Registered User
 
Join Date: Aug 2003
Location: San Antonio, Texas, USA
Posts: 6,893
Quote:
Originally Posted by trackie999 View Post
lrhorer: Please tell me you're having the same issue!
I'm afraid not. I'm on TWC San Antonio with 3 Cisco TAs. Two S3 TiVos and one THD. All three have upgraded drives. (All three are also hacked.)

Is there anyone out there with 2 or more TAs that is either suffering the problem on both / all or on only one?

Edit: Ah, I see Trackie999 has the issue on three different TiVos. That would seem to rule out a hardware failure.

Last edited by lrhorer : 10-10-2011 at 08:18 PM.
lrhorer is offline   Reply With Quote
Old 10-10-2011, 07:28 PM   #170
lrhorer
Registered User
 
Join Date: Aug 2003
Location: San Antonio, Texas, USA
Posts: 6,893
Quote:
Originally Posted by trackie999 View Post
My primary goal is to come up with a workaround that is fully automated. We may or may not be able to identify the root cause of the issue, but we will be able to eliminate a bunch of potential causes and this can help Tivo with providing a permanent fix.
Well, as I understand it, the issue can be temporarily abated by taking down the internet connection to the Tivo for 3 or 4 days, right? One possibility would be to set up a proxy server for the TiVo's internet connections. The proxy can be set to automatically disable itself for 3 or 4 days at a time and then come back online for 5 or 6 days.

Last edited by lrhorer : 10-10-2011 at 07:40 PM.
lrhorer is offline   Reply With Quote
Old 10-10-2011, 07:58 PM   #171
lrhorer
Registered User
 
Join Date: Aug 2003
Location: San Antonio, Texas, USA
Posts: 6,893
Quote:
Originally Posted by WO312 View Post
If it is true that it only affects TWC, how could that be? What could be different in the TWC implementation of SDV compared to everybody else??
Oh, I can think of a number of different possibilities. One that jumps to mind is the number of SDV channels may be huge, especially when one considers duplicates. Perhaps some buffer somewhere is overflowing when the number of channels reported by the TA exceeds some magic number (2047, maybe?). This buffer overflow could then be corrupting the GC process in some very specific way.

I'm not saying this is the case, it's just one possible scenario.

Quote:
Originally Posted by WO312 View Post
And I'll never understand why this only affects what must be a relatively small number of people, or there would be an uproar.
Again, there are lots of possibilities. The specific lineup may have something to do with it, or a firmware rev. With that in mind, are any of you running the same version I am:



Quote:
Originally Posted by WO312 View Post
And why my 1 TB upgrade worked great, and the problem only started with the 2 TB upgrade.
I would tend to suspect coincidence on that venue. Any chance you still have your 1T laying around for testing purposes?

Last edited by lrhorer : 10-10-2011 at 08:20 PM.
lrhorer is offline   Reply With Quote
Old 10-10-2011, 08:36 PM   #172
trackie999
Registered User
 
trackie999's Avatar
 
Join Date: Sep 2009
Posts: 89
I am trying the firewalled Tivo approach. My first attempt failed when my router allowed Tivo to connect after 77 hours. (I was out of town and assumed it would be done by then)

My current attempt has been going for almost 5 days now...

Take a look at the info from my current run:
Code:
Oct  6 05:06:48 (none) DbGc[12083]: fEnableIndexingM=1 fEnableGcM=1
Oct  6 05:10:19 (none) dbcache[12083]: Creating dbcache in program dbgc-mcp, size = 10
Oct  6 05:10:20 (none) DbGc[12083]: SetState(): eVirgin --> eBefored
Oct  6 05:10:20 (none) DbGc[12083]: SetState(): eBefored --> eMarkingActive
Oct  6 07:30:31 (none) DbGc[12083]: SetState(): eMarkingActive --> eMarkingReactive
Oct  6 07:30:40 (none) DbGc[12083]: SetState(): eMarkingReactive --> eTryingToInstallGcMask
Oct  6 07:30:40 (none) DbGc[12083]: SetState(): eTryingToInstallGcMask --> eInstallingGcMask
Oct  6 07:30:43 (none) DbGc[12083]: SetState(): eInstallingGcMask --> eSweeping
Oct  6 12:48:51 (none) DbGc::LogMemoryUsage[12083]: LogMemoryUsage( After DbShowingIndexer::VisitAllStationDays )
Oct  6 12:48:51 (none) TmkMempool[12083]: STAT dbgc-mcp: blocks=3648 bytes=1069912 bytesMax=1563840 unusedBytes=3093328 chunks=31 chunkBytes=974336 freeChunks=2 freeChunkBytes=1536 maxFreeChunk=2955848
Oct  6 12:49:00 (none) DbGc::LogMemoryUsage[12083]: LogMemoryUsage( pShowingWriterM )
Oct  6 12:49:00 (none) TmkMempool[12083]: STAT dbgc-mcp: blocks=3648 bytes=1069912 bytesMax=1563840 unusedBytes=3093328 chunks=31 chunkBytes=974336 freeChunks=2 freeChunkBytes=1536 maxFreeChunk=2955848
Oct  6 12:49:18 (none) DbGc::LogMemoryUsage[12083]: LogMemoryUsage( pProgramWriterM )
Oct  6 12:49:18 (none) TmkMempool[12083]: STAT dbgc-mcp: blocks=3648 bytes=1069912 bytesMax=1563840 unusedBytes=3093328 chunks=31 chunkBytes=974336 freeChunks=2 freeChunkBytes=1536 maxFreeChunk=2955848
Oct  6 12:49:18 (none) DbGc::LogMemoryUsage[12083]: LogMemoryUsage( pGenreWriterM )
Oct  6 12:49:18 (none) TmkMempool[12083]: STAT dbgc-mcp: blocks=3648 bytes=1069912 bytesMax=1563840 unusedBytes=3093328 chunks=31 chunkBytes=974336 freeChunks=2 freeChunkBytes=1536 maxFreeChunk=2955848
Oct  6 12:49:25 (none) DbGc::LogMemoryUsage[12083]: LogMemoryUsage( pSeriesIndexerM )
Oct  6 12:49:25 (none) TmkMempool[12083]: STAT dbgc-mcp: blocks=3648 bytes=1069912 bytesMax=1563840 unusedBytes=3093328 chunks=31 chunkBytes=974336 freeChunks=2 freeChunkBytes=1536 maxFreeChunk=2955848
Oct  6 12:49:25 (none) DbGc::LogMemoryUsage[12083]: LogMemoryUsage( After running pShowingIndexer )
Oct  6 12:49:25 (none) TmkMempool[12083]: STAT dbgc-mcp: blocks=3648 bytes=1069912 bytesMax=1563840 unusedBytes=3093328 chunks=31 chunkBytes=974336 freeChunks=2 freeChunkBytes=1536 maxFreeChunk=2955848
Oct  6 12:49:30 (none) DbGc[12083]: DbGc::AfterIndexersFSuccessful = 1
Oct  6 12:49:30 (none) DbGc[12083]: DbGc::StoreCompletionInDb: 15253/46170 (0x0)
Oct  6 12:49:30 (none) DbGc[12083]: DbGc::Mark succeeded, sweep soon
Oct  6 12:49:30 (none) TmkActivityStats[12083]: DbGcBackgroundAction-->(Pri:0 Time Sample: 7 h 42 min)
Oct  6 12:49:30 (none) TmkActivityStats[12113]:   DbGcClientActivity-->(Pri:0 Time Sample: 9 h 12 min)
Oct  6 18:49:58 (none) TmkActivityStats[14904]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct  7 00:50:27 (none) TmkActivityStats[16192]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct  7 06:50:55 (none) TmkActivityStats[17658]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct  7 12:51:24 (none) TmkActivityStats[19019]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct  8 00:52:20 (none) TmkActivityStats[21601]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct  8 02:44:28 (none) DbGc[22006]: TrioRubbished id:1609861 s:2
Oct  8 02:44:29 (none) DbGc[22006]: TrioRubbished id:1609862 s:2
Oct  8 02:44:30 (none) DbGc[21969]: TrioRubbished id:1609863 s:2
Oct  8 02:44:31 (none) DbGc[21969]: TrioRubbished id:1609864 s:2
Oct  8 02:44:37 (none) DbGc[22006]: TrioRubbished id:1632297 s:2
Oct  8 02:44:55 (none) DbGc[22006]: TrioRubbished id:1838060 s:2
Oct  8 02:45:31 (none) DbGc[22030]: TrioRubbished id:1920572 s:2
Oct  8 02:46:07 (none) DbGc[22006]: TrioRubbished id:2055187 s:2
Oct  8 02:47:16 (none) DbGc[22037]: TrioRubbished id:2063708 s:2
Oct  8 02:47:17 (none) DbGc[22037]: TrioRubbished id:2068875 s:2
Oct  8 02:47:17 (none) DbGc[22037]: TrioRubbished id:2073805 s:2
Oct  8 02:47:18 (none) DbGc[22037]: TrioRubbished id:2077229 s:2
Oct  8 02:47:22 (none) DbGc[22032]: TrioRubbished id:2083744 s:2
Oct  8 02:47:23 (none) DbGc[22032]: TrioRubbished id:2083745 s:2
Oct  8 02:47:23 (none) DbGc[22032]: TrioRubbished id:2083746 s:2
Oct  8 02:47:24 (none) DbGc[22032]: TrioRubbished id:2083747 s:2
Oct  8 02:47:24 (none) DbGc[22032]: TrioRubbished id:2083748 s:2
Oct  8 02:47:25 (none) DbGc[22032]: TrioRubbished id:2083749 s:2
Oct  8 02:47:25 (none) DbGc[22032]: TrioRubbished id:2083750 s:2
Oct  8 02:47:26 (none) DbGc[22032]: TrioRubbished id:2083751 s:2
Oct  8 02:47:29 (none) DbGc[22032]: TrioRubbished id:2083752 s:2
Oct  8 02:47:29 (none) DbGc[22032]: TrioRubbished id:2083753 s:2
Oct  8 02:47:29 (none) DbGc[22032]: TrioRubbished id:2083754 s:2
Oct  8 02:47:30 (none) DbGc[22032]: TrioRubbished id:2083758 s:2
Oct  8 02:47:30 (none) DbGc[22032]: TrioRubbished id:2083759 s:2
Oct  8 02:47:30 (none) DbGc[22032]: TrioRubbished id:2083760 s:2
Oct  8 02:47:31 (none) DbGc[22032]: TrioRubbished id:2083761 s:2
Oct  8 02:47:31 (none) DbGc[22032]: TrioRubbished id:2083762 s:2
Oct  8 02:47:32 (none) DbGc[22032]: TrioRubbished id:2083763 s:2
Oct  8 02:47:32 (none) DbGc[22032]: TrioRubbished id:2083764 s:2
Oct  8 02:47:32 (none) DbGc[22032]: TrioRubbished id:2083779 s:2
Oct  8 06:52:49 (none) TmkActivityStats[22912]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct  8 12:53:17 (none) TmkActivityStats[24248]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct  8 18:32:47 (none) DbGc[25516]: TrioRubbished id:2162512 s:2
Oct  8 18:32:48 (none) DbGc[25516]: TrioRubbished id:2162513 s:2
Oct  8 18:32:50 (none) DbGc[25502]: TrioRubbished id:2162514 s:2
Oct  8 18:53:46 (none) TmkActivityStats[25596]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct  9 00:54:14 (none) TmkActivityStats[26857]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct  9 06:54:43 (none) TmkActivityStats[28108]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct  9 12:55:11 (none) TmkActivityStats[29424]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct  9 13:44:43 (none) DbGc[29612]: TrioRubbished id:2234524 s:2
Oct  9 13:55:33 (none) DbGc[29642]: TrioRubbished id:2266835 s:2
Oct  9 13:55:37 (none) DbGc[29643]: TrioRubbished id:2266887 s:2
Oct  9 13:55:46 (none) DbGc[29642]: TrioRubbished id:2267045 s:2
Oct  9 15:56:07 (none) DbGc[30115]: TrioRubbished id:2267171 s:2
Oct  9 18:55:40 (none) TmkActivityStats[30675]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct 10 00:56:08 (none) TmkActivityStats[31948]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct 10 02:09:55 (none) DbGc[32208]: TrioRubbished id:2267172 s:2
Oct 10 02:09:59 (none) DbGc[32208]: TrioRubbished id:2267285 s:2
Oct 10 06:56:36 (none) TmkActivityStats[884]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct 10 12:57:05 (none) TmkActivityStats[2226]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct 10 18:57:33 (none) TmkActivityStats[3386]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct 11 00:58:02 (none) TmkActivityStats[4720]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct 11 06:58:30 (none) TmkActivityStats[6067]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
You can see Oct 6 12:49:30 (none) DbGc[12083]: DbGc::StoreCompletionInDb: 15253/46170 (0x0)
This date matches System Information -> Indexing date (-4 hr offset from UTC)

Should it take 10 hours and 13 minutes to go from 2267171 to 2267172? (mfs_dumpobj info attached)
Oct 9 15:56:07 (none) DbGc[30115]: TrioRubbished id:2267171 s:2
Oct 10 02:09:55 (none) DbGc[32208]: TrioRubbished id:2267172 s:2

It's been sweeping ever since, you can see that it maybe picked up ~60 objects over a 4 day period.

I tried to increase dbgc's (and children's) priorities thinking that it was cpu starved but it made no difference.

My guess is maybe guide records in mfs apps are locked and dbgc is idling away waiting for a record to be freed. (I have no idea if there are record locks in mfs) I also observed very little cpu activity and strace was also pretty boring to watch...

Do you think routerplus would provide any insight?

I attached my TA's sw info below.

... Also, I have 3 TivoHDs and all of them are having this issue. I purchased them years apart, so we can rule out bad hardware.


Quote:
Originally Posted by lrhorer View Post
Well, as I understand it, the issue can be temporarily abated by taking down the internet connection to the Tivo for 3 or 4 days, right? One possibility would be to set up a proxy server for the TiVo's internet connections. The proxy can be set to automatically disable itself for 3 or 4 days at a time and then come back online for 5 or 6 days.

Attached Images
File Type: png TA Info.png (73.0 KB, 12 views)
Attached Files
File Type: txt 2267171.txt (10.5 KB, 1 views)
File Type: txt 2267172.txt (27.6 KB, 1 views)

Last edited by trackie999 : 10-11-2011 at 06:38 AM. Reason: attached fsid dumps
trackie999 is offline   Reply With Quote
Old 10-10-2011, 10:22 PM   #173
WO312
Registered User
 
Join Date: Jan 2003
Location: Wilmington, NC
Posts: 1,259
Quote:
Originally Posted by wtherrell View Post
Sun circles the earth?? From what century have you time-traveled here ??
Hmmm, guess my humor goes right over your head. We MUST be from different centuries.
WO312 is offline   Reply With Quote
Old 10-10-2011, 10:26 PM   #174
WO312
Registered User
 
Join Date: Jan 2003
Location: Wilmington, NC
Posts: 1,259
Quote:
Originally Posted by lrhorer View Post
I would tend to suspect coincidence on that venue. Any chance you still have your 1T laying around for testing purposes?
I DO still have my 1 TB . Not a bad idea. Maybe I will do the experiment, but it's a real pain to open my Tivo as I have it sandwiched pretty well. I think I will continue with my current experiment first.
WO312 is offline   Reply With Quote
Old 10-10-2011, 10:44 PM   #175
wtherrell
Registered User
 
Join Date: Dec 2004
Location: Huntersville, NC
Posts: 331
Quote:
Originally Posted by WO312 View Post
Hmmm, guess my humor goes right over your head. We MUST be from different centuries.
No, I got it. Alas, sometimes I just can't control my smart-ass reflex.
wtherrell is offline   Reply With Quote
Old 10-10-2011, 11:52 PM   #176
pninen
Registered User
 
Join Date: Jun 2003
Posts: 103
Quote:
Originally Posted by trackie999 View Post
WO312,

DO NOT RUN CHANNEL LINE UP FIX IF YOU RECEIVED S03 ERROR!
YOU WILL GET STUCK IN A NEVER ENDING GUIDED SETUP -> S03 -> REBOOT LOOP!

If you have S03 Error, you can fix it by running "Clear program information & To Do List"
Well I recently had the S03 error, and I fixed it by doing the channel line up fix, and it worked for me. It rebooted twice and then it was all good.

PS: People have asked if this only happens on drives 1TB and above. The answer is no. It happened on my 750GB drive. TiVo told me the drive was bad so I bought a brand new 2TB drive from weaknees, and had the problem again in just a few weeks. Now I keep it under control by unplugging the internet connection for >48 hours every now and then.

Big pain in the ass.
pninen is offline   Reply With Quote
Old 10-11-2011, 09:02 AM   #177
Teeps
Registered User
 
Teeps's Avatar
 
Join Date: Aug 2001
Location: Torrance,Cal. 90503
Posts: 1,038
GC on my S3 (2tb), as of this morning, is still showing Saturday 8OCT2011.

GC had self updated on 8OCT, from a previous GC date that was "forced" by an internet disconnection (only) of about 3 days.
Teeps is offline   Reply With Quote
Old 10-11-2011, 05:10 PM   #178
trackie999
Registered User
 
trackie999's Avatar
 
Join Date: Sep 2009
Posts: 89
Good news everyone!

After 5 days 16 hours and 40.5 minutes my dbgc completed

System Information Screen shows:
Program Information To: Wednesday, October 19, 2011 (Oct 6 + 13)
GC: Tuesday, October 11 12:11PM

Code:
Oct  6 05:06:48 (none) DbGc[12083]: fEnableIndexingM=1 fEnableGcM=1
Oct  6 05:10:19 (none) dbcache[12083]: Creating dbcache in program dbgc-mcp, size = 10
Oct  6 05:10:20 (none) DbGc[12083]: SetState(): eVirgin --> eBefored
Oct  6 05:10:20 (none) DbGc[12083]: SetState(): eBefored --> eMarkingActive
Oct  6 07:30:31 (none) DbGc[12083]: SetState(): eMarkingActive --> eMarkingReactive
Oct  6 07:30:40 (none) DbGc[12083]: SetState(): eMarkingReactive --> eTryingToInstallGcMask
Oct  6 07:30:40 (none) DbGc[12083]: SetState(): eTryingToInstallGcMask --> eInstallingGcMask
Oct  6 07:30:43 (none) DbGc[12083]: SetState(): eInstallingGcMask --> eSweeping
Oct  6 12:48:51 (none) DbGc::LogMemoryUsage[12083]: LogMemoryUsage( After DbShowingIndexer::VisitAllStationDays )
Oct  6 12:48:51 (none) TmkMempool[12083]: STAT dbgc-mcp: blocks=3648 bytes=1069912 bytesMax=1563840 unusedBytes=3093328 chunks=31 chunkBytes=974336 freeChunks=2 freeChunkBytes=1536 maxFreeChunk=2955848
Oct  6 12:49:00 (none) DbGc::LogMemoryUsage[12083]: LogMemoryUsage( pShowingWriterM )
Oct  6 12:49:00 (none) TmkMempool[12083]: STAT dbgc-mcp: blocks=3648 bytes=1069912 bytesMax=1563840 unusedBytes=3093328 chunks=31 chunkBytes=974336 freeChunks=2 freeChunkBytes=1536 maxFreeChunk=2955848
Oct  6 12:49:18 (none) DbGc::LogMemoryUsage[12083]: LogMemoryUsage( pProgramWriterM )
Oct  6 12:49:18 (none) TmkMempool[12083]: STAT dbgc-mcp: blocks=3648 bytes=1069912 bytesMax=1563840 unusedBytes=3093328 chunks=31 chunkBytes=974336 freeChunks=2 freeChunkBytes=1536 maxFreeChunk=2955848
Oct  6 12:49:18 (none) DbGc::LogMemoryUsage[12083]: LogMemoryUsage( pGenreWriterM )
Oct  6 12:49:18 (none) TmkMempool[12083]: STAT dbgc-mcp: blocks=3648 bytes=1069912 bytesMax=1563840 unusedBytes=3093328 chunks=31 chunkBytes=974336 freeChunks=2 freeChunkBytes=1536 maxFreeChunk=2955848
Oct  6 12:49:25 (none) DbGc::LogMemoryUsage[12083]: LogMemoryUsage( pSeriesIndexerM )
Oct  6 12:49:25 (none) TmkMempool[12083]: STAT dbgc-mcp: blocks=3648 bytes=1069912 bytesMax=1563840 unusedBytes=3093328 chunks=31 chunkBytes=974336 freeChunks=2 freeChunkBytes=1536 maxFreeChunk=2955848
Oct  6 12:49:25 (none) DbGc::LogMemoryUsage[12083]: LogMemoryUsage( After running pShowingIndexer )
Oct  6 12:49:25 (none) TmkMempool[12083]: STAT dbgc-mcp: blocks=3648 bytes=1069912 bytesMax=1563840 unusedBytes=3093328 chunks=31 chunkBytes=974336 freeChunks=2 freeChunkBytes=1536 maxFreeChunk=2955848
Oct  6 12:49:30 (none) DbGc[12083]: DbGc::AfterIndexersFSuccessful = 1
Oct  6 12:49:30 (none) DbGc[12083]: DbGc::StoreCompletionInDb: 15253/46170 (0x0)
Oct  6 12:49:30 (none) DbGc[12083]: DbGc::Mark succeeded, sweep soon
Oct  6 12:49:30 (none) TmkActivityStats[12083]: DbGcBackgroundAction-->(Pri:0 Time Sample: 7 h 42 min)
Oct  6 12:49:30 (none) TmkActivityStats[12113]:   DbGcClientActivity-->(Pri:0 Time Sample: 9 h 12 min)
Oct  6 18:49:58 (none) TmkActivityStats[14904]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct  7 00:50:27 (none) TmkActivityStats[16192]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct  7 06:50:55 (none) TmkActivityStats[17658]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct  7 12:51:24 (none) TmkActivityStats[19019]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct  8 00:52:20 (none) TmkActivityStats[21601]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct  8 02:44:28 (none) DbGc[22006]: TrioRubbished id:1609861 s:2
Oct  8 02:44:29 (none) DbGc[22006]: TrioRubbished id:1609862 s:2
Oct  8 02:44:30 (none) DbGc[21969]: TrioRubbished id:1609863 s:2
Oct  8 02:44:31 (none) DbGc[21969]: TrioRubbished id:1609864 s:2
Oct  8 02:44:37 (none) DbGc[22006]: TrioRubbished id:1632297 s:2
Oct  8 02:44:55 (none) DbGc[22006]: TrioRubbished id:1838060 s:2
Oct  8 02:45:31 (none) DbGc[22030]: TrioRubbished id:1920572 s:2
Oct  8 02:46:07 (none) DbGc[22006]: TrioRubbished id:2055187 s:2
Oct  8 02:47:16 (none) DbGc[22037]: TrioRubbished id:2063708 s:2
Oct  8 02:47:17 (none) DbGc[22037]: TrioRubbished id:2068875 s:2
Oct  8 02:47:17 (none) DbGc[22037]: TrioRubbished id:2073805 s:2
Oct  8 02:47:18 (none) DbGc[22037]: TrioRubbished id:2077229 s:2
Oct  8 02:47:22 (none) DbGc[22032]: TrioRubbished id:2083744 s:2
Oct  8 02:47:23 (none) DbGc[22032]: TrioRubbished id:2083745 s:2
Oct  8 02:47:23 (none) DbGc[22032]: TrioRubbished id:2083746 s:2
Oct  8 02:47:24 (none) DbGc[22032]: TrioRubbished id:2083747 s:2
Oct  8 02:47:24 (none) DbGc[22032]: TrioRubbished id:2083748 s:2
Oct  8 02:47:25 (none) DbGc[22032]: TrioRubbished id:2083749 s:2
Oct  8 02:47:25 (none) DbGc[22032]: TrioRubbished id:2083750 s:2
Oct  8 02:47:26 (none) DbGc[22032]: TrioRubbished id:2083751 s:2
Oct  8 02:47:29 (none) DbGc[22032]: TrioRubbished id:2083752 s:2
Oct  8 02:47:29 (none) DbGc[22032]: TrioRubbished id:2083753 s:2
Oct  8 02:47:29 (none) DbGc[22032]: TrioRubbished id:2083754 s:2
Oct  8 02:47:30 (none) DbGc[22032]: TrioRubbished id:2083758 s:2
Oct  8 02:47:30 (none) DbGc[22032]: TrioRubbished id:2083759 s:2
Oct  8 02:47:30 (none) DbGc[22032]: TrioRubbished id:2083760 s:2
Oct  8 02:47:31 (none) DbGc[22032]: TrioRubbished id:2083761 s:2
Oct  8 02:47:31 (none) DbGc[22032]: TrioRubbished id:2083762 s:2
Oct  8 02:47:32 (none) DbGc[22032]: TrioRubbished id:2083763 s:2
Oct  8 02:47:32 (none) DbGc[22032]: TrioRubbished id:2083764 s:2
Oct  8 02:47:32 (none) DbGc[22032]: TrioRubbished id:2083779 s:2
Oct  8 06:52:49 (none) TmkActivityStats[22912]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct  8 12:53:17 (none) TmkActivityStats[24248]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct  8 18:32:47 (none) DbGc[25516]: TrioRubbished id:2162512 s:2
Oct  8 18:32:48 (none) DbGc[25516]: TrioRubbished id:2162513 s:2
Oct  8 18:32:50 (none) DbGc[25502]: TrioRubbished id:2162514 s:2
Oct  8 18:53:46 (none) TmkActivityStats[25596]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct  9 00:54:14 (none) TmkActivityStats[26857]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct  9 06:54:43 (none) TmkActivityStats[28108]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct  9 12:55:11 (none) TmkActivityStats[29424]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct  9 13:44:43 (none) DbGc[29612]: TrioRubbished id:2234524 s:2
Oct  9 13:55:33 (none) DbGc[29642]: TrioRubbished id:2266835 s:2
Oct  9 13:55:37 (none) DbGc[29643]: TrioRubbished id:2266887 s:2
Oct  9 13:55:46 (none) DbGc[29642]: TrioRubbished id:2267045 s:2
Oct  9 15:56:07 (none) DbGc[30115]: TrioRubbished id:2267171 s:2
Oct  9 18:55:40 (none) TmkActivityStats[30675]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct 10 00:56:08 (none) TmkActivityStats[31948]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct 10 02:09:55 (none) DbGc[32208]: TrioRubbished id:2267172 s:2
Oct 10 02:09:59 (none) DbGc[32208]: TrioRubbished id:2267285 s:2
Oct 10 06:56:36 (none) TmkActivityStats[884]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct 10 12:57:05 (none) TmkActivityStats[2226]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct 10 18:57:33 (none) TmkActivityStats[3386]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct 11 00:58:02 (none) TmkActivityStats[4720]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct 11 06:58:30 (none) TmkActivityStats[6067]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct 11 12:58:59 (none) TmkActivityStats[7338]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
Oct 11 16:11:34 (none) DbGc[8008]: Sweep done (eSucceeded) -- rescheduling marking in 61200 sec
Oct 11 16:11:34 (none) DbGc[8008]: SetState(): eSweeping --> eFinished
Oct 11 16:11:34 (none) DbGc[8008]: shouldTrioRubbishM 6696 56 65
Oct 11 16:11:34 (none) DbGcStats[8008]: ---------------
Oct 11 16:11:34 (none) DbGcStats[8008]: DbGC statistics
Oct 11 16:11:34 (none) DbGcStats[8008]: {
Oct 11 16:11:34 (none) DbGcStats[8008]:           Type       #InMemory   #Queued     #Collected
Oct 11 16:11:34 (none) DbGcStats[8008]:           ~~~~       ~~~~~~~~~   ~~~~~~~~~~  ~~~~~~~~~~
Oct 11 16:11:34 (none) DbGcStats[8008]:             Program     36972      17152       2198
Oct 11 16:11:34 (none) DbGcStats[8008]:              Series     16823          0        327
Oct 11 16:11:34 (none) DbGcStats[8008]:             Station      1123          0          8
Oct 11 16:11:34 (none) DbGcStats[8008]:          StationDay       225      10373          0
Oct 11 16:11:34 (none) DbGcStats[8008]:             LoopSet        10          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:            SwSystem         0          1          0
Oct 11 16:11:34 (none) DbGcStats[8008]:            SwModule         6          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:           Recording         0       4552        400
Oct 11 16:11:34 (none) DbGcStats[8008]:            Showcase         0         10          0
Oct 11 16:11:34 (none) DbGcStats[8008]:               Image       514          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:             Headend         0         14          0
Oct 11 16:11:34 (none) DbGcStats[8008]:       ResourceGroup         0          1          0
Oct 11 16:11:34 (none) DbGcStats[8008]:               Setup         0          4          0
Oct 11 16:11:34 (none) DbGcStats[8008]:       ComponentCode       753          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:           Component       381          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:          SeasonPass         7         83          0
Oct 11 16:11:34 (none) DbGcStats[8008]:          PostalCode         2          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:        PrefsElement       146          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:               Genre       204          2          0
Oct 11 16:11:34 (none) DbGcStats[8008]:            IrFormat        84          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:         IrBlastData       192          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:           VideoClip        20          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:        IrTivoFormat         1        164          0
Oct 11 16:11:34 (none) DbGcStats[8008]:         MessageItem         4          2          0
Oct 11 16:11:34 (none) DbGcStats[8008]:             DataSet       136          0         27
Oct 11 16:11:34 (none) DbGcStats[8008]:            AreaCode         0          1          0
Oct 11 16:11:34 (none) DbGcStats[8008]:       DatabaseState         1          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:        MyWorldState         1          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:           LogoGroup         0          4          0
Oct 11 16:11:34 (none) DbGcStats[8008]:               Table         0          7          0
Oct 11 16:11:34 (none) DbGcStats[8008]:      CaptureRequest        10          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:             AuxInfo        13          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:          MediaState         0          1          0
Oct 11 16:11:34 (none) DbGcStats[8008]:      AvalancheState         1          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:            MenuItem        11        103          0
Oct 11 16:11:34 (none) DbGcStats[8008]:      LeadGeneration         0          8          0
Oct 11 16:11:34 (none) DbGcStats[8008]:        TuikResource      1721          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:    TuikResourceHolder         0       1803          0
Oct 11 16:11:34 (none) DbGcStats[8008]:    TuikResourceGroup        28         15          0
Oct 11 16:11:34 (none) DbGcStats[8008]:            AvConfig         1          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:       GeneralConfig         1          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:         PhoneConfig         1          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:      LocationConfig         1          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:           ArmConfig         1          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:    CorrelationPartHolder         1          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:       ServiceConfig         0          1          0
Oct 11 16:11:34 (none) DbGcStats[8008]:     LiveCacheConfig         1          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:    LocksLimitsState         1          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:       EncryptionKey        15         13          0
Oct 11 16:11:34 (none) DbGcStats[8008]:           NetConfig         1          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:            UserInfo         1          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:           DvdConfig         1          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:        StaticConfig         1          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:           SpigotMap         0          4          0
Oct 11 16:11:34 (none) DbGcStats[8008]:    ModelInformation         1          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:    ClosedCaptioningState         1          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:      ProviderConfig         1          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:        AdContentSet         1          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:            UnionTag        13          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:    NetworkRecordRequest         2          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:      RecorderConfig         1          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:    FrontPanelConfig         1          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:      MessageManager         1          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:           SecureLog         1          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:       SecureLogPart         1          0          0
Oct 11 16:11:34 (none) DbGcStats[8008]:    PodChannelHolder         0          9          0
Oct 11 16:11:34 (none) DbGcStats[8008]:    RegionRatingTable         0          1          0
Oct 11 16:11:34 (none) DbGcStats[8008]:           Cablecard         0          1          0
Oct 11 16:11:34 (none) DbGcStats[8008]:           SyncState         0          2          0
Oct 11 16:11:34 (none) DbGcStats[8008]:        ServerBackup         0         10          0
Oct 11 16:11:34 (none) DbGcStats[8008]:           ~~~~~~~~~   ~~~~~~~~   ~~~~~~~~~~  ~~~~~~~~~~
Oct 11 16:11:34 (none) DbGcStats[8008]:               total     59440      34341       2960
Oct 11 16:11:34 (none) DbGcStats[8008]:  
Oct 11 16:11:34 (none) DbGcStats[8008]:   nRubbish=854  nTrioRubbish( recent=1 stale=0 made=41 ) 
Oct 11 16:11:34 (none) DbGcStats[8008]:   indexed=1 GCed=1
Oct 11 16:11:34 (none) DbGcStats[8008]:   fFoundDanglingRef=0
Oct 11 16:11:34 (none) DbGcStats[8008]:   State:   eFinished
Oct 11 16:11:34 (none) DbGcStats[8008]:   Outcome: eSucceeded
Oct 11 16:11:34 (none) DbGcStats[8008]:   102402/262144 inodes used
Oct 11 16:11:34 (none) DbGcStats[8008]:  
Oct 11 16:11:34 (none) DbGcStats[8008]:   Attempts To Install GC Mask: 1
Oct 11 16:11:34 (none) DbGcStats[8008]:   ActiveLockConflicts during MarkActive: 0
Oct 11 16:11:34 (none) DbGcStats[8008]:   ActiveLockConflicts during MarkActive (BurpQueue): 0
Oct 11 16:11:34 (none) DbGcStats[8008]:   ActiveLockConflicts during MarkReactive (BurpQueue): 0
Oct 11 16:11:34 (none) DbGcStats[8008]:   ActiveLockConflicts while sweeping: 0
Oct 11 16:11:34 (none) DbGcStats[8008]:   nNonMaskableFsIdsM while installing GC Mask: 12791
Oct 11 16:11:34 (none) DbGcStats[8008]:  
Oct 11 16:11:34 (none) DbGcStats[8008]:   msec MarkActive:      8400504 (140.0 mins)
Oct 11 16:11:34 (none) DbGcStats[8008]:   msec MarkReactive:       8652 (0.1 mins)
Oct 11 16:11:34 (none) DbGcStats[8008]:   msec Indexing:       19408346 (323.5 mins)
Oct 11 16:11:34 (none) DbGcStats[8008]:   msec InstallGcMask:      2829 (0.0 mins)
Oct 11 16:11:34 (none) DbGcStats[8008]:   msec SweepOne:         962887 (16.0 mins)
Oct 11 16:11:34 (none) DbGcStats[8008]:   sec  Sweep State:      463251 (7,720.9 mins)
Oct 11 16:11:34 (none) DbGcStats[8008]:  
Oct 11 16:11:34 (none) DbGcStats[8008]:          before App Blocks 34.1769% free (223536/654056)
Oct 11 16:11:34 (none) DbGcStats[8008]:          before Media Blocks 2.39975% free (58961920/2457006080)
Oct 11 16:11:34 (none) DbGcStats[8008]:             now App Blocks 34.6784% free (226816/654056)
Oct 11 16:11:34 (none) DbGcStats[8008]:             now Media Blocks 0.865209% free (21258240/2457006080)
Oct 11 16:11:34 (none) DbGcStats[8008]:  
Oct 11 16:11:34 (none) DbGcStats[8008]: }
Oct 11 16:11:34 (none) DbGcStats[8008]: ---------------
Oct 11 16:11:35 (none) DbGc[8008]: DbGc::StoreCompletionInDb: 15258/58294 (0x0)
Oct 11 18:59:27 (none) TmkActivityStats[8523]:   DbGcClientActivity-->(Pri:0 Time Sample:  6 h 0 min)
As you can see vast majority of the time was spent in sweep state.


Also tverr is full of these messages:
Oct 11 05:59:54 (none) MakeDeltas[5861]: line 565 s = 0x30001
Oct 11 06:00:05 (none) last message repeated 40 times
Oct 11 06:00:10 (none) AckSyncId[5861]: line 784 s = 0x30001
Oct 11 06:00:21 (none) last message repeated 40 times

Process ID changes every time so these processes must be dying for some reason. Any idea what s=0x30001 represents?
Edit: I found ackSyncId string in tivoapp @ 01EA9E20 and MakeDeltas @ 01EA9D90
lrhorer: would you attempt to ID purpose?

Router will allow this Tivo to connect at midnight tonight, will see how long it will take to complete next dbgc run.

Last edited by trackie999 : 10-11-2011 at 05:29 PM.
trackie999 is offline   Reply With Quote
Old 10-11-2011, 05:15 PM   #179
wtherrell
Registered User
 
Join Date: Dec 2004
Location: Huntersville, NC
Posts: 331
Well, unplugging the internet connection did not seem to be doing any good. My last GC was right after I had to clear and delete last August to correct SO3 error. Two months ago.Today GC was still on August 10. So today I did the Channel fix and the GC finally updated to today, Oct. 11. Maybe two months of garbage was too much for the Tivo HD to handle in 3 days or so of being disconnected from the internet. I am going to watch the updates and when it gets 4 days behind the program guide connection, I will try the internet disconnect again for a couple of days.
wtherrell is offline   Reply With Quote
Old 10-12-2011, 02:49 AM   #180
Eccles
Mostly harmless
 
Eccles's Avatar
 
Join Date: Dec 2001
Location: Austin, TX
Posts: 349
Quote:
Originally Posted by pninen

Well I recently had the S03 error, and I fixed it by doing the channel line up fix, and it worked for me. It rebooted twice and then it was all good.
Likewise, I used the Channel Lineup fix the last time my HD hit the S03 problem, and I had no problems at all.
__________________
Sony SVR-2000 + 80GB B drive (Lifetime, sold)
80-hour Series2 (Lifetime)
20-hour TiVo HD with 1TB drive, 142 HD hours (Lifetime, sold)
150-hour Premiere XL (Lifetime)
Eccles is offline   Reply With Quote
Reply
Forum Jump




Thread Tools


Posting Rules
You may not post new threads
You may not post replies
You may not post attachments
You may not edit your posts

vB code is On
Smilies are On
[IMG] code is On
HTML code is Off

Advertisements

TiVo Community
Powered by vBulletin® Version 3.6.8
Copyright ©2000 - 2014, Jelsoft Enterprises Ltd.
vBulletin Skins by: Relivo Media

(C) 2013 Magenium Solutions - All Rights Reserved. No information may be posted elsewhere without written permission.
TiVoŽ is a registered trademark of TiVo Inc. This site is not owned or operated by TiVo Inc.
All times are GMT -5. The time now is 07:12 AM.
OUR NETWORK: MyOpenRouter | TechLore | SansaCommunity | RoboCommunity | MediaSmart Home | Explore3DTV | Dijit Community | DVR Playground |