EPG Daily Update Error

An evolving, supported alternative to Rovi
Forum rules
★ Download the latest EPG123 here: https://garyan2.github.io/ <> Setup guide here: https://garyan2.github.io/install.html
bigal

Posts: 44
Joined: Sat May 21, 2022 2:31 pm
Location:

HTPC Specs: Show details

EPG Daily Update Error

#1

Post by bigal » Mon Jun 20, 2022 10:15 am

Refers to the mxf file.


[2022-06-20 05:54:25] ===============================================================================
[2022-06-20 05:54:25] Activating the epg123 configuration GUI. version 1.7.1.7
[2022-06-20 05:54:25] ===============================================================================
[2022-06-20 05:54:25] *** Windows 7 Home Premium, 64-bit [Version: 6.1.7601.0] ***
[2022-06-20 05:54:25] *** Windows Media Center [Version: 6.1.7600.16385] is installed. ***
[2022-06-20 05:54:28] [ INFO] Status request successful. account expires: 2023-01-07T20:18:59Z , lineups: 1/4 , lastDataUpdate: 2022-06-20T05:00:13Z
[2022-06-20 05:54:28] [ INFO] system status: Online , message: No known issues.
[2022-06-20 05:54:28] [ INFO] Successfully requested listing of subscribed lineups from Schedules Direct.
[2022-06-20 05:54:28] [ INFO] Successfully retrieved the station mapping for lineup USA-OTA-48195.
[2022-06-20 05:54:29] [ INFO] Successfully queried the Task Scheduler for status. Ready. Last Run 2022-06-20 03:30:00; Exit: 0x00000000
[2022-06-20 05:54:48] ===============================================================================
[2022-06-20 05:54:48] Activating the epg123 client GUI. version 1.7.1.7
[2022-06-20 05:54:48] ===============================================================================
[2022-06-20 05:54:48] *** Windows 7 Home Premium, 64-bit [Version: 6.1.7601.0] ***
[2022-06-20 05:54:48] *** Windows Media Center [Version: 6.1.7600.16385] is installed. ***
[2022-06-20 05:54:49] [ INFO] Successfully queried the Task Scheduler for status. Ready. Last Run 2022-06-20 03:30:00; Exit: 0x00000000
[2022-06-20 05:55:25] ===============================================================================
[2022-06-20 05:55:25] Activating the epg123 configuration GUI. version 1.7.1.7
[2022-06-20 05:55:25] ===============================================================================
[2022-06-20 05:55:25] *** Windows 7 Home Premium, 64-bit [Version: 6.1.7601.0] ***
[2022-06-20 05:55:25] *** Windows Media Center [Version: 6.1.7600.16385] is installed. ***
[2022-06-20 05:55:27] [ INFO] Status request successful. account expires: 2023-01-07T20:18:59Z , lineups: 1/4 , lastDataUpdate: 2022-06-20T05:00:13Z
[2022-06-20 05:55:27] [ INFO] system status: Online , message: No known issues.
[2022-06-20 05:55:27] [ INFO] Successfully requested listing of subscribed lineups from Schedules Direct.
[2022-06-20 05:55:27] [ INFO] Successfully retrieved the station mapping for lineup USA-OTA-48195.
[2022-06-20 05:55:27] [ INFO] Successfully queried the Task Scheduler for status. Ready. Last Run 2022-06-20 03:30:00; Exit: 0x00000000
[2022-06-20 06:00:32] ===============================================================================
[2022-06-20 06:00:32] Beginning epg123 update execution. version 1.7.1.7
[2022-06-20 06:00:32] ===============================================================================
[2022-06-20 06:00:32] *** Windows 7 Home Premium, 64-bit [Version: 6.1.7601.0] ***
[2022-06-20 06:00:32] *** Windows Media Center [Version: 6.1.7600.16385] is installed. ***
[2022-06-20 06:00:32] [ INFO] Beginning EPG123 update execution. 2022-06-20 10:00:32Z
[2022-06-20 06:00:32] [ INFO] DaysToDownload: 17 , TheTVDBNumbers : True , PrefixEpisodeTitle: False , PrefixEpisodeDescription : False , AppendEpisodeDesc: True , OADOverride : True , SeasonEventImages : True , TMDbCoverArt: False , IncludeSDLogos : True , AutoAddNew: True , CreateXmltv: False , ModernMediaUiPlusSupport: False
[2022-06-20 06:00:33] [ INFO] Status request successful. account expires: 2023-01-07T20:18:59Z , lineups: 1/4 , lastDataUpdate: 2022-06-20T05:00:13Z
[2022-06-20 06:00:33] [ INFO] system status: Online , message: No known issues.
[2022-06-20 06:00:34] [ INFO] Successfully requested listing of subscribed lineups from Schedules Direct.
[2022-06-20 06:00:34] Entering BuildLineupServices() for 1 lineups.
[2022-06-20 06:00:34] [ INFO] Successfully retrieved the station mapping for lineup USA-OTA-48195.
[2022-06-20 06:00:34] [ INFO] Kicking off background worker to download and process 18 station logos.
[2022-06-20 06:00:34] Exiting BuildLineupServices(). SUCCESS.
[2022-06-20 06:00:34] Entering GetAllScheduleEntryMd5s() for 17 days on 64 stations.
[2022-06-20 06:00:34] [ INFO] The background worker to download station logos threw an exception. Message: The given key was not present in the dictionary.
[2022-06-20 06:00:37] [ INFO] Successfully retrieved Md5s for 64 station's daily schedules. (0:00:00:02.8800040 / 115.766 KB)
[2022-06-20 06:00:37] [ INFO] Found 1088 cached daily schedules.
[2022-06-20 06:00:37] [ INFO] Downloaded 0 daily schedules.
[2022-06-20 06:00:38] [ INFO] Processed 1088 daily schedules for 64 stations for average of 17.0 days per station.
[2022-06-20 06:00:38] Exiting GetAllScheduleEntryMd5s(). SUCCESS.
[2022-06-20 06:00:38] Entering BuildAllProgramEntries() for 16546 programs.
[2022-06-20 06:00:39] [ INFO] Killing process epg123[10216] to continue execution of new instance.
[2022-06-20 06:00:39] ===============================================================================
[2022-06-20 06:00:39] Beginning epg123 update execution. version 1.7.1.7
[2022-06-20 06:00:39] ===============================================================================
[2022-06-20 06:00:39] *** Windows 7 Home Premium, 64-bit [Version: 6.1.7601.0] ***
[2022-06-20 06:00:39] *** Windows Media Center [Version: 6.1.7600.16385] is installed. ***
[2022-06-20 06:00:39] ===============================================================================
[2022-06-20 06:00:39] Beginning epg123 client execution. version 1.7.1.7
[2022-06-20 06:00:39] ===============================================================================
[2022-06-20 06:00:39] *** Windows 7 Home Premium, 64-bit [Version: 6.1.7601.0] ***
[2022-06-20 06:00:39] *** Windows Media Center [Version: 6.1.7600.16385] is installed. ***
[2022-06-20 06:00:39] [ INFO] Beginning EPG123 update execution. 2022-06-20 10:00:39Z
[2022-06-20 06:00:39] [ INFO] Import: True , Match: True , NoLogo: False , Force: False , ShowProgress: False , NoGC: False , NoVerify: False , Verbose: False
[2022-06-20 06:00:39] [ INFO] DaysToDownload: 17 , TheTVDBNumbers : True , PrefixEpisodeTitle: False , PrefixEpisodeDescription : False , AppendEpisodeDesc: True , OADOverride : True , SeasonEventImages : True , TMDbCoverArt: False , IncludeSDLogos : True , AutoAddNew: True , CreateXmltv: False , ModernMediaUiPlusSupport: False
[2022-06-20 06:00:39] [ INFO] Status request successful. account expires: 2023-01-07T20:18:59Z , lineups: 1/4 , lastDataUpdate: 2022-06-20T05:00:13Z
[2022-06-20 06:00:39] [ INFO] system status: Online , message: No known issues.
[2022-06-20 06:00:39] Entering ImportMxfFile() for file "c:\programdata\garyan2\epg123\output\epg123.mxf".
[2022-06-20 06:00:40] [ INFO] Successfully requested listing of subscribed lineups from Schedules Direct.
[2022-06-20 06:00:40] Entering BuildLineupServices() for 1 lineups.
[2022-06-20 06:00:40] [ INFO] Successfully retrieved the station mapping for lineup USA-OTA-48195.
[2022-06-20 06:00:41] [ INFO] Kicking off background worker to download and process 17 station logos.
[2022-06-20 06:00:41] Exiting BuildLineupServices(). SUCCESS.
[2022-06-20 06:00:41] Entering GetAllScheduleEntryMd5s() for 17 days on 64 stations.
[2022-06-20 06:00:42] [ INFO] The background worker to download station logos threw an exception. Message: The given key was not present in the dictionary.
[2022-06-20 06:00:43] [ INFO] Successfully retrieved Md5s for 64 station's daily schedules. (0:00:00:02.4600035 / 115.766 KB)
[2022-06-20 06:00:43] [ INFO] Found 1088 cached daily schedules.
[2022-06-20 06:00:43] [ INFO] Downloaded 0 daily schedules.
[2022-06-20 06:00:44] [ INFO] Processed 1088 daily schedules for 64 stations for average of 17.0 days per station.
[2022-06-20 06:00:44] Exiting GetAllScheduleEntryMd5s(). SUCCESS.
[2022-06-20 06:00:44] Entering BuildAllProgramEntries() for 16546 programs.
[2022-06-20 06:00:49] [ INFO] Found 15734 cached program descriptions.
[2022-06-20 06:00:53] [ INFO] Successfully retrieved 812 program descriptions. (0:00:00:04.3600061 / 1.570 MB)
[2022-06-20 06:00:54] Exiting BuildAllProgramEntries(). SUCCESS.
[2022-06-20 06:00:54] Entering BuildAllGenericSeriesInfoDescriptions() for 2124 series.
[2022-06-20 06:00:54] [ INFO] Found 2105 cached/unavailable series descriptions.
[2022-06-20 06:00:54] [ INFO] Successfully retrieved 19 generic program descriptions. (0:00:00:00.1400002 / 5.357 KB)
[2022-06-20 06:00:54] Exiting BuildAllGenericSeriesInfoDescriptions(). SUCCESS.
[2022-06-20 06:00:54] Entering GetAllMoviePosters() for 625 movies.
[2022-06-20 06:00:54] [ INFO] Found 605 cached/unavailable movie poster links.
[2022-06-20 06:00:54] [ INFO] Successfully retrieved artwork info for 20 programs. (0:00:00:00.1300001 / 178.706 KB)
[2022-06-20 06:00:54] Exiting GetAllMoviePosters(). SUCCESS.
[2022-06-20 06:00:54] Entering GetAllSeriesImages() for 2124 series.
[2022-06-20 06:00:55] [ INFO] Found 2008 cached/unavailable series image links.
[2022-06-20 06:00:55] [ INFO] Refreshing 87 series image links.
[2022-06-20 06:00:55] [ INFO] Successfully retrieved artwork info for 116 programs. (0:00:00:00.4500006 / 777.655 KB)
[2022-06-20 06:00:55] Exiting GetAllSeriesImages(). SUCCESS.
[2022-06-20 06:00:55] Entering GetAllSeasonImages() for 1824 seasons.
[2022-06-20 06:00:55] [ INFO] Found 1749 cached/unavailable season image links.
[2022-06-20 06:00:55] [ INFO] Successfully retrieved artwork info for 75 programs. (0:00:00:00.2900004 / 503.627 KB)
[2022-06-20 06:00:56] Exiting GetAllSeasonImages(). SUCCESS.
[2022-06-20 06:00:56] Entering GetAllSportsImages() for 32 sports events.
[2022-06-20 06:00:56] [ INFO] Found 31 cached/unavailable sport event image links.
[2022-06-20 06:00:56] [ INFO] Successfully retrieved artwork info for 1 programs. (0:00:00:00.1300002 / 3.427 KB)
[2022-06-20 06:00:56] Exiting GetAllSportsImages(). SUCCESS.
[2022-06-20 06:00:56] [ INFO] Completed compiling keywords and keyword groups.
[2022-06-20 06:00:56] [ERROR] Failed to save the MXF file to "C:\ProgramData\GaRyan2\epg123\output\epg123.mxf". Message: The process cannot access the file 'C:\ProgramData\GaRyan2\epg123\output\epg123.mxf' because it is being used by another process.
[2022-06-20 06:00:56] [ERROR] Failed to create MXF file. Exiting.
[2022-06-20 06:00:56] [ INFO] epg123 update execution time was 00:00:17.1000240.
[2022-06-20 06:00:56] [ INFO] Killing process epg123Client[10548] to continue execution of new instance.
[2022-06-20 06:00:56] ===============================================================================
[2022-06-20 06:00:56] Beginning epg123 client execution. version 1.7.1.7
[2022-06-20 06:00:56] ===============================================================================
[2022-06-20 06:00:56] *** Windows 7 Home Premium, 64-bit [Version: 6.1.7601.0] ***
[2022-06-20 06:00:56] *** Windows Media Center [Version: 6.1.7600.16385] is installed. ***
[2022-06-20 06:00:56] [ INFO] Import: True , Match: True , NoLogo: False , Force: False , ShowProgress: False , NoGC: False , NoVerify: False , Verbose: False
[2022-06-20 06:00:58] Entering ImportMxfFile() for file "c:\programdata\garyan2\epg123\output\epg123.mxf".
[2022-06-20 06:01:52] [ INFO] Successfully imported .mxf file into Media Center database. Exit code: 0
[2022-06-20 06:01:52] Exiting ImportMxfFile(). SUCCESS.
[2022-06-20 06:01:52] Entering VerifyLoad()
[2022-06-20 06:01:57] [ INFO] Checked 32490 entries and corrected 0 of them.
[2022-06-20 06:01:57] Exiting VerifyLoad()
[2022-06-20 06:01:57] [ INFO] Matching WDIVDT3 to channel 4.3
[2022-06-20 06:01:57] [ INFO] Exception thrown during SubscribeLineupChannel(). You cannot map a UserHidden channel.
at Microsoft.MediaCenter.Guide.MergedChannel.AddChannelListings(Channel csiChannel)
at epg123Client.WmcStore.SubscribeLineupChannel(Int64 lineupChannelId, Int64 mergedChannelId)
[2022-06-20 06:01:57] [ INFO] Matching WDIVDT3 to channel 4.3
[2022-06-20 06:01:57] [ INFO] Exception thrown during SubscribeLineupChannel(). You cannot map a UserHidden channel.
at Microsoft.MediaCenter.Guide.MergedChannel.AddChannelListings(Channel csiChannel)
at epg123Client.WmcStore.SubscribeLineupChannel(Int64 lineupChannelId, Int64 mergedChannelId)
[2022-06-20 06:01:57] [ INFO] Completed the automatch of lineup stations to tuner channels.
[2022-06-20 06:01:57] [ INFO] Completed lineup refresh.
[2022-06-20 06:01:57] Entering RunWmcIndexTask(PvrScheduleTask)
[2022-06-20 06:01:57] [ INFO] SUCCESS: Attempted to run the scheduled task "Microsoft\Windows\Media Center\PvrScheduleTask".
[2022-06-20 06:01:57] [ INFO] Successfully started the PvrScheduleTask task. Exit code: 0
[2022-06-20 06:01:57] Exiting RunWmcIndexTask(PvrScheduleTask). SUCCESS.
[2022-06-20 06:01:57] Entering RunWmcIndexTask(ReindexSearchRoot)
[2022-06-20 06:01:57] [ INFO] SUCCESS: Attempted to run the scheduled task "Microsoft\Windows\Media Center\ReindexSearchRoot".
[2022-06-20 06:01:57] [ INFO] Successfully started the ReindexSearchRoot task. Exit code: 0
[2022-06-20 06:01:57] Exiting RunWmcIndexTask(ReindexSearchRoot). SUCCESS.
[2022-06-20 06:01:57] [ INFO] MXF file was created on 2022-06-20 03:30:00
[2022-06-20 06:01:57] [WARNG] There was an ERROR generated during the MXF file creation.
[2022-06-20 06:01:58] [ INFO] Completed EPG123 client execution.
[2022-06-20 06:01:58] [ INFO] EPG123 client execution time was 00:01:01.8665050.

