EPG123 Bug Reports

An evolving, supported alternative to Rovi
Forum rules
★ Download the latest EPG123 here: http://epg123.garyan2.net <> Setup guide here: http://epg123.garyan2.net/downloads/epg123_Guide.pdf
sjr56stn

Posts: 34
Joined: Tue Mar 03, 2015 4:49 pm
Location:

HTPC Specs: Show details

Re: EPG123 Bug Reports

#901

Post by sjr56stn » Thu Feb 14, 2019 11:53 am

Gary,
I have had a few amber warnings as described above, but they have always gone away the following day. But today I have a red error. The trace file has 10 occurrences of "[ERROR] Did not find expected Md5Schedule file in cache directory." and at the end "[ERROR] The imported MXF file contained an ERROR in its status field."
Any idea what is wrong?
Steve

PS - I must be really dumb but I cannot see how to attach the trace.log to this message on this forum!

User avatar
garyan2

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

HTPC Specs: Show details

#902

Post by garyan2 » Thu Feb 14, 2019 2:46 pm

sjr56stn wrote:
Thu Feb 14, 2019 11:53 am
Gary,
I have had a few amber warnings as described above, but they have always gone away the following day. But today I have a red error. The trace file has 10 occurrences of "[ERROR] Did not find expected Md5Schedule file in cache directory." and at the end "[ERROR] The imported MXF file contained an ERROR in its status field."
Any idea what is wrong?
Steve

PS - I must be really dumb but I cannot see how to attach the trace.log to this message on this forum!
I just downloaded all of your schedule data without issue (except for some time discontinuities that have been happening lately). This error is usually caused by a difference in MD5 hash of what the SD feed says you need, and what was actually downloaded. In this case, I think it was just bad timing on your part that you were performing updates at the same time SD was doing their updates with the upstream provider. If you manually run again, it should be without error.
- Gary
Stomping out the Rovi disease, one media center at a time. http://epg123.garyan2.net

adam1991

Posts: 2611
Joined: Sat Jun 11, 2011 2:31 pm
Location:

HTPC Specs: Show details

#903

Post by adam1991 » Thu Feb 14, 2019 4:48 pm

sjr56stn wrote:
Thu Feb 14, 2019 11:53 am
PS - I must be really dumb but I cannot see how to attach the trace.log to this message on this forum!
Can you just open the tracelog and copy the relevant section?

If so, you can just paste it into your message here. Bracket it with the "code" tags, which you can insert directly using the button up above the editor that looks like this: </> . It's the fifth button from the left.

sjr56stn

Posts: 34
Joined: Tue Mar 03, 2015 4:49 pm
Location:

HTPC Specs: Show details

#904

Post by sjr56stn » Thu Feb 14, 2019 6:10 pm

Gary, Just ran it again manually, and got exactly the same result.

sjr56stn

Posts: 34
Joined: Tue Mar 03, 2015 4:49 pm
Location:

HTPC Specs: Show details

#905

Post by sjr56stn » Thu Feb 14, 2019 6:49 pm

Gary, here is the trace.log for the latest attempt...

Code: Select all

[14/02/2019 18:40:03] ===============================================================================
[14/02/2019 18:40:03]  Activating the epg123 configuration GUI. version 1.2.11.0
[14/02/2019 18:40:03] ===============================================================================
[14/02/2019 18:40:06] [ INFO] Successfully queried the Task Scheduler for status. Ready. Last Run 14/02/2019 03:48:59; Exit: 0x00000000
[14/02/2019 18:40:07] [ INFO] Token request successful. serverID: 20141201.web.1
[14/02/2019 18:40:07] [ INFO] Status request successful. account expires: 2019-08-31T09:33:53Z , lineups: 3/4 , lastDataUpdate: 2019-02-14T13:15:52Z
[14/02/2019 18:40:07] [ INFO] system status: Online , message: No known issues.
[14/02/2019 18:40:08] [ INFO] Successfully requested listing of client lineups from Schedules Direct.
[14/02/2019 18:40:08] [ INFO] Successfully retrieved the station mapping for lineup GBR-1000014-DEFAULT.
[14/02/2019 18:40:09] [ INFO] Successfully retrieved the station mapping for lineup GBR-1000017-DEFAULT.
[14/02/2019 18:40:11] [ INFO] Successfully retrieved the station mapping for lineup ZZZ-19.2E-DEFAULT.
[14/02/2019 18:40:33] ===============================================================================
[14/02/2019 18:40:33]  Beginning epg123 update execution. version 1.2.11.0
[14/02/2019 18:40:33] ===============================================================================
[14/02/2019 18:40:33] [ INFO] Beginning EPG123 update execution. 2019-02-14 18:40:33Z
[14/02/2019 18:40:33] [ INFO] DaysToDownload: 21 , TheTVDBNumbers : False , PrefixEpisodeTitle: False , PrefixEpisodeDescription : False , AppendEpisodeDesc: True , OADOverride : True , TMDbCoverArt: True , IncludeSDLogos : True , AutoAddNew: True , CreateXmltv: False , ModernMediaUiPlusSupport: False
[14/02/2019 18:40:34] [ INFO] Status request successful. account expires: 2019-08-31T09:33:53Z , lineups: 3/4 , lastDataUpdate: 2019-02-14T13:15:52Z
[14/02/2019 18:40:34] [ INFO] system status: Online , message: No known issues.
[14/02/2019 18:40:35] [ INFO] Successfully retrieved TMDb configurations.
[14/02/2019 18:40:50] [ INFO] Successfully requested listing of client lineups from Schedules Direct.
[14/02/2019 18:40:50] Entering buildLineupServices() for 3 lineups.
[14/02/2019 18:40:51] [ INFO] Successfully retrieved the station mapping for lineup GBR-1000014-DEFAULT.
[14/02/2019 18:40:53] [ INFO] Successfully retrieved the station mapping for lineup GBR-1000017-DEFAULT.
[14/02/2019 18:40:54] [ INFO] Successfully retrieved the station mapping for lineup ZZZ-19.2E-DEFAULT.
[14/02/2019 18:40:54] Exiting buildLineupServices(). SUCCESS.
[14/02/2019 18:40:54] Entering getAllScheduleEntryMd5s() for 21 days on 128 stations.
[14/02/2019 18:40:58] [ INFO] Successfully retrieved Md5s for 128 station's daily schedules. (0:00:00:03.8124073 /   247.243 KB)
[14/02/2019 18:41:01] [ INFO] Successfully retrieved   1 station's daily schedules.          (0:00:00:00.6240011 /    40.544 KB)
[14/02/2019 18:41:01] [ INFO] Found 2307 cached daily schedules.
[14/02/2019 18:41:01] [ INFO] Downloaded 18 daily schedules.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:11] [ INFO] Processed 2325 daily schedules for 128 stations.
[14/02/2019 18:41:11] Exiting getAllScheduleEntryMd5s(). SUCCESS.
[14/02/2019 18:41:11] Entering buildAllProgramEntries() for 11966 programs.
[14/02/2019 18:41:31] [ INFO] Found 11966 cached program descriptions.
[14/02/2019 18:41:31] [ INFO] Processed 11966 program descriptions.
[14/02/2019 18:41:31] Exiting buildAllProgramEntries(). SUCCESS.
[14/02/2019 18:41:31] Entering buildAllGenericSeriesInfoDescriptions() for 3286 series.
[14/02/2019 18:41:32] [ INFO] Found 3286 cached series descriptions.
[14/02/2019 18:41:32] [ INFO] Processed 3286 series descriptions.
[14/02/2019 18:41:32] Exiting buildAllGenericSeriesInfoDescriptions(). SUCCESS.
[14/02/2019 18:41:32] Entering getAllMoviePosters() for 591 movies.
[14/02/2019 18:41:36] [ INFO] Successfully retrieved artwork info for  91 programs. (0:00:00:03.7128066 /   609.018 KB)
[14/02/2019 18:41:49] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:16.3196288 /     3.272 MB)
[14/02/2019 18:41:49] [ INFO] Processed 591 movie poster links.
[14/02/2019 18:41:49] Exiting getAllMoviePosters(). SUCCESS.
[14/02/2019 18:41:49] Entering getAllSeriesImages() for 3286 series.
[14/02/2019 18:41:49] [ INFO] Found 0 cached series image links.
[14/02/2019 18:42:08] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:18.9852333 /     4.384 MB)
[14/02/2019 18:42:15] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:25.7244452 /     3.663 MB)
[14/02/2019 18:42:17] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:28.3452498 /     1.867 MB)
[14/02/2019 18:42:27] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:18.9696333 /     2.255 MB)
[14/02/2019 18:42:29] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:40.1544705 /     2.255 MB)
[14/02/2019 18:42:33] [ INFO] Successfully retrieved artwork info for 286 programs. (0:00:00:15.3972270 /     1.005 MB)
[14/02/2019 18:42:38] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:22.6688399 /     1.555 MB)
[14/02/2019 18:42:38] [ INFO] Processed 3286 series image links.
[14/02/2019 18:42:38] Exiting getAllSeriesImages(). SUCCESS.
[14/02/2019 18:42:38] [ INFO] Completed compiling keywords and keyword groups.
[14/02/2019 18:42:39] [ INFO] Completed save of the MXF file to "C:\epg123\output\epg123.mxf".
[14/02/2019 18:42:39] [ INFO] Completed save of image archive file to "C:\epg123\guideImages.xml".
[14/02/2019 18:42:41] [ INFO] 18 files deleted from the cache directory during cleanup.
[14/02/2019 18:42:41] [ INFO] Downloaded and processed    21.132 MB of data from Schedules Direct.
[14/02/2019 18:42:41] [ INFO] Generated .mxf file contains 128 services, 3286 series, 11966 programs, and 17317 people with 3785 image links.
[14/02/2019 18:42:41] [ INFO] Completed EPG123 update execution. SUCCESS.
[14/02/2019 18:42:41] [ INFO] epg123 update execution time was 00:02:07.9644258.
[14/02/2019 18:42:41] ===============================================================================
[14/02/2019 18:42:41]  Beginning epg123 client execution. version 1.2.11.0
[14/02/2019 18:42:41] ===============================================================================
[14/02/2019 18:42:41] [ INFO] Beginning epg123 client execution. 2019-02-14 18:42:41Z
[14/02/2019 18:42:41] [ INFO] Import: True , Match: False , NoLogo: False , Force: False , ShowProgress: True
[14/02/2019 18:42:43] Entering importMxfFile() for file "c:\epg123\output\epg123.mxf"
[14/02/2019 18:43:24] [ INFO] Successfully imported .mxf file into Media Center database. Exit code: 0
[14/02/2019 18:43:24] Exiting importMxfFile(). SUCCESS.
[14/02/2019 18:43:24] [ INFO] Completed lineup refresh.
[14/02/2019 18:43:24] Entering runWmcTask(ReindexSearchRoot)
[14/02/2019 18:43:24] [ INFO] SUCCESS: Attempted to run the scheduled task "Microsoft\Windows\Media Center\ReindexSearchRoot".
[14/02/2019 18:43:24] [ INFO] Successfully started the ReindexSearchRoot task. Exit code: 0
[14/02/2019 18:43:24] Exiting runWmcTask(ReindexSearchRoot). SUCCESS.
[14/02/2019 18:43:24] Entering runWmcTask(PvrScheduleTask)
[14/02/2019 18:43:24] [ INFO] SUCCESS: Attempted to run the scheduled task "Microsoft\Windows\Media Center\PvrScheduleTask".
[14/02/2019 18:43:24] [ INFO] Successfully started the PvrScheduleTask task. Exit code: 0
[14/02/2019 18:43:24] Exiting runWmcTask(PvrScheduleTask). SUCCESS.
[14/02/2019 18:43:24] [ERROR] The imported MXF file contained an ERROR in its status field.
[14/02/2019 18:43:24] [ INFO] Completed EPG123 client execution.
[14/02/2019 18:43:24] [ INFO] EPG123 client execution time was 00:00:42.6192748.

