[WebEPG-BUG] Discards programs in the future because : 'Program starts in the past' (1 Viewer)

[ziphnor]

MediaPortal Version: SVN
Windows Version: Windows XP SP2
CPU Type: Athlon 64 3000+
HDD: Samsung Spinpont 250GB
Memory: 1.5GB DDR400
Motherboard: Asus A8N-E
Motherboard Chipset: Nforce 4
Motherboard Bios:
Video Card: ATi X550
Video Card Driver: Cat 6.9
Sound Card: Onboard
Sound Card AC3:
Sound Card Driver:
1. TV Card: Twinhan Cab CI (2031)
1. TV Card Type: DVB-C
1. TV Card Driver: 1.2.3.8
2. TV Card: Twinhan Cab CI (2031)
2. TV Card Type: DVB-C
2. TV Card Driver: 1.2.3.8

Problem:
I have been suffering from some problems with strange programs lasting from say 01:00 - 15:00 even though it seemed highly unlikely that this was the case.

I think i also know what the problem is. Below is the part of the WebEPG log for BBC Prime. WebEPG was executed around 2pm as it shows in the log. We see it adding a show correctly starting at 1am 18/10(ie tomorrow). Then the problem occurs, the next show Fimbles starts 6:10 AM 18/10(and that IS correct) but is ignored because 'Program starts in the past' (which is NOT correct). So what is going on? I notice that the first show to be added after this(ALOT of shows are ignored) is one that starts at 15:00, or more precisely its the FIRST show that starts later on the 18/10 than the the current time(which is ~14:15 17/10). It seems that WebEPG is checking against the time but not the date(or possibly just and incorrect date when deciding if the show should be added).

Here is the start of the problem:

2006-10-17 14:14:50.562500 [Debug][1]: WebEPG: Guide, Program title: Nat-tv
2006-10-17 14:14:50.562500 [Debug][1]: WebEPG: Guide, Program start: 1:0 - 0/0/0
2006-10-17 14:14:50.562500 [Debug][1]: WebEPG: Guide, Program desc.: Med bl.a. dokumentar, økonomi og skole-tv.
(Nat-tv)
2006-10-17 14:14:50.562500 [Debug][1]: WebEPG: Guide, Program genre: Med bl.a. dokumentar, økonomi og skole-tv.
2006-10-17 14:14:50.562500 [Debug][1]: WebEPG: Guide, Program Debug: [0 True]
2006-10-17 14:14:50.562500 [Debug][1]: WebEPG: TimeZone, Adjusting from start Guide Time: 01:00 18-10-2006
2006-10-17 14:14:50.562500 [Debug][1]: WebEPG: TimeZone, Adjusting to start Local Time: 01:00 18-10-2006
2006-10-17 14:14:50.562500 [Info.][1]: WebEPG: Guide, Program Info: 20061018010000 - Nat-tv
2006-10-17 14:14:50.562500 [Info.][1]: WebEPG: Reading http://tv.tv2.dk/tv/listning.php?Region=4&KanalID=37&Soegeord=&Dato=1&Kategori=0&Periode=1 POST:
2006-10-17 14:14:50.859375 [Info.][1]: WebEPG: Listing Count 35
2006-10-17 14:14:50.859375 [Debug][1]: WebEPG: Guide, Program title: Fimbles (G) (10)
2006-10-17 14:14:50.859375 [Debug][1]: WebEPG: Guide, Program start: 6:10 - 0/0/0
2006-10-17 14:14:50.859375 [Debug][1]: WebEPG: Guide, Program desc.: For børn.
(Fimbles)
2006-10-17 14:14:50.859375 [Debug][1]: WebEPG: Guide, Program genre: For børn.
2006-10-17 14:14:50.859375 [Debug][1]: WebEPG: Guide, Program Debug: [1 False]
2006-10-17 14:14:50.859375 [Debug][1]: WebEPG: TimeZone, Adjusting from start Guide Time: 06:10 18-10-2006
2006-10-17 14:14:50.859375 [Debug][1]: WebEPG: TimeZone, Adjusting to start Local Time: 06:10 18-10-2006
2006-10-17 14:14:50.859375 [Info.][1]: WebEPG: Guide, Program Info: 20061018061000 - Fimbles (G) (10)
2006-10-17 14:14:50.859375 [Info.][1]: WebEPG: Program starts in the past, ignoring it

And here is the end of the problem:

2006-10-17 14:14:50.875000 [Debug][1]: WebEPG: Guide, Program title: Irske hjerter (6)
2006-10-17 14:14:50.875000 [Debug][1]: WebEPG: Guide, Program start: 14:0 - 0/0/0
2006-10-17 14:14:50.875000 [Debug][1]: WebEPG: Guide, Program desc.: Engelsk dramaserie.
(Ballykissangel)
2006-10-17 14:14:50.875000 [Debug][1]: WebEPG: Guide, Program genre: Engelsk dramaserie.
2006-10-17 14:14:50.875000 [Debug][1]: WebEPG: Guide, Program Debug: [1 False]
2006-10-17 14:14:50.875000 [Debug][1]: WebEPG: TimeZone, Adjusting from start Guide Time: 14:00 18-10-2006
2006-10-17 14:14:50.875000 [Debug][1]: WebEPG: TimeZone, Adjusting to start Local Time: 14:00 18-10-2006
2006-10-17 14:14:50.875000 [Info.][1]: WebEPG: Guide, Program Info: 20061018140000 - Irske hjerter (6)
2006-10-17 14:14:50.875000 [Info.][1]: WebEPG: Program starts in the past, ignoring it
2006-10-17 14:14:50.875000 [Debug][1]: WebEPG: Guide, Program title: Skadestuens hjertehold (TH) (1)
2006-10-17 14:14:50.875000 [Debug][1]: WebEPG: Guide, Program start: 15:0 - 0/0/0
2006-10-17 14:14:50.875000 [Debug][1]: WebEPG: Guide, Program desc.: Engelsk dramaserie.
(Casualty @ Holby City)
2006-10-17 14:14:50.875000 [Debug][1]: WebEPG: Guide, Program genre: Engelsk dramaserie.
2006-10-17 14:14:50.875000 [Debug][1]: WebEPG: Guide, Program Debug: [1 False]
2006-10-17 14:14:50.890625 [Debug][1]: WebEPG: TimeZone, Adjusting from start Guide Time: 15:00 18-10-2006
2006-10-17 14:14:50.890625 [Debug][1]: WebEPG: TimeZone, Adjusting to start Local Time: 15:00 18-10-2006
2006-10-17 14:14:50.890625 [Info.][1]: WebEPG: Guide, Program Info: 20061018150000 - Skadestuens hjertehold (TH) (1)

 

[jawbroken]

Ah, this is probably why sometimes when I go to long between grabbing guide data and run out, when I run WebEPG again I don't get program data for the current times, only for some hours later.

 

[ziphnor]

There is definetly something dodgy about that time check(even the above bug aside). At the very least it shouldnt discard shows that OVERLAP the current time. Furthermore i dont think anyone would mind a bit of info on what had been on earlier the same day. So IMHO it should only discard shows that were from the previous day(alternatively maybe > 24 old).

 

[ziphnor]

I found the responsible lines in the WebEPG source:

Lines 737-742:

//Program starts in the past
if (program.Start < GetLongDateTime(_StartGrab))
{
_log.Info(LogType.WebEPG, "WebEPG: Program starts in the past, ignoring it");
return null;
}

I outcommented this and now my EPG is correct. However this is just a hack not a fix. Though i doubt that this check is necessary at all its probably a good idea to find out what the problem is with GetLongDateTime or program.Start.

 

[James]

Fixed.

Thanks for the detailed analysis ziphnor. I've also now set it to -2 hours, because I do not always have the end time (that is calculated later) of a program I need to use the program start time. So a few programs still running may be discarded, but only on the first grab. If you keep your guide up to date this shouldn't be a problem

/James

 

[James]

Ziphnor,

You have some funny stuff with your time zone:

2006-10-17 14:14:45.421875 [Info.][1]: WebEPG: TimeZone, Local: Romance Standard Time
2006-10-17 14:14:45.421875 [Info.][1]: WebEPG: TimeZone, Site : W. Europe Standard Time

/James

 

[ziphnor]

Just to understand you first reply, you fixed the bug in the time check AND as a seperate thing adjusted it for -2 hours?

As to the timezones:
The timezone on the machine in questions is GMT+1 with adjustment for daylight savings time.

Windows have a specific setting for Copenhagen(denmark) and some other cities called Romance Standard Time. For stockholm(ie sweden) its W. European standard time. Both are GMT+1 though.

See:
http://www.castlesoft.co.nz/SpotLight/Spotlight002.htm