Space

Posts: 2838
Joined: Sun Jun 02, 2013 9:44 pm
Location:

HTPC Specs: Show details

#2

Post by Space » Mon Jun 20, 2022 11:29 am

The only errors I see are from trying to run multiple instances of either the EPG123 client or update program at the same time. For instance you have the update running (perhaps in the background) and then another instance of the EPG123 update program starts up and kills the first one. It also looks like while the EPG123 update program is running, the EPG123 client program starts at the same time.

It's not clear to me what is causing this, perhaps you have multiple Task Scheduler entries for EPG123 that are stepping on each other? Or maybe you are just manually running the tools while another instance is already running. I'm not sure, but I'm guessing Gary will be better at deciphering what is going on...
Last edited by Space on Mon Jun 20, 2022 3:14 pm, edited 1 time in total.

bigal

Posts: 44
Joined: Sat May 21, 2022 2:31 pm
Location:

HTPC Specs: Show details

#3

Post by bigal » Mon Jun 20, 2022 1:03 pm

Much obliged - I checked with Task Manager and an instance of EPG was shown as running.
I ended that task and ran the scheduled task manually; it ran ok and updated the listings back to the 17 days that I normally get.
Again, thank you...
[2022-06-20 08:55:09] ===============================================================================
[2022-06-20 08:55:09] Beginning epg123 update execution. version 1.7.1.7
[2022-06-20 08:55:09] ===============================================================================
[2022-06-20 08:55:09] *** Windows 7 Home Premium, 64-bit [Version: 6.1.7601.0] ***
[2022-06-20 08:55:09] *** Windows Media Center [Version: 6.1.7600.16385] is installed. ***
[2022-06-20 08:55:10] [ INFO] Beginning EPG123 update execution. 2022-06-20 12:55:10Z
[2022-06-20 08:55:10] [ INFO] DaysToDownload: 17 , TheTVDBNumbers : True , PrefixEpisodeTitle: False , PrefixEpisodeDescription : False , AppendEpisodeDesc: True , OADOverride : True , SeasonEventImages : True , TMDbCoverArt: False , IncludeSDLogos : True , AutoAddNew: True , CreateXmltv: False , ModernMediaUiPlusSupport: False
[2022-06-20 08:55:10] [ INFO] Status request successful. account expires: 2023-01-07T20:18:59Z , lineups: 1/4 , lastDataUpdate: 2022-06-20T05:00:13Z
[2022-06-20 08:55:10] [ INFO] system status: Online , message: No known issues.
[2022-06-20 08:55:11] [ INFO] Successfully requested listing of subscribed lineups from Schedules Direct.
[2022-06-20 08:55:11] Entering BuildLineupServices() for 1 lineups.
[2022-06-20 08:55:12] [ INFO] Successfully retrieved the station mapping for lineup USA-OTA-48195.
[2022-06-20 08:55:12] [ INFO] Kicking off background worker to download and process 12 station logos.
[2022-06-20 08:55:12] Exiting BuildLineupServices(). SUCCESS.
[2022-06-20 08:55:12] Entering GetAllScheduleEntryMd5s() for 17 days on 64 stations.
[2022-06-20 08:55:12] [ INFO] The background worker to download station logos threw an exception. Message: The given key was not present in the dictionary.
[2022-06-20 08:55:13] [ INFO] Successfully retrieved Md5s for 64 station's daily schedules. (0:00:00:01.2300017 / 115.766 KB)
[2022-06-20 08:55:13] [ INFO] Found 1088 cached daily schedules.
[2022-06-20 08:55:13] [ INFO] Downloaded 0 daily schedules.
[2022-06-20 08:55:14] [ INFO] Processed 1088 daily schedules for 64 stations for average of 17.0 days per station.
[2022-06-20 08:55:14] Exiting GetAllScheduleEntryMd5s(). SUCCESS.
[2022-06-20 08:55:14] Entering BuildAllProgramEntries() for 16460 programs.
[2022-06-20 08:55:18] [ INFO] Found 15648 cached program descriptions.
[2022-06-20 08:55:23] [ INFO] Successfully retrieved 812 program descriptions. (0:00:00:04.7300066 / 1.570 MB)
[2022-06-20 08:55:24] Exiting BuildAllProgramEntries(). SUCCESS.
[2022-06-20 08:55:24] Entering BuildAllGenericSeriesInfoDescriptions() for 2121 series.
[2022-06-20 08:55:24] [ INFO] Found 2102 cached/unavailable series descriptions.
[2022-06-20 08:55:24] [ INFO] Successfully retrieved 19 generic program descriptions. (0:00:00:00.1300002 / 5.357 KB)
[2022-06-20 08:55:24] Exiting BuildAllGenericSeriesInfoDescriptions(). SUCCESS.
[2022-06-20 08:55:24] Entering GetAllMoviePosters() for 622 movies.
[2022-06-20 08:55:25] [ INFO] Found 602 cached/unavailable movie poster links.
[2022-06-20 08:55:25] [ INFO] Successfully retrieved artwork info for 20 programs. (0:00:00:00.1400002 / 178.706 KB)
[2022-06-20 08:55:25] Exiting GetAllMoviePosters(). SUCCESS.
[2022-06-20 08:55:25] Entering GetAllSeriesImages() for 2121 series.
[2022-06-20 08:55:25] [ INFO] Found 2005 cached/unavailable series image links.
[2022-06-20 08:55:25] [ INFO] Refreshing 87 series image links.
[2022-06-20 08:55:26] [ INFO] Successfully retrieved artwork info for 116 programs. (0:00:00:00.4400006 / 777.655 KB)
[2022-06-20 08:55:26] Exiting GetAllSeriesImages(). SUCCESS.
[2022-06-20 08:55:26] Entering GetAllSeasonImages() for 1822 seasons.
[2022-06-20 08:55:26] [ INFO] Found 1747 cached/unavailable season image links.
[2022-06-20 08:55:26] [ INFO] Successfully retrieved artwork info for 75 programs. (0:00:00:00.3400005 / 504.452 KB)
[2022-06-20 08:55:26] Exiting GetAllSeasonImages(). SUCCESS.
[2022-06-20 08:55:26] Entering GetAllSportsImages() for 32 sports events.
[2022-06-20 08:55:26] [ INFO] Found 31 cached/unavailable sport event image links.
[2022-06-20 08:55:26] [ INFO] Successfully retrieved artwork info for 1 programs. (0:00:00:00.0800002 / 3.427 KB)
[2022-06-20 08:55:26] Exiting GetAllSportsImages(). SUCCESS.
[2022-06-20 08:55:26] [ INFO] Completed compiling keywords and keyword groups.
[2022-06-20 08:55:27] [ INFO] Completed save of the MXF file to "C:\ProgramData\GaRyan2\epg123\output\epg123.mxf".
[2022-06-20 08:55:28] [ INFO] 229 entries deleted from the cache file during cleanup.
[2022-06-20 08:55:28] [ INFO] Downloaded and processed 3.119 MB of data from Schedules Direct.
[2022-06-20 08:55:28] [ INFO] Generated .mxf file contains 64 services, 2121 series, 1822 seasons, 16460 programs, 32055 schedule entries, and 30436 people with 3706 image links.
[2022-06-20 08:55:28] [ INFO] Completed EPG123 update execution. SUCCESS.
[2022-06-20 08:55:28] [ INFO] epg123 update execution time was 00:00:18.8900264.
[2022-06-20 08:55:29] ===============================================================================
[2022-06-20 08:55:29] Beginning epg123 client execution. version 1.7.1.7
[2022-06-20 08:55:29] ===============================================================================
[2022-06-20 08:55:29] *** Windows 7 Home Premium, 64-bit [Version: 6.1.7601.0] ***
[2022-06-20 08:55:29] *** Windows Media Center [Version: 6.1.7600.16385] is installed. ***
[2022-06-20 08:55:29] [ INFO] Import: True , Match: True , NoLogo: False , Force: False , ShowProgress: False , NoGC: False , NoVerify: False , Verbose: False
[2022-06-20 08:55:29] Entering ImportMxfFile() for file "c:\programdata\garyan2\epg123\output\epg123.mxf".
[2022-06-20 08:56:16] [ INFO] Successfully imported .mxf file into Media Center database. Exit code: 0
[2022-06-20 08:56:16] Exiting ImportMxfFile(). SUCCESS.
[2022-06-20 08:56:16] Entering VerifyLoad()
[2022-06-20 08:56:22] [ INFO] Checked 32055 entries and corrected 0 of them.
[2022-06-20 08:56:22] Exiting VerifyLoad()
[2022-06-20 08:56:22] [ INFO] Matching WDIVDT3 to channel 4.3
[2022-06-20 08:56:22] [ INFO] Exception thrown during SubscribeLineupChannel(). You cannot map a UserHidden channel.
at Microsoft.MediaCenter.Guide.MergedChannel.AddChannelListings(Channel csiChannel)
at epg123Client.WmcStore.SubscribeLineupChannel(Int64 lineupChannelId, Int64 mergedChannelId)
[2022-06-20 08:56:22] [ INFO] Matching WDIVDT3 to channel 4.3
[2022-06-20 08:56:22] [ INFO] Exception thrown during SubscribeLineupChannel(). You cannot map a UserHidden channel.
at Microsoft.MediaCenter.Guide.MergedChannel.AddChannelListings(Channel csiChannel)
at epg123Client.WmcStore.SubscribeLineupChannel(Int64 lineupChannelId, Int64 mergedChannelId)
[2022-06-20 08:56:22] [ INFO] Completed the automatch of lineup stations to tuner channels.
[2022-06-20 08:56:22] [ INFO] Completed lineup refresh.
[2022-06-20 08:56:22] Entering RunWmcIndexTask(PvrScheduleTask)
[2022-06-20 08:56:22] [ INFO] SUCCESS: Attempted to run the scheduled task "Microsoft\Windows\Media Center\PvrScheduleTask".
[2022-06-20 08:56:22] [ INFO] Successfully started the PvrScheduleTask task. Exit code: 0
[2022-06-20 08:56:22] Exiting RunWmcIndexTask(PvrScheduleTask). SUCCESS.
[2022-06-20 08:56:22] Entering RunWmcIndexTask(ReindexSearchRoot)
[2022-06-20 08:56:22] [ INFO] SUCCESS: Attempted to run the scheduled task "Microsoft\Windows\Media Center\ReindexSearchRoot".
[2022-06-20 08:56:22] [ INFO] Successfully started the ReindexSearchRoot task. Exit code: 0
[2022-06-20 08:56:22] Exiting RunWmcIndexTask(ReindexSearchRoot). SUCCESS.
[2022-06-20 08:56:22] [ INFO] MXF file was created on 2022-06-20 08:55:10
[2022-06-20 08:56:22] [ INFO] Completed EPG123 client execution.
[2022-06-20 08:56:22] [ INFO] EPG123 client execution time was 00:00:53.7296888.

