EPG update broken when Channel changes transponder or is renamed #179

sidey79 · 2019-02-02T23:10:21Z

I've updated to 3.16.2.2 today and wanted to check if #158 is fixed. But now, i can't get epg data:

00:01:48.300 T:3671061360  NOTICE: AddOnLog: Enigma2 Client: pvr.vuplus - GetEPGForChannel Could not find <e2event> element
00:01:48.300 T:3671061360   ERROR: GetEPGForChannel: Add-on 'ET9200:10.2.11.24' returned an error: server error
00:01:48.300 T:3671061360   ERROR: Update: Failed to update table '<n/a>'
00:01:48.438 T:3671061360  NOTICE: AddOnLog: Enigma2 Client: pvr.vuplus - GetEPGForChannel Could not find <e2event> element
00:01:48.438 T:3671061360   ERROR: GetEPGForChannel: Add-on 'ET9200:10.2.11.24' returned an error: server error
00:01:48.438 T:3671061360   ERROR: Update: Failed to update table '<n/a>'
00:01:48.572 T:3671061360  NOTICE: AddOnLog: Enigma2 Client: pvr.vuplus - GetEPGForChannel Could not find <e2event> element
00:01:48.572 T:3671061360   ERROR: GetEPGForChannel: Add-on 'ET9200:10.2.11.24' returned an error: server error
00:01:48.573 T:3671061360   ERROR: Update: Failed to update table '<n/a>'
00:01:50.037 T:3671061360  NOTICE: AddOnLog: Enigma2 Client: pvr.vuplus - GetEPGForChannel Could not find <e2event> element
00:01:50.037 T:3671061360   ERROR: GetEPGForChannel: Add-on 'ET9200:10.2.11.24' returned an error: server error

Playback of recordings is working.
LiveTV is also working

My enigma2 receiver is running on OWIF 1.3.5.

The text was updated successfully, but these errors were encountered:

phunkyfish · 2019-02-02T23:45:23Z

Do you have a debug log? Then I can ask you for the output of a few api calls to see what’s different.

<n/a> should be ignored in your channels list.

This should only be cosmetic in the log however. Is there an impact in kodi?

sidey79 · 2019-02-02T23:57:33Z

i know, this sounds strange, but enabeling debug, will cause the epg refresh to work