kleestark

Posts: 5
Joined: Fri Jan 16, 2015 2:27 am
Location:

HTPC Specs: Show details

#906

Post by kleestark » Thu Feb 14, 2019 7:49 pm

Not sure if I'm in the correct topic here. Running 1.2.11 and everybody appears to be happy; no log warnings or errors, apart from a few info messages re: discontinuity. Configured to ask for 21 days of guide data, and have consistently gotten 19-20 days on average for as long as I can remember (with the occasional slip to 18) until this week, when I've dropped to 16 days on average so far. Lineup = USA-NM30443-X.

Should I be worried about this?

User avatar
garyan2

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

HTPC Specs: Show details

#907

Post by garyan2 » Thu Feb 14, 2019 9:58 pm

sjr56stn wrote:
Thu Feb 14, 2019 6:49 pm
Gary, here is the trace.log for the latest attempt...

Code: Select all

[14/02/2019 18:40:03] ===============================================================================
[14/02/2019 18:40:03]  Activating the epg123 configuration GUI. version 1.2.11.0
[14/02/2019 18:40:03] ===============================================================================
[14/02/2019 18:40:06] [ INFO] Successfully queried the Task Scheduler for status. Ready. Last Run 14/02/2019 03:48:59; Exit: 0x00000000
[14/02/2019 18:40:07] [ INFO] Token request successful. serverID: 20141201.web.1
[14/02/2019 18:40:07] [ INFO] Status request successful. account expires: 2019-08-31T09:33:53Z , lineups: 3/4 , lastDataUpdate: 2019-02-14T13:15:52Z
[14/02/2019 18:40:07] [ INFO] system status: Online , message: No known issues.
[14/02/2019 18:40:08] [ INFO] Successfully requested listing of client lineups from Schedules Direct.
[14/02/2019 18:40:08] [ INFO] Successfully retrieved the station mapping for lineup GBR-1000014-DEFAULT.
[14/02/2019 18:40:09] [ INFO] Successfully retrieved the station mapping for lineup GBR-1000017-DEFAULT.
[14/02/2019 18:40:11] [ INFO] Successfully retrieved the station mapping for lineup ZZZ-19.2E-DEFAULT.
[14/02/2019 18:40:33] ===============================================================================
[14/02/2019 18:40:33]  Beginning epg123 update execution. version 1.2.11.0
[14/02/2019 18:40:33] ===============================================================================
[14/02/2019 18:40:33] [ INFO] Beginning EPG123 update execution. 2019-02-14 18:40:33Z
[14/02/2019 18:40:33] [ INFO] DaysToDownload: 21 , TheTVDBNumbers : False , PrefixEpisodeTitle: False , PrefixEpisodeDescription : False , AppendEpisodeDesc: True , OADOverride : True , TMDbCoverArt: True , IncludeSDLogos : True , AutoAddNew: True , CreateXmltv: False , ModernMediaUiPlusSupport: False
[14/02/2019 18:40:34] [ INFO] Status request successful. account expires: 2019-08-31T09:33:53Z , lineups: 3/4 , lastDataUpdate: 2019-02-14T13:15:52Z
[14/02/2019 18:40:34] [ INFO] system status: Online , message: No known issues.
[14/02/2019 18:40:35] [ INFO] Successfully retrieved TMDb configurations.
[14/02/2019 18:40:50] [ INFO] Successfully requested listing of client lineups from Schedules Direct.
[14/02/2019 18:40:50] Entering buildLineupServices() for 3 lineups.
[14/02/2019 18:40:51] [ INFO] Successfully retrieved the station mapping for lineup GBR-1000014-DEFAULT.
[14/02/2019 18:40:53] [ INFO] Successfully retrieved the station mapping for lineup GBR-1000017-DEFAULT.
[14/02/2019 18:40:54] [ INFO] Successfully retrieved the station mapping for lineup ZZZ-19.2E-DEFAULT.
[14/02/2019 18:40:54] Exiting buildLineupServices(). SUCCESS.
[14/02/2019 18:40:54] Entering getAllScheduleEntryMd5s() for 21 days on 128 stations.
[14/02/2019 18:40:58] [ INFO] Successfully retrieved Md5s for 128 station's daily schedules. (0:00:00:03.8124073 /   247.243 KB)
[14/02/2019 18:41:01] [ INFO] Successfully retrieved   1 station's daily schedules.          (0:00:00:00.6240011 /    40.544 KB)
[14/02/2019 18:41:01] [ INFO] Found 2307 cached daily schedules.
[14/02/2019 18:41:01] [ INFO] Downloaded 18 daily schedules.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:11] [ INFO] Processed 2325 daily schedules for 128 stations.
[14/02/2019 18:41:11] Exiting getAllScheduleEntryMd5s(). SUCCESS.
[14/02/2019 18:41:11] Entering buildAllProgramEntries() for 11966 programs.
[14/02/2019 18:41:31] [ INFO] Found 11966 cached program descriptions.
[14/02/2019 18:41:31] [ INFO] Processed 11966 program descriptions.
[14/02/2019 18:41:31] Exiting buildAllProgramEntries(). SUCCESS.
[14/02/2019 18:41:31] Entering buildAllGenericSeriesInfoDescriptions() for 3286 series.
[14/02/2019 18:41:32] [ INFO] Found 3286 cached series descriptions.
[14/02/2019 18:41:32] [ INFO] Processed 3286 series descriptions.
[14/02/2019 18:41:32] Exiting buildAllGenericSeriesInfoDescriptions(). SUCCESS.
[14/02/2019 18:41:32] Entering getAllMoviePosters() for 591 movies.
[14/02/2019 18:41:36] [ INFO] Successfully retrieved artwork info for  91 programs. (0:00:00:03.7128066 /   609.018 KB)
[14/02/2019 18:41:49] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:16.3196288 /     3.272 MB)
[14/02/2019 18:41:49] [ INFO] Processed 591 movie poster links.
[14/02/2019 18:41:49] Exiting getAllMoviePosters(). SUCCESS.
[14/02/2019 18:41:49] Entering getAllSeriesImages() for 3286 series.
[14/02/2019 18:41:49] [ INFO] Found 0 cached series image links.
[14/02/2019 18:42:08] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:18.9852333 /     4.384 MB)
[14/02/2019 18:42:15] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:25.7244452 /     3.663 MB)
[14/02/2019 18:42:17] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:28.3452498 /     1.867 MB)
[14/02/2019 18:42:27] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:18.9696333 /     2.255 MB)
[14/02/2019 18:42:29] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:40.1544705 /     2.255 MB)
[14/02/2019 18:42:33] [ INFO] Successfully retrieved artwork info for 286 programs. (0:00:00:15.3972270 /     1.005 MB)
[14/02/2019 18:42:38] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:22.6688399 /     1.555 MB)
[14/02/2019 18:42:38] [ INFO] Processed 3286 series image links.
[14/02/2019 18:42:38] Exiting getAllSeriesImages(). SUCCESS.
[14/02/2019 18:42:38] [ INFO] Completed compiling keywords and keyword groups.
[14/02/2019 18:42:39] [ INFO] Completed save of the MXF file to "C:\epg123\output\epg123.mxf".
[14/02/2019 18:42:39] [ INFO] Completed save of image archive file to "C:\epg123\guideImages.xml".
[14/02/2019 18:42:41] [ INFO] 18 files deleted from the cache directory during cleanup.
[14/02/2019 18:42:41] [ INFO] Downloaded and processed    21.132 MB of data from Schedules Direct.
[14/02/2019 18:42:41] [ INFO] Generated .mxf file contains 128 services, 3286 series, 11966 programs, and 17317 people with 3785 image links.
[14/02/2019 18:42:41] [ INFO] Completed EPG123 update execution. SUCCESS.
[14/02/2019 18:42:41] [ INFO] epg123 update execution time was 00:02:07.9644258.
[14/02/2019 18:42:41] ===============================================================================
[14/02/2019 18:42:41]  Beginning epg123 client execution. version 1.2.11.0
[14/02/2019 18:42:41] ===============================================================================
[14/02/2019 18:42:41] [ INFO] Beginning epg123 client execution. 2019-02-14 18:42:41Z
[14/02/2019 18:42:41] [ INFO] Import: True , Match: False , NoLogo: False , Force: False , ShowProgress: True
[14/02/2019 18:42:43] Entering importMxfFile() for file "c:\epg123\output\epg123.mxf"
[14/02/2019 18:43:24] [ INFO] Successfully imported .mxf file into Media Center database. Exit code: 0
[14/02/2019 18:43:24] Exiting importMxfFile(). SUCCESS.
[14/02/2019 18:43:24] [ INFO] Completed lineup refresh.
[14/02/2019 18:43:24] Entering runWmcTask(ReindexSearchRoot)
[14/02/2019 18:43:24] [ INFO] SUCCESS: Attempted to run the scheduled task "Microsoft\Windows\Media Center\ReindexSearchRoot".
[14/02/2019 18:43:24] [ INFO] Successfully started the ReindexSearchRoot task. Exit code: 0
[14/02/2019 18:43:24] Exiting runWmcTask(ReindexSearchRoot). SUCCESS.
[14/02/2019 18:43:24] Entering runWmcTask(PvrScheduleTask)
[14/02/2019 18:43:24] [ INFO] SUCCESS: Attempted to run the scheduled task "Microsoft\Windows\Media Center\PvrScheduleTask".
[14/02/2019 18:43:24] [ INFO] Successfully started the PvrScheduleTask task. Exit code: 0
[14/02/2019 18:43:24] Exiting runWmcTask(PvrScheduleTask). SUCCESS.
[14/02/2019 18:43:24] [ERROR] The imported MXF file contained an ERROR in its status field.
[14/02/2019 18:43:24] [ INFO] Completed EPG123 client execution.
[14/02/2019 18:43:24] [ INFO] EPG123 client execution time was 00:00:42.6192748.
I am sooooo sorry. I used someone else's lineups... not yours. I will check yours out later tonight and you should have the results when you check in the morning.
- Gary
Stomping out the Rovi disease, one media center at a time. http://epg123.garyan2.net

