EPG123 Bug Reports

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 ★
Post Reply
User avatar
garyan2

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

HTPC Specs: Show details

#1761

Post by garyan2 » Mon Jun 26, 2023 5:51 pm

This looks like you have multiple servers running and they are fighting each other for a token. There can only be a single token in use at any given time and it is being invalidated when you are running an update. Invalidating can also happen if another server is downloading images from SD; it doesn't have to be during an update.

Sent from my SM-G781U1 using Tapatalk

- Gary
Keeping WMC alive beyond January 2020. https://garyan2.github.io
Top
bw1

Posts: 19
Joined: Fri Dec 23, 2011 10:58 pm
Location:

HTPC Specs: Show details

#1762

Post by bw1 » Mon Jun 26, 2023 6:47 pm

garyan2 wrote: ↑Mon Jun 26, 2023 5:51 pm This looks like you have multiple servers running and they are fighting each other for a token. There can only be a single token in use at any given time and it is being invalidated when you are running an update. Invalidating can also happen if another server is downloading images from SD; it doesn't have to be during an update.

Sent from my SM-G781U1 using Tapatalk
That may have been the case at one time, but I haven't had a second machine running WMC for quite a while.
Top
User avatar
garyan2

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

HTPC Specs: Show details

#1763

Post by garyan2 » Mon Jun 26, 2023 6:59 pm

If you don't have any other program running that interacts with Schedules Direct, are you behind a VPN, or using something that changes your IP address frequently? SD also validates token by IP address.

Sent from my SM-G781U1 using Tapatalk

- Gary
Keeping WMC alive beyond January 2020. https://garyan2.github.io
Top
bw1

Posts: 19
Joined: Fri Dec 23, 2011 10:58 pm
Location:

HTPC Specs: Show details

#1764

Post by bw1 » Mon Jun 26, 2023 11:15 pm

garyan2 wrote: ↑Mon Jun 26, 2023 6:59 pm If you don't have any other program running that interacts with Schedules Direct, are you behind a VPN, or using something that changes your IP address frequently? SD also validates token by IP address.

Sent from my SM-G781U1 using Tapatalk
No VPN.
I recently setup another ISP and a wired router that supports load balancing, so it's possible (probable?) that it could be using 1 or the other IP address assigned by the ISP depending on the connection. However, I'm pretty sure this has been going on for a while, likely longer that I've had this setup.

But since most people don't have static IP addresses, it doesn't seem to be a good idea to expect the same IP address for the same user login credentials.
Top
User avatar
garyan2

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

HTPC Specs: Show details

#1765

Post by garyan2 » Mon Jun 26, 2023 11:31 pm

The token is tied to the IP address, so a different IP address cannot use the same token. So no problem with a user changing an IP address, just they can't use the same token as the other IP address.

Not sure if load balancing would be the cause. The IP address SD will match with the token is the external IP address... unless that is what your ISP/router provides (multiple external IP addresses)?
- Gary
Keeping WMC alive beyond January 2020. https://garyan2.github.io
Top
Space

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

HTPC Specs: Show details

#1766

Post by Space » Tue Jun 27, 2023 2:27 am

If it's load balancing between two different ISP's then it is definitely using two different IP addresses.

Depending on how the router load balances, it could be using different IP addresses between the WMC PC and the SD server for different connections.

You should set up the load balancing so that the source IP or MAC address of your WMC machine always uses the same outbound link so that it always uses the same IP.
Top
bw1

Posts: 19
Joined: Fri Dec 23, 2011 10:58 pm
Location:

HTPC Specs: Show details

#1767

Post by bw1 » Tue Jun 27, 2023 1:41 pm

Space wrote: ↑Tue Jun 27, 2023 2:27 am If it's load balancing between two different ISP's then it is definitely using two different IP addresses.

Depending on how the router load balances, it could be using different IP addresses between the WMC PC and the SD server for different connections.

You should set up the load balancing so that the source IP or MAC address of your WMC machine always uses the same outbound link so that it always uses the same IP.
I can try disconnecting the 2nd WAN until I determine how to set it up to support that.
Top
Space

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

HTPC Specs: Show details

#1768

Post by Space » Tue Jun 27, 2023 11:25 pm

bw1 wrote: ↑Tue Jun 27, 2023 1:41 pm ...
I can try disconnecting the 2nd WAN until I determine how to set it up to support that.
Yes, that would be a good test.

Try it with one link disconnected for a while and see if you have problems, if it is OK then reconnect the second link and see if the problem returns.

There are different ways to do load balancing, there is per-connection, per-host, per-packet, etc. I would think the only method that wouldn't cause an issue with SchedulesDirect would be per-host. With per-host, it always uses the same path between the same two hosts, so all connections will take the same path between them (use the same outbound link).

This might not be what you want as far as load balancing goes, however, as if you only have a few hosts/machines then it may (by chance) never use one of the links (or balance unevenly). This is why I suggested instead to specifically make the WMC machine always use the same outbound link (all the time or just when connecting to the SchedulesDirect server, but that may be difficult if the SD server's IP address changes often or they use rotating IP addresses).
Top
bw1

Posts: 19
Joined: Fri Dec 23, 2011 10:58 pm
Location:

HTPC Specs: Show details

#1769

Post by bw1 » Thu Jun 29, 2023 2:49 pm

Space wrote: ↑Tue Jun 27, 2023 11:25 pm
bw1 wrote: ↑Tue Jun 27, 2023 1:41 pm ...
I can try disconnecting the 2nd WAN until I determine how to set it up to support that.
Yes, that would be a good test.

Try it with one link disconnected for a while and see if you have problems, if it is OK then reconnect the second link and see if the problem returns.

There are different ways to do load balancing, there is per-connection, per-host, per-packet, etc. I would think the only method that wouldn't cause an issue with SchedulesDirect would be per-host. With per-host, it always uses the same path between the same two hosts, so all connections will take the same path between them (use the same outbound link).

This might not be what you want as far as load balancing goes, however, as if you only have a few hosts/machines then it may (by chance) never use one of the links (or balance unevenly). This is why I suggested instead to specifically make the WMC machine always use the same outbound link (all the time or just when connecting to the SchedulesDirect server, but that may be difficult if the SD server's IP address changes often or they use rotating IP addresses).
The last 2 nights epg123 has processed successfully with the 2nd WAN disconnected. I'll try it again with it connected tonight and see if the error returns.
Top
bw1

Posts: 19
Joined: Fri Dec 23, 2011 10:58 pm
Location:

HTPC Specs: Show details

#1770

Post by bw1 » Fri Jun 30, 2023 12:24 pm

Yep, it failed again with the load balancing.

Code: Select all

[6/30/2023 3:33:00 AM] ===============================================================================
[6/30/2023 3:33:00 AM] Beginning EPG123 update execution. version 1.8.0.6
[6/30/2023 3:33:00 AM] ===============================================================================
[6/30/2023 3:33:00 AM] *** Windows 7 Ultimate, 64-bit [Version: 6.1.7601.0] ***
[6/30/2023 3:33:00 AM] *** .NET Framework 4.8.03761 is installed. ***
[6/30/2023 3:33:00 AM] *** Windows Media Center [Version: 6.1.7600.16385] is installed. ***
[6/30/2023 3:33:00 AM] [ INFO] DaysToDownload: 21 , TheTVDBNumbers : True , PrefixEpisodeTitle: True , PrefixEpisodeDescription : False , AppendEpisodeDesc: False , OADOverride : True , SeasonEventImages : True , IncludeSDLogos : True , AutoAddNew: True , CreateXmltv: False
[6/30/2023 3:33:00 AM] [ INFO] Token request successful. serverID: OFFICE-DESKTOP , datetime: 2023-06-29T21:12:13Z
[6/30/2023 3:33:01 AM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2023-06-30T07:33:01Z
[6/30/2023 3:33:01 AM] [ INFO] Validation of cached token failed. Requesting new token.
[6/30/2023 3:33:01 AM] [ INFO] Token refresh successful. serverID: OFFICE-DESKTOP , datetime: 2023-06-30T07:33:02Z
[6/30/2023 3:33:02 AM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2023-06-30T07:33:02Z
[6/30/2023 3:33:02 AM] [ERROR] Did not receive a response from Schedules Direct for a status request.
[6/30/2023 3:33:03 AM] [ INFO] SD responded with error code: 4006 , message: Token has expired. Request new token. , serverID: 20141201.web , datetime: 2023-06-30T07:33:03Z
[6/30/2023 3:33:03 AM] [ERROR] Did not receive a response from Schedules Direct for list of subscribed lineups.
[6/30/2023 3:33:03 AM] [ INFO] EPG123 update execution time was 00:00:02.9871708.
[6/30/2023 3:33:03 AM] [ERROR] Failed to create MXF file. Exiting.
Top
Space

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

HTPC Specs: Show details

#1771

Post by Space » Fri Jun 30, 2023 11:32 pm

I'm curious, what router/firmware are you are using for load balancing?
Top
bw1

Posts: 19
Joined: Fri Dec 23, 2011 10:58 pm
Location:

HTPC Specs: Show details

#1772

Post by bw1 » Sun Jul 02, 2023 11:15 pm

Space wrote: ↑Fri Jun 30, 2023 11:32 pm I'm curious, what router/firmware are you are using for load balancing?
TP-Link ER605

Firmware Version: 2.1.2 Build 20230210 Rel.62992
Top
User avatar
alhaunts

Posts: 66
Joined: Wed Jan 01, 2020 5:45 pm
Location:

HTPC Specs: Show details

#1773

Post by alhaunts » Fri Jul 07, 2023 11:10 am

Got the dreaded red x this morning.

Code: Select all

7/7/2023 4:57:00 AM] ===============================================================================
[7/7/2023 4:57:00 AM] Beginning EPG123 update execution. version 1.8.0.7
[7/7/2023 4:57:00 AM] ===============================================================================
[7/7/2023 4:57:00 AM] *** Windows 7 Professional, 64-bit [Version: 6.1.7601.24544] ***
[7/7/2023 4:57:00 AM] *** .NET Framework 4.8.03761 is installed. ***
[7/7/2023 4:57:00 AM] *** Windows Media Center [Version: 6.1.7600.16385] is installed. ***
[7/7/2023 4:57:00 AM] [ INFO] DaysToDownload: 14 , TheTVDBNumbers : True , PrefixEpisodeTitle: False , PrefixEpisodeDescription : False , AppendEpisodeDesc: False , OADOverride : True , SeasonEventImages : True , IncludeSDLogos : True , AutoAddNew: True , CreateXmltv: False
[7/7/2023 4:57:00 AM] [ INFO] Token request successful. serverID: MainRig , datetime: 2023-07-07T07:57:24Z
[7/7/2023 4:57:06 AM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2023-07-07T08:57:05Z
[7/7/2023 4:57:06 AM] [ INFO] Validation of cached token failed. Requesting new token.
[7/7/2023 4:57:14 AM] [ INFO] Token refresh successful. serverID: MainRig , datetime: 2023-07-07T08:57:13Z
[7/7/2023 4:57:21 AM] [ INFO] Status request successful. account expires: 2023-12-01T16:41:19Z , lineups: 1/4 , lastDataUpdate: 2023-07-07T05:28:58Z
[7/7/2023 4:57:21 AM] [ INFO] System status: Online , message: No known issues.
[7/7/2023 4:57:21 AM] [ INFO] epg123 is not up to date. Latest released version is 1.8.0.8 and can be downloaded from https://github.com/garyan2/epg123/releases/tag/1.8.0.8.
[7/7/2023 4:57:26 AM] [ INFO] Successfully requested listing of subscribed lineups from Schedules Direct.
[7/7/2023 4:57:26 AM] Entering BuildLineupServices() for 1 lineups.
[7/7/2023 4:57:32 AM] [ INFO] Successfully retrieved the station mapping for lineup USA-OTA-14174. (87 stations; 87 channels)
[7/7/2023 4:57:32 AM] Exiting BuildLineupServices(). SUCCESS.
[7/7/2023 4:57:32 AM] Entering GetAllScheduleEntryMd5s() for 14 days on 34 stations.
[7/7/2023 4:58:26 AM] [ INFO] Successfully retrieved Md5s for 34/34 stations' daily schedules. (0:00:00:53.7170498)
[7/7/2023 5:01:06 AM] [ INFO] Successfully retrieved 34 stations' daily schedules. (0:00:02:39.8761734)
[7/7/2023 5:01:07 AM] [ INFO] Found 242 cached daily schedules.
[7/7/2023 5:01:07 AM] [ INFO] Downloaded 234 daily schedules.
[7/7/2023 5:01:07 AM] [ INFO] Processed 476 daily schedules for 34 stations for average of 14.0 days per station.
[7/7/2023 5:01:07 AM] Exiting GetAllScheduleEntryMd5s(). SUCCESS.
[7/7/2023 5:01:07 AM] Entering BuildAllProgramEntries() for 10660 programs.
[7/7/2023 5:01:09 AM] [ INFO] Found 9612 cached program descriptions.
[7/7/2023 5:06:09 AM] [ INFO] HTTP request exception thrown. Message: System.AggregateException: One or more errors occurred. ---> System.Threading.Tasks.TaskCanceledException: A task was canceled.
   --- End of inner exception stack trace ---
   at System.Threading.Tasks.Task`1.GetResultCore(Boolean waitCompletionNotification)
   at GaRyan2.BaseAPI.GetApiResponse[T](Method method, String uri, Object classObject)
---> (Inner Exception #0) System.Threading.Tasks.TaskCanceledException: A task was canceled.<---

[7/7/2023 5:06:09 AM] [ERROR] Did not receive a response from Schedules Direct for 1048 program descriptions. (0:00:05:00.2027028)
[7/7/2023 5:06:09 AM] [WARNG] Failed to download and process 1048 program descriptions.
[7/7/2023 5:06:09 AM] Exiting BuildAllProgramEntries(). SUCCESS.
[7/7/2023 5:06:09 AM] Entering BuildAllGenericSeriesInfoDescriptions() for 1323 series.
[7/7/2023 5:06:09 AM] [ INFO] Found 1323 cached/unavailable series descriptions.
[7/7/2023 5:06:10 AM] Exiting BuildAllGenericSeriesInfoDescriptions(). SUCCESS.
[7/7/2023 5:06:10 AM] Entering GetAllMoviePosters() for 199 movies.
[7/7/2023 5:06:10 AM] [ INFO] Found 199 cached/unavailable movie poster links.
[7/7/2023 5:06:10 AM] Exiting GetAllMoviePosters(). SUCCESS.
[7/7/2023 5:06:10 AM] Entering GetAllSeriesImages() for 1323 series.
[7/7/2023 5:06:10 AM] [ INFO] Found 1270 cached/unavailable series image links.
[7/7/2023 5:06:10 AM] [ INFO] Refreshing 41 series image links.
[7/7/2023 5:06:27 AM] [ INFO] Successfully retrieved artwork info for 53/53 programs. (0:00:00:17.0775998)
[7/7/2023 5:06:27 AM] Exiting GetAllSeriesImages(). SUCCESS.
[7/7/2023 5:06:27 AM] Entering GetAllSeasonImages() for 1405 seasons.
[7/7/2023 5:06:27 AM] [ INFO] Found 1309 cached/unavailable season image links.
[7/7/2023 5:06:49 AM] [ INFO] Successfully retrieved artwork info for 96/96 programs. (0:00:00:21.9720796)
[7/7/2023 5:06:49 AM] Exiting GetAllSeasonImages(). SUCCESS.
[7/7/2023 5:06:49 AM] Entering GetAllSportsImages() for 16 sports events.
[7/7/2023 5:06:49 AM] [ INFO] Found 12 cached/unavailable sport event image links.
[7/7/2023 5:06:55 AM] [ INFO] Successfully retrieved artwork info for 4/4 programs. (0:00:00:05.3164634)
[7/7/2023 5:06:55 AM] Exiting GetAllSportsImages(). SUCCESS.
[7/7/2023 5:06:55 AM] [ INFO] Completed compiling keywords and keyword groups.
[7/7/2023 5:06:55 AM] [ INFO] 1235 entries deleted from the cache file during cleanup.
[7/7/2023 5:06:57 AM] [ INFO] Completed save of the MXF file to "C:\ProgramData\GaRyan2\epg123\output\epg123.mxf". (13.328 MB)
[7/7/2023 5:06:57 AM] [ INFO] Generated MXF file contains 34 services, 1323 series, 1405 seasons, 10660 programs, 16143 schedule entries, and 20621 people with 2218 image links.
[7/7/2023 5:06:57 AM] [ INFO] Completed EPG123 update execution. SUCCESS.
[7/7/2023 5:06:57 AM] [ INFO] EPG123 update execution time was 00:09:56.4177482.
[7/7/2023 5:06:57 AM] ===============================================================================
[7/7/2023 5:06:57 AM]  Beginning epg123 client execution. version 1.8.0.7
[7/7/2023 5:06:57 AM] ===============================================================================
[7/7/2023 5:06:57 AM] *** Windows 7 Professional, 64-bit [Version: 6.1.7601.24544] ***
[7/7/2023 5:06:57 AM] *** .NET Framework 4.8.03761 is installed. ***
[7/7/2023 5:06:57 AM] *** Windows Media Center [Version: 6.1.7600.16385] is installed. ***
[7/7/2023 5:06:57 AM] [ INFO] Import: True , Match: True , NoLogo: False , Force: False , ShowProgress: False , NoGC: False , NoVerify: False , Verbose: False
[7/7/2023 5:06:58 AM] Entering ImportMxfFile() for file "C:\ProgramData\GaRyan2\epg123\output\epg123.mxf".
[7/7/2023 5:07:14 AM] [ INFO] Successfully imported .mxf file into Media Center database. Exit code: 0
[7/7/2023 5:07:14 AM] Exiting ImportMxfFile(). SUCCESS.
[7/7/2023 5:07:14 AM] Entering VerifyLoad()
[7/7/2023 5:07:16 AM] [ INFO] Checked 16143 entries and corrected 4 of them.
[7/7/2023 5:07:16 AM] Exiting VerifyLoad()
[7/7/2023 5:07:16 AM] [ INFO] Completed channel cleanup as needed after MXF file import.
[7/7/2023 5:07:16 AM] [ INFO] Completed the automatic mapping of lineup stations to tuner channels.
[7/7/2023 5:07:16 AM] [ INFO] Completed lineup refresh.
[7/7/2023 5:07:16 AM] Entering RunWmcIndexTask(PvrScheduleTask)
[7/7/2023 5:07:16 AM] [ INFO] SUCCESS: Attempted to run the scheduled task "Microsoft\Windows\Media Center\PvrScheduleTask".
[7/7/2023 5:07:16 AM] [ INFO] Successfully started the PvrScheduleTask task. Exit code: 0
[7/7/2023 5:07:16 AM] Exiting RunWmcIndexTask(PvrScheduleTask). SUCCESS.
[7/7/2023 5:07:16 AM] Entering RunWmcIndexTask(ReindexSearchRoot)
[7/7/2023 5:07:16 AM] [ INFO] SUCCESS: Attempted to run the scheduled task "Microsoft\Windows\Media Center\ReindexSearchRoot".
[7/7/2023 5:07:16 AM] [ INFO] Successfully started the ReindexSearchRoot task. Exit code: 0
[7/7/2023 5:07:16 AM] Exiting RunWmcIndexTask(ReindexSearchRoot). SUCCESS.
[7/7/2023 5:07:17 AM] [ INFO] MXF file was created on 7/7/2023 4:57:21 AM
[7/7/2023 5:07:17 AM] [ERROR] There was an ERROR generated during the MXF file creation.
[7/7/2023 5:07:17 AM] [ INFO] Completed EPG123 client execution.
[7/7/2023 5:07:17 AM] [ INFO] EPG123 client execution time was 00:00:19.9608148.
Is this a problem on SD's end?
Top
byronomo

Posts: 38
Joined: Thu Mar 14, 2013 10:19 am
Location:

HTPC Specs: Show details

#1774

Post by byronomo » Wed Aug 02, 2023 11:25 pm

Hi Gary,

I just upgraded to 1.8.1 and now I cannot login to Schedules Direct.

Screenshot and log attached.

Thanks yet again for all of the support that you provide!
Capture.JPG

Code: Select all

[8/1/2023 4:50:02 AM] ===============================================================================
[8/1/2023 4:50:02 AM]  Beginning epg123 update execution. version 1.7.3.0
[8/1/2023 4:50:02 AM] ===============================================================================
[8/1/2023 4:50:02 AM] *** Windows 10 Professional, 64-bit [Version: 10.0.19045.3208] (22H2) ***
[8/1/2023 4:50:02 AM] *** Windows Media Center is not installed. ***
[8/1/2023 4:50:02 AM] [ INFO] Beginning EPG123 update execution. 2023-08-01 08:50:02Z
[8/1/2023 4:50:02 AM] [ INFO] DaysToDownload: 14 , TheTVDBNumbers : True , PrefixEpisodeTitle: False , PrefixEpisodeDescription : False , AppendEpisodeDesc: False , OADOverride : True , SeasonEventImages : True , TMDbCoverArt: True , IncludeSDLogos : True , AutoAddNew: True , CreateXmltv: False , ModernMediaUiPlusSupport: False
[8/1/2023 4:50:03 AM] [ INFO] Token request successful. serverID: 20141201.web , datetime: 2023-08-01T08:50:03Z
[8/1/2023 4:50:03 AM] [ INFO] Status request successful. account expires: 2024-01-08T19:10:23Z , lineups: 2/4 , lastDataUpdate: 2023-08-01T05:39:14Z
[8/1/2023 4:50:03 AM] [ INFO] System status: Online , message: No known issues.
[8/1/2023 4:50:04 AM] [ INFO] epg123 is not up to date. Latest version is 1.8.1.0 and can be downloaded from https://github.com/garyan2/epg123/releases/tag/1.8.1.0
[8/1/2023 4:50:05 AM] [ INFO] Successfully retrieved TMDb configurations.
[8/1/2023 4:50:05 AM] [ INFO] Successfully requested listing of subscribed lineups from Schedules Direct.
[8/1/2023 4:50:05 AM] Entering BuildLineupServices() for 2 lineups.
[8/1/2023 4:50:06 AM] [ INFO] Successfully retrieved the station mapping for lineup USA-GA61403-X.
[8/1/2023 4:50:06 AM] [ INFO] Successfully retrieved the station mapping for lineup USA-OTA-30024.
[8/1/2023 4:50:07 AM] [ INFO] Stations added for download since last configuration save are: WANFDT8, UP, DPLUSSD, AFRCAHD, STELLAR, GRIOEHD, CHIMETV, EARTHX, FOXWX, UPHD, CARAIHD, WXIADT5, WUPADT7
[8/1/2023 4:50:07 AM] Exiting BuildLineupServices(). SUCCESS.
[8/1/2023 4:50:07 AM] Entering GetAllScheduleEntryMd5s() for 14 days on 159 stations.
[8/1/2023 4:50:07 AM] [ INFO] Successfully retrieved Md5s for  89 stations' daily schedules. (0:00:00:00.5599980)
[8/1/2023 4:50:09 AM] [ INFO] Successfully retrieved  89 stations' daily schedules.          (0:00:00:01.3079996)
[8/1/2023 4:50:10 AM] [ INFO] Successfully retrieved Md5s for  70 stations' daily schedules. (0:00:00:00.4310020)
[8/1/2023 4:50:11 AM] [ INFO] Successfully retrieved  70 stations' daily schedules.          (0:00:00:00.8390010)
[8/1/2023 4:50:12 AM] [ INFO] Found 1765 cached daily schedules.
[8/1/2023 4:50:12 AM] [ INFO] Downloaded 461 daily schedules.
[8/1/2023 4:50:14 AM] [ INFO] Processed 2226 daily schedules for 159 stations for average of 14.0 days per station.
[8/1/2023 4:50:14 AM] Exiting GetAllScheduleEntryMd5s(). SUCCESS.
[8/1/2023 4:50:14 AM] Entering BuildAllProgramEntries() for 29384 programs.
[8/1/2023 4:50:23 AM] [ INFO] Found 27367 cached program descriptions.
[8/1/2023 4:50:25 AM] [ INFO] Successfully retrieved  767 program descriptions. (0:00:00:02.7009993)
[8/1/2023 4:50:27 AM] [ INFO] Successfully retrieved 1250 program descriptions. (0:00:00:04.0669985)
[8/1/2023 4:50:28 AM] Exiting BuildAllProgramEntries(). SUCCESS.
[8/1/2023 4:50:28 AM] Entering BuildAllGenericSeriesInfoDescriptions() for 3850 series.
[8/1/2023 4:50:28 AM] [ INFO] Found 3820 cached/unavailable series descriptions.
[8/1/2023 4:50:28 AM] [ INFO] Successfully retrieved  30 generic program descriptions. (0:00:00:00.1039988)
[8/1/2023 4:50:29 AM] Exiting BuildAllGenericSeriesInfoDescriptions(). SUCCESS.
[8/1/2023 4:50:29 AM] Entering GetAllMoviePosters() for 1744 movies.
[8/1/2023 4:50:29 AM] [ INFO] Found 1664 cached/unavailable movie poster links.
[8/1/2023 4:50:29 AM] [ INFO] Successfully retrieved artwork info for  80 programs. (0:00:00:00.2490003)
[8/1/2023 4:50:29 AM] Exiting GetAllMoviePosters(). SUCCESS.
[8/1/2023 4:50:29 AM] Entering GetAllSeriesImages() for 3850 series.
[8/1/2023 4:50:29 AM] [ INFO] Found 3605 cached/unavailable series image links.
[8/1/2023 4:50:29 AM] [ INFO] Refreshing 136 series image links.
[8/1/2023 4:50:30 AM] [ INFO] Successfully retrieved artwork info for 125 programs. (0:00:00:00.2629999)
[8/1/2023 4:50:30 AM] [ INFO] Successfully retrieved artwork info for 120 programs. (0:00:00:00.2879985)
[8/1/2023 4:50:30 AM] Exiting GetAllSeriesImages(). SUCCESS.
[8/1/2023 4:50:30 AM] Entering GetAllSeasonImages() for 3378 seasons.
[8/1/2023 4:50:30 AM] [ INFO] Found 3208 cached/unavailable season image links.
[8/1/2023 4:50:30 AM] [ INFO] Successfully retrieved artwork info for  45 programs. (0:00:00:00.1770001)
[8/1/2023 4:50:30 AM] [ INFO] Successfully retrieved artwork info for 125 programs. (0:00:00:00.2669997)
[8/1/2023 4:50:30 AM] Exiting GetAllSeasonImages(). SUCCESS.
[8/1/2023 4:50:30 AM] Entering GetAllSportsImages() for 152 sports events.
[8/1/2023 4:50:30 AM] [ INFO] Found 124 cached/unavailable sport event image links.
[8/1/2023 4:50:31 AM] [ INFO] Successfully retrieved artwork info for  28 programs. (0:00:00:00.0880004)
[8/1/2023 4:50:31 AM] Exiting GetAllSportsImages(). SUCCESS.
[8/1/2023 4:50:31 AM] [ INFO] Completed compiling keywords and keyword groups.
[8/1/2023 4:50:31 AM] [ INFO] Downloaded and processed 11.102 MB of data from Schedules Direct.
[8/1/2023 4:50:32 AM] [ INFO] Completed save of the MXF file to "C:\ProgramData\GaRyan2\epg123\output\epg123.mxf". (44.329 MB)
[8/1/2023 4:50:32 AM] [ INFO] Generated .mxf file contains 159 services, 3850 series, 3378 seasons, 29384 programs, 61066 schedule entries, and 50536 people with 7834 image links.
[8/1/2023 4:50:32 AM] [ INFO] 2905 entries deleted from the cache file during cleanup.
[8/1/2023 4:50:34 AM] [ INFO] Completed EPG123 update execution. SUCCESS.
[8/1/2023 4:50:34 AM] [ INFO] epg123 update execution time was 00:00:31.8740014.
[8/2/2023 4:50:08 AM] ===============================================================================
[8/2/2023 4:50:08 AM]  Beginning epg123 update execution. version 1.7.3.0
[8/2/2023 4:50:08 AM] ===============================================================================
[8/2/2023 4:50:08 AM] *** Windows 10 Professional, 64-bit [Version: 10.0.19045.3208] (22H2) ***
[8/2/2023 4:50:08 AM] *** Windows Media Center is not installed. ***
[8/2/2023 4:50:08 AM] [ INFO] Beginning EPG123 update execution. 2023-08-02 08:50:08Z
[8/2/2023 4:50:08 AM] [ INFO] DaysToDownload: 14 , TheTVDBNumbers : True , PrefixEpisodeTitle: False , PrefixEpisodeDescription : False , AppendEpisodeDesc: False , OADOverride : True , SeasonEventImages : True , TMDbCoverArt: True , IncludeSDLogos : True , AutoAddNew: True , CreateXmltv: False , ModernMediaUiPlusSupport: False
[8/2/2023 4:50:09 AM] [ INFO] Token request successful. serverID: 20141201.web , datetime: 2023-08-02T08:50:09Z
[8/2/2023 4:50:09 AM] [ INFO] Status request successful. account expires: 2024-01-08T19:10:23Z , lineups: 2/4 , lastDataUpdate: 2023-08-02T04:33:26Z
[8/2/2023 4:50:09 AM] [ INFO] System status: Online , message: No known issues.
[8/2/2023 4:50:09 AM] [ INFO] epg123 is not up to date. Latest version is 1.8.1.0 and can be downloaded from https://github.com/garyan2/epg123/releases/tag/1.8.1.0
[8/2/2023 4:50:11 AM] [ INFO] Successfully retrieved TMDb configurations.
[8/2/2023 4:50:11 AM] [ INFO] Successfully requested listing of subscribed lineups from Schedules Direct.
[8/2/2023 4:50:11 AM] Entering BuildLineupServices() for 2 lineups.
[8/2/2023 4:50:11 AM] [ INFO] Successfully retrieved the station mapping for lineup USA-GA61403-X.
[8/2/2023 4:50:12 AM] [ INFO] Successfully retrieved the station mapping for lineup USA-OTA-30024.
[8/2/2023 4:50:12 AM] [ INFO] Stations added for download since last configuration save are: WANFDT8, UP, DPLUSSD, AFRCAHD, STELLAR, GRIOEHD, CHIMETV, EARTHX, FOXWX, UPHD, CARAIHD, WXIADT5, WUPADT7
[8/2/2023 4:50:12 AM] Exiting BuildLineupServices(). SUCCESS.
[8/2/2023 4:50:12 AM] Entering GetAllScheduleEntryMd5s() for 14 days on 159 stations.
[8/2/2023 4:50:12 AM] [ INFO] Successfully retrieved Md5s for  89 stations' daily schedules. (0:00:00:00.3750002)
[8/2/2023 4:50:14 AM] [ INFO] Successfully retrieved  89 stations' daily schedules.          (0:00:00:01.9490001)
[8/2/2023 4:50:16 AM] [ INFO] Successfully retrieved Md5s for  70 stations' daily schedules. (0:00:00:00.2880009)
[8/2/2023 4:50:18 AM] [ INFO] Successfully retrieved  70 stations' daily schedules.          (0:00:00:01.2590001)
[8/2/2023 4:50:19 AM] [ INFO] Found 1481 cached daily schedules.
[8/2/2023 4:50:19 AM] [ INFO] Downloaded 745 daily schedules.
[8/2/2023 4:50:21 AM] [ INFO] Processed 2226 daily schedules for 159 stations for average of 14.0 days per station.
[8/2/2023 4:50:21 AM] Exiting GetAllScheduleEntryMd5s(). SUCCESS.
[8/2/2023 4:50:21 AM] Entering BuildAllProgramEntries() for 29605 programs.
[8/2/2023 4:50:30 AM] [ INFO] Found 27155 cached program descriptions.
[8/2/2023 4:50:31 AM] [ INFO] Successfully retrieved 1200 program descriptions. (0:00:00:01.1189994)
[8/2/2023 4:50:31 AM] [ INFO] Successfully retrieved 1250 program descriptions. (0:00:00:01.4119993)
[8/2/2023 4:50:33 AM] Exiting BuildAllProgramEntries(). SUCCESS.
[8/2/2023 4:50:33 AM] Entering BuildAllGenericSeriesInfoDescriptions() for 3849 series.
[8/2/2023 4:50:33 AM] [ INFO] Found 3816 cached/unavailable series descriptions.
[8/2/2023 4:50:33 AM] [ INFO] Successfully retrieved  33 generic program descriptions. (0:00:00:00.1469991)
[8/2/2023 4:50:34 AM] Exiting BuildAllGenericSeriesInfoDescriptions(). SUCCESS.
[8/2/2023 4:50:34 AM] Entering GetAllMoviePosters() for 1735 movies.
[8/2/2023 4:50:34 AM] [ INFO] Found 1672 cached/unavailable movie poster links.
[8/2/2023 4:50:34 AM] [ INFO] Successfully retrieved artwork info for  63 programs. (0:00:00:00.1839982)
[8/2/2023 4:50:34 AM] Exiting GetAllMoviePosters(). SUCCESS.
[8/2/2023 4:50:34 AM] Entering GetAllSeriesImages() for 3849 series.
[8/2/2023 4:50:34 AM] [ INFO] Found 3619 cached/unavailable series image links.
[8/2/2023 4:50:34 AM] [ INFO] Refreshing 122 series image links.
[8/2/2023 4:50:35 AM] [ INFO] Successfully retrieved artwork info for 105 programs. (0:00:00:00.1970010)
[8/2/2023 4:50:35 AM] [ INFO] Successfully retrieved artwork info for 125 programs. (0:00:00:00.2469997)
[8/2/2023 4:50:35 AM] Exiting GetAllSeriesImages(). SUCCESS.
[8/2/2023 4:50:35 AM] Entering GetAllSeasonImages() for 3400 seasons.
[8/2/2023 4:50:35 AM] [ INFO] Found 3232 cached/unavailable season image links.
[8/2/2023 4:50:35 AM] [ INFO] Successfully retrieved artwork info for  43 programs. (0:00:00:00.1599993)
[8/2/2023 4:50:35 AM] [ INFO] Successfully retrieved artwork info for 125 programs. (0:00:00:00.2760003)
[8/2/2023 4:50:35 AM] Exiting GetAllSeasonImages(). SUCCESS.
[8/2/2023 4:50:35 AM] Entering GetAllSportsImages() for 167 sports events.
[8/2/2023 4:50:35 AM] [ INFO] Found 139 cached/unavailable sport event image links.
[8/2/2023 4:50:35 AM] [ INFO] Successfully retrieved artwork info for  28 programs. (0:00:00:00.0920023)
[8/2/2023 4:50:35 AM] Exiting GetAllSportsImages(). SUCCESS.
[8/2/2023 4:50:35 AM] [ INFO] Completed compiling keywords and keyword groups.
[8/2/2023 4:50:35 AM] [ INFO] Downloaded and processed 12.711 MB of data from Schedules Direct.
[8/2/2023 4:50:37 AM] [ INFO] Completed save of the MXF file to "C:\ProgramData\GaRyan2\epg123\output\epg123.mxf". (44.440 MB)
[8/2/2023 4:50:37 AM] [ INFO] Generated .mxf file contains 159 services, 3849 series, 3400 seasons, 29605 programs, 61046 schedule entries, and 50544 people with 7845 image links.
[8/2/2023 4:50:37 AM] [ INFO] 3185 entries deleted from the cache file during cleanup.
[8/2/2023 4:50:39 AM] [ INFO] Completed EPG123 update execution. SUCCESS.
[8/2/2023 4:50:39 AM] [ INFO] epg123 update execution time was 00:00:31.1420006.
[8/2/2023 8:49:04 AM] ===============================================================================
[8/2/2023 8:49:04 AM]  Activating the epg123 configuration GUI. version 1.7.3.0
[8/2/2023 8:49:04 AM] ===============================================================================
[8/2/2023 8:49:04 AM] *** Windows 10 Professional, 64-bit [Version: 10.0.19045.3208] (22H2) ***
[8/2/2023 8:49:04 AM] *** Windows Media Center is not installed. ***
[8/2/2023 8:49:07 AM] [ INFO] epg123 is not up to date. Latest version is 1.8.1.0 and can be downloaded from https://github.com/garyan2/epg123/releases/tag/1.8.1.0
[8/2/2023 8:49:08 AM] [ INFO] Status request successful. account expires: 2024-01-08T19:10:23Z , lineups: 2/4 , lastDataUpdate: 2023-08-02T04:33:26Z
[8/2/2023 8:49:08 AM] [ INFO] System status: Online , message: No known issues.
[8/2/2023 8:49:08 AM] [ INFO] Successfully requested listing of subscribed lineups from Schedules Direct.
[8/2/2023 8:49:08 AM] [ INFO] Successfully retrieved the station mapping for lineup USA-GA61403-X.
[8/2/2023 8:49:08 AM] [ INFO] Successfully retrieved the station mapping for lineup USA-OTA-30024.
[8/2/2023 8:49:09 AM] [ INFO] Successfully queried the Task Scheduler for status. No task is schedule to run.
[8/2/2023 7:03:04 PM] =====================================================================================
[8/2/2023 7:03:04 PM] EPG123_GUI: Activating the configuration GUI. version 1.8.1.0
[8/2/2023 7:03:04 PM] =====================================================================================
[8/2/2023 7:03:04 PM] *** Windows 10 Professional, 64-bit [Version: 10.0.19045.3208] (22H2) ***
[8/2/2023 7:03:04 PM] *** .NET Framework 4.8.04084 is installed. ***
[8/2/2023 7:03:07 PM] [ INFO] Successfully downloaded configuration file from http://localhost:9009/epg123/epg123.cfg.
[8/2/2023 7:03:07 PM] [ INFO] Successfully queried the Task Scheduler for status. Ready. Last Run 8/2/2023 4:50:02 AM. Exit: 0x00000000
[8/2/2023 7:03:07 PM] [ERROR] Did not receive a response from Schedules Direct for a token request.
[8/2/2023 7:03:25 PM] [ERROR] Did not receive a response from Schedules Direct for a token request.
[8/2/2023 7:03:35 PM] =====================================================================================
[8/2/2023 7:03:35 PM] EPG123_GUI: Activating the configuration GUI. version 1.8.1.0
[8/2/2023 7:03:35 PM] =====================================================================================
[8/2/2023 7:03:35 PM] *** Windows 10 Professional, 64-bit [Version: 10.0.19045.3208] (22H2) ***
[8/2/2023 7:03:35 PM] *** .NET Framework 4.8.04084 is installed. ***
[8/2/2023 7:03:36 PM] [ INFO] Successfully downloaded configuration file from http://localhost:9009/epg123/epg123.cfg.
[8/2/2023 7:03:36 PM] [ INFO] Successfully queried the Task Scheduler for status. No task is schedule to run.
[8/2/2023 7:03:36 PM] [ERROR] Did not receive a response from Schedules Direct for a token request.
[8/2/2023 7:03:57 PM] [ERROR] Did not receive a response from Schedules Direct for a token request.
[8/2/2023 7:04:35 PM] [ERROR] Did not receive a response from Schedules Direct for a token request.
[8/2/2023 7:05:39 PM] =====================================================================================
[8/2/2023 7:05:39 PM] EPG123_GUI: Activating the configuration GUI. version 1.8.1.0
[8/2/2023 7:05:39 PM] =====================================================================================
[8/2/2023 7:05:39 PM] *** Windows 10 Professional, 64-bit [Version: 10.0.19045.3208] (22H2) ***
[8/2/2023 7:05:39 PM] *** .NET Framework 4.8.04084 is installed. ***
[8/2/2023 7:05:40 PM] [ INFO] Successfully downloaded configuration file from http://localhost:9009/epg123/epg123.cfg.
[8/2/2023 7:05:40 PM] [ INFO] Successfully queried the Task Scheduler for status. No task is schedule to run.
[8/2/2023 7:05:40 PM] [ERROR] Did not receive a response from Schedules Direct for a token request.
[8/2/2023 7:05:44 PM] [ERROR] Did not receive a response from Schedules Direct for a token request.
[8/2/2023 7:08:42 PM] =====================================================================================
[8/2/2023 7:08:42 PM] EPG123_GUI: Activating the configuration GUI. version 1.8.1.0
[8/2/2023 7:08:42 PM] =====================================================================================
[8/2/2023 7:08:42 PM] *** Windows 10 Professional, 64-bit [Version: 10.0.19045.3208] (22H2) ***
[8/2/2023 7:08:42 PM] *** .NET Framework 4.8.04084 is installed. ***
[8/2/2023 7:08:43 PM] [ INFO] Successfully downloaded configuration file from http://localhost:9009/epg123/epg123.cfg.
[8/2/2023 7:08:43 PM] [ INFO] Successfully queried the Task Scheduler for status. Ready. Last Run 8/2/2023 4:50:02 AM. Exit: 0x00000000
[8/2/2023 7:08:43 PM] [ERROR] Did not receive a response from Schedules Direct for a token request.
[8/2/2023 7:08:47 PM] [ERROR] Did not receive a response from Schedules Direct for a token request.
[8/2/2023 7:16:52 PM] [ERROR] Did not receive a response from Schedules Direct for a token request.
[8/2/2023 7:18:05 PM] [ERROR] Did not receive a response from Schedules Direct for a token request.
Edit: I also noticed that when I did the install, I wasn't prompted to select whether I wanted Server and/or Client as had been the case with previous versions. I'm not sure if this was by design or is indicative of an issue with my install.
Last edited by byronomo on Thu Aug 03, 2023 10:40 am, edited 1 time in total.
Top
Space

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

HTPC Specs: Show details

#1775

Post by Space » Thu Aug 03, 2023 1:41 am

I also just upgraded and do not appear to have a problem with logging in, but my subscribed lineups in the config GUI are now missing...

EDIT: OK, I ran the config GUI again and this time it opened up and I was logged out and was unable to log in to SD. Perhaps an SD problem? Error code 4003 in the server.log.

EDIT 2:
Looks like might be an unexpected character from SD?

Code: Select all

[8/2/2023 9:20:46 PM] [ INFO] HTTP request exception thrown. Message: System.AggregateException: One or more errors occurred. ---> Newtonsoft.Json.JsonReaderException: Unexpected character encountered while parsing value: <. Path '', line 0, position 0.
   at Newtonsoft.Json.JsonTextReader.ParseValue()
   at Newtonsoft.Json.JsonReader.ReadForType(JsonContract contract, Boolean hasConverter)
   at Newtonsoft.Json.Serialization.JsonSerializerInternalReader.Deserialize(JsonReader reader, Type objectType, Boolean checkAdditionalContent)
   at Newtonsoft.Json.JsonSerializer.DeserializeInternal(JsonReader reader, Type objectType)
   at Newtonsoft.Json.JsonConvert.DeserializeObject(String value, Type type, JsonSerializerSettings settings)
   at Newtonsoft.Json.JsonConvert.DeserializeObject[T](String value, JsonSerializerSettings settings)
   at GaRyan2.SchedulesDirectAPI.API.HandleHttpResponseError[T](HttpResponseMessage response, String content)
   at GaRyan2.BaseAPI.<GetHttpResponse>d__17`1.MoveNext()
   --- End of inner exception stack trace ---
   at System.Threading.Tasks.Task`1.GetResultCore(Boolean waitCompletionNotification)
   at GaRyan2.BaseAPI.GetApiResponse[T](Method method, String uri, Object classObject)
---> (Inner Exception #0) Newtonsoft.Json.JsonReaderException: Unexpected character encountered while parsing value: <. Path '', line 0, position 0.
   at Newtonsoft.Json.JsonTextReader.ParseValue()
   at Newtonsoft.Json.JsonReader.ReadForType(JsonContract contract, Boolean hasConverter)
   at Newtonsoft.Json.Serialization.JsonSerializerInternalReader.Deserialize(JsonReader reader, Type objectType, Boolean checkAdditionalContent)
   at Newtonsoft.Json.JsonSerializer.DeserializeInternal(JsonReader reader, Type objectType)
   at Newtonsoft.Json.JsonConvert.DeserializeObject(String value, Type type, JsonSerializerSettings settings)
   at Newtonsoft.Json.JsonConvert.DeserializeObject[T](String value, JsonSerializerSettings settings)
   at GaRyan2.SchedulesDirectAPI.API.HandleHttpResponseError[T](HttpResponseMessage response, String content)
   at GaRyan2.BaseAPI.<GetHttpResponse>d__17`1.MoveNext()<---

[8/2/2023 9:20:46 PM] [ERROR] Did not receive a response from Schedules Direct for a token request.
[8/2/2023 9:20:46 PM] [ INFO] Image server initialized with 12 worker threads.
[8/2/2023 9:20:46 PM] [ INFO] File server initialized with 4 worker threads.
[8/2/2023 9:20:46 PM] [ INFO] UDP Server initialized.
[8/2/2023 9:38:53 PM] [ INFO] Refreshed Schedules Direct API token. Token=5c277...
[8/2/2023 9:43:56 PM] [ INFO] HTTP request exception thrown. Message: System.AggregateException: One or more errors occurred. ---> Newtonsoft.Json.JsonReaderException: Unexpected character encountered while parsing value: <. Path '', line 0, position 0.
   at Newtonsoft.Json.JsonTextReader.ParseValue()
   at Newtonsoft.Json.JsonReader.ReadForType(JsonContract contract, Boolean hasConverter)
   at Newtonsoft.Json.Serialization.JsonSerializerInternalReader.Deserialize(JsonReader reader, Type objectType, Boolean checkAdditionalContent)
   at Newtonsoft.Json.JsonSerializer.DeserializeInternal(JsonReader reader, Type objectType)
   at Newtonsoft.Json.JsonConvert.DeserializeObject(String value, Type type, JsonSerializerSettings settings)
   at Newtonsoft.Json.JsonConvert.DeserializeObject[T](String value, JsonSerializerSettings settings)
   at GaRyan2.SchedulesDirectAPI.API.HandleHttpResponseError[T](HttpResponseMessage response, String content)
   at GaRyan2.BaseAPI.<GetHttpResponse>d__17`1.MoveNext()
   --- End of inner exception stack trace ---
   at System.Threading.Tasks.Task`1.GetResultCore(Boolean waitCompletionNotification)
   at GaRyan2.BaseAPI.GetApiResponse[T](Method method, String uri, Object classObject)
---> (Inner Exception #0) Newtonsoft.Json.JsonReaderException: Unexpected character encountered while parsing value: <. Path '', line 0, position 0.
   at Newtonsoft.Json.JsonTextReader.ParseValue()
   at Newtonsoft.Json.JsonReader.ReadForType(JsonContract contract, Boolean hasConverter)
   at Newtonsoft.Json.Serialization.JsonSerializerInternalReader.Deserialize(JsonReader reader, Type objectType, Boolean checkAdditionalContent)
   at Newtonsoft.Json.JsonSerializer.DeserializeInternal(JsonReader reader, Type objectType)
   at Newtonsoft.Json.JsonConvert.DeserializeObject(String value, Type type, JsonSerializerSettings settings)
   at Newtonsoft.Json.JsonConvert.DeserializeObject[T](String value, JsonSerializerSettings settings)
   at GaRyan2.SchedulesDirectAPI.API.HandleHttpResponseError[T](HttpResponseMessage response, String content)
   at GaRyan2.BaseAPI.<GetHttpResponse>d__17`1.MoveNext()<---

[8/2/2023 9:43:56 PM] [ERROR] Did not receive a response from Schedules Direct for a token request.
[8/2/2023 9:44:09 PM] [ INFO] SD responded with error code: 4003 , message: Invalid username or token has expired. , serverID: 20141201.web , datetime: 2023-08-03T01:44:08Z
[8/2/2023 9:44:09 PM] [ERROR] Did not receive a response from Schedules Direct for a token request.
EDIT 3:
Just ran the config GUI and it's all fine now, I assume it was an SD server issue, but it does look like EPG123 is not handling things properly when SD is down in this way.
Top
User avatar
garyan2

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

HTPC Specs: Show details

#1776

Post by garyan2 » Thu Aug 03, 2023 2:22 pm

This is a recent thing. When SD responds now with an error code 500 Server Error, the payload is html rather than json causing the exception in my code. Since the exception is being thrown, I don't get any useful information for the user.
- Gary
Keeping WMC alive beyond January 2020. https://garyan2.github.io
Top
harakan2

Posts: 6
Joined: Wed Nov 30, 2022 8:20 pm
Location:

HTPC Specs: Show details

#1777

Post by harakan2 » Mon Aug 07, 2023 4:47 pm

A few weeks ago I started getting warnings from EPG123, reporting "Failed to parse he schedule Md5" for two channels - as they were channels I don't watch, I turned them off in the configuration tool. However, as of yesterday, another channel has started throwing the same warning (ITV1CNE).

I've updated to the latest version (1.8.1.3), re-run the configuration utility and used "Clear Cache" and "Save and Execute", but it's still reporting the same warnings for the same channels.

Is this a problem on my end, a problem on with SDDirect, or a problem in EPG123?

Any help appreciated!

Code: Select all

[07/08/2023 17:35:22] =====================================================================================
[07/08/2023 17:35:22] EPG123: Beginning MXF and XMLTV file updates. version 1.8.1.3
[07/08/2023 17:35:22] =====================================================================================
[07/08/2023 17:35:22] *** Windows 10 Professional, 64-bit [Version: 10.0.19045.3208] (22H2) ***
[07/08/2023 17:35:22] *** .NET Framework 4.8.04084 is installed. ***
[07/08/2023 17:35:22] [ INFO] DaysToDownload: 14 , TheTVDBNumbers : True , PrefixEpisodeTitle: True , PrefixEpisodeDescription : False , AppendEpisodeDesc: False , OADOverride : True , SeasonEventImages : True , IncludeSDLogos : False , AutoAddNew: True , CreateXmltv: False
[07/08/2023 17:35:22] [ INFO] Token request successful. serverID: MERCURY , datetime: 2023-08-07T16:34:37Z
[07/08/2023 17:35:23] [ INFO] Status request successful. account expires: 2024-02-16T18:38:58Z , lineups: 1/4 , lastDataUpdate: 2023-08-06T21:11:24Z
[07/08/2023 17:35:23] [ INFO] System status: Online , message: No known issues.
[07/08/2023 17:35:24] [ INFO] Successfully requested listing of subscribed lineups from Schedules Direct.
[07/08/2023 17:35:24] Entering BuildLineupServices() for 1 lineups.
[07/08/2023 17:35:24] [ INFO] Successfully retrieved the station mapping for lineup GBR-1001658-DEFAULT. (154 stations; 157 channels)
[07/08/2023 17:35:24] Exiting BuildLineupServices(). SUCCESS.
[07/08/2023 17:35:24] Entering GetAllScheduleEntryMd5s() for 14 days on 154 stations.
[07/08/2023 17:35:26] [ INFO] Successfully retrieved Md5s for 89/89 stations' daily schedules. (0:00:00:01.5936186)
[07/08/2023 17:35:26] [WARNG] Failed to parse the schedule Md5 return for stationId 68145 (ITV1CNE) on 2023-08-07 and after.
[07/08/2023 17:35:26] [WARNG] Failed to parse the schedule Md5 return for stationId 141862 (QVC2UK) on 2023-08-07 and after.
[07/08/2023 17:35:27] [ INFO] Successfully retrieved Md5s for 65/65 stations' daily schedules. (0:00:00:01.1094472)
[07/08/2023 17:35:27] [WARNG] Failed to parse the schedule Md5 return for stationId 141863 (AMDISUK) on 2023-08-07 and after.
[07/08/2023 17:35:27] [ INFO] Found 2114 cached daily schedules.
[07/08/2023 17:35:27] [ INFO] Downloaded 0 daily schedules.
[07/08/2023 17:35:27] [ INFO] Processed 2114 daily schedules for 154 stations for average of 13.0 days per station.
[07/08/2023 17:35:27] Exiting GetAllScheduleEntryMd5s(). SUCCESS.
[07/08/2023 17:35:27] Entering BuildAllProgramEntries() for 15031 programs.
Top
Space

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

HTPC Specs: Show details

#1778

Post by Space » Tue Aug 08, 2023 8:10 am

These Md5 parsing failures are generally an issue with SchedulesDirect and usually clear up on their own.
Top
harakan2

Posts: 6
Joined: Wed Nov 30, 2022 8:20 pm
Location:

HTPC Specs: Show details

#1779

Post by harakan2 » Tue Aug 08, 2023 3:36 pm

Space wrote: ↑Tue Aug 08, 2023 8:10 am These Md5 parsing failures are generally an issue with SchedulesDirect and usually clear up on their own.
The original two channels (QVC2UK and AMDISUK) have been showing issues for weeks, and another channel has failed today:

Code: Select all

[08/08/2023 16:44:19] [WARNG] Failed to parse the schedule Md5 return for stationId 33638 (POP) on 2023-08-08 and after.
Is there a debug option for EPG123 to dump the raw schedule data / expected MD5 values to a file?

Updated: I opened a case with SD, and they confirmed a problem with QVC2UK and AMDISUK, and the other two channels that were failing now seem to be working again - hopefully they'll remain stable.
Top
Sancho

Posts: 160
Joined: Wed Jun 13, 2012 9:52 pm
Location:

HTPC Specs: Show details

#1780

Post by Sancho » Wed Aug 09, 2023 2:37 pm

Received the following error(s) on two HTPCs:

Code: Select all

[8/9/2023 5:20:00 AM] =====================================================================================
[8/9/2023 5:20:00 AM] EPG123: Beginning MXF and XMLTV file updates. version 1.8.1.3
[8/9/2023 5:20:00 AM] =====================================================================================
[8/9/2023 5:20:00 AM] *** Windows 7 Ultimate, 64-bit [Version: 6.1.7601.24544] ***
[8/9/2023 5:20:00 AM] *** .NET Framework 4.8.03761 is installed. ***
[8/9/2023 5:20:00 AM] [ INFO] DaysToDownload: 21 , TheTVDBNumbers : True , PrefixEpisodeTitle: False , PrefixEpisodeDescription : False , AppendEpisodeDesc: True , OADOverride : True , SeasonEventImages : True , IncludeSDLogos : True , AutoAddNew: True , CreateXmltv: False
[8/9/2023 5:20:00 AM] [ INFO] Token request successful. serverID: BR-HTPC , datetime: 2023-08-09T04:23:08Z
[8/9/2023 5:20:00 AM] [ INFO] HTTP request exception thrown. Message: System.AggregateException: One or more errors occurred. ---> Newtonsoft.Json.JsonReaderException: Unexpected character encountered while parsing value: <. Path '', line 0, position 0.
   at Newtonsoft.Json.JsonTextReader.ParseValue()
   at Newtonsoft.Json.JsonReader.ReadForType(JsonContract contract, Boolean hasConverter)
   at Newtonsoft.Json.Serialization.JsonSerializerInternalReader.Deserialize(JsonReader reader, Type objectType, Boolean checkAdditionalContent)
   at Newtonsoft.Json.JsonSerializer.DeserializeInternal(JsonReader reader, Type objectType)
   at Newtonsoft.Json.JsonConvert.DeserializeObject(String value, Type type, JsonSerializerSettings settings)
   at Newtonsoft.Json.JsonConvert.DeserializeObject[T](String value, JsonSerializerSettings settings)
   at GaRyan2.SchedulesDirectAPI.API.HandleHttpResponseError[T](HttpResponseMessage response, String content)
   at GaRyan2.SchedulesDirectAPI.API.<GetHttpResponse>d__1`1.MoveNext()
   --- End of inner exception stack trace ---
   at System.Threading.Tasks.Task`1.GetResultCore(Boolean waitCompletionNotification)
   at GaRyan2.BaseAPI.GetApiResponse[T](Method method, String uri, Object classObject)
---> (Inner Exception #0) Newtonsoft.Json.JsonReaderException: Unexpected character encountered while parsing value: <. Path '', line 0, position 0.
   at Newtonsoft.Json.JsonTextReader.ParseValue()
   at Newtonsoft.Json.JsonReader.ReadForType(JsonContract contract, Boolean hasConverter)
   at Newtonsoft.Json.Serialization.JsonSerializerInternalReader.Deserialize(JsonReader reader, Type objectType, Boolean checkAdditionalContent)
   at Newtonsoft.Json.JsonSerializer.DeserializeInternal(JsonReader reader, Type objectType)
   at Newtonsoft.Json.JsonConvert.DeserializeObject(String value, Type type, JsonSerializerSettings settings)
   at Newtonsoft.Json.JsonConvert.DeserializeObject[T](String value, JsonSerializerSettings settings)
   at GaRyan2.SchedulesDirectAPI.API.HandleHttpResponseError[T](HttpResponseMessage response, String content)
   at GaRyan2.SchedulesDirectAPI.API.<GetHttpResponse>d__1`1.MoveNext()<---
[8/9/2023 5:20:00 AM] [ INFO] Validation of cached token failed. Requesting new token.
[8/9/2023 5:20:00 AM] [ INFO] Token refresh successful. serverID: BR-HTPC , datetime: 2023-08-09T09:19:59Z
[8/9/2023 5:20:00 AM] [ INFO] HTTP request exception thrown. Message: System.AggregateException: One or more errors occurred. ---> Newtonsoft.Json.JsonReaderException: Unexpected character encountered while parsing value: <. Path '', line 0, position 0.
   at Newtonsoft.Json.JsonTextReader.ParseValue()
   at Newtonsoft.Json.JsonReader.ReadForType(JsonContract contract, Boolean hasConverter)
   at Newtonsoft.Json.Serialization.JsonSerializerInternalReader.Deserialize(JsonReader reader, Type objectType, Boolean checkAdditionalContent)
   at Newtonsoft.Json.JsonSerializer.DeserializeInternal(JsonReader reader, Type objectType)
   at Newtonsoft.Json.JsonConvert.DeserializeObject(String value, Type type, JsonSerializerSettings settings)
   at Newtonsoft.Json.JsonConvert.DeserializeObject[T](String value, JsonSerializerSettings settings)
   at GaRyan2.SchedulesDirectAPI.API.HandleHttpResponseError[T](HttpResponseMessage response, String content)
   at GaRyan2.SchedulesDirectAPI.API.<GetHttpResponse>d__1`1.MoveNext()
   --- End of inner exception stack trace ---
   at System.Threading.Tasks.Task`1.GetResultCore(Boolean waitCompletionNotification)
   at GaRyan2.BaseAPI.GetApiResponse[T](Method method, String uri, Object classObject)
---> (Inner Exception #0) Newtonsoft.Json.JsonReaderException: Unexpected character encountered while parsing value: <. Path '', line 0, position 0.
   at Newtonsoft.Json.JsonTextReader.ParseValue()
   at Newtonsoft.Json.JsonReader.ReadForType(JsonContract contract, Boolean hasConverter)
   at Newtonsoft.Json.Serialization.JsonSerializerInternalReader.Deserialize(JsonReader reader, Type objectType, Boolean checkAdditionalContent)
   at Newtonsoft.Json.JsonSerializer.DeserializeInternal(JsonReader reader, Type objectType)
   at Newtonsoft.Json.JsonConvert.DeserializeObject(String value, Type type, JsonSerializerSettings settings)
   at Newtonsoft.Json.JsonConvert.DeserializeObject[T](String value, JsonSerializerSettings settings)
   at GaRyan2.SchedulesDirectAPI.API.HandleHttpResponseError[T](HttpResponseMessage response, String content)
   at GaRyan2.SchedulesDirectAPI.API.<GetHttpResponse>d__1`1.MoveNext()<---
[8/9/2023 5:20:00 AM] [ERROR] Did not receive a response from Schedules Direct for a status request.
[8/9/2023 5:20:03 AM] [ INFO] HTTP request exception thrown. Message: System.AggregateException: One or more errors occurred. ---> Newtonsoft.Json.JsonReaderException: Unexpected character encountered while parsing value: <. Path '', line 0, position 0.
   at Newtonsoft.Json.JsonTextReader.ParseValue()
   at Newtonsoft.Json.JsonReader.ReadForType(JsonContract contract, Boolean hasConverter)
   at Newtonsoft.Json.Serialization.JsonSerializerInternalReader.Deserialize(JsonReader reader, Type objectType, Boolean checkAdditionalContent)
   at Newtonsoft.Json.JsonSerializer.DeserializeInternal(JsonReader reader, Type objectType)
   at Newtonsoft.Json.JsonConvert.DeserializeObject(String value, Type type, JsonSerializerSettings settings)
   at Newtonsoft.Json.JsonConvert.DeserializeObject[T](String value, JsonSerializerSettings settings)
   at GaRyan2.SchedulesDirectAPI.API.HandleHttpResponseError[T](HttpResponseMessage response, String content)
   at GaRyan2.SchedulesDirectAPI.API.<GetHttpResponse>d__1`1.MoveNext()
   --- End of inner exception stack trace ---
   at System.Threading.Tasks.Task`1.GetResultCore(Boolean waitCompletionNotification)
   at GaRyan2.BaseAPI.GetApiResponse[T](Method method, String uri, Object classObject)
---> (Inner Exception #0) Newtonsoft.Json.JsonReaderException: Unexpected character encountered while parsing value: <. Path '', line 0, position 0.
   at Newtonsoft.Json.JsonTextReader.ParseValue()
   at Newtonsoft.Json.JsonReader.ReadForType(JsonContract contract, Boolean hasConverter)
   at Newtonsoft.Json.Serialization.JsonSerializerInternalReader.Deserialize(JsonReader reader, Type objectType, Boolean checkAdditionalContent)
   at Newtonsoft.Json.JsonSerializer.DeserializeInternal(JsonReader reader, Type objectType)
   at Newtonsoft.Json.JsonConvert.DeserializeObject(String value, Type type, JsonSerializerSettings settings)
   at Newtonsoft.Json.JsonConvert.DeserializeObject[T](String value, JsonSerializerSettings settings)
   at GaRyan2.SchedulesDirectAPI.API.HandleHttpResponseError[T](HttpResponseMessage response, String content)
   at GaRyan2.SchedulesDirectAPI.API.<GetHttpResponse>d__1`1.MoveNext()<---
[8/9/2023 5:20:03 AM] [ERROR] Did not receive a response from Schedules Direct for list of subscribed lineups.
[8/9/2023 5:20:03 AM] [ INFO] EPG123 update execution time was 00:00:02.7381566.
[8/9/2023 5:20:03 AM] [ERROR] Failed to create MXF file. Exiting.
[8/9/2023 5:20:03 AM] =====================================================================================
[8/9/2023 5:20:03 AM] EPG123CLIENT: Beginning MXF file import. version 1.8.1.3
[8/9/2023 5:20:03 AM] =====================================================================================
[8/9/2023 5:20:03 AM] *** Windows 7 Ultimate, 64-bit [Version: 6.1.7601.24544] ***
[8/9/2023 5:20:03 AM] *** .NET Framework 4.8.03761 is installed. ***
[8/9/2023 5:20:03 AM] *** Windows Media Center [Version: 6.1.7600.16385] is installed. ***
[8/9/2023 5:20:03 AM] [ INFO] Import: True , Match: True , NoLogo: False , Force: False , ShowProgress: False , NoGC: False , NoVerify: False , Verbose: False
[8/9/2023 5:20:04 AM] Entering ImportMxfFile() for file "C:\ProgramData\GaRyan2\epg123\output\epg123.mxf".
[8/9/2023 5:22:16 AM] [ INFO] Successfully imported .mxf file into Media Center database. Exit code: 0
[8/9/2023 5:22:16 AM] Exiting ImportMxfFile(). SUCCESS.
[8/9/2023 5:22:16 AM] Entering VerifyLoad()
[8/9/2023 5:22:35 AM] [ INFO] Service !Service!EPG123_62079: MLBN has a time discontinuity at 8/11/2023 8:00:00 PM. Skipping verification of this station's schedule entries.
[8/9/2023 5:22:39 AM] [ INFO] Service !Service!EPG123_62081: MLBHD has a time discontinuity at 8/11/2023 8:00:00 PM. Skipping verification of this station's schedule entries.
[8/9/2023 5:22:50 AM] [ INFO] Service !Service!EPG123_15717: RTPI has a time discontinuity at 8/14/2023 8:00:00 PM. Skipping verification of this station's schedule entries.
[8/9/2023 5:22:52 AM] [ INFO] Checked 248367 entries and corrected 0 of them.
[8/9/2023 5:22:52 AM] Exiting VerifyLoad()
[8/9/2023 5:22:55 AM] [ INFO] Completed channel cleanup as needed after MXF file import.
[8/9/2023 5:22:59 AM] [ INFO] Completed the automatic mapping of lineup stations to tuner channels.
[8/9/2023 5:22:59 AM] [ INFO] Completed lineup refresh.
[8/9/2023 5:22:59 AM] Entering ReindexDatabase()
[8/9/2023 5:23:00 AM] [ INFO] SUCCESS: WMC database indexing has started.
[8/9/2023 5:23:00 AM] Exiting ReindexDatabase(). SUCCESS.
[8/9/2023 5:23:00 AM] [ INFO] MXF file was created on 8/8/2023 5:20:01 AM
[8/9/2023 5:23:00 AM] [ERROR] The MXF file imported is 24.05 hours old.
[8/9/2023 5:23:01 AM] [ INFO] Completed EPG123 client execution.
[8/9/2023 5:23:01 AM] [ INFO] EPG123 client execution time was 00:02:57.7831686.
[8/9/2023 5:29:32 AM] =====================================================================================
[8/9/2023 5:29:32 AM] EPG123CLIENT: Beginning WMC recorder storage/tuner conflict checks. version 1.8.1.3
[8/9/2023 5:29:32 AM] =====================================================================================
[8/9/2023 5:29:32 AM] *** Windows 7 Ultimate, 64-bit [Version: 6.1.7601.24544] ***
[8/9/2023 5:29:32 AM] *** .NET Framework 4.8.03761 is installed. ***
[8/9/2023 5:29:32 AM] *** Windows Media Center [Version: 6.1.7600.16385] is installed. ***
[8/9/2023 5:29:32 AM] [ INFO] WMC database indexing took 00:06:32.1964324. Exit: 0x00000000
[8/9/2023 5:29:32 AM] [ INFO] Recorder storage drive E:\ has 245.335 GB available. (1.577 TB of 1.817 TB used)
[8/9/2023 5:29:33 AM] [ INFO] No tuner conflicts detected within next 3 days.
[8/9/2023 5:29:33 AM] [ INFO] Completed WMC recorder storage/tuner conflict checks.
Manual update from the Configurator worked.
Top
Post Reply

Return to “EPG123”