[PATCH] Verhinderung der DVB-Uhrzeitaktualisierung

[rhabarber1848]

Hi,

im Berliner Netz von Kabel Deutschland sendet Deutsche Welle-TV
eine falsche Uhrzeit per DVB, diese liegt zwei Stunden in der Zukunft.

Enigma und sectionsd lesen beide diese Zeit. Ob hier eine Fehlkonfiguration
seitens KD, des Senders oder eine fehlerhafte Umsetzung von DVB-Spezifi-
kationen seitens Tuxbox vorliegt, weiß ich nicht. Falls mir jemand Debug-
Hinweise, z.B. per dvbsnoop, geben kann, bin ich gerne bereit, zu helfen.

Fakt ist, dass durch die falsche Uhrzeit sämtliche Timereinstellungen
durcheinandergeraten, wenn ich während einer DVB-Uhrzeitaktualisierung
Deutsche Welle-TV schaue.
Das will ich verhindern. Die Nutzung von NTP ist für mich keine Option.

Ich habe dazu, analog zum EPG-Filter, einen DVB-Time-Filter konzipiert.

Um die DVB-Uhrzeitaktualisierung bei DW-TV zu deaktivieren, muss
die Datei /var/tuxbox/config/zapit/dvbtimefilter.xml angelegt werden:

<?xml version="1.0" encoding="UTF-8"?>
<zapit>
<filter serviceID="025f" name="DW-TV EUROPA" tsid="0262" onid="f001"/>
</zapit>

Beim Umschalten auf DW-TV erscheint:

01:49:10.871 [sectionsd] commandserviceChanged: DVB time update is blocked!

Beim Aufwachen des time-threads:

01:50:52.520 [timeThread] Time NOT set via DVB due to ignored channel, going to sleep for 120 seconds

Beim Umschalten auf einen anderen Kanal erscheint:

01:52:05.441 [sectionsd] commandserviceChanged: DVB time update is allowed again!

Beim Aufwachen des time-threads auf diesem Kanal:

01:52:53.184 [timeThread] - 15.06.2009 01:52:54, tim: Mon Jun 15 01:52:54 2009
01:52:54.004 [timeThread] Time set via DVB, going to sleep for 120 seconds.

Wenn DW-TV als lastChannelTV in zapit.conf eingetragen ist, wird der
time-thread einmal pro Minute reaktiviert:

01:00:17.841 [sectionsd] commandserviceChanged: DVB time update is blocked!
01:00:33.215 [timeThread] Time NOT set via DVB due to ignored channel, going to sleep for 60 seconds.
01:01:33.280 [timeThread] Time NOT set via DVB due to ignored channel, going to sleep for 60 seconds.
01:02:33.330 [timeThread] Time NOT set via DVB due to ignored channel, going to sleep for 60 seconds.

Umschalten auf einen anderen Kanal:

01:02:50.401 [sectionsd] commandserviceChanged: DVB time update is allowed again!
01:03:34.114 [timeThread] - 15.06.2009 01:58:55, tim: Mon Jun 15 01:58:55 2009
01:58:55.004 [timeThread] Time set via DVB, going to sleep for 120 seconds.

Hier der Patch: sectionsd_nodvbtime.diff

[GetAway]

@rhabarber1848

Scheint zu funktionieren.

Wenn DW-TV als lastChannelTV in zapit.conf eingetragen ist, wird der
time-thread einmal pro Minute reaktiviert:

01:00:17.841 [sectionsd] commandserviceChanged: DVB time update is blocked!
01:00:33.215 [timeThread] Time NOT set via DVB due to ignored channel, going to sleep for 60 seconds.
01:01:33.280 [timeThread] Time NOT set via DVB due to ignored channel, going to sleep for 60 seconds.
01:02:33.330 [timeThread] Time NOT set via DVB due to ignored channel, going to sleep for 60 seconds.

Nur diese Ausgabe kommt weder beim booten noch beim zappen
auf diesen Kanal. Es wird immer die voreingestellte Zeit genommen.(bei mir 300 sec.)
Kanal in als LastChannel eingetragen.

[seife]

Klingt hilfreich, ich schau es mir diese Woche an (ich habe noch ein paar andere Kleinigkeiten zum Uhr stellen in petto).

Du könntest mal versuchen, ob es besser wird, wenn du in sectionsd.cpp statt getUTC(&UTC, true) ein getUTC(&UTC, false) machst, so dass er die TOT statt der TDT benutzt...