KevinRush

Posts: 52
Joined: Tue Aug 20, 2013 2:59 pm
Location:

HTPC Specs: Show details

#4

Post by KevinRush » Thu Feb 01, 2024 5:41 pm

Was the solution ever found? I'm having this problem.

User avatar
Beitie

Posts: 27
Joined: Mon Jul 20, 2015 7:08 pm
Location:

HTPC Specs: Show details

#5

Post by Beitie » Tue Mar 05, 2024 1:00 am

Mine is giving an error saying that the Schedules Direct file is 72 hours old.
[3/4/2024 6:51:49 PM] [ERROR] The MXF file imported is 72.33 hours old.

User avatar
garyan2

Posts: 7438
Joined: Fri Nov 27, 2015 7:23 pm
Location:

HTPC Specs: Show details

#6

Post by garyan2 » Tue Mar 05, 2024 3:24 am

There are going to be errors prior to that entry when it tried to create the mxf file. That is what you need to look at.
- Gary
Keeping WMC alive beyond January 2020. https://garyan2.github.io

User avatar
Beitie

Posts: 27
Joined: Mon Jul 20, 2015 7:08 pm
Location:

HTPC Specs: Show details

#7

Post by Beitie » Thu Mar 07, 2024 11:56 pm

[3/2/2024 9:12:48 PM] [ INFO] SD responded with error code: 9009 , message: Failed to get new token. Review the local server.log file for SD response details. , serverID: Beities-HTPC , datetime: 2024-03-03T03:12:48Z
[3/2/2024 9:12:48 PM] [ INFO] ***** The EPG123 Server service could not obtain a token from Schedules Direct. View the server.log file for details.
[3/2/2024 9:12:48 PM] [ERROR] Did not receive a response from EPG123 Server for a token request.
[3/2/2024 9:12:49 PM] [ERROR] Failed to login to Schedules Direct. Aborting update.
[3/2/2024 9:12:49 PM] [ERROR] Failed to create MXF file. Exiting.
Looks like my problem started here. I've never had this issue before.

