[Korregiert] Zeitsprünge bei ARD?

mauerspecht · March 8, 2006 at 11:13 PM

Ich habe meinen VDR 1.3.43 auf SuSE 10 auf Zeitsyschronisation duch ARD bei DVB-C ISH NRW konfiguriert. Leider habe ich da heute seltsame Sprünge, die Zeit in der ersten Zeile von /var/log/messages stimmt noch.
Ist ARD eine schlechte Wahl, oder liegt es am Empfang?

Habe jetzt erst einmal auf ZDF umgestellt. NTP nehme ich nicht da mein Internet über einen Linux Recher läuft, der ist nicht immer an.

Mar 8 20:35:01 activy vdr: [3202] System Time = Wed Mar 8 20:35:01 2006 (1141846501)
Mar 8 20:35:01 activy vdr: [3202] Local Time = Thu Mar 9 00:35:01 2006 (1141860901)
Mar 9 00:35:01 activy syslog-ng[2797]: STATS: dropped 0
Mar 9 00:35:05 activy vdr: [3201] frontend 1 lost lock on channel 31, tp 121
Mar 9 00:35:05 activy vdr: [3201] frontend 1 regained lock on channel 31, tp 121
Mar 9 00:35:07 activy vdr: [3201] frontend 1 lost lock on channel 31, tp 121
Mar 9 00:35:07 activy vdr: [3201] frontend 1 regained lock on channel 31, tp 121
Mar 9 00:35:10 activy vdr: [3201] frontend 1 lost lock on channel 31, tp 121
Mar 9 00:35:10 activy vdr: [3201] frontend 1 regained lock on channel 31, tp 121
Mar 9 00:35:13 activy vdr: [3201] frontend 1 lost lock on channel 31, tp 121
Mar 9 00:35:14 activy vdr: [3201] frontend 1 regained lock on channel 31, tp 121
Mar 9 00:35:15 activy vdr: [3201] frontend 1 lost lock on channel 31, tp 121
Mar 9 00:35:15 activy vdr: [3201] frontend 1 regained lock on channel 31, tp 121
Mar 9 00:35:16 activy vdr: [3201] frontend 1 lost lock on channel 31, tp 121
Mar 9 00:35:16 activy vdr: [3201] frontend 1 regained lock on channel 31, tp 121
Mar 9 00:35:19 activy vdr: [3201] frontend 1 lost lock on channel 31, tp 121
Mar 9 00:35:19 activy vdr: [3201] frontend 1 regained lock on channel 31, tp 121
Mar 9 00:35:20 activy vdr: [3201] frontend 1 lost lock on channel 31, tp 121
Mar 9 00:35:20 activy vdr: [3201] frontend 1 regained lock on channel 31, tp 121
Mar 9 00:35:21 activy vdr: [3201] frontend 1 lost lock on channel 31, tp 121
Mar 9 00:35:21 activy vdr: [3201] frontend 1 regained lock on channel 31, tp 121
Mar 9 00:35:23 activy vdr: [3202] System Time = Thu Mar 9 00:35:23 2006 (1141860923)
Mar 9 00:35:23 activy vdr: [3202] Local Time = Wed Mar 8 20:35:23 2006 (1141846523)
Mar 8 20:40:28 activy vdr: [3202] System Time = Wed Mar 8 20:40:28 2006 (1141846828)
Mar 8 20:40:28 activy vdr: [3202] Local Time = Fri Aug 11 21:40:29 2028 (1849635629)
Aug 11 21:40:42 activy vdr: [3202] System Time = Fri Aug 11 21:40:42 2028 (1849635642)
Aug 11 21:40:42 activy syslog-ng[2797]: STATS: dropped 0
Aug 11 21:40:42 activy vdr: [3202] Local Time = Wed Mar 8 20:40:43 2006 (1141846843)
Mar 8 20:43:35 activy vdr: [3202] System Time = Wed Mar 8 20:43:35 2006 (1141847015)
Mar 8 20:43:35 activy vdr: [3202] Local Time = Thu Mar 9 00:43:36 2006 (1141861416)
Mar 9 00:43:44 activy vdr: [3202] System Time = Thu Mar 9 00:43:44 2006 (1141861424)
Mar 9 00:43:44 activy vdr: [3202] Local Time = Wed Mar 8 20:43:45 2006 (1141847025)
Mar 8 20:44:34 activy vdr: [3180] channel 16 (MDR FERNSEHEN) event 20:15 'Sachsen-Anhalt spezial - Die Reportage' status 1
Mar 8 20:44:35 activy vdr: [3180] channel 16 (MDR FERNSEHEN) event 20:45 'Des Wahnsinns kesse Leute' status 2
Mar 8 20:44:51 activy vdr: [3180] channel 16 (MDR FERNSEHEN) event 20:45 'Des Wahnsinns kesse Leute' status 4
Mar 8 20:46:45 activy vdr: [3202] System Time = Wed Mar 8 20:46:45 2006 (1141847205)
Mar 8 20:46:45 activy vdr: [3202] Local Time = Tue Dec 20 20:46:46 1994 (787952806)
Dec 20 20:46:46 activy vdr: [3202] System Time = Tue Dec 20 20:46:46 1994 (787952806)
Dec 20 20:46:46 activy vdr: [3202] Local Time = Wed Mar 8 20:46:47 2006 (1141847207)
Mar 8 20:51:09 activy kernel: lirc_serial: AIEEEE: your clock just jumped backwards
Mar 8 20:51:09 activy kernel: lirc_serial: 0 1 440f35ad 440f6a38 6f4e9 9ad96
Mar 8 20:55:01 activy vdr: [3202] System Time = Wed Mar 8 20:55:01 2006 (1141847701)
Mar 8 20:55:01 activy vdr: [3202] Local Time = Wed Mar 8 12:55:02 2006 (1141818902)
Mar 8 12:55:12 activy vdr: [3202] System Time = Wed Mar 8 12:55:12 2006 (1141818912)
Mar 8 12:55:12 activy vdr: [3202] Local Time = Wed Mar 8 20:55:12 2006 (1141847712)
Mar 8 20:56:46 activy vdr: [3202] System Time = Wed Mar 8 20:56:46 2006 (1141847806)
Mar 8 20:56:46 activy vdr: [3202] Local Time = Tue Dec 20 20:56:47 1994 (787953407)
Dec 20 20:56:49 activy vdr: [3202] System Time = Tue Dec 20 20:56:49 1994 (787953409)
Dec 20 20:56:49 activy vdr: [3202] Local Time = Wed Mar 8 20:56:48 2006 (1141847808)