Was wird denn auf dem Transponder sonst noch gesendet, ausser DW-TV?

[rhabarber1848]

Was wird denn auf dem Transponder sonst noch gesendet, ausser DW-TV?

http://helpdesk.kdgforum.de/index.php?s ... 11&set=4,1

610 MHz, dort findet sich noch Parlamentsfernsehen, wo ebenfalls
die falsche Uhrzeit gesendet wird.

[mrvica]

ich hatte ähnliches Problem mit Enigma, z.B. CMC sendet falsche Uhrzeit, zwar nicht so extrem, genug aber dass einige Plugins dann nicht funktionieren, z.B. zap timer, ich habe das unter Enigma einfach gelöst, indem ich auf dem Sender unter Setup korrekte Zeit eingestellt habe (z.B. die vom ZDF), scheint so zu funktionieren

mrvica

[rhabarber1848]

Du könntest mal versuchen, ob es besser wird, wenn du in sectionsd.cpp statt getUTC(&UTC, true) ein getUTC(&UTC, false) machst, so dass er die TOT statt der TDT benutzt..

Das habe ich mit einem ansonsten ungepatchten sectionsd gemacht:

Aktueller Sender Phoenix (458 MHz):

[timeThread] - 15.06.2009 14:47:16, tim: Mon Jun 15 14:47:16 2009
[timeThread] Time set via DVB, going to sleep for 120 seconds.

Umgeschaltet auf DW-TV (610 MHz):

14:47:24.124 eit_set_update_filter, servicekey = 0x262f001025f, current version 5
[sectionsd] getUTC: read: Connection timed out
[timeThread] Time set via DVB, going to sleep for 120 seconds.

Bis 14:52 Uhr keine weiteren Logmeldungen, dann das:

[sectionsd] getUTC: read: Connection timed out
[timeThread] Time set via DVB, going to sleep for 120 seconds.

Umgeschaltet auf ZDF (626 MHz):

14:53:05.076 eit_set_update_filter, servicekey = 0x43700016d66, current version 30
[timeThread] - 15.06.2009 14:54:27, tim: Mon Jun 15 14:54:27 2009
[timeThread] Time set via DVB, going to sleep for 120 seconds.

Das hilft also nicht.

[rhabarber1848]

610 MHz, dort findet sich noch Parlamentsfernsehen, wo ebenfalls die falsche Uhrzeit gesendet wird.

Positiv getestete Vorlage für dvbtimefilter.xml, welche den kompletten Transponder sperrt:

<?xml version="1.0" encoding="UTF-8"?>
<zapit>
<filter tsid="0262" onid="f001"/>
</zapit>

Auf dem Transponder sind nur DW-TV und Parlamentsfernsehen.

[seife]

das hilft insofern, dass die Uhr zumindest nicht falsch gestellt wird , also genauso wie der Filter.
Ich kenne mich aber zuwenig mit der TOT /TDT-Problematik aus, um das zu beurteilen.

Die Frage ist eher, was machen wir, wenn die Kiste auf so einem Kanal bootet?
Wäre es evtl. besser, einfach den Korrekturfaktor mit abzulegen (halbstundenweise, soviel ich weiss ist das die "auflösung" der Zeitzonen)? Es sieht ja so aus, als würde dieser Transponder (TDT/TOT sind transponderweit, nicht pro "Kanal") einfach localtime senden, aber genau werden wir das erst wissen, wenn der Fehler bis zur Winterzeit noch nicht behoben ist

Evtl. könnte man ja auch auf einem einstellbaren Kanal starten (evtl. ohne Bild und Ton...), warten bis die Zeit eingelesen ist und dann auf den gespeicherten Startkanal umschalten. Das wäre dann aber die Kür

mrvica: was für Abweichungen (welche Grössenordnungen) hast du denn gesehen? War das auch einfach eine Zeitzone daneben oder waren das z.B. "42 Minuten"?

[rhabarber1848]

Die Frage ist eher, was machen wir, wenn die Kiste auf so einem Kanal bootet?

Der betroffene Kanal existiert nur im 862 MHz-Ausbaugebiet von Berlin,
andernorts speist Kabel Deutschland den Transponder überhaupt nicht ein.
User, die dvbtimefilter.xml nutzen, wissen warum und vermeiden dann
auch, dass die Dbox2 beim Booten diesen Transponder anwählt.

aber genau werden wir das erst wissen, wenn der Fehler bis zur Winterzeit noch nicht behoben ist