Thread PVRGUIProgressHandler start, auto delete: true
00:49:08.434 T:3832095600   DEBUG: AddOnLog: Enigma2 Client: pvr.vuplus - GetEPGForChannel Getting EPG for channel 'Das Erste HD'
00:49:08.434 T:3832095600    INFO: AddOnLog: Enigma2 Client: pvr.vuplus - GetHttpXML Open webAPI with URL: 'http://10.2.11.24:80/web/epgservice?sRef=1%3A0%3A19%3A283D%3A3FB%3A1%3AC00000%3A0%3A0%3A0%3A'
00:49:08.434 T:3832095600   DEBUG: CFileCache::Open - opening <web/epgservice> using cache
00:49:08.435 T:3832095600   DEBUG: CurlFile::Open(0xf183a1a8) http://10.2.11.24:80/web/epgservice?sRef=1%3A0%3A19%3A283D%3A3FB%3A1%3AC00000%3A0%3A0%3A0%3A
00:49:08.435 T:3832095600    INFO: easy_acquire - Created session to http://10.2.11.24
00:49:12.108 T:3332359024   DEBUG: Thread FileCache start, auto delete: false
00:49:12.173 T:3480216432    INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?)
00:49:12.174 T:3480216432   DEBUG: Thread FileCache 3480216432 terminating
00:49:12.175 T:3732927344    INFO: AddOnLog: Enigma2 Client: pvr.vuplus - GetHttpXML Got result. Length: 218083
00:49:12.185 T:3332359024    INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?)
00:49:12.186 T:3332359024   DEBUG: Thread FileCache 3332359024 terminating
00:49:12.186 T:3832095600    INFO: AddOnLog: Enigma2 Client: pvr.vuplus - GetHttpXML Got result. Length: 175008
00:49:12.211 T:3732927344    INFO: AddOnLog: Enigma2 Client: pvr.vuplus - GetEPGForChannel Loaded 1 EPG Entries for channel 'ONE HD'
00:49:12.215 T:3732927344   DEBUG: AddOnLog: Enigma2 Client: pvr.vuplus - GetEPGForChannel Getting EPG for channel 'ONE HD'
00:49:12.216 T:3732927344    INFO: AddOnLog: Enigma2 Client: pvr.vuplus - GetHttpXML Open webAPI with URL: 'http://10.2.11.24:80/web/epgservice?sRef=1%3A0%3A19%3A2888%3A40F%3A1%3AC00000%3A0%3A0%3A0%3A'
00:49:12.216 T:3732927344   DEBUG: CFileCache::Open - opening <web/epgservice> using cache
00:49:12.216 T:3732927344   DEBUG: CurlFile::Open(0x2153528) http://10.2.11.24:80/web/epgservice?sRef=1%3A0%3A19%3A2888%3A40F%3A1%3AC00000%3A0%3A0%3A0%3A
00:49:12.222 T:3832095600    INFO: AddOnLog: Enigma2 Client: pvr.vuplus - GetEPGForChannel Loaded 103 EPG Entries for channel 'Das Erste HD'
00:49:12.232 T:3832095600   DEBUG: AddOnLog: Enigma2 Client: pvr.vuplus - GetEPGForChannel Getting EPG for channel 'ZDF HD'
00:49:12.232 T:3832095600    INFO: AddOnLog: Enigma2 Client: pvr.vuplus - GetHttpXML Open webAPI with URL: 'http://10.2.11.24:80/web/epgservice?sRef=1%3A0%3A19%3A2B66%3A3F3%3A1%3AC00000%3A0%3A0%3A0%3A'
00:49:12.232 T:3832095600   DEBUG: CFileCache::Open - opening <web/epgservice> using cache
00:49:12.233 T:3832095600   DEBUG: CurlFile::Open(0xf183a1a8) http://10.2.11.24:80/web/epgservice?sRef=1%3A0%3A19%3A2B66%3A3F3%3A1%3AC00000%3A0%3A0%3A0%3A
00:49:15.987 T:3332359024   DEBUG: Thread FileCache start, auto delete: false
00:49:16.247 T:3659527024   DEBUG: Previous line repeats 1 times.
00:49:16.247 T:3659527024   DEBUG: GetImageHash - unable to stat url http://10.2.11.24:80/picon/1_0_19_EF10_421_1_C00000_0_0_0.png
00:49:16.252 T:3972182896   DEBUG: GetImageHash - unable to stat url http://10.2.11.24:80/picon/1_0_19_283D_3FB_1_C00000_0_0_0.png
00:49:16.308 T:3480216432    INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?)
00:49:16.321 T:3332359024    INFO: Previous line repeats 1 times.
00:49:16.321 T:3332359024   DEBUG: Thread FileCache 3332359024 terminating
00:49:16.322 T:3732927344    INFO: AddOnLog: Enigma2 Client: pvr.vuplus - GetHttpXML Got result. Length: 218083
00:49:16.358 T:3480216432   DEBUG: Thread FileCache 3480216432 terminating
00:49:16.359 T:3832095600    INFO: AddOnLog: Enigma2 Client: pvr.vuplus - GetHttpXML Got result. Length: 185373
00:49:16.364 T:3732927344    INFO: AddOnLog: Enigma2 Client: pvr.vuplus - GetEPGForChannel Loaded 1 EPG Entries for channel 'ONE HD'
00:49:16.370 T:3732927344   DEBUG: AddOnLog: Enigma2 Client: pvr.vuplus - GetEPGForChannel Getting EPG for channel 'ONE HD'
00:49:16.370 T:3732927344    INFO: AddOnLog: Enigma2 Client: pvr.vuplus - GetHttpXML Open webAPI with URL: 'http://10.2.11.24:80/web/epgservice?sRef=1%3A0%3A19%3A2888%3A40F%3A1%3AC00000%3A0%3A0%3A0%3A'
00:49:16.370 T:3732927344   DEBUG: CFileCache::Open - opening <web/epgservice> using cache
00:49:16.371 T:3732927344   DEBUG: CurlFile::Open(0x2153528) http://10.2.11.24:80/web/epgservice?sRef=1%3A0%3A19%3A2888%3A40F%3A1%3AC00000%3A0%3A0%3A0%3A
00:49:16.397 T:3832095600    INFO: AddOnLog: Enigma2 Client: pvr.vuplus - GetEPGForChannel Loaded 103 EPG Entries for channel 'ZDF HD'
00:49:16.407 T:3832095600   DEBUG: AddOnLog: Enigma2 Client: pvr.vuplus - GetEPGForChannel Getting EPG for channel 'RTL HD'
00:49:16.407 T:3832095600    INFO: AddOnLog: Enigma2 Client: pvr.vuplus - GetHttpXML Open webAPI with URL: 'http://10.2.11.24:80/web/epgservice?sRef=1%3A0%3A19%3AEF10%3A421%3A1%3AC00000%3A0%3A0%3A0%3A'
00:49:16.408 T:3832095600   DEBUG: CFileCache::Open - opening <web/epgservice> using cache
00:49:16.408 T:3832095600   DEBUG: CurlFile::Open(0xf183a1a8) http://10.2.11.24:80/web/epgservice?sRef=1%3A0%3A19%3AEF10%3A421%3A1%3AC00000%3A0%3A0%3A0%3A
00:49:19.993 T:3480216432   DEBUG: Thread FileCache start, auto delete: false
00:49:20.073 T:3332359024   DEBUG: Previous line repeats 1 times.
00:49:20.073 T:3332359024    INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?)
00:49:20.080 T:3480216432    INFO: Previous line repeats 1 times.
00:49:20.080 T:3480216432   DEBUG: Thread FileCache 3480216432 terminating
00:49:20.080 T:3732927344    INFO: AddOnLog: Enigma2 Client: pvr.vuplus - GetHttpXML Got result. Length: 218083
00:49:20.109 T:3732927344    INFO: AddOnLog: Enigma2 Client: pvr.vuplus - GetEPGForChannel Loaded 1 EPG Entries for channel 'ONE HD'
00:49:20.112 T:3732927344   DEBUG: AddOnLog: Enigma2 Client: pvr.vuplus - GetEPGForChannel Getting EPG for channel 'SIXX HD'
00:49:20.112 T:3732927344    INFO: AddOnLog: Enigma2 Client: pvr.vuplus - GetHttpXML Open webAPI with URL: 'http://10.2.11.24:80/web/epgservice?sRef=1%3A0%3A19%3AEF77%3A3F9%3A1%3AC00000%3A0%3A0%3A0%3A'
00:49:20.113 T:3732927344   DEBUG: CFileCache::Open - opening <web/epgservice> using cache
00:49:20.113 T:3732927344   DEBUG: CurlFile::Open(0x2153528) http://10.2.11.24:80/web/epgservice?sRef=1%3A0%3A19%3AEF77%3A3F9%3A1%3AC00000%3A0%3A0%3A0%3A
00:49:20.123 T:3332359024   DEBUG: Thread FileCache 3332359024 terminating