User avatar
garyan2

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

HTPC Specs: Show details

#908

Post by garyan2 » Thu Feb 14, 2019 9:59 pm

kleestark wrote:
Thu Feb 14, 2019 7:49 pm
Not sure if I'm in the correct topic here. Running 1.2.11 and everybody appears to be happy; no log warnings or errors, apart from a few info messages re: discontinuity. Configured to ask for 21 days of guide data, and have consistently gotten 19-20 days on average for as long as I can remember (with the occasional slip to 18) until this week, when I've dropped to 16 days on average so far. Lineup = USA-NM30443-X.

Should I be worried about this?
I wouldn't worry just yet. It could be an indicator, but SD will really say they only advertise 14 days and anything above that is just gravy for the user.

I'll check it out later tonight, anyway.
- Gary
Stomping out the Rovi disease, one media center at a time. http://epg123.garyan2.net

kleestark

Posts: 5
Joined: Fri Jan 16, 2015 2:27 am
Location:

HTPC Specs: Show details

#909

Post by kleestark » Thu Feb 14, 2019 10:15 pm

garyan2 wrote:
Thu Feb 14, 2019 9:59 pm
I wouldn't worry just yet. It could be an indicator, but SD will really say they only advertise 14 days and anything above that is just gravy for the user.

I'll check it out later tonight, anyway.
Thanks, Gary; figured that's how I should view it. I do still seem to be getting at least some new guide data every day, with some stations doing better than others.

User avatar
garyan2

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

HTPC Specs: Show details

#910

Post by garyan2 » Fri Feb 15, 2019 4:07 am

sjr56stn wrote:
Thu Feb 14, 2019 6:49 pm
Gary, here is the trace.log for the latest attempt...

Code: Select all