Jetzt ist es so, dass die Uhrzeit des Transponders drei Stunden in der
Zukunft liegt, während der Winterzeit waren es afair nur zwei Stunden.

Evtl. könnte man ja auch auf einem einstellbaren Kanal starten (evtl. ohne Bild und Ton...), warten bis die Zeit eingelesen ist und dann auf den gespeicherten Startkanal umschalten. Das wäre dann aber die Kür

Bei mir startet die Dbox2 auf einem festeingestellten Kanal, der nicht
auf dem Problemtransponder liegt. War da nicht mal ein feature request,
der den zapit-Startkanal in Neutrino konfigurierbar machen sollte?
(duck und weg...)

[mrvica]

>> was für Abweichungen (welche Grössenordnungen) hast du denn gesehen?

die Uhr ging bei CMC etwa 3-4 Minuten nach (war kein Zeitzonenproblem), zap timer gestellt auf 6 Minuten hat dann nach etwa 10 Minuten gestartet, unter Setup, System Settings, Time Settings, Time Correction habe ich dann die richtige Zeit eingestellt, wie es aussieht betrifft das dann alle Sender auf dem Transponder (in diesem Fall Hotbird 12303V, 3/4, 27500) irgendwo wird das gespeichert (denke in config), nach dem Hochfahren aus dem deep stand-by ist die Zeit korrekt

mrvica

EDIT: >> irgendwo wird das gespeichert (denke in config)
ups!
eher nicht, wahrscheinlich in /var/tuxbox/config/enigma/services

[rhabarber1848]

Es gibt ein Problem zwischen sectionsd und zapit/Neutrino.

In meinen Patch für sectionsd legt die Variable channel_no_dvb_time fest,
ob vom aktuellen Kanal die DVB-Zeit gelesen werden darf. Bisher war sie
auf false, d.h. vom aktuellen Kanal darf die DVB-Zeit übernommen werden.

Ich habe die Kontrollvariable channel_no_dvb_time nun auf true gesetzt, da
ansonsten beim Boxstart auf einem gesperrten Kanal trotzdem die Uhrzeit
aktualisiert wurde (drei Stunden in der Zukunft):

Thu Jan 1 01:00:00 CET 1970
...
01:00:01.173 Add channel 0x0262f0010000, mask 0xffffffff0000 to NoDVBTimelist
...
[neutrino] registering as event client
[LCDFONT] FTC_Face_Requester (Fix15/Bold)
01:00:16.601 [sectionsd] commandserviceChanged: DVB time update is blocked!
...
[controld] VIDEO_EVENT_SIZE_CHANGED 720x576 (4:3 -> 16:9)
01:00:20.252 [timeThread] - 15.06.2009 20:00:22, tim: Mon Jun 15 20:00:22 2009
20:00:22.008 [timeThread] Time NOT set via DVB due to ignored channel, going to sleep for 300 seconds.

Die Ursache liegt darin, dass sectionsd beim Boxstart vor zapit gestartet wird.
Gleichzeitig wird innerhalb von sectionsd der time thread und damit getUTC
gestartet bevor zapit läuft, hier nur die wichtigsten Logmeldungen zitiert:

$Id: sectionsd.cpp,v 1.299 2009/06/14 21:46:04 rhabarber1848 Exp $
[sectionsd] getUTC started (Debug-Meldung in dmxapi.cpp)
$Id: zapit.cpp,v 1.430 2009/05/19 18:21:46 seife Exp $
[neutrino] enable flash
[controld] VIDEO_EVENT_SIZE_CHANGED 720x576 (4:3 -> 16:9)
[sectionsd] getUTC: read: Connection timed out
[sectionsd] getUTC started
[sectionsd] getUTC finished
[timeThread] - 17.06.2009 19:50:09, tim: Wed Jun 17 19:50:09 2009
[timeThread] Time set via DVB, going to sleep for 120 seconds.

Wenn channel_no_dvb_time per default auf false ist,
liest getUTC die Zeit ein, bevor Neutrino g_Sectionsd->setServiceChanged
senden kann, was in sectionsd die Funktion commandserviceChanged aufruft,
die prüft, ob vom aktuellen Kanal die DVB-Zeit gelesen werden darf.
Der erste Aufruf von getUTC erzeugt nicht immer einen time-out,
was das Debuggen erschwert...