celica · March 8, 2006 at 11:31 PM

Hast Du parallel noch ntp aktiv und holt sich Linux das evtl. von Deinem Router oder einem anderen System aus dem lokalen LAN?
Denn das sind ja nicht nur Zeit sondern sogar Datumssprünge?

mauerspecht · March 9, 2006 at 10:47 PM

NTP hab ich nicht, habe ich ja extra geschrieben bevor jemand NTP als Lösung vorschlägt. Seit der Umstellung auf ZDF habe ich keine Sprünge mehr. Die Range von 1994 - 2038 erinnert mich an nach Zurück in die Zukunft I-III.

Bevor jemand fragt: Die frontend 1 Fehler kommen von der Siemens DVB-C mit CI, der Slotblech Adapter für das Antennekabel macht das Signal unbrauchbar. Ich werde das Kabel demnächst durch ein Lüftergitter routen.

l

celica · March 10, 2006 at 12:02 AM

wie jetzt,

oben schreibst Du "Zeitsprünge bei ZDF?"
dann wieder mit ZDF kein Prob?

dann: ntp verwendest Du nicht, ist der Prozess aber auch wirklich down?

Irgendwo muß es ja her kommen, ist das Log oben zeitlich so komplett oder fehlt da was?

Was zeigt denn "ps aux" und dmesg?

Passiert es auch, wenn kei LAN am vdr?

mauerspecht · March 10, 2006 at 11:42 PM

Titel ist korregiert. Man sollte halt nicht nach 23:00 noch Beiträge erstellen.

Hier scheint mir ja keiner zu glauben das ich den ntp nicht benutze, ist aber so.

ps aux | grep -i ntp
root 25379 0.0 0.1 1824 572 pts/0 S+ 23:11 0:00 grep -i ntp

grep -R net /etc/cron.*
/etc/cron.daily/suse.de-updatedb: echo --netuser=$UPDATEDB_NETUSER`"
/etc/cron.daily/suse.de-updatedb: echo --netpaths=\'$(eval echo $UPDATEDB_NETPATHS)\'`"

Anhand des Syslogs kann man ja erkennen das die Änderung vom dem Prozess vdr vorgenommen wird:

Mar 8 20:46:45 activy vdr: [3202] System Time = Wed Mar 8 20:46:45 2006 (1141847205)
Mar 8 20:46:45 activy vdr: [3202] Local Time = Tue Dec 20 20:46:46 1994 (787952806)

Der entsprechende Code in eit.c:

isyslog("System Time = %s (%ld)", *TimeToString(loctim), loctim);
isyslog("Local Time = %s (%ld)", *TimeToString(sattim), sattim);

Der Ausschnitt aus der Syslog ist nicht gekürzt, ich habe noch ein paar Seiten mehr, ich denke das reicht zum debuggen.

Den dmesg von vorgestern habe ich natürlich nicht mehr, ich meine aber das er mit dem laden der Treiber endete. Sieht heute so aus, ab DVB Treiber:

Linux video capture interface: v1.00
saa7146: register extension 'dvb'.
ACPI: PCI Interrupt 0000:00:0c.0[A] -> GSI 20 (level, low) -> IRQ 16
saa7146: found saa7146 @ mem e09fa800 (revision 1, irq 16) (0x13c2,0x0002).
DVB: registering new adapter (Technotrend/Hauppauge WinTV DVB-C rev2.X).
adapter has MAC addr = 00:d0:5c:5b:ba:1a
dvb-ttpci: info @ card 0: firm f0240009, rtsl b0250018, vid 71010068, app 80f62623
dvb-ttpci: firmware @ card 0 supports CI link layer interface
dvb-ttpci: adac type set to 0 @ card 0
saa7146_vv: saa7146 (0): registered device video0 [v4l2]
saa7146_vv: saa7146 (0): registered device vbi0 [v4l2]
DVB: registering frontend 0 (VLSI VES1820 DVB-C)...
input: DVB on-card IR receiver as /class/input/input2
dvb-ttpci: found av7110-0.
ACPI: PCI Interrupt 0000:00:12.0[A] -> GSI 21 (level, low) -> IRQ 18
saa7146: found saa7146 @ mem e0a34000 (revision 1, irq 18) (0x110a,0x0000).
DVB: registering new adapter (Fujitsu Siemens DVB-C).
adapter has MAC addr = 00:d0:5c:02:1e:d2
dvb-ttpci: info @ card 1: firm f0240009, rtsl b0250018, vid 71010068, app 80f62623
dvb-ttpci: firmware @ card 1 supports CI link layer interface
dvb-ttpci: DVB-C analog module @ card 1 detected, initializing MSP3400
saa7146_vv: saa7146 (1): registered device video1 [v4l2]
saa7146_vv: saa7146 (1): registered device vbi1 [v4l2]
DVB: registering frontend 1 (VLSI VES1820 DVB-C)...
dvb-ttpci: found av7110-1.
saa7146: register extension 'budget_av'.
ACPI: PCI Interrupt 0000:00:08.0[A] -> GSI 17 (level, low) -> IRQ 19
saa7146: found saa7146 @ mem e0a60000 (revision 1, irq 19) (0x153b,0x1157).
DVB: registering new adapter (Terratec Cinergy 1200 DVB-T).
adapter failed MAC signature check
encoded MAC from EEPROM was ff:ff:ff:ff:ff:ff:ff:ff:ff:ff:ff:ff:ff:ff:ff:ff:ff:ff:ff:ff
budget-av: ci interface initialised.
KNC1-2: MAC addr = 00:0a:ac:01:ac:87
DVB: registering frontend 2 (Philips TDA10046H DVB-T)...
saa7146: register extension 'budget dvb'.
tda1004x: setting up plls for 53MHz sampling clock
tda1004x: timeout waiting for DSP ready
tda1004x: found firmware revision 0 -- invalid
tda1004x: waiting for firmware upload...
tda1004x: found firmware revision 20 -- ok

Ende von dmesg

Die Karten in dem VDR von 0 gezählt :

0 : Hauppauge WinTV DVB-C
1 : Fujitsu Siemens DVB-C mit CI, die alphacrypt habe ich gestern entfernt
2 : Terratec Cinergy 1200 DVB-T

Ich frage mich jetzt von welcher Karte der VDR die Zeit nimmt? Er hat ja 2 DVB-C zur Auswahl, von der die eine wegen des Anschlusskabels Fehler produziert:

Mar 9 00:35:21 activy vdr: [3201] frontend 1 lost lock on channel 31, tp 121
Mar 9 00:35:21 activy vdr: [3201] frontend 1 regained lock on channel 31, tp 121

Noch ein paar Werte aus der setup.conf:

PrimaryDVB = 1
TimeSource = C
TimeTransponder = 394

Und aus der channels.conf

grep 394 channels.conf
KABEL1;ProSiebenSat.1:746000000:C23D12M16B8T8G4Y0:T:27500:161:162=deu:167:0:16394:8468:8705:0
ZDF;ZDFvision:394000:C0M64:C:6900:110:120=deu,121=2ch;125=dd:130:0:28006:1:1079:0
3sat;ZDFvision:394000:C0M64:C:6900:210:220=deu,221=2ch;225=dd:230:0:28007:1:1079:0
ZDFtheaterkanal;ZDFvision:394000:C0M64:C:6900:1110:1120=deu:130:0:28016:1:1079:0
ZDFinfokanal;ZDFvision:394000:C0M64:C:6900:610:620=deu:130:0:28011:1:1079:0
ZDFdokukanal;ZDFvision:394000:C0M64:C:6900:660:670=deu:130:0:28014:1:1079:0
DLF;ZDFvision:394000:C0M64:C:6900:0:810=deu:0:0:28013:1:1079:0
DKULTUR;ZDFvision:394000:C0M64:C:6900:0:710=deu:0:0:28012:1:1079:0

Participate now!