[14/02/2019 18:40:03] ===============================================================================
[14/02/2019 18:40:03]  Activating the epg123 configuration GUI. version 1.2.11.0
[14/02/2019 18:40:03] ===============================================================================
[14/02/2019 18:40:06] [ INFO] Successfully queried the Task Scheduler for status. Ready. Last Run 14/02/2019 03:48:59; Exit: 0x00000000
[14/02/2019 18:40:07] [ INFO] Token request successful. serverID: 20141201.web.1
[14/02/2019 18:40:07] [ INFO] Status request successful. account expires: 2019-08-31T09:33:53Z , lineups: 3/4 , lastDataUpdate: 2019-02-14T13:15:52Z
[14/02/2019 18:40:07] [ INFO] system status: Online , message: No known issues.
[14/02/2019 18:40:08] [ INFO] Successfully requested listing of client lineups from Schedules Direct.
[14/02/2019 18:40:08] [ INFO] Successfully retrieved the station mapping for lineup GBR-1000014-DEFAULT.
[14/02/2019 18:40:09] [ INFO] Successfully retrieved the station mapping for lineup GBR-1000017-DEFAULT.
[14/02/2019 18:40:11] [ INFO] Successfully retrieved the station mapping for lineup ZZZ-19.2E-DEFAULT.
[14/02/2019 18:40:33] ===============================================================================
[14/02/2019 18:40:33]  Beginning epg123 update execution. version 1.2.11.0
[14/02/2019 18:40:33] ===============================================================================
[14/02/2019 18:40:33] [ INFO] Beginning EPG123 update execution. 2019-02-14 18:40:33Z
[14/02/2019 18:40:33] [ INFO] DaysToDownload: 21 , TheTVDBNumbers : False , PrefixEpisodeTitle: False , PrefixEpisodeDescription : False , AppendEpisodeDesc: True , OADOverride : True , TMDbCoverArt: True , IncludeSDLogos : True , AutoAddNew: True , CreateXmltv: False , ModernMediaUiPlusSupport: False
[14/02/2019 18:40:34] [ INFO] Status request successful. account expires: 2019-08-31T09:33:53Z , lineups: 3/4 , lastDataUpdate: 2019-02-14T13:15:52Z
[14/02/2019 18:40:34] [ INFO] system status: Online , message: No known issues.
[14/02/2019 18:40:35] [ INFO] Successfully retrieved TMDb configurations.
[14/02/2019 18:40:50] [ INFO] Successfully requested listing of client lineups from Schedules Direct.
[14/02/2019 18:40:50] Entering buildLineupServices() for 3 lineups.
[14/02/2019 18:40:51] [ INFO] Successfully retrieved the station mapping for lineup GBR-1000014-DEFAULT.
[14/02/2019 18:40:53] [ INFO] Successfully retrieved the station mapping for lineup GBR-1000017-DEFAULT.
[14/02/2019 18:40:54] [ INFO] Successfully retrieved the station mapping for lineup ZZZ-19.2E-DEFAULT.
[14/02/2019 18:40:54] Exiting buildLineupServices(). SUCCESS.
[14/02/2019 18:40:54] Entering getAllScheduleEntryMd5s() for 21 days on 128 stations.
[14/02/2019 18:40:58] [ INFO] Successfully retrieved Md5s for 128 station's daily schedules. (0:00:00:03.8124073 /   247.243 KB)
[14/02/2019 18:41:01] [ INFO] Successfully retrieved   1 station's daily schedules.          (0:00:00:00.6240011 /    40.544 KB)
[14/02/2019 18:41:01] [ INFO] Found 2307 cached daily schedules.
[14/02/2019 18:41:01] [ INFO] Downloaded 18 daily schedules.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:03] [ERROR] Did not find expected Md5Schedule file in cache directory.
[14/02/2019 18:41:11] [ INFO] Processed 2325 daily schedules for 128 stations.
[14/02/2019 18:41:11] Exiting getAllScheduleEntryMd5s(). SUCCESS.
[14/02/2019 18:41:11] Entering buildAllProgramEntries() for 11966 programs.
[14/02/2019 18:41:31] [ INFO] Found 11966 cached program descriptions.
[14/02/2019 18:41:31] [ INFO] Processed 11966 program descriptions.
[14/02/2019 18:41:31] Exiting buildAllProgramEntries(). SUCCESS.
[14/02/2019 18:41:31] Entering buildAllGenericSeriesInfoDescriptions() for 3286 series.
[14/02/2019 18:41:32] [ INFO] Found 3286 cached series descriptions.
[14/02/2019 18:41:32] [ INFO] Processed 3286 series descriptions.
[14/02/2019 18:41:32] Exiting buildAllGenericSeriesInfoDescriptions(). SUCCESS.
[14/02/2019 18:41:32] Entering getAllMoviePosters() for 591 movies.
[14/02/2019 18:41:36] [ INFO] Successfully retrieved artwork info for  91 programs. (0:00:00:03.7128066 /   609.018 KB)
[14/02/2019 18:41:49] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:16.3196288 /     3.272 MB)
[14/02/2019 18:41:49] [ INFO] Processed 591 movie poster links.
[14/02/2019 18:41:49] Exiting getAllMoviePosters(). SUCCESS.
[14/02/2019 18:41:49] Entering getAllSeriesImages() for 3286 series.
[14/02/2019 18:41:49] [ INFO] Found 0 cached series image links.
[14/02/2019 18:42:08] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:18.9852333 /     4.384 MB)
[14/02/2019 18:42:15] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:25.7244452 /     3.663 MB)
[14/02/2019 18:42:17] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:28.3452498 /     1.867 MB)
[14/02/2019 18:42:27] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:18.9696333 /     2.255 MB)
[14/02/2019 18:42:29] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:40.1544705 /     2.255 MB)
[14/02/2019 18:42:33] [ INFO] Successfully retrieved artwork info for 286 programs. (0:00:00:15.3972270 /     1.005 MB)
[14/02/2019 18:42:38] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:22.6688399 /     1.555 MB)
[14/02/2019 18:42:38] [ INFO] Processed 3286 series image links.
[14/02/2019 18:42:38] Exiting getAllSeriesImages(). SUCCESS.
[14/02/2019 18:42:38] [ INFO] Completed compiling keywords and keyword groups.
[14/02/2019 18:42:39] [ INFO] Completed save of the MXF file to "C:\epg123\output\epg123.mxf".
[14/02/2019 18:42:39] [ INFO] Completed save of image archive file to "C:\epg123\guideImages.xml".
[14/02/2019 18:42:41] [ INFO] 18 files deleted from the cache directory during cleanup.
[14/02/2019 18:42:41] [ INFO] Downloaded and processed    21.132 MB of data from Schedules Direct.
[14/02/2019 18:42:41] [ INFO] Generated .mxf file contains 128 services, 3286 series, 11966 programs, and 17317 people with 3785 image links.
[14/02/2019 18:42:41] [ INFO] Completed EPG123 update execution. SUCCESS.
[14/02/2019 18:42:41] [ INFO] epg123 update execution time was 00:02:07.9644258.
[14/02/2019 18:42:41] ===============================================================================
[14/02/2019 18:42:41]  Beginning epg123 client execution. version 1.2.11.0
[14/02/2019 18:42:41] ===============================================================================
[14/02/2019 18:42:41] [ INFO] Beginning epg123 client execution. 2019-02-14 18:42:41Z
[14/02/2019 18:42:41] [ INFO] Import: True , Match: False , NoLogo: False , Force: False , ShowProgress: True
[14/02/2019 18:42:43] Entering importMxfFile() for file "c:\epg123\output\epg123.mxf"
[14/02/2019 18:43:24] [ INFO] Successfully imported .mxf file into Media Center database. Exit code: 0
[14/02/2019 18:43:24] Exiting importMxfFile(). SUCCESS.
[14/02/2019 18:43:24] [ INFO] Completed lineup refresh.
[14/02/2019 18:43:24] Entering runWmcTask(ReindexSearchRoot)
[14/02/2019 18:43:24] [ INFO] SUCCESS: Attempted to run the scheduled task "Microsoft\Windows\Media Center\ReindexSearchRoot".
[14/02/2019 18:43:24] [ INFO] Successfully started the ReindexSearchRoot task. Exit code: 0
[14/02/2019 18:43:24] Exiting runWmcTask(ReindexSearchRoot). SUCCESS.
[14/02/2019 18:43:24] Entering runWmcTask(PvrScheduleTask)
[14/02/2019 18:43:24] [ INFO] SUCCESS: Attempted to run the scheduled task "Microsoft\Windows\Media Center\PvrScheduleTask".
[14/02/2019 18:43:24] [ INFO] Successfully started the PvrScheduleTask task. Exit code: 0
[14/02/2019 18:43:24] Exiting runWmcTask(PvrScheduleTask). SUCCESS.
[14/02/2019 18:43:24] [ERROR] The imported MXF file contained an ERROR in its status field.
[14/02/2019 18:43:24] [ INFO] Completed EPG123 client execution.
[14/02/2019 18:43:24] [ INFO] EPG123 client execution time was 00:00:42.6192748.
I downloaded all of your stations (for real this time) and can confirm the error. Basically, the MD5 hash downloaded for a specific station on a specific date is not matching what the referencing list of MD5s said it should be. Below is the list of stations and the corresponding dates that have this MD5 mismatch and therefore did not get updated for those dates.