User avatar
garyan2

Posts: 7438
Joined: Fri Nov 27, 2015 7:23 pm
Location:

HTPC Specs: Show details

#8

Post by garyan2 » Fri Mar 08, 2024 12:40 am

Did you look at the server.log file?
- Gary
Keeping WMC alive beyond January 2020. https://garyan2.github.io

User avatar
Beitie

Posts: 27
Joined: Mon Jul 20, 2015 7:08 pm
Location:

HTPC Specs: Show details

#9

Post by Beitie » Fri Mar 08, 2024 3:38 am

I'm software illiterate and do not understand how to do that. 😔
---------
Update, I searched and learned.

Code: Select all

[3/7/2024 6:08:24 PM] [ INFO] Starting EPG123 Server service ...
[3/7/2024 6:08:24 PM] [ INFO] BaseApi: https://json.schedulesdirect.org/20141201/ , BaseArtwork: https://json.schedulesdirect.org/20141201/ , Debug: False
[3/7/2024 6:08:24 PM] [ INFO] HTTP request exception thrown. Message: One or more errors occurred.  An error occurred while sending the request.  The underlying connection was closed: Could not establish trust relationship for the SSL/TLS secure channel.  The remote certificate is invalid according to the validation procedure. 
[3/7/2024 6:08:24 PM] [ERROR] Did not receive a response from Schedules Direct for a token request.
[3/7/2024 6:08:24 PM] [ INFO] UDP Server initialized.
[3/7/2024 6:08:24 PM] [ INFO] File server initialized with 4 worker threads.
[3/7/2024 6:08:24 PM] [ INFO] Image server initialized with 12 worker threads.
[3/7/2024 6:08:24 PM] [ INFO] EPG123 Server service completed initializations.
[3/7/2024 6:09:04 PM] [ INFO] HTTP request exception thrown. Message: One or more errors occurred.  An error occurred while sending the request.  The underlying connection was closed: Could not establish trust relationship for the SSL/TLS secure channel.  The remote certificate is invalid according to the validation procedure. 
[3/7/2024 6:09:04 PM] [ERROR] Did not receive a response from Schedules Direct for a token request.
[3/7/2024 6:10:09 PM] [ INFO] HTTP request exception thrown. Message: One or more errors occurred.  An error occurred while sending the request.  The underlying connection was closed: Could not establish trust relationship for the SSL/TLS secure channel.  The remote certificate is invalid according to the validation procedure. 
[3/7/2024 6:10:09 PM] [ERROR] Did not receive a response from Schedules Direct for a token request.
[3/7/2024 6:32:01 PM] [ INFO] HTTP request exception thrown. Message: One or more errors occurred.  An error occurred while sending the request.  The underlying connection was closed: Could not establish trust relationship for the SSL/TLS secure channel.  The remote certificate is invalid according to the validation procedure. 
[3/7/2024 6:32:01 PM] [ERROR] Did not receive a response from Schedules Direct for a token request.

