PerformGarbageCleanup increase under 1.7.0.10?

[StinkyImp]

I finally updated to 1.7.0.10 on November 23rd. My last Garbage Cleanup before that was on November 21st using "portable" version 1.6.7.3.

Code: Select all

PG123 Log Parser (and Report Generator) - v 1.7.6 (64 bit)
Report Created on 12/11/2021 at 07:56:33
================================================================
[11/21/2021 12:07:27 AM]  Beginning epg123 client execution. version 1.6.7.3
[11/22/2021 12:07:19 AM]  Beginning epg123 client execution. version 1.6.7.3
[11/23/2021 12:07:25 AM]  Beginning epg123 client execution. version 1.7.0.10
[11/24/2021 12:07:29 AM]  Beginning epg123 client execution. version 1.7.0.10
[11/25/2021 12:07:39 AM]  Beginning epg123 client execution. version 1.7.0.10
[11/26/2021 12:07:26 AM]  Beginning epg123 client execution. version 1.7.0.10

===== QUERY INFORMATION (Predefined) ===========================
Logs used:		trace.log ONLY
Search String:		t execution. version
Date Range:		11/21/2021 thru 11/26/2021 (6 days)
Total results found:	6
Query time:		03 seconds

===== GENERAL INFORMATION ======================================
Log Path:		C:\epg123\
Logfile timespan:	10/21/2021 thru 12/11/2021 (52 days)
Total lines processed:	4473

===== SYSTEM INFORMATION =======================================
Operating System:	Windows 7 Professional (64 bit)
Processor:		Intel(R) Core(TM) i3-3220 CPU @ 3.30GHz
Total RAM:		8.00 GB
ehshell version:	6.1.7601.23434
EPG123 version:		1.7.0.10

It seems like my Garbage Cleanup has gone from an average of 10 minutes (for years) to an average of 15+ minutes since the upgrade. I only noticed it because my overall execution times on garbage days is longer than it was historically.

Is this by design under the "installer" version or do I have a problem I need to look in to?

Code: Select all

EPG123 Log Parser (and Report Generator) - v 1.7.6 (64 bit)
Report Created on 12/11/2021 at 07:54:41
================================================================
[10/22/2021 12:07:31 AM] Entering PerformGarbageCleanup().
[10/22/2021 12:17:15 AM] Exiting PerformGarbageCleanup(). SUCCESS.
[10/27/2021 12:07:26 AM] Entering PerformGarbageCleanup().
[10/27/2021 12:19:00 AM] Exiting PerformGarbageCleanup(). SUCCESS.
[11/1/2021 12:07:29 AM] Entering PerformGarbageCleanup().
[11/1/2021 12:19:07 AM] Exiting PerformGarbageCleanup(). SUCCESS.
[11/6/2021 12:07:27 AM] Entering PerformGarbageCleanup().
[11/6/2021 12:18:26 AM] Exiting PerformGarbageCleanup(). SUCCESS.
[11/11/2021 12:07:32 AM] Entering PerformGarbageCleanup().
[11/11/2021 12:18:55 AM] Exiting PerformGarbageCleanup(). SUCCESS.
[11/16/2021 12:07:22 AM] Entering PerformGarbageCleanup().
[11/16/2021 12:18:36 AM] Exiting PerformGarbageCleanup(). SUCCESS.
[11/21/2021 12:07:28 AM] Entering PerformGarbageCleanup().
[11/21/2021 12:18:26 AM] Exiting PerformGarbageCleanup(). SUCCESS.
[11/26/2021 12:07:28 AM] Entering PerformGarbageCleanup().
[11/26/2021 12:24:16 AM] Exiting PerformGarbageCleanup(). SUCCESS.
[12/1/2021 12:07:35 AM] Entering PerformGarbageCleanup().
[12/1/2021 12:22:30 AM] Exiting PerformGarbageCleanup(). SUCCESS.
[12/6/2021 12:07:24 AM] Entering PerformGarbageCleanup().
[12/6/2021 12:22:28 AM] Exiting PerformGarbageCleanup(). SUCCESS.
[12/11/2021 12:07:32 AM] Entering PerformGarbageCleanup().
[12/11/2021 12:23:12 AM] Exiting PerformGarbageCleanup(). SUCCESS.

===== QUERY INFORMATION (Predefined) ===========================
Logs used:		trace.log ONLY
Search String:		PerformGarbageCleanup
Date Range:		10/21/2021 thru 12/11/2021 (52 days)
Total results found:	22
Query time:		03 seconds

[garyan2]

In 1.7.0.0, I changed the garbage collection function to include a forced WMC backup (added the -b switch). The additional time is for WMC to perform that backup and update the files in c:\programdata\microsoft\ehome\mcepgX-Y\backup\lineup, \recordings, and \subscriptions. This is so in case the user experiences a database recovery, the restored configuration will be recent.