Code: Select all

21810	QVCUK		21/02/2019-03/03/2019
97330	5SPIKUK		15/02/2019-03/03/2019
101972	BLAZUK		15/02/2019-03/03/2019
33638	POP		15/02/2019-03/03/2019
56896	POPMXUK		15/02/2019-06/03/2019
This may clear itself up by next update, but if not, I suggest opening a ticket with the above information.
- Gary
Stomping out the Rovi disease, one media center at a time. http://epg123.garyan2.net

User avatar
garyan2

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

HTPC Specs: Show details

#911

Post by garyan2 » Fri Feb 15, 2019 4:32 am

kleestark wrote:
Thu Feb 14, 2019 10:15 pm
garyan2 wrote:
Thu Feb 14, 2019 9:59 pm
I wouldn't worry just yet. It could be an indicator, but SD will really say they only advertise 14 days and anything above that is just gravy for the user.

I'll check it out later tonight, anyway.
Thanks, Gary; figured that's how I should view it. I do still seem to be getting at least some new guide data every day, with some stations doing better than others.
I'm getting the same results, around 16-17 days worth. If you want to get some data, you can scan through your trace.log file and look for the following string:

Code: Select all

[ INFO] Processed XXXX daily schedules for YY stations.
If you calculate XXXX/YY, you will get the average number of days per station and will be able to see any trend and when it started. I only download 15 days, so I don't have visibility into any degradation here yet.
- Gary
Stomping out the Rovi disease, one media center at a time. http://epg123.garyan2.net

kleestark

Posts: 5
Joined: Fri Jan 16, 2015 2:27 am
Location:

HTPC Specs: Show details

#912

Post by kleestark » Fri Feb 15, 2019 5:26 am

garyan2 wrote:
Fri Feb 15, 2019 4:32 am
If you calculate XXXX/YY, you will get the average number of days per station and will be able to see any trend and when it started. I only download 15 days, so I don't have visibility into any degradation here yet.
Got it. From my logs, that metric consistently lands very near 21 until about Jan 23, when it starts moving gradually lower. Average of task runs in the last few days now closer to 17-18.
Assuming I'm still asking for a valid lineup as I do still get some new data every day.
I suppose if SD isn't getting data, there's not much to do? Can certainly live with this level -- if it keeps moving lower, I'll post again. Thanks!

sjr56stn

Posts: 34
Joined: Tue Mar 03, 2015 4:49 pm
Location:

HTPC Specs: Show details

#913

Post by sjr56stn » Fri Feb 15, 2019 11:00 am

Gary,
Yes I was impressed by the standard of your clairvoyance, checking the download of my line-ups when I hadn’t yet sent you the trace file!
As you suggest I shall raise a ticket with SD.
I looked at the five stations you identified as having the MD5 mismatch, and only one of the five was checked for download in EPG123, so I decided to uncheck it and see if that cleared the problem, and it did. So I have a temporary work-around.
Thanks and regards,
Steve

User avatar
garyan2

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

HTPC Specs: Show details

#914

Post by garyan2 » Fri Feb 15, 2019 4:52 pm

sjr56stn wrote:
Fri Feb 15, 2019 11:00 am
Gary,
Yes I was impressed by the standard of your clairvoyance, checking the download of my line-ups when I hadn’t yet sent you the trace file!
As you suggest I shall raise a ticket with SD.
I looked at the five stations you identified as having the MD5 mismatch, and only one of the five was checked for download in EPG123, so I decided to uncheck it and see if that cleared the problem, and it did. So I have a temporary work-around.
Thanks and regards,
Steve
Yah, I fumbled a bit there. You have sent me files in the past as well as posted trace information before which would have made me appear clairvoyant ... but I screwed that up.

Either way, it looks like @rkulagow has found the issue and cleared it up. You will probably be getting a response from him soon and closing the ticket. :thumbup:
- Gary
Stomping out the Rovi disease, one media center at a time. http://epg123.garyan2.net

sjr56stn

Posts: 34
Joined: Tue Mar 03, 2015 4:49 pm
Location:

HTPC Specs: Show details

#915

Post by sjr56stn » Sat Feb 16, 2019 10:57 am

Yes, he has now fixed the problem.

dafunk60

Posts: 13
Joined: Tue Sep 20, 2016 1:17 am
Location:

HTPC Specs: Show details

#916

Post by dafunk60 » Thu Feb 21, 2019 5:32 am

Hello,

I've been getting the following error for the past couple of days.

Code: Select all

[2/21/2019 12:24:00 AM] ===============================================================================
[2/21/2019 12:24:00 AM]  Beginning epg123 client execution. version 1.2.11.0
[2/21/2019 12:24:00 AM] ===============================================================================
[2/21/2019 12:24:00 AM] [ INFO] Beginning epg123 client execution. 2019-02-21 05:24:00Z
[2/21/2019 12:24:00 AM] [ INFO] Import: True , Match: True , NoLogo: False , Force: False , ShowProgress: True
[2/21/2019 12:24:01 AM] Entering importMxfFile() for file "c:\epg123\output\epg123.mxf"
[2/21/2019 12:24:42 AM] [ INFO] Error: The following error was encountered while processing the file. Aborting.
[2/21/2019 12:24:42 AM] [ INFO] RowSet::SetRange failed on Program_keywords Program_keywordsI_ParentChildKey - HR = 0x80004005, minor = 28574, 1471, 0, 0, "", "", ""
[2/21/2019 12:24:42 AM] [ERROR] Error using loadmxf.exe to import new guide information. Exit code: -1
[2/21/2019 12:24:42 AM] Exiting importMxfFile(). FAILURE.
[2/21/2019 12:24:42 AM] [ERROR] Failed to import .mxf file. Exiting.
[2/21/2019 12:24:42 AM] [WARNG] The imported MXF file contained a WARNING in its status field.
I've cleared the cache & tried the import from the epg123.exe. Anything else I should try or any other info I can provide to troubleshoot?

Thanks!

User avatar
garyan2

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

HTPC Specs: Show details

#917

Post by garyan2 » Thu Feb 21, 2019 6:35 am

dafunk60 wrote:
Thu Feb 21, 2019 5:32 am
Hello,

I've been getting the following error for the past couple of days.

Code: Select all

[2/21/2019 12:24:00 AM] ===============================================================================
[2/21/2019 12:24:00 AM]  Beginning epg123 client execution. version 1.2.11.0
[2/21/2019 12:24:00 AM] ===============================================================================
[2/21/2019 12:24:00 AM] [ INFO] Beginning epg123 client execution. 2019-02-21 05:24:00Z
[2/21/2019 12:24:00 AM] [ INFO] Import: True , Match: True , NoLogo: False , Force: False , ShowProgress: True
[2/21/2019 12:24:01 AM] Entering importMxfFile() for file "c:\epg123\output\epg123.mxf"
[2/21/2019 12:24:42 AM] [ INFO] Error: The following error was encountered while processing the file. Aborting.
[2/21/2019 12:24:42 AM] [ INFO] RowSet::SetRange failed on Program_keywords Program_keywordsI_ParentChildKey - HR = 0x80004005, minor = 28574, 1471, 0, 0, "", "", ""
[2/21/2019 12:24:42 AM] [ERROR] Error using loadmxf.exe to import new guide information. Exit code: -1
[2/21/2019 12:24:42 AM] Exiting importMxfFile(). FAILURE.
[2/21/2019 12:24:42 AM] [ERROR] Failed to import .mxf file. Exiting.
[2/21/2019 12:24:42 AM] [WARNG] The imported MXF file contained a WARNING in its status field.
I've cleared the cache & tried the import from the epg123.exe. Anything else I should try or any other info I can provide to troubleshoot?

Thanks!
Looks like your database may be corrupted. Try the following to try and restore functionality (stop when problem goes away):

1) From a command prompt, run "start /wait c:\windows\ehome\mcupdate.exe -uf -dbgc".
2) Using EPG123, clear the cache and do a [Save & Execute].
3) Using EPG123 Client, click the [Rebuild WMC Database]. You will have to import the guide listings once complete (or do #2 again).
4) Using EPG123 Client, click the [Client Setup] button for a clean start.