User avatar
garyan2

Posts: 7438
Joined: Fri Nov 27, 2015 7:23 pm
Location:

HTPC Specs: Show details

#10

Post by garyan2 » Fri Mar 08, 2024 2:45 pm

Did something change on your Windows OS? You are failing to negotiate TLS1.2 with the Schedules Direct server. Any updates just prior to this problem showing up?
- Gary
Keeping WMC alive beyond January 2020. https://garyan2.github.io

User avatar
Beitie

Posts: 27
Joined: Mon Jul 20, 2015 7:08 pm
Location:

HTPC Specs: Show details

#11

Post by Beitie » Sat Mar 09, 2024 2:05 am

Nope, no updates that I'm aware of. Running Windows 7 64 Bit.

User avatar
garyan2

Posts: 7438
Joined: Fri Nov 27, 2015 7:23 pm
Location:

HTPC Specs: Show details

#12

Post by garyan2 » Sat Mar 09, 2024 3:26 am

Okay, I just published a beta release (v1.8.2.10). This tries to force using TLS1.2 which may/may not work to address this issue. A couple of users have seen this in the past and it has evidently resolved itself without any idea why.
- Gary
Keeping WMC alive beyond January 2020. https://garyan2.github.io

User avatar
Beitie

Posts: 27
Joined: Mon Jul 20, 2015 7:08 pm
Location:

HTPC Specs: Show details

#13

Post by Beitie » Sat Mar 09, 2024 4:38 am

I downloaded the new beta. As soon as I enter in my user name and password in the program, I get the token error pop up window. So I un installed, restarted Windows, re-installed, and re entered my log in info. Same token error. I then logged into Schedules Direct on the web page, and noticed that my username had a slight discrepancy, where my first letter was not capitalized. Is it possible that SD has my IP blocked for failed log in?

Code: Select all

[3/8/2024 10:22:26 PM] [ INFO] Starting EPG123 Server service ...
[3/8/2024 10:22:26 PM] [ INFO] BaseApi: https://json.schedulesdirect.org/20141201/ , BaseArtwork: https://json.schedulesdirect.org/20141201/ , Debug: False
[3/8/2024 10:22:49 PM] [ INFO] HTTP request exception thrown. Message: One or more errors occurred.  An error occurred while sending the request.  The underlying connection was closed: Could not establish trust relationship for the SSL/TLS secure channel.  The remote certificate is invalid according to the validation procedure. 
[3/8/2024 10:22:49 PM] [ERROR] Did not receive a response from Schedules Direct for a token request.
[3/8/2024 10:22:49 PM] [ INFO] UDP Server initialized.
[3/8/2024 10:22:49 PM] [ INFO] File server initialized with 4 worker threads.
[3/8/2024 10:22:49 PM] [ INFO] Image server initialized with 12 worker threads.
[3/8/2024 10:22:49 PM] [ INFO] EPG123 Server service completed initializations.
[3/8/2024 10:23:13 PM] [ INFO] HTTP request exception thrown. Message: One or more errors occurred.  An error occurred while sending the request.  The underlying connection was closed: Could not establish trust relationship for the SSL/TLS secure channel.  The remote certificate is invalid according to the validation procedure. 
[3/8/2024 10:23:13 PM] [ERROR] Did not receive a response from Schedules Direct for a token request.
[3/8/2024 10:25:32 PM] [ INFO] HTTP request exception thrown. Message: One or more errors occurred.  An error occurred while sending the request.  The underlying connection was closed: Could not establish trust relationship for the SSL/TLS secure channel.  The remote certificate is invalid according to the validation procedure. 
[3/8/2024 10:25:32 PM] [ERROR] Did not receive a response from Schedules Direct for a token request.

User avatar
garyan2

Posts: 7438
Joined: Fri Nov 27, 2015 7:23 pm
Location:

HTPC Specs: Show details

#14

Post by garyan2 » Sat Mar 09, 2024 3:14 pm

In a way, I'm glad it didn't change anything. Trying to force TLS1.2 from the client is not optimal. The TLS connection is mainly driven by the OS and the installed .NET Framework and using the client to force a connection means it won't be future proof as new standards come out.

One very simple thing to check is the clock on the OS. Perform a time sync and see if it then starts working. This may explain why this error sometimes appears and then magically disappears for some users.
- Gary
Keeping WMC alive beyond January 2020. https://garyan2.github.io

User avatar
Beitie

Posts: 27
Joined: Mon Jul 20, 2015 7:08 pm
Location:

HTPC Specs: Show details

#15

Post by Beitie » Sat Mar 09, 2024 10:14 pm

It's true that my clock does tend to wander. I performed the re-sync as suggested (4:07pm updated to 4:09pm). However, as soon as I started up the Configuration program, I got the Token error again. :(

User avatar
garyan2

Posts: 7438
Joined: Fri Nov 27, 2015 7:23 pm
Location:

HTPC Specs: Show details

#16

Post by garyan2 » Sun Mar 10, 2024 4:21 am

What version of .NET Framework do you have installed? Any updates available for it? Managing the secure connection is done by .NET and the OS.

EDIT: Also, open a browser and go to https://json.schedulesdirect.org/201412 ... /languages and make sure your browser can setup a secure connection.
- Gary
Keeping WMC alive beyond January 2020. https://garyan2.github.io

User avatar
Beitie