Der sectionsd-time thread ist schon aktiv, bevor zapit/Neutrino überhaupt gestartet
werden. In meiner aktuellen lokalen Version des Patches wird also beim Start von
sectionsd das Auslesen der DVB-Zeit blockiert, bis Neutrino g_Sectionsd->setServiceChanged
sendet. Dadurch dauert es ca. 15-20 Sekunden länger, bis die Uhrzeit ausgelesen wurde...

Habt ihr Vorschläge, das zu verbessern?

[seife]

Generell könnte man sich überlegen, den sectionsd erst "loslaufen" zu lassen, wenn neutrino soweit ist. Z.B. greift die epg-blacklist momentan auch nicht, wenn auf einem der Kanäle gestartet wird, die eigentlich blacklisted sein sollten.

Nachdem ich aber immer noch auf den Code vom neuen neutrino gespannt bin, in dem sich das, weil es keine verschiedenen daemons mehr gibt, viel einfacher fixen lässt, ist mein Antrieb, daran was zu machen, momentan recht gering.

[rhabarber1848]

Generell könnte man sich überlegen, den sectionsd erst "loslaufen" zu lassen, wenn neutrino soweit ist.

Der neue default channel_no_dvb_time = true hat den gleichen
Effekt, also werde ich in dieser Richtung weitermachen.

[rhabarber1848]

Hier noch einige Beobachtungen:

Boxstart auf 3SAT mit getUTC-time out

01:00:02.134 [sectionsd] getUTC started
[neutrino] enable flash
[neutrino] registering as event client
[controld] VIDEO_EVENT_SIZE_CHANGED 720x576 (4:3 -> 16:9)
[sectionsd] getUTC: read: Connection timed out
01:00:33.175 [sectionsd] getUTC error (die obige time out-Meldung gehört zu dieser Meldung)
01:00:34.200 [sectionsd] getUTC started
01:01:02.200 [sectionsd] getUTC finished
[timeThread] - 17.06.2009 20:19:38, tim: Wed Jun 17 20:19:38 2009
20:19:38.006 [timeThread] Time set via DVB, going to sleep for 120 seconds.

Boxstart auf ARD ohne getUTC-time out, hier würde die DVB time-blacklist nicht greifen

01:00:02.237 [sectionsd] getUTC started
[neutrino] enable flash
[neutrino] registering as event client
01:00:18.080 [sectionsd] getUTC finished
[timeThread] - 17.06.2009 20:21:14, tim: Wed Jun 17 20:21:14 2009
01:00:18.168 [timeThread] Time set via DVB, going to sleep for 120 seconds.
[controld] VIDEO_EVENT_SIZE_CHANGED 720x576 (4:3 -> 16:9)

Alle Logs sind mit einem Original-sectionsd erstellt, der nur um
Debug-Meldungen erweitert wurde.

[rhabarber1848]

Generell könnte man sich überlegen, den sectionsd erst "loslaufen" zu lassen, wenn neutrino soweit ist.

Der neue default channel_no_dvb_time = true hat den gleichen
Effekt, also werde ich in dieser Richtung weitermachen.

Nachtrag:
Wenn ich das so mache, sorgt waitForTimeset() dafür, dass beim Dbox-Start
auf einem DVB time-blocked-Kanal alle anderen sectionsd-threads erst loslaufen,
nachdem eine gültige Uhrzeit eingelesen wurde. D.h. kein EPG!
In diesem Fall muss erst auf einen anderen, nicht für DVB time gesperrten,
Kanal umgeschaltet werden.

Also nochmal:
Die Dbox sollte nicht auf einem Kanal starten, der für DVB time gesperrt ist!

Ich habe das Feature für mich programmiert, damit DW-TV mir nicht die
Systemuhr durcheinanderbringt, ich habe Sorge getragen, dass die Dbox
nie auf einem solchen Kanal startet.

[rhabarber1848]

Hier der Patch: sectionsd_nodvbtime.diff

Ich habe den Patch aktualisiert, dabei ist mir aufgefallen, dass
das Auslesen der DVB-Zeit auf dem ZDF-Transponder unterschiedlich
lang ist und im Vergleich zu anderen Transpondern länger dauert.

Hier die Zeitdauer von getUTC:
ARD 1s
ZDF 10-28s
NDR3 1s
Phoenix 1s
TCM 5s
SAT.1 3s
RTL 3s

[seife]

Das ist normal (dass es unterschiedlich lange dauert). Ich mag nicht in die spec schauen (so ich sie denn überhaupt habe / finde ), aber alle Implementationen, die ich bisher gesehen habe, haben einen Timeout von ~35 Sekunden für's einlesen von TOT/TDT, also gehe ich davon aus, dass die nur alle ~30 Sekunden gesendet werden muss.