Let me look deeper in this. Maybe the epg refresh is disrupted during playback of recordings.

sidey79 · 2019-02-03T00:06:23Z

Sorry, i can't reproduce the problem since activated debug.

phunkyfish · 2019-02-03T00:18:52Z

In your original log:

00:01:48.573 T:3671061360 ERROR: Update: Failed to update table '<n/a>'

The <n/a> would usually be a channel name that doesn't have any EPG data. I've never seen it with n/a before. Very strange

sidey79 · 2019-02-03T00:24:03Z

This is a channel that may moved to another transponder.

phunkyfish · 2019-02-03T08:34:29Z

That makes sense. So the channel was blank in the bouquet for a time. If it happens again try to capture one of the api calls from your STB and I can account for it in the addon. R.

…

On 3 Feb 2019, at 00:24, sidey79 ***@***.***> wrote: This is a channel that may moved to another transponder. — You are receiving this because you commented. Reply to this email directly, view it on GitHub, or mute the thread.

phunkyfish · 2019-02-11T21:45:03Z

This could be dealt with in the addon by checking the channels and groups to see if there are any new ones periodically. It might make sense to cover it in #154, once we have async connection it would be easy to check once a day for any channel/group changes and disconnect/reconnect to reload.

phunkyfish · 2019-02-25T10:15:33Z

Initially the addon will notify saying you should restart if a change is detected. This will be in for 3.18.0 (along with async connection). In a following release the addon will move to async EPG where the reload will happen automatically one the user has stopped watching the current programme.

phunkyfish · 2019-03-05T06:43:01Z

First version of this fix will just notify once per day if channels have changed if enabled (3.19.0). The following release will automatically reload channels once per day. Time can be set to occur after standard ABM (Auto Bouquet Maker) run on E2 device.

phunkyfish changed the title ~~epg update broken~~ EPG update broken when Channel changes transponder or is renamed Feb 11, 2019

phunkyfish added the bug label Feb 25, 2019

phunkyfish mentioned this issue Mar 4, 2019

Async connection #193

Merged

phunkyfish closed this as completed in #193 Mar 5, 2019

Provide feedback

Saved searches

Use saved searches to filter your results more quickly

EPG update broken when Channel changes transponder or is renamed #179

EPG update broken when Channel changes transponder or is renamed #179

sidey79 commented Feb 2, 2019

phunkyfish commented Feb 2, 2019

sidey79 commented Feb 2, 2019

sidey79 commented Feb 3, 2019

phunkyfish commented Feb 3, 2019

sidey79 commented Feb 3, 2019

phunkyfish commented Feb 3, 2019 via email

phunkyfish commented Feb 11, 2019

phunkyfish commented Feb 25, 2019

phunkyfish commented Mar 5, 2019

EPG update broken when Channel changes transponder or is renamed #179

EPG update broken when Channel changes transponder or is renamed #179

Comments

sidey79 commented Feb 2, 2019

phunkyfish commented Feb 2, 2019

sidey79 commented Feb 2, 2019

sidey79 commented Feb 3, 2019

phunkyfish commented Feb 3, 2019

sidey79 commented Feb 3, 2019

phunkyfish commented Feb 3, 2019 via email

phunkyfish commented Feb 11, 2019

phunkyfish commented Feb 25, 2019

phunkyfish commented Mar 5, 2019