Posts: 27
Joined: Mon Jul 20, 2015 7:08 pm
Location:

HTPC Specs: Show details

#17

Post by Beitie » Sun Mar 10, 2024 6:56 pm

.NET Framework 4.8 is installed. I was ale to view the linked website.

I have been using the EPG123, and SD pretty much ever since Windows dropped EPG support.

User avatar
garyan2

Posts: 7438
Joined: Fri Nov 27, 2015 7:23 pm
Location:

HTPC Specs: Show details

#18

Post by garyan2 » Sun Mar 10, 2024 8:29 pm

Download the portable version of EPG123 and extract into a temp folder. Run the epg123_gui.exe file and try to login. This will tell us if it is limited to a specific exe file or not... they use the exact same dll file so should behave the same.
- Gary
Keeping WMC alive beyond January 2020. https://garyan2.github.io

User avatar
Beitie

Posts: 27
Joined: Mon Jul 20, 2015 7:08 pm
Location:

HTPC Specs: Show details

#19

Post by Beitie » Thu Mar 14, 2024 1:55 am

Okay, sorry for the delay. I was able to try this today. When I opened the 1.8.2.9.gui in my temp folder, I was able to log in. I also re-synced the clock before logging in. So since it seemed to work, I exited out, and logged in with the 1.8.2.10 that I still had fully installed. I was able to log in there as well. So I restarted Windows, and ran an update. It seemed to work, but showed some warnings as well.

Code: Select all