Es ist schon korrekt dass alle Threads erst loslaufen, wenn die Zeit gesetzt ist - sonst kommen alle internen timeouts des sectionsd durcheinander. Man könnte statt der aktuellen systemzeit dafüe eine "monotonic clock" verwenden, ich habe das auch schon mal eingebaut, aber dann festgestellt, dass es die erst ab Kernel 2.6 gibt...

Wir sollten das eindeutig als Expertenfeature handhaben: wer es benutzt, muss wissen, was er tut. Wir müssen nur dafür sorgen, dass niemand eine GUI-Option draus macht

[rhabarber1848]

Noch eine Frage zum Patch da ich von thread-Programmierung keine Ahnung habe:

Code: Alles auswählen

pthread_mutex_lock( &timeThreadSleepMutex );
dvb_time_update = false;
pthread_mutex_unlock( &timeThreadSleepMutex );

Ist der mutex lock/unlock nötig?

[prodigy7]

Nachdem ich aber immer noch auf den Code vom neuen neutrino gespannt bin, in dem sich das, weil es keine verschiedenen daemons mehr gibt, viel einfacher fixen lässt, ist mein Antrieb, daran was zu machen, momentan recht gering.

Hab ich was verpasst oder wink mit dem Zaunfall?

[hannebamb(el)]

Siehe dbox2world.selfip.com <== Coolstream HD1 mit Neutrino

[seife]

Ich bin leider nicht dazu gekommen, es auszuprobieren, aber ich habe mir den Patch angeschaut:

Code: Alles auswählen

+#define DVBTIME_FILTER_PATH "/var/tuxbox/config/zapit/dvbtimefilter.xml"
+std::string dvbtime_filter_dir = DVBTIME_FILTER_PATH;

Die Variable wird dvbtime_filter_dir wird genau einmal benutzt => direkt DVBTIME_FILTER_PATH benutzen.

Code: Alles auswählen

+»······»·······if (dvb_time_update) {
+»······»·······»·······pthread_mutex_lock( &timeThreadSleepMutex );
+»······»·······»·······dvb_time_update = false;
+»······»·······»·······pthread_mutex_unlock( &timeThreadSleepMutex );
+»······»·······}

Der timeThreadSleepMutex ist für was anderes Wenn, dann wäre es vermutlich der messagingLock, den du nehmen wollen würdest. Da die Variable aber nur an einer Stelle geschrieben und an den anderen nur gelesen wird, musst du nicht locken.

Der Rest sieht soweit ok aus. => Check's ein, die Konflikte mit meinen geplanten Änderungen sollten sich in Grenzen halten.

P.S.: um wieviel einfacher es wäre, solche Patches auf einer ordentlichen Mailingliste zu diskutieren, will ich mir gar nicht vorstellen

[rhabarber1848]

[/code]Die Variable wird dvbtime_filter_dir wird genau einmal benutzt => direkt DVBTIME_FILTER_PATH benutzen.

Ich habe mir die Variable epg_filter_dir zum Vorbild genommen

Der Patch ist mit der o.g. Korrektur, ohne mutex_lock, jetzt im CVS.
http://article.gmane.org/gmane.comp.vid ... ox.scm/720

Dazu habe ich noch in readDVBTimeFilter() dvb_time_update = true
gesetzt, wenn dvbtimefilter.xml nicht gefunden wurde.

[mb405]

geht irgendwie nicht hier
ich hab mal paar logausgaben rein

Add channel 0x000000000000, mask 0x000000000000 to NoDVBTimelist

in meiner blockliste steht nur

Code: Alles auswählen

<?xml version="1.0" encoding="UTF-8"?>
<zapit>
	<filter service_id="2ee3" name="RTL Television" service_type="01"/>
</zapit>

EDIT:
das format ist falsch gewesen. das passt

Code: Alles auswählen

<?xml version="1.0" encoding="UTF-8"?>
<zapit>
	<filter name="RTL Television" onid="0001" tsid="0441" serviceID="2ee3"/>
</zapit>

[rhabarber1848]

Minimalangaben sind onid und tsid, damit wird ein ganzer Transponder gesperrt.
Wenn nur ein Kanal gesperrt werden soll, muss zusätzlich serviceID angegeben werden.

PS: Die Syntax ist dieselbe wie beim EPG-Filter:
http://cvs.tuxbox-cvs.sourceforge.net/t ... iew=markup