EPG on XBMC often incorrect - TVHeadend backend
#1
Hi all,
Running latest updates to XBMC - XBMC-PRE-11.0 Compiled: Nov 12 2011
TVHeadend HTSP client version 1.0.0
Running TVHeadend latest from GIT git-fb106fa

XBMC settings for Livetv:
General: Synchronise channel groups with backends - ON
: Always use the channel order from the backends - ON
: Use backend channels numbers - ON
EPG : Default EPG window: Timeline (What we use all the time)
: Days to display in the EPG: 5days
: EPG Update interval: 30 min
: Prevent EPG updates while playing a tv stream - NO
: Do not store the EPG in the database - YES


I have a TV front-end running and the EPG is very often incorrect. It shows programmes in the wrong channel, shows are too long/too short, sometimes no EPG entries appear for a channel (So the channel gets hidden from the timeline), and generally get mixed up entries on the EPG.
I cannot find a pattern to when it happens. Often to fix it I reboot but this does not always correct the entries.
Sometimes changing channel and going back to the EPG corrects it.

In TVHeadend GUI channel information, EPG entries, etc, are all correct so the source of information appears OK, so I assume this is XBMC incorrectly loading the EPG data, and/or finding something it cannot handle on the first pass, and it takes several attempts to correct itself (but not auto-retrying)


Some of the things I notice in xbmc debug logs:
  • FixOverlappingEvents
  • PVRTimers - UpdateEntries - updated timer 304 on client 1


Some of the log excerpts:

Code:
17:40:01 T:3002944368   DEBUG: EPG - FixOverlappingEvents - event 'Freedomland' ends after event 'Freedomland' starts. changing the end time of 'Freedomland' to the start time of 'Freedomland': '17/11/2011 11:00 PM'
17:40:01 T:3002944368   DEBUG: EPG - FixOverlappingEvents - event 'Steven Seagal: Lawman' ends after event 'Steven Seagal: Lawman' starts. changing the end time of 'Steven Seagal: Lawman' to the start time of 'Steven Seagal: Lawman': '18/11/2011 12:20 AM'
17:40:01 T:3002944368   DEBUG: EPG - FixOverlappingEvents - event 'Inside Hollywood' ends after event 'Inside Hollywood' starts. changing the end time of 'Inside Hollywood' to the start time of 'Inside Hollywood': '18/11/2011 12:50 AM'
17:40:01 T:3002944368   DEBUG: EPG - FixOverlappingEvents - event 'Super Casino' ends after event 'Super Casino' starts. changing the end time of 'Super Casino' to the start time of 'Super Casino': '18/11/2011 1:00 AM'
17:40:01 T:3002944368   DEBUG: EPG - FixOverlappingEvents - event 'Jewellery Channel' ends after event 'Jewellery Channel' starts. changing the end time of 'Jewellery Channel' to the start time of 'Jewellery Channel': '18/11/2011 6:00 AM'


Code:
17:55:01 T:2992454512   DEBUG: PVRTimers - UpdateEntries - updated timer 302 on client 1
17:55:01 T:2992454512   DEBUG: PVRTimers - UpdateEntries - updated timer 303 on client 1
17:55:01 T:2992454512   DEBUG: PVRTimers - UpdateEntries - updated timer 304 on client 1
17:55:01 T:2992454512   DEBUG: PVRTimers - UpdateEntries - updated timer 305 on client 1
17:55:04 T:2971474800   DEBUG: AddOnLog: Tvheadend HTSP Client: ParseChannelUpdate - id:532, name:'(null)', icon:'(null)', event:0
17:55:04 T:2971474800   DEBUG: AddOnLog: Tvheadend HTSP Client: ParseChannelUpdate - id:532, name:'(null)', icon:'(null)', event:2432
17:55:31 T:2829056880   DEBUG: Thread Jobworker 2829056880 terminating (autodelete)


This keeps triggering:

Code:
18:00:00 T:2829056880   DEBUG: Thread Jobworker start, auto delete: 1
18:00:01 T:2992454512   DEBUG: CPVRTimers - Update - updating timers
18:00:01 T:2992454512   DEBUG: PVRTimers - UpdateEntries - updated timer 302 on client 1
18:00:01 T:2992454512   DEBUG: PVRTimers - UpdateEntries - updated timer 303 on client 1
18:00:01 T:2992454512   DEBUG: PVRTimers - UpdateEntries - updated timer 304 on client 1
18:00:01 T:2992454512   DEBUG: PVRTimers - UpdateEntries - updated timer 305 on client 1
18:00:04 T:2971474800   DEBUG: AddOnLog: Tvheadend HTSP Client: ParseChannelUpdate - id:532, name:'(null)', icon:'(null)', event:0
18:00:04 T:2971474800   DEBUG: AddOnLog: Tvheadend HTSP Client: ParseChannelUpdate - id:1404, name:'(null)', icon:'(null)', event:21203
18:00:04 T:2971474800   DEBUG: AddOnLog: Tvheadend HTSP Client: ParseChannelUpdate - id:537, name:'(null)', icon:'(null)', event:0
18:00:04 T:2971474800   DEBUG: AddOnLog: Tvheadend HTSP Client: ParseChannelUpdate - id:537, name:'(null)', icon:'(null)', event:2026
18:00:04 T:2971474800   DEBUG: AddOnLog: Tvheadend HTSP Client: ParseChannelUpdate - id:1403, name:'(null)', icon:'(null)', event:0
18:00:04 T:2971474800   DEBUG: AddOnLog: Tvheadend HTSP Client: ParseChannelUpdate - id:1403, name:'(null)', icon:'(null)', event:21024
18:00:04 T:2971474800   DEBUG: AddOnLog: Tvheadend HTSP Client: ParseChannelUpdate - id:1187, name:'(null)', icon:'(null)', event:20972
18:00:04 T:2971474800   DEBUG: AddOnLog: Tvheadend HTSP Client: ParseChannelUpdate - id:288, name:'(null)', icon:'(null)', event:4212
18:00:04 T:2971474800   DEBUG: AddOnLog: Tvheadend HTSP Client: ParseChannelUpdate - id:1254, name:'(null)', icon:'(null)', event:6411
18:00:04 T:2971474800   DEBUG: AddOnLog: Tvheadend HTSP Client: ParseChannelUpdate - id:641, name:'(null)', icon:'(null)', event:0
18:00:04 T:2971474800   DEBUG: AddOnLog: Tvheadend HTSP Client: ParseChannelUpdate - id:641, name:'(null)', icon:'(null)', event:20210
18:00:04 T:2971474800   DEBUG: AddOnLog: Tvheadend HTSP Client: ParseChannelUpdate - id:1014, name:'(null)', icon:'(null)', event:20251
18:00:04 T:2971474800   DEBUG: AddOnLog: Tvheadend HTSP Client: ParseChannelUpdate - id:142, name:'(null)', icon:'(null)', event:0
18:00:04 T:2971474800   DEBUG: AddOnLog: Tvheadend HTSP Client: ParseChannelUpdate - id:142, name:'(null)', icon:'(null)', event:20371
18:00:04 T:2971474800   DEBUG: AddOnLog: Tvheadend HTSP Client: ParseChannelUpdate - id:539, name:'(null)', icon:'(null)', event:0
18:00:11 T:2971474800   DEBUG: AddOnLog: Tvheadend HTSP Client: ParseChannelUpdate - id:1253, name:'(null)', icon:'(null)', event:21576
18:00:20 T:2971474800   DEBUG: AddOnLog: Tvheadend HTSP Client: ParseChannelUpdate - id:1046, name:'(null)', icon:'(null)', event:21583
18:00:31 T:2829056880   DEBUG: Thread Jobworker 2829056880 terminating (autodelete)



The size of the Epg databases are shown below:
Code:
root@XBMCLive:/home/andyb/.xbmc/userdata/Database# du -h Epg4.db
1.8M    Epg4.db
root@XBMCLive:/home/andyb/.xbmc/userdata/Database# du -h Epg5.db
12M     Epg5.db

I can reset the log and do a full logdump to try and diagnose further if anyone can advise where/what I should be looking mainly for here.

Just a few pointers would be great and I'll do more debugging. I'm also going to have a dig into the XBMC code that detects when no EPG info is present and doesn't show the channel in the EPG, as I want it to always appear, regardless of if EPG data is found or not.

Thanks in advance anyone for advise/help/tips!
Reply
#2
Same here.
Reply
#3
Hi the same with

vdr and vnsi (pipelka - last commit 9 Aug 2011)
2:11.0-pvr+p8~git20111111.28637ff-0ubuntu1~stable55~oneiric

Also since 55 folders in tv recording cannot be open by enter key anymore.

What is the update cycle for the ppa binaries - maybe a month?

And it's time to say again - big thanks to the developers of xbmc-pvr and vnsi !
Reply
#4
Same here, a lot of the time the entries are on the wrong channel.
also I never shut my htpc down, only put it to standby.. after a day or two my epg doesn't show any entries at all... if I reboot the epg comes back but it can take a few minutes after booting to appear.
Reply
#5
Ah interesting.
Our XBMC PC is sent to standby/resume all the time, I do find when the EPG is very badly out of sync a reboot helps, but I wonder if I'm not giving it long enough after a reboot to get the EPG back in sync/populated correctly.

Will do a few experiments and see what I can find out this evening.
Reply
#6
https://github.com/opdenkamp/xbmc/issues/326
opdenkamp / dushmaniac

xbmc-pvr [Eden-PVR builds] [now included in mainline XBMC, so no more source link here :)]
personal website: [link]

Found a problem with PVR? Report it on Trac, under "PVR - core components". Please attach the full debug log.

If you like my work, please consider donating to me and/or Team XBMC.
Reply
#7
Ahh, many thanks dushmaniac, I hadn't found that issue. Will pull the latest git source and post follow-ups in the github
Reply
#8
Has this problem been resolved? I'm using the latest opdenkamp source + tvheadend 2.2 and still get the EPG showing programs in the wrong channel. Once I restart XBMC, it updates the EPG and has the correct information. A while later the problem begins. I suspend PC when not in use, if that makes any difference.
Reply
#9
Same problem here with imported xmltv on openelec and tvh addon 2.0.7 ->2.1.3. Tried a lot of xbmc pvr ver from april to now

Even tvh web gui shows the wrong epg info on some channels after a while. But "always" ok on first import the the program is on wrong day/time and channel info

Is there a fix for this ?
Reply
#10
Guys,

I'd like to point out that I'm in the process of completely re-writing the EPG system for TVH. In fact if andyb2000 is who I think it is he's my chief tester Wink

This is still work in progress and is not yet in the main branch. But I'm working on it.

Pop along to #hts or check my github fork if you're interested (github.com/adamsutton/tvheadend).

Regards
Adam
Reply
#11
For me epg issue seem to be fixed by a fresh new clean install of openelec and tvh addon. Tvh grabbing epg from web. www.ontv.se
Reply

Logout Mark Read Team Forum Stats Members Help
EPG on XBMC often incorrect - TVHeadend backend0