[3/13/2024 8:40:16 PM] =====================================================================================
[3/13/2024 8:40:16 PM] EPG123_GUI: Activating the configuration GUI. version 1.8.2.10
[3/13/2024 8:40:16 PM] =====================================================================================
[3/13/2024 8:40:16 PM] *** Windows 7 Home Premium, 64-bit [Version: 6.1.7601.24544] ***
[3/13/2024 8:40:16 PM] *** .NET Framework 4.8.03761 is installed. ***
[3/13/2024 8:40:17 PM] [ INFO] Successfully downloaded configuration file from http://localhost:9009/epg123/epg123.cfg.
[3/13/2024 8:40:17 PM] [ INFO] Successfully queried the Task Scheduler for status. No task is schedule to run.
[3/13/2024 8:40:18 PM] [ INFO] Token refresh successful. serverID: Beities-HTPC , datetime: 2024-03-14T01:40:18Z
[3/13/2024 8:40:18 PM] [ INFO] Status request successful. account expires: 2024-11-10T17:37:53Z , lineups: 1/4 , lastDataUpdate: 2024-03-14T01:33:09Z
[3/13/2024 8:40:18 PM] [ INFO] System status: Online , message: No known issues.
[3/13/2024 8:40:18 PM] [ INFO] Successfully requested listing of subscribed lineups from Schedules Direct.
[3/13/2024 8:40:18 PM] [ INFO] Successfully retrieved the station mapping for lineup USA-OTA-56001. (108 stations; 108 channels)
[3/13/2024 8:41:08 PM] =====================================================================================
[3/13/2024 8:41:08 PM] EPG123CLIENT: Activating the client GUI. version 1.8.2.10
[3/13/2024 8:41:08 PM] =====================================================================================
[3/13/2024 8:41:08 PM] *** Windows 7 Home Premium, 64-bit [Version: 6.1.7601.24544] ***
[3/13/2024 8:41:08 PM] *** .NET Framework 4.8.03761 is installed. ***
[3/13/2024 8:41:08 PM] *** Windows Media Center [Version: 6.1.7600.16385] is installed. ***
[3/13/2024 8:41:08 PM] [ INFO] Successfully queried the Task Scheduler for status. No task is schedule to run.
[3/13/2024 8:41:17 PM] [ INFO] Successfully wrote task xml file for import when running without elevated rights.
[3/13/2024 8:41:22 PM] =====================================================================================
[3/13/2024 8:41:22 PM] EPG123CLIENT: Activating the client GUI. version 1.8.2.10
[3/13/2024 8:41:22 PM] =====================================================================================
[3/13/2024 8:41:22 PM] *** Windows 7 Home Premium, 64-bit [Version: 6.1.7601.24544] ***
[3/13/2024 8:41:22 PM] *** .NET Framework 4.8.03761 is installed. ***
[3/13/2024 8:41:22 PM] *** Windows Media Center [Version: 6.1.7600.16385] is installed. ***
[3/13/2024 8:41:22 PM] [ INFO] Successfully queried the Task Scheduler for status. No task is schedule to run.
[3/13/2024 8:41:22 PM] [ INFO] Successfully imported the daily task into Task Scheduler.
[3/13/2024 8:41:22 PM] [ INFO] Successfully queried the Task Scheduler for status. Ready. The task has not yet run. 
[3/13/2024 8:45:39 PM] =====================================================================================
[3/13/2024 8:45:39 PM] EPG123: Beginning MXF and XMLTV file updates. version 1.8.2.10
[3/13/2024 8:45:39 PM] =====================================================================================
[3/13/2024 8:45:39 PM] *** Windows 7 Home Premium, 64-bit [Version: 6.1.7601.24544] ***
[3/13/2024 8:45:39 PM] *** .NET Framework 4.8.03761 is installed. ***
[3/13/2024 8:45:40 PM] [ INFO] DaysToDownload: 14 , TheTVDBNumbers : True , PrefixEpisodeTitle: False , PrefixEpisodeDescription : False , AppendEpisodeDesc: False , OADOverride : True , SeasonEventImages : True , IncludeSDLogos : True , AutoAddNew: True , CreateXmltv: False
[3/13/2024 8:45:40 PM] [WARNG] The "EPG123 Server" service is not running. Program images and remote client downloads will not be available.
[3/13/2024 8:45:42 PM] [ INFO] Token request successful. serverID: 20141201.web , datetime: 2024-03-14T01:45:42Z
[3/13/2024 8:45:42 PM] [ INFO] Status request successful. account expires: 2024-11-10T17:37:53Z , lineups: 1/4 , lastDataUpdate: 2024-03-14T01:42:49Z
[3/13/2024 8:45:42 PM] [ INFO] System status: Online , message: No known issues.
[3/13/2024 8:45:43 PM] [ INFO] Successfully requested listing of subscribed lineups from Schedules Direct.
[3/13/2024 8:45:43 PM] Entering BuildLineupServices() for 1 lineups.
[3/13/2024 8:45:43 PM] [ INFO] Successfully retrieved the station mapping for lineup USA-OTA-56001. (108 stations; 108 channels)
[3/13/2024 8:45:44 PM] Exiting BuildLineupServices(). SUCCESS.
[3/13/2024 8:45:44 PM] Entering GetAllScheduleEntryMd5s() for 14 days on 68 stations.
[3/13/2024 8:45:44 PM] [ INFO] Successfully retrieved Md5s for 68/68 stations' daily schedules. (0:00:00:00.7100010)
[3/13/2024 8:45:48 PM] [ INFO] Successfully retrieved 68 stations' daily schedules. (0:00:00:04.0410057)
[3/13/2024 8:45:51 PM] [ INFO] Found 0 cached daily schedules.
[3/13/2024 8:45:51 PM] [ INFO] Downloaded 952 daily schedules.
[3/13/2024 8:45:52 PM] [ INFO] Processed 952 daily schedules for 68 stations for average of 14.0 days per station.
[3/13/2024 8:45:52 PM] Exiting GetAllScheduleEntryMd5s(). SUCCESS.
[3/13/2024 8:45:52 PM] Entering BuildAllProgramEntries() for 10411 programs.
[3/13/2024 8:45:52 PM] [ INFO] Found 0 cached program descriptions.
[3/13/2024 8:45:56 PM] [ INFO] Successfully retrieved 1250/1250 program descriptions. (0:00:00:03.7500052)
[3/13/2024 8:45:56 PM] [ INFO] Successfully retrieved 1250/1250 program descriptions. (0:00:00:04.3300060)
[3/13/2024 8:45:57 PM] [ INFO] Successfully retrieved 1250/1250 program descriptions. (0:00:00:04.5100063)
[3/13/2024 8:45:57 PM] [ INFO] Successfully retrieved 1250/1250 program descriptions. (0:00:00:04.5200063)
[3/13/2024 8:46:00 PM] [ INFO] Successfully retrieved 1250/1250 program descriptions. (0:00:00:03.9700056)
[3/13/2024 8:46:00 PM] [ INFO] Successfully retrieved 1250/1250 program descriptions. (0:00:00:03.6900052)
[3/13/2024 8:46:01 PM] [ INFO] Successfully retrieved 1250/1250 program descriptions. (0:00:00:03.9500055)
[3/13/2024 8:46:01 PM] [ INFO] Successfully retrieved 1250/1250 program descriptions. (0:00:00:04.1400058)
[3/13/2024 8:46:01 PM] [ INFO] Successfully retrieved 411/411 program descriptions. (0:00:00:01.3700019)
[3/13/2024 8:46:07 PM] Exiting BuildAllProgramEntries(). SUCCESS.
[3/13/2024 8:46:07 PM] Entering BuildAllGenericSeriesInfoDescriptions() for 1643 series.
[3/13/2024 8:46:07 PM] [ INFO] Found 795 cached/unavailable series descriptions.
[3/13/2024 8:46:08 PM] [ INFO] Successfully retrieved 125/125 generic program descriptions. (0:00:00:00.3900006)
[3/13/2024 8:46:08 PM] [ INFO] Successfully retrieved 125/125 generic program descriptions. (0:00:00:00.4000006)
[3/13/2024 8:46:08 PM] [ INFO] Successfully retrieved 125/125 generic program descriptions. (0:00:00:00.4300006)
[3/13/2024 8:46:08 PM] [ INFO] Successfully retrieved 125/125 generic program descriptions. (0:00:00:00.4700007)
[3/13/2024 8:46:08 PM] [ INFO] Successfully retrieved 98/98 generic program descriptions. (0:00:00:00.3500005)
[3/13/2024 8:46:08 PM] [ INFO] Successfully retrieved 125/125 generic program descriptions. (0:00:00:00.3900006)
[3/13/2024 8:46:08 PM] [ INFO] Successfully retrieved 125/125 generic program descriptions. (0:00:00:00.4100006)
[3/13/2024 8:46:08 PM] Exiting BuildAllGenericSeriesInfoDescriptions(). SUCCESS.
[3/13/2024 8:46:08 PM] Entering GetAllMoviePosters() for 259 movies.
[3/13/2024 8:46:08 PM] [ INFO] Found 0 cached/unavailable movie poster links.
[3/13/2024 8:46:08 PM] [ INFO] Successfully retrieved artwork info for 9/9 programs. (0:00:00:00.0900001)
[3/13/2024 8:46:09 PM] [ INFO] Successfully retrieved artwork info for 125/125 programs. (0:00:00:00.2700003)
[3/13/2024 8:46:09 PM] [ INFO] Successfully retrieved artwork info for 125/125 programs. (0:00:00:00.2700003)
[3/13/2024 8:46:09 PM] [ INFO] TMDb catalog search for "Four Frightened People" from 1934 found 1 results.
[3/13/2024 8:46:09 PM] [ INFO] TMDb catalog search for "Arise, My Love" from 1940 found 1 results.
[3/13/2024 8:46:09 PM] [ INFO] TMDb catalog search for "We're Not Dressing" from 1934 found 1 results.
[3/13/2024 8:46:09 PM] [ INFO] TMDb catalog search for "Supernatural" from 1933 found 1 results.
[3/13/2024 8:46:09 PM] [ INFO] TMDb catalog search for "The Beatles Explosion" from 0 found 1 results.
[3/13/2024 8:46:09 PM] Exiting GetAllMoviePosters(). SUCCESS.
[3/13/2024 8:46:09 PM] Entering GetAllSeriesImages() for 1643 series.
[3/13/2024 8:46:09 PM] [ INFO] Found 0 cached/unavailable series image links.
[3/13/2024 8:46:09 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2024-03-14T01:46:09Z
[3/13/2024 8:46:09 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2024-03-14T01:46:09Z
[3/13/2024 8:46:09 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2024-03-14T01:46:09Z
[3/13/2024 8:46:09 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2024-03-14T01:46:09Z
[3/13/2024 8:46:09 PM] [ INFO] Did not receive a response from Schedules Direct for artwork info of 125 programs. (0:00:00:00.0900001)
[3/13/2024 8:46:09 PM] [ INFO] Did not receive a response from Schedules Direct for artwork info of 125 programs. (0:00:00:00.0900001)
[3/13/2024 8:46:09 PM] [ INFO] Did not receive a response from Schedules Direct for artwork info of 125 programs. (0:00:00:00.1000001)
[3/13/2024 8:46:09 PM] [ INFO] Did not receive a response from Schedules Direct for artwork info of 125 programs. (0:00:00:00.1100002)
[3/13/2024 8:46:10 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2024-03-14T01:46:09Z
[3/13/2024 8:46:10 PM] [ INFO] Did not receive a response from Schedules Direct for artwork info of 125 programs. (0:00:00:00.1500002)
[3/13/2024 8:46:10 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2024-03-14T01:46:09Z
[3/13/2024 8:46:10 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2024-03-14T01:46:09Z
[3/13/2024 8:46:10 PM] [ INFO] Did not receive a response from Schedules Direct for artwork info of 125 programs. (0:00:00:00.1700002)
[3/13/2024 8:46:10 PM] [ INFO] Did not receive a response from Schedules Direct for artwork info of 125 programs. (0:00:00:00.1900002)
[3/13/2024 8:46:10 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2024-03-14T01:46:09Z
[3/13/2024 8:46:10 PM] [ INFO] Did not receive a response from Schedules Direct for artwork info of 125 programs. (0:00:00:00.1700002)
[3/13/2024 8:46:10 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2024-03-14T01:46:09Z
[3/13/2024 8:46:10 PM] [ INFO] Did not receive a response from Schedules Direct for artwork info of 125 programs. (0:00:00:00.1600002)
[3/13/2024 8:46:10 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2024-03-14T01:46:09Z
[3/13/2024 8:46:10 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2024-03-14T01:46:09Z
[3/13/2024 8:46:10 PM] [ INFO] Did not receive a response from Schedules Direct for artwork info of 125 programs. (0:00:00:00.1600002)
[3/13/2024 8:46:10 PM] [ INFO] Did not receive a response from Schedules Direct for artwork info of 125 programs. (0:00:00:00.1700002)
[3/13/2024 8:46:10 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2024-03-14T01:46:09Z
[3/13/2024 8:46:10 PM] [ INFO] Did not receive a response from Schedules Direct for artwork info of 125 programs. (0:00:00:00.1700002)
[3/13/2024 8:46:10 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2024-03-14T01:46:09Z
[3/13/2024 8:46:10 PM] [ INFO] Did not receive a response from Schedules Direct for artwork info of 125 programs. (0:00:00:00.1610003)
[3/13/2024 8:46:10 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2024-03-14T01:46:10Z
[3/13/2024 8:46:10 PM] [ INFO] Did not receive a response from Schedules Direct for artwork info of 18 programs. (0:00:00:00.1600003)
[3/13/2024 8:46:10 PM] [WARNG] Failed to download and process 1643 series image links.
[3/13/2024 8:46:10 PM] Exiting GetAllSeriesImages(). SUCCESS.
[3/13/2024 8:46:10 PM] Entering GetAllSeasonImages() for 1434 seasons.
[3/13/2024 8:46:10 PM] [ INFO] Found 593 cached/unavailable season image links.
[3/13/2024 8:46:10 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2024-03-14T01:46:10Z
[3/13/2024 8:46:10 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2024-03-14T01:46:10Z
[3/13/2024 8:46:10 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2024-03-14T01:46:10Z
[3/13/2024 8:46:10 PM] [ INFO] Did not receive a response from Schedules Direct for artwork info of 125 programs. (0:00:00:00.1600003)
[3/13/2024 8:46:10 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2024-03-14T01:46:10Z
[3/13/2024 8:46:10 PM] [ INFO] Did not receive a response from Schedules Direct for artwork info of 125 programs. (0:00:00:00.1700003)
[3/13/2024 8:46:10 PM] [ INFO] Did not receive a response from Schedules Direct for artwork info of 125 programs. (0:00:00:00.1800003)
[3/13/2024 8:46:10 PM] [ INFO] Did not receive a response from Schedules Direct for artwork info of 125 programs. (0:00:00:00.1900003)
[3/13/2024 8:46:10 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2024-03-14T01:46:10Z
[3/13/2024 8:46:10 PM] [ INFO] Did not receive a response from Schedules Direct for artwork info of 125 programs. (0:00:00:00.1600002)
[3/13/2024 8:46:10 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2024-03-14T01:46:10Z
[3/13/2024 8:46:10 PM] [ INFO] Did not receive a response from Schedules Direct for artwork info of 125 programs. (0:00:00:00.1600002)
[3/13/2024 8:46:10 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2024-03-14T01:46:10Z
[3/13/2024 8:46:10 PM] [ INFO] Did not receive a response from Schedules Direct for artwork info of 91 programs. (0:00:00:00.1600003)
[3/13/2024 8:46:11 PM] [WARNG] Failed to download and process 248 season image links.
[3/13/2024 8:46:11 PM] Exiting GetAllSeasonImages(). SUCCESS.
[3/13/2024 8:46:11 PM] Entering GetAllSportsImages() for 328 sports events.
[3/13/2024 8:46:11 PM] [ INFO] Found 0 cached/unavailable sport event image links.
[3/13/2024 8:46:11 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2024-03-14T01:46:10Z
[3/13/2024 8:46:11 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2024-03-14T01:46:10Z
[3/13/2024 8:46:11 PM] [ INFO] Did not receive a response from Schedules Direct for artwork info of 125 programs. (0:00:00:00.1600002)
[3/13/2024 8:46:11 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2024-03-14T01:46:10Z
[3/13/2024 8:46:11 PM] [ INFO] Did not receive a response from Schedules Direct for artwork info of 125 programs. (0:00:00:00.1700003)
[3/13/2024 8:46:11 PM] [ INFO] Did not receive a response from Schedules Direct for artwork info of 78 programs. (0:00:00:00.1800003)
[3/13/2024 8:46:11 PM] [WARNG] Failed to download and process 328 sport event image links.
[3/13/2024 8:46:11 PM] Exiting GetAllSportsImages(). SUCCESS.
[3/13/2024 8:46:11 PM] [ INFO] Completed compiling keywords and keyword groups.
[3/13/2024 8:46:11 PM] [ INFO] 0 entries deleted from the cache file during cleanup.
[3/13/2024 8:46:13 PM] [ INFO] Completed save of the MXF file to "C:\ProgramData\GaRyan2\epg123\output\epg123.mxf". (14.567 MB)
[3/13/2024 8:46:13 PM] [ INFO] Generated MXF file contains 68 services, 1643 series, 1434 seasons, 10411 programs, 28878 schedule entries, and 20784 people with 295 image links.
[3/13/2024 8:46:13 PM] [ INFO] Completed EPG123 update execution. SUCCESS.
[3/13/2024 8:46:13 PM] [ INFO] EPG123 update execution time was 00:00:33.2030467.
[3/13/2024 8:46:15 PM] =====================================================================================
[3/13/2024 8:46:15 PM] EPG123CLIENT: Beginning MXF file import. version 1.8.2.10
[3/13/2024 8:46:15 PM] =====================================================================================
[3/13/2024 8:46:15 PM] *** Windows 7 Home Premium, 64-bit [Version: 6.1.7601.24544] ***
[3/13/2024 8:46:15 PM] *** .NET Framework 4.8.03761 is installed. ***
[3/13/2024 8:46:15 PM] *** Windows Media Center [Version: 6.1.7600.16385] is installed. ***
[3/13/2024 8:46:15 PM] [ INFO] Import: True , Match: False , NoLogo: False , Force: False , ShowProgress: False , NoGC: True , NoVerify: False , Verbose: False
[3/13/2024 8:46:15 PM] Entering ImportMxfFile() for file "C:\ProgramData\GaRyan2\epg123\output\epg123.mxf".
[3/13/2024 8:46:16 PM] [ INFO] MXF file was created on 3/13/2024 8:45:42 PM -05:00
[3/13/2024 8:46:16 PM] [WARNG] There was a WARNING generated during the MXF file creation.
[3/13/2024 8:46:16 PM] [WARNG] ACTION: Review trace.log file to determine cause of warning during MXF file creation within last 24 hours.
[3/13/2024 8:46:52 PM] [ INFO] Successfully imported .mxf file into Media Center database. Exit code: 0
[3/13/2024 8:46:52 PM] Exiting ImportMxfFile(). SUCCESS.
[3/13/2024 8:46:52 PM] Entering VerifyLoad()
[3/13/2024 8:46:57 PM] [ INFO] Checked 28878 entries and corrected 5 of them.
[3/13/2024 8:46:57 PM] Exiting VerifyLoad()
[3/13/2024 8:46:57 PM] [ INFO] Completed lineup refresh.
[3/13/2024 8:46:57 PM] Entering ReindexDatabase()
[3/13/2024 8:46:57 PM] [ INFO] SUCCESS: WMC database indexing has started.
[3/13/2024 8:46:57 PM] Exiting ReindexDatabase(). SUCCESS.
[3/13/2024 8:46:59 PM] [ INFO] Completed EPG123 client execution.
[3/13/2024 8:46:59 PM] [ INFO] EPG123 client execution time was 00:00:44.6050628.

User avatar
garyan2

Posts: 7438
Joined: Fri Nov 27, 2015 7:23 pm
Location:

HTPC Specs: Show details

#20

Post by garyan2 » Thu Mar 14, 2024 3:15 am

That wasn't a good update for how it should work. It appears after you rebooted, the server service failed to start.

Code: Select all

[3/13/2024 8:45:40 PM] [WARNG] The "EPG123 Server" service is not running. Program images and remote client downloads will not be available.
You successfully got a token directly from Schedules Direct rather than the service, but your token was invalidated during your update.

Code: Select all

[3/13/2024 8:46:09 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2024-03-14T01:46:09Z
I'm thinking that may have been due to the service finally starting (after reboot) while you were updating. It would have requested a new token; invalidating token being used for the update. Try to run an update again to see if it is clean.
- Gary
Keeping WMC alive beyond January 2020. https://garyan2.github.io

Post Reply