EDIT: Actually, looks like I added that in 1.6.7.2? I'll have to see if there is anything else that may have contributed to the increase in time.

[garyan2]

Ah, I remember now. With 1.6.7.3, it would perform the WMC backups the day before garbage cleanup was due. With 1.7.0.0, I included the backup with the garbage collection so they would be done at the same time.

[StinkyImp]

You are, as usual, AWESOME SAUCE!

[Space]

This may be only me, but my garbage cleanup seems to take longer and longer each time. I also notice that my program guide seems to never get purged (program listings for old days in the guide stay there, as can be seen using Remote Potato and clicking the left arrow to go backwards in time).

Not sure if anyone else has this problem, but it is something to look out for if the time keeps increasing...

[StinkyImp]

This may be only me, but my garbage cleanup seems to take longer and longer each time...

I think you mentioned this before and is the reason I thought I might be having an issue. I'll keep an eye on it. If its average doesn't increase, I'll call it good.

It may very well be that "sub 20 minute" garbage cleanup's my new normal?

[StinkyImp]

It appears that whatever you did between .10 and .12 brought me back down to my previous "normal" garbage times. I was concerned about Space's issue with increasing times but that doesn't seem to be a problem with mine.

Code: Select all

[10/22/2021 12:07:30 AM]  Beginning epg123 client execution. version 1.6.7.3
[10/22/2021 12:07:31 AM] Entering PerformGarbageCleanup().
[10/22/2021 12:17:15 AM] Exiting PerformGarbageCleanup(). SUCCESS.
[10/27/2021 12:07:26 AM] Entering PerformGarbageCleanup().
[10/27/2021 12:19:00 AM] Exiting PerformGarbageCleanup(). SUCCESS.
[11/1/2021 12:07:29 AM] Entering PerformGarbageCleanup().
[11/1/2021 12:19:07 AM] Exiting PerformGarbageCleanup(). SUCCESS.
[11/6/2021 12:07:27 AM] Entering PerformGarbageCleanup().
[11/6/2021 12:18:26 AM] Exiting PerformGarbageCleanup(). SUCCESS.
[11/11/2021 12:07:32 AM] Entering PerformGarbageCleanup().
[11/11/2021 12:18:55 AM] Exiting PerformGarbageCleanup(). SUCCESS.
[11/16/2021 12:07:22 AM] Entering PerformGarbageCleanup().
[11/16/2021 12:18:36 AM] Exiting PerformGarbageCleanup(). SUCCESS.
[11/21/2021 12:07:28 AM] Entering PerformGarbageCleanup().
[11/21/2021 12:18:26 AM] Exiting PerformGarbageCleanup(). SUCCESS.

[11/26/2021 12:07:26 AM]  Beginning epg123 client execution. version 1.7.0.10
[11/26/2021 12:07:28 AM] Entering PerformGarbageCleanup().
[11/26/2021 12:24:16 AM] Exiting PerformGarbageCleanup(). SUCCESS.
[12/1/2021 12:07:35 AM] Entering PerformGarbageCleanup().
[12/1/2021 12:22:30 AM] Exiting PerformGarbageCleanup(). SUCCESS.
[12/6/2021 12:07:24 AM] Entering PerformGarbageCleanup().
[12/6/2021 12:22:28 AM] Exiting PerformGarbageCleanup(). SUCCESS.
[12/11/2021 12:07:32 AM] Entering PerformGarbageCleanup().
[12/11/2021 12:23:12 AM] Exiting PerformGarbageCleanup(). SUCCESS.
[12/16/2021 12:08:00 AM] Entering PerformGarbageCleanup().
[12/16/2021 12:24:49 AM] Exiting PerformGarbageCleanup(). SUCCESS.

[12/21/2021 12:08:56 AM]  Beginning epg123 client execution. version 1.7.0.12
[12/21/2021 12:08:57 AM] Entering PerformGarbageCleanup().
[12/21/2021 12:19:47 AM] Exiting PerformGarbageCleanup(). SUCCESS.
[12/26/2021 12:07:30 AM] Entering PerformGarbageCleanup().
[12/26/2021 12:18:15 AM] Exiting PerformGarbageCleanup(). SUCCESS.

[garyan2]

Sorry, but I didn't do anything between .10 and .12 for this. Not sure why the backup is taking less time than before if you haven't changed anything in WMC (removed channels/tuners). I don't have anything to take credit for.

[StinkyImp]

My WMC system runs like clockwork. The only thing I've changed in the past year or so is to update EPG123. Since June I've devoted all my spare time to playing with this new Tablo-Roku setup which is completely outside WMC and the PC it runs on.

You may have done something inadvertently that synced things back up. I know you're trying to be humble but... take the win!