#1 will possibly fix any WMC database corruption if that is the problem.
#2 will clear out any corrupted cached files used to create the mxf file if that is the problem.
#3 will delete the current WMC database and restore your tuner setups, scheduled recordings, and custom configurations.
#4 will nuke the WMC database and ehome folder and start over. You will still be able to restore your scheduled recordings and custom configurations.

You could actually do #1 and #2 at the same time.
- Gary
Stomping out the Rovi disease, one media center at a time. http://epg123.garyan2.net

dafunk60

Posts: 13
Joined: Tue Sep 20, 2016 1:17 am
Location:

HTPC Specs: Show details

#918

Post by dafunk60 » Sun Feb 24, 2019 1:56 am

garyan2 wrote:
Thu Feb 21, 2019 6:35 am
Looks like your database may be corrupted. Try the following to try and restore functionality (stop when problem goes away):

1) From a command prompt, run "start /wait c:\windows\ehome\mcupdate.exe -uf -dbgc".
2) Using EPG123, clear the cache and do a [Save & Execute].
3) Using EPG123 Client, click the [Rebuild WMC Database]. You will have to import the guide listings once complete (or do #2 again).
4) Using EPG123 Client, click the [Client Setup] button for a clean start.
....
Thank you for the help! Steps 1 & 2 have resolved the issue. I suspect you are correct about the WMC DB was corrupted as mcupdate.exe -uf -dbgc crashed the first two times I ran it. Third time it completed. I then performed step 2 and there were no errors in the epg123 log.

Katarr

Posts: 9
Joined: Mon Jan 09, 2017 4:55 am
Location:

HTPC Specs: Show details

#919

Post by Katarr » Mon Feb 25, 2019 3:04 pm

Gary,

I have an odd problem here. I was seeing a bunch of the "Red Icon" indicators, but (just odd timing) when I checked them, there was usually a new update to install. Now I am getting on their own, so I checked the log. The only error I can see is one that tells me that the MXF file imported is really old. Although it reports as an error, I do seem to be getting updated channel listings just fine. I don't know the internals, but I thought the MXF file was created anew with each run, so could I have a folder permissions issue? Anyway, here is a copy of the log from last night...

ROBIN.

Code: Select all

[02/25/2019 03:00:00] ===============================================================================
[02/25/2019 03:00:00]  Beginning epg123 update execution. version 1.2.11.0
[02/25/2019 03:00:00] ===============================================================================
[02/25/2019 03:00:00] [ INFO] Beginning EPG123 update execution. 2019-02-25 10:00:00Z
[02/25/2019 03:00:00] [ INFO] DaysToDownload: 21 , TheTVDBNumbers : False , PrefixEpisodeTitle: False , PrefixEpisodeDescription : False , AppendEpisodeDesc: False , OADOverride : True , TMDbCoverArt: True , IncludeSDLogos : True , AutoAddNew: False , CreateXmltv: False , ModernMediaUiPlusSupport: False
[02/25/2019 03:00:01] [ INFO] Token request successful. serverID: 20141201.web.1
[02/25/2019 03:00:01] [ INFO] Status request successful. account expires: 2019-07-30T03:40:05Z , lineups: 1/4 , lastDataUpdate: 2019-02-24T23:22:59Z
[02/25/2019 03:00:01] [ INFO] system status: Online , message: No known issues.
[02/25/2019 03:00:01] [ INFO] Successfully retrieved TMDb configurations.
[02/25/2019 03:00:01] [ INFO] Successfully requested listing of client lineups from Schedules Direct.
[02/25/2019 03:00:01] Entering buildLineupServices() for 1 lineups.
[02/25/2019 03:00:02] [ INFO] Successfully retrieved the station mapping for lineup USA-AZ02424-X.
[02/25/2019 03:00:02] Exiting buildLineupServices(). SUCCESS.
[02/25/2019 03:00:02] Entering getAllScheduleEntryMd5s() for 21 days on 69 stations.
[02/25/2019 03:00:03] [ INFO] Successfully retrieved Md5s for  69 station's daily schedules. (0:00:00:00.7901003 /   124.797 KB)
[02/25/2019 03:00:03] [ INFO] Successfully retrieved  43 station's daily schedules.          (0:00:00:00.4740602 /   606.863 KB)
[02/25/2019 03:00:04] [ INFO] Found 1072 cached daily schedules.
[02/25/2019 03:00:04] [ INFO] Downloaded 101 daily schedules.
[02/25/2019 03:00:06] [ INFO] Processed 1173 daily schedules for 69 stations.
[02/25/2019 03:00:06] Exiting getAllScheduleEntryMd5s(). SUCCESS.
[02/25/2019 03:00:06] Entering buildAllProgramEntries() for 17060 programs.
[02/25/2019 03:00:20] [ INFO] Found 16604 cached program descriptions.
[02/25/2019 03:00:20] [ INFO] Successfully retrieved  456 program descriptions. (0:00:00:00.7335931 /   940.638 KB)
[02/25/2019 03:00:22] [ INFO] Processed 17060 program descriptions.
[02/25/2019 03:00:22] Exiting buildAllProgramEntries(). SUCCESS.
[02/25/2019 03:00:22] Entering buildAllGenericSeriesInfoDescriptions() for 2014 series.
[02/25/2019 03:00:23] [ INFO] Found 1997 cached series descriptions.
[02/25/2019 03:00:23] [ INFO] Successfully retrieved  17 generic program descriptions. (0:00:00:00.1465187 /    10.164 KB)
[02/25/2019 03:00:23] [ INFO] Processed 2014 series descriptions.
[02/25/2019 03:00:23] Exiting buildAllGenericSeriesInfoDescriptions(). SUCCESS.
[02/25/2019 03:00:23] Entering getAllMoviePosters() for 1166 movies.
[02/25/2019 03:00:24] [ INFO] Successfully retrieved artwork info for 166 programs. (0:00:00:00.5990761 /     1.317 MB)
[02/25/2019 03:00:25] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:01.7517225 /     2.981 MB)
[02/25/2019 03:00:26] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:03.4654401 /     4.417 MB)
[02/25/2019 03:00:27] [ INFO] Processed 1166 movie poster links.
[02/25/2019 03:00:27] Exiting getAllMoviePosters(). SUCCESS.
[02/25/2019 03:00:27] Entering getAllSeriesImages() for 2014 series.
[02/25/2019 03:00:27] [ INFO] Found 0 cached series image links.
[02/25/2019 03:00:29] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:01.8172307 /     4.391 MB)
[02/25/2019 03:00:30] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:03.0848917 /     8.386 MB)
[02/25/2019 03:00:31] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:03.9650035 /     5.449 MB)
[02/25/2019 03:00:31] [ INFO] Successfully retrieved artwork info for  14 programs. (0:00:00:01.8417339 /   327.396 KB)
[02/25/2019 03:00:32] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:04.8566167 /     4.338 MB)
[02/25/2019 03:00:33] [ INFO] Processed 2014 series image links.
[02/25/2019 03:00:33] Exiting getAllSeriesImages(). SUCCESS.
[02/25/2019 03:00:33] [ INFO] Completed compiling keywords and keyword groups.
[02/25/2019 03:00:34] [ INFO] Completed save of the MXF file to "C:\ProgramData\GaRyan2\epg123\output\epg123.mxf".
[02/25/2019 03:00:34] [ INFO] Completed save of image archive file to "C:\ProgramData\GaRyan2\epg123\guideImages.xml".
[02/25/2019 03:00:35] [ INFO] 1201 files deleted from the cache directory during cleanup.
[02/25/2019 03:00:35] [ INFO] Downloaded and processed    33.241 MB of data from Schedules Direct.
[02/25/2019 03:00:35] [ INFO] Generated .mxf file contains 69 services, 2014 series, 17060 programs, and 32654 people with 3211 image links.
[02/25/2019 03:00:35] [ INFO] Completed EPG123 update execution. SUCCESS.
[02/25/2019 03:00:35] [ INFO] epg123 update execution time was 00:00:34.9704407.
[02/25/2019 03:00:35] ===============================================================================
[02/25/2019 03:00:35]  Beginning epg123 client execution. version 1.2.11.0
[02/25/2019 03:00:35] ===============================================================================
[02/25/2019 03:00:35] [ INFO] Beginning epg123 client execution. 2019-02-25 10:00:35Z
[02/25/2019 03:00:35] [ INFO] Import: True , Match: True , NoLogo: False , Force: False , ShowProgress: False
[02/25/2019 03:00:36] Entering importMxfFile() for file "c:\program files (x86)\epg123\epg123.mxf"
[02/25/2019 03:01:59] [ INFO] Successfully imported .mxf file into Media Center database. Exit code: 0
[02/25/2019 03:01:59] Exiting importMxfFile(). SUCCESS.
[02/25/2019 03:02:01] [ INFO] Removing KPHODT2 from channel 32 in lineup EPG123 Cable ONE - Digital (Prescott).
[02/25/2019 03:02:01] [ INFO] Matching OLY to channel 162
[02/25/2019 03:02:01] [ INFO] Matching KAETDT to channel 1008
[02/25/2019 03:02:01] [ INFO] Removing ESPNUHD from channel 1136 in lineup EPG123 Cable ONE - Digital (Prescott).
[02/25/2019 03:02:01] [ INFO] Removing GOLFHD from channel 1158 in lineup EPG123 Cable ONE - Digital (Prescott).
[02/25/2019 03:02:01] [ INFO] Matching OLYHD to channel 1162
[02/25/2019 03:02:01] [ INFO] Removing FOODPHD from channel 1271 in lineup EPG123 Cable ONE - Digital (Prescott).
[02/25/2019 03:02:01] [ INFO] Removing HGTVPHD from channel 1273 in lineup EPG123 Cable ONE - Digital (Prescott).
[02/25/2019 03:02:01] [ INFO] Removing TRAVPHD from channel 1282 in lineup EPG123 Cable ONE - Digital (Prescott).
[02/25/2019 03:02:01] [ INFO] Removing FBNHD from channel 1338 in lineup EPG123 Cable ONE - Digital (Prescott).
[02/25/2019 03:02:02] [ INFO] Completed the automatch of lineup stations to tuner channels.
[02/25/2019 03:02:02] [ INFO] Completed lineup refresh.
[02/25/2019 03:02:02] Entering runWmcTask(ReindexSearchRoot)
[02/25/2019 03:02:02] [ INFO] SUCCESS: Attempted to run the scheduled task "Microsoft\Windows\Media Center\ReindexSearchRoot".
[02/25/2019 03:02:02] [ INFO] Successfully started the ReindexSearchRoot task. Exit code: 0
[02/25/2019 03:02:02] Exiting runWmcTask(ReindexSearchRoot). SUCCESS.
[02/25/2019 03:02:02] [ INFO] Changed "Chronicle Mysteries" series recording request's 'anyLanguage' setting to TRUE.
[02/25/2019 03:02:02] Entering runWmcTask(PvrScheduleTask)
[02/25/2019 03:02:02] [ INFO] SUCCESS: Attempted to run the scheduled task "Microsoft\Windows\Media Center\PvrScheduleTask".
[02/25/2019 03:02:02] [ INFO] Successfully started the PvrScheduleTask task. Exit code: 0
[02/25/2019 03:02:02] Exiting runWmcTask(PvrScheduleTask). SUCCESS.
[02/25/2019 03:02:03] [ERROR] The MXF file imported is 3,552.03 hours old.
[02/25/2019 03:02:03] [ INFO] Completed EPG123 client execution.
[02/25/2019 03:02:03] [ INFO] EPG123 client execution time was 00:01:27.4836090.
[02/25/2019 06:31:08] ===============================================================================
[02/25/2019 06:31:08]  Activating the epg123 configuration GUI. version 1.2.11.0
[02/25/2019 06:31:08] ===============================================================================
[02/25/2019 06:31:09] [ INFO] Successfully queried the Task Scheduler for status. Ready. Last Run 02/25/2019 02:59:59; Exit: 0x00000000
[02/25/2019 06:31:09] [ INFO] Token request successful. serverID: 20141201.web.1
[02/25/2019 06:31:09] [ INFO] Status request successful. account expires: 2019-07-30T03:40:05Z , lineups: 1/4 , lastDataUpdate: 2019-02-24T23:22:59Z
[02/25/2019 06:31:09] [ INFO] system status: Online , message: No known issues.
[02/25/2019 06:31:09] [ INFO] Successfully requested listing of client lineups from Schedules Direct.
[02/25/2019 06:31:10] [ INFO] Successfully retrieved the station mapping for lineup USA-AZ02424-X.

User avatar
garyan2

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

HTPC Specs: Show details

#920

Post by garyan2 » Tue Feb 26, 2019 12:24 am

Katarr wrote:
Mon Feb 25, 2019 3:04 pm
Gary,

I have an odd problem here. I was seeing a bunch of the "Red Icon" indicators, but (just odd timing) when I checked them, there was usually a new update to install. Now I am getting on their own, so I checked the log. The only error I can see is one that tells me that the MXF file imported is really old. Although it reports as an error, I do seem to be getting updated channel listings just fine. I don't know the internals, but I thought the MXF file was created anew with each run, so could I have a folder permissions issue? Anyway, here is a copy of the log from last night...

ROBIN.

Code: Select all

[02/25/2019 03:00:00] ===============================================================================
[02/25/2019 03:00:00]  Beginning epg123 update execution. version 1.2.11.0
[02/25/2019 03:00:00] ===============================================================================
[02/25/2019 03:00:00] [ INFO] Beginning EPG123 update execution. 2019-02-25 10:00:00Z
[02/25/2019 03:00:00] [ INFO] DaysToDownload: 21 , TheTVDBNumbers : False , PrefixEpisodeTitle: False , PrefixEpisodeDescription : False , AppendEpisodeDesc: False , OADOverride : True , TMDbCoverArt: True , IncludeSDLogos : True , AutoAddNew: False , CreateXmltv: False , ModernMediaUiPlusSupport: False
[02/25/2019 03:00:01] [ INFO] Token request successful. serverID: 20141201.web.1
[02/25/2019 03:00:01] [ INFO] Status request successful. account expires: 2019-07-30T03:40:05Z , lineups: 1/4 , lastDataUpdate: 2019-02-24T23:22:59Z
[02/25/2019 03:00:01] [ INFO] system status: Online , message: No known issues.
[02/25/2019 03:00:01] [ INFO] Successfully retrieved TMDb configurations.
[02/25/2019 03:00:01] [ INFO] Successfully requested listing of client lineups from Schedules Direct.
[02/25/2019 03:00:01] Entering buildLineupServices() for 1 lineups.
[02/25/2019 03:00:02] [ INFO] Successfully retrieved the station mapping for lineup USA-AZ02424-X.
[02/25/2019 03:00:02] Exiting buildLineupServices(). SUCCESS.
[02/25/2019 03:00:02] Entering getAllScheduleEntryMd5s() for 21 days on 69 stations.
[02/25/2019 03:00:03] [ INFO] Successfully retrieved Md5s for  69 station's daily schedules. (0:00:00:00.7901003 /   124.797 KB)
[02/25/2019 03:00:03] [ INFO] Successfully retrieved  43 station's daily schedules.          (0:00:00:00.4740602 /   606.863 KB)
[02/25/2019 03:00:04] [ INFO] Found 1072 cached daily schedules.
[02/25/2019 03:00:04] [ INFO] Downloaded 101 daily schedules.
[02/25/2019 03:00:06] [ INFO] Processed 1173 daily schedules for 69 stations.
[02/25/2019 03:00:06] Exiting getAllScheduleEntryMd5s(). SUCCESS.
[02/25/2019 03:00:06] Entering buildAllProgramEntries() for 17060 programs.
[02/25/2019 03:00:20] [ INFO] Found 16604 cached program descriptions.
[02/25/2019 03:00:20] [ INFO] Successfully retrieved  456 program descriptions. (0:00:00:00.7335931 /   940.638 KB)
[02/25/2019 03:00:22] [ INFO] Processed 17060 program descriptions.
[02/25/2019 03:00:22] Exiting buildAllProgramEntries(). SUCCESS.
[02/25/2019 03:00:22] Entering buildAllGenericSeriesInfoDescriptions() for 2014 series.
[02/25/2019 03:00:23] [ INFO] Found 1997 cached series descriptions.
[02/25/2019 03:00:23] [ INFO] Successfully retrieved  17 generic program descriptions. (0:00:00:00.1465187 /    10.164 KB)
[02/25/2019 03:00:23] [ INFO] Processed 2014 series descriptions.
[02/25/2019 03:00:23] Exiting buildAllGenericSeriesInfoDescriptions(). SUCCESS.
[02/25/2019 03:00:23] Entering getAllMoviePosters() for 1166 movies.
[02/25/2019 03:00:24] [ INFO] Successfully retrieved artwork info for 166 programs. (0:00:00:00.5990761 /     1.317 MB)
[02/25/2019 03:00:25] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:01.7517225 /     2.981 MB)
[02/25/2019 03:00:26] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:03.4654401 /     4.417 MB)
[02/25/2019 03:00:27] [ INFO] Processed 1166 movie poster links.
[02/25/2019 03:00:27] Exiting getAllMoviePosters(). SUCCESS.
[02/25/2019 03:00:27] Entering getAllSeriesImages() for 2014 series.
[02/25/2019 03:00:27] [ INFO] Found 0 cached series image links.
[02/25/2019 03:00:29] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:01.8172307 /     4.391 MB)
[02/25/2019 03:00:30] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:03.0848917 /     8.386 MB)
[02/25/2019 03:00:31] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:03.9650035 /     5.449 MB)
[02/25/2019 03:00:31] [ INFO] Successfully retrieved artwork info for  14 programs. (0:00:00:01.8417339 /   327.396 KB)
[02/25/2019 03:00:32] [ INFO] Successfully retrieved artwork info for 500 programs. (0:00:00:04.8566167 /     4.338 MB)
[02/25/2019 03:00:33] [ INFO] Processed 2014 series image links.
[02/25/2019 03:00:33] Exiting getAllSeriesImages(). SUCCESS.
[02/25/2019 03:00:33] [ INFO] Completed compiling keywords and keyword groups.
[02/25/2019 03:00:34] [ INFO] Completed save of the MXF file to "C:\ProgramData\GaRyan2\epg123\output\epg123.mxf".
[02/25/2019 03:00:34] [ INFO] Completed save of image archive file to "C:\ProgramData\GaRyan2\epg123\guideImages.xml".
[02/25/2019 03:00:35] [ INFO] 1201 files deleted from the cache directory during cleanup.
[02/25/2019 03:00:35] [ INFO] Downloaded and processed    33.241 MB of data from Schedules Direct.
[02/25/2019 03:00:35] [ INFO] Generated .mxf file contains 69 services, 2014 series, 17060 programs, and 32654 people with 3211 image links.
[02/25/2019 03:00:35] [ INFO] Completed EPG123 update execution. SUCCESS.
[02/25/2019 03:00:35] [ INFO] epg123 update execution time was 00:00:34.9704407.
[02/25/2019 03:00:35] ===============================================================================
[02/25/2019 03:00:35]  Beginning epg123 client execution. version 1.2.11.0
[02/25/2019 03:00:35] ===============================================================================
[02/25/2019 03:00:35] [ INFO] Beginning epg123 client execution. 2019-02-25 10:00:35Z
[02/25/2019 03:00:35] [ INFO] Import: True , Match: True , NoLogo: False , Force: False , ShowProgress: False
[02/25/2019 03:00:36] Entering importMxfFile() for file "c:\program files (x86)\epg123\epg123.mxf"
[02/25/2019 03:01:59] [ INFO] Successfully imported .mxf file into Media Center database. Exit code: 0
[02/25/2019 03:01:59] Exiting importMxfFile(). SUCCESS.
[02/25/2019 03:02:01] [ INFO] Removing KPHODT2 from channel 32 in lineup EPG123 Cable ONE - Digital (Prescott).
[02/25/2019 03:02:01] [ INFO] Matching OLY to channel 162
[02/25/2019 03:02:01] [ INFO] Matching KAETDT to channel 1008
[02/25/2019 03:02:01] [ INFO] Removing ESPNUHD from channel 1136 in lineup EPG123 Cable ONE - Digital (Prescott).
[02/25/2019 03:02:01] [ INFO] Removing GOLFHD from channel 1158 in lineup EPG123 Cable ONE - Digital (Prescott).
[02/25/2019 03:02:01] [ INFO] Matching OLYHD to channel 1162
[02/25/2019 03:02:01] [ INFO] Removing FOODPHD from channel 1271 in lineup EPG123 Cable ONE - Digital (Prescott).
[02/25/2019 03:02:01] [ INFO] Removing HGTVPHD from channel 1273 in lineup EPG123 Cable ONE - Digital (Prescott).
[02/25/2019 03:02:01] [ INFO] Removing TRAVPHD from channel 1282 in lineup EPG123 Cable ONE - Digital (Prescott).
[02/25/2019 03:02:01] [ INFO] Removing FBNHD from channel 1338 in lineup EPG123 Cable ONE - Digital (Prescott).
[02/25/2019 03:02:02] [ INFO] Completed the automatch of lineup stations to tuner channels.
[02/25/2019 03:02:02] [ INFO] Completed lineup refresh.
[02/25/2019 03:02:02] Entering runWmcTask(ReindexSearchRoot)
[02/25/2019 03:02:02] [ INFO] SUCCESS: Attempted to run the scheduled task "Microsoft\Windows\Media Center\ReindexSearchRoot".
[02/25/2019 03:02:02] [ INFO] Successfully started the ReindexSearchRoot task. Exit code: 0
[02/25/2019 03:02:02] Exiting runWmcTask(ReindexSearchRoot). SUCCESS.
[02/25/2019 03:02:02] [ INFO] Changed "Chronicle Mysteries" series recording request's 'anyLanguage' setting to TRUE.
[02/25/2019 03:02:02] Entering runWmcTask(PvrScheduleTask)
[02/25/2019 03:02:02] [ INFO] SUCCESS: Attempted to run the scheduled task "Microsoft\Windows\Media Center\PvrScheduleTask".
[02/25/2019 03:02:02] [ INFO] Successfully started the PvrScheduleTask task. Exit code: 0
[02/25/2019 03:02:02] Exiting runWmcTask(PvrScheduleTask). SUCCESS.
[02/25/2019 03:02:03] [ERROR] The MXF file imported is 3,552.03 hours old.
[02/25/2019 03:02:03] [ INFO] Completed EPG123 client execution.
[02/25/2019 03:02:03] [ INFO] EPG123 client execution time was 00:01:27.4836090.
[02/25/2019 06:31:08] ===============================================================================
[02/25/2019 06:31:08]  Activating the epg123 configuration GUI. version 1.2.11.0
[02/25/2019 06:31:08] ===============================================================================
[02/25/2019 06:31:09] [ INFO] Successfully queried the Task Scheduler for status. Ready. Last Run 02/25/2019 02:59:59; Exit: 0x00000000
[02/25/2019 06:31:09] [ INFO] Token request successful. serverID: 20141201.web.1
[02/25/2019 06:31:09] [ INFO] Status request successful. account expires: 2019-07-30T03:40:05Z , lineups: 1/4 , lastDataUpdate: 2019-02-24T23:22:59Z
[02/25/2019 06:31:09] [ INFO] system status: Online , message: No known issues.
[02/25/2019 06:31:09] [ INFO] Successfully requested listing of client lineups from Schedules Direct.
[02/25/2019 06:31:10] [ INFO] Successfully retrieved the station mapping for lineup USA-AZ02424-X.
I don't know how you got here, but first thing to do is delete your current task and create a new one. If you look in the log, you will see the following:

Code: Select all

[02/25/2019 03:00:34] [ INFO] Completed save of the MXF file to "C:\ProgramData\GaRyan2\epg123\output\epg123.mxf".
 ...
[02/25/2019 03:00:36] Entering importMxfFile() for file "c:\program files (x86)\epg123\epg123.mxf"
You are not importing the same file that you are creating. The file in the Program Files folder is 148 days old which puts it back to the beginning of October 2018?

Once you create a new task, perform a [Save & Execute] and verify that you get the green logo.
- Gary
Stomping out the Rovi disease, one media center at a time. http://epg123.garyan2.net

Post Reply