[strace] 0kb 00001.ts

TheChief · 25. April 2018

Hm, hier irgendwo liegt der Hund begraben:

Code

Apr 25 11:02:00 rec18 vdr: [18604] ERROR: video data stream broken
Apr 25 11:02:00 rec18 vdr: [18604] initiating emergency exit
Apr 25 11:02:00 rec18 vdr: [18590] emergency exit requested - shutting down

kls · 25. April 2018

Tut mir leid, da fällt mir jetzt auch nichts mehr dazu ein.

Wenn mit einem einzigen Device streamdev einen Kanal liefert, dann müsste auch VDR aufnehmen können.

Jetzt müssen wir wohl etwas Debug-Aufwand betreiben.

Füge bitte mal in device.c in der Funktion cDevice::Action() diese Zeile ein:

Code

                 for (int i = 0; i < MAXRECEIVERS; i++) {
                     fprintf(stderr, " %d", i);//XXX
                     cMutexLock MutexLock(&mutexReceiver);

Da werden sehr viele Ausgaben entstehen (also nicht ins Logfile schreiben lassen ;-). Worum es mir geht ist, ob da immer nur die gleiche Zahl kommt oder verschiedene. Du brauchst nicht die gesamte Ausgaben zu posten, sondern nur die (evtl. unterschiedlichen) Zahlenwerte.

Klaus

chrisz · 8. Mai 2018

Hallo Klaus,

sorry für den delay.

Kann es sein das ich nicht in die Funktion (den for loop) hineinlaufe ? Keinerlei Logging...

Edit: Moment, ich checke das...

kls · 8. Mai 2018

Das kann eigentlich nicht sein, denn das ist die zentrale Verteilstelle für TS-Pakete.

Die Ausgabe erfolgt nach stdout, nicht ins Logfile!

- Zeile an der richtigen Stelle eingefügt?

- device.c neu übersetzt und vdr gelinkt?

- VDR neu gestartet?

Klaus

chrisz · 8. Mai 2018

Code

void cDevice::Action(void)
{

dsyslog("FOO-DBG [001] cDevice::Action"); // XXX

  if (Running() && OpenDvr()) {

     dsyslog("FOO-DBG [002] Running"); // XXX

     while (Running()) {

           dsyslog("FOO-DBG [003] Running"); // XXX
           // Read data from the DVR device:
           uchar *b = NULL;
           if (GetTSPacket(b)) {

              dsyslog("FOO-DBG [004] GetTSPacket"); // XXX
              if (b) {

                 dsyslog("FOO-DBG [005] d"); // XXX
                 // Distribute the packet to all attached receivers:
                 Lock();
                 cCamSlot *cs = CamSlot();
                 if (cs)
                    dsyslog("FOO-DBG [006] cs"); // XXX
                    cs->TsPostProcess(b);
                 int Pid = TsPid(b);
                 bool IsScrambled = TsIsScrambled(b);

                dsyslog("FOO-DBG-MAXRECEIVERS: %d", MAXRECEIVERS);

                 for (int i = 0; i < MAXRECEIVERS; i++) {

Alles anzeigen

syslog:

Code

May  8 14:36:51 rec18 vdr: [8542] timer 1 (1 1400-1500 'DBG-TEST-001') start
May  8 14:36:51 rec18 vdr: [8542] Title: 'Schloss Einstein - Erfurt' Subtitle: '(null)'
May  8 14:36:51 rec18 vdr: [8542] record /srv/video/DBG-TEST-001/2018-05-08.14.00.1-0.rec
May  8 14:36:51 rec18 vdr: [8542] cFileName::SetOffset: removing zero-sized file /srv/video/DBG-TEST-001/2018-05-08.14.00.1-0.rec/00001.ts
May  8 14:36:51 rec18 vdr: [8542] recording to '/srv/video/DBG-TEST-001/2018-05-08.14.00.1-0.rec/00001.ts'
May  8 14:36:51 rec18 vdr: [8542] writing timer id '1@rec18' to /srv/video/DBG-TEST-001/2018-05-08.14.00.1-0.rec/.timer
May  8 14:36:51 rec18 vdr: [8552] device 1 receiver thread started (pid=8542, tid=8552, prio=high)
May  8 14:36:51 rec18 vdr: [8552] FOO-DBG [001] cDevice::Action
May  8 14:36:51 rec18 vdr: [8552] FOO-DBG [002] Running
May  8 14:36:51 rec18 vdr: [8552] FOO-DBG [003] Running
May  8 14:36:51 rec18 vdr: [8553] device 1 TS buffer thread started (pid=8542, tid=8553, prio=high)
May  8 14:36:51 rec18 vdr: [8551] recording thread started (pid=8542, tid=8551, prio=high)
May  8 14:36:51 rec18 vdr: [8542] ERROR: Kanal blockiert (zeichnet auf)!
May  8 14:36:52 rec18 vdr: [8552] FOO-DBG [004] GetTSPacket
May  8 14:36:52 rec18 vdr: [8552] FOO-DBG [003] Running
May  8 14:36:52 rec18 vdr: [8552] FOO-DBG [004] GetTSPacket
May  8 14:36:52 rec18 vdr: [8552] FOO-DBG [003] Running
May  8 14:36:52 rec18 vdr: [8552] FOO-DBG [004] GetTSPacket
May  8 14:36:52 rec18 vdr: [8552] FOO-DBG [003] Running
May  8 14:36:52 rec18 vdr: [8552] FOO-DBG [004] GetTSPacket
May  8 14:36:52 rec18 vdr: [8552] FOO-DBG [003] Running
May  8 14:36:52 rec18 vdr: [8552] FOO-DBG [004] GetTSPacket
May  8 14:36:52 rec18 vdr: [8552] FOO-DBG [003] Running
May  8 14:36:52 rec18 vdr: [8552] FOO-DBG [004] GetTSPacket
May  8 14:36:52 rec18 vdr: [8552] FOO-DBG [003] Running
May  8 14:36:52 rec18 vdr: [8552] FOO-DBG [004] GetTSPacket
May  8 14:36:52 rec18 vdr: [8552] FOO-DBG [003] Running
May  8 14:36:52 rec18 vdr: [8552] FOO-DBG [004] GetTSPacket
May  8 14:36:52 rec18 vdr: [8552] FOO-DBG [003] Running
May  8 14:36:52 rec18 vdr: [8552] FOO-DBG [004] GetTSPacket
May  8 14:36:52 rec18 vdr: [8552] FOO-DBG [003] Running
May  8 14:36:52 rec18 vdr: [8552] FOO-DBG [004] GetTSPacket
May  8 14:36:52 rec18 vdr: [8552] FOO-DBG [003] Running
May  8 14:36:53 rec18 vdr: [8552] FOO-DBG [004] GetTSPacket
May  8 14:36:53 rec18 vdr: [8552] FOO-DBG [003] Running
May  8 14:36:53 rec18 vdr: [8552] FOO-DBG [004] GetTSPacket
May  8 14:36:53 rec18 vdr: [8552] FOO-DBG [003] Running
May  8 14:36:53 rec18 vdr: [8552] FOO-DBG [004] GetTSPacket
May  8 14:36:53 rec18 vdr: [8552] FOO-DBG [003] Running

Alles anzeigen

chrisz · 8. Mai 2018

So siehts aus, wenn ich per Streamdev den Kanal streame:

Code

May  8 14:50:26 rec18 vdr: [10160] FOO-DBG [004] GetTSPacket
May  8 14:50:26 rec18 vdr: [10160] FOO-DBG [003] Running
May  8 14:50:26 rec18 vdr: [10160] FOO-DBG [004] GetTSPacket
May  8 14:50:26 rec18 vdr: [10160] FOO-DBG [003] Running
May  8 14:50:26 rec18 vdr: [10160] FOO-DBG [004] GetTSPacket
May  8 14:50:26 rec18 vdr: [10160] FOO-DBG [003] Running
May  8 14:50:26 rec18 vdr: [10160] FOO-DBG [004] GetTSPacket
May  8 14:50:26 rec18 vdr: [10160] FOO-DBG [003] Running
May  8 14:50:26 rec18 vdr: [10160] FOO-DBG [004] GetTSPacket
May  8 14:50:26 rec18 vdr: [10160] FOO-DBG [003] Running
May  8 14:50:26 rec18 vdr: [10160] FOO-DBG [004] GetTSPacket
May  8 14:50:26 rec18 vdr: [10160] FOO-DBG [003] Running
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG [004] GetTSPacket
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG [003] Running
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG [004] GetTSPacket
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG [003] Running
May  8 14:50:27 rec18 vdr: [10150] max. latency time 2 seconds
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG [004] GetTSPacket
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG [003] Running
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG [004] GetTSPacket
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG [003] Running
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG [004] GetTSPacket
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG [003] Running
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG [004] GetTSPacket
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG [003] Running
May  8 14:50:27 rec18 vdr: [10157] Streamdev: Accepted new client (HTTP) 192.168.181.107:56463
May  8 14:50:27 rec18 vdr: [10163] streamdev-livestreaming thread started (pid=10150, tid=10163, prio=high)
May  8 14:50:27 rec18 vdr: [10162] streamdev-writer thread started (pid=10150, tid=10162, prio=high)
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG [004] GetTSPacket
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG [003] Running
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG [004] GetTSPacket
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG [003] Running
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG [004] GetTSPacket
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG [005] d
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 0
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 1
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 2
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 3
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 4
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 5
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 6
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 7
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 8
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 9
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 10
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 11
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 12
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 13
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 14
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 15
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG [003] Running
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG [004] GetTSPacket
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG [005] d
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 0
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 1
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 2
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 3
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 4
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 5
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 6
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 7
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 8
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 9
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 10
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 11
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 12
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 13
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 14
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG 15
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG [003] Running
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG [004] GetTSPacket
May  8 14:50:27 rec18 vdr: [10160] FOO-DBG [005] d

Alles anzeigen

kls · 8. Mai 2018

Und prompt sehe ich natürlich, dass meine Ausgabe drei Zeilen weiter hinten reingehört hätte:

Code

for (int i = 0; i < MAXRECEIVERS; i++) {
                     cMutexLock MutexLock(&mutexReceiver);
                     cReceiver *Receiver = receiver[i];
                     if (Receiver && Receiver->WantsPid(Pid)) {
                        fprintf(stderr, " %d", i);//XXX
                        Receiver->Receive(b, TS_SIZE);

Ist aber egal, denn so wie es aussieht kommen überhaupt keine TS-Pakete an (kein "FOO-DBG [005] d").

Warum sich das in den beiden Fällen unterschiedlich verhält kann ich mir leider auch nicht erklären.

Klaus

chrisz · 9. Mai 2018

Okay, wenn du Dir das nicht erklären kannst, wer denn dann

Viele Grüße. Ich setzte das ganze nochmal auf einem fresh System auf. Bleibe aber bei Debian stretch und der Digital Devices v7.

TomJoad · 9. Mai 2018

Mich irritiert das "ERROR: Kanal blockiert (zeichnet auf)!". Vielleicht ist doch etwas besonderes an deiner setup.conf oder Aufrufparametern von vdr und Plugins.

TheChief · 9. Mai 2018

Den Fehler bekomme ich auch bei jedem VDR Start. Glaub der ist "normal".

SurfaceCleanerZ · 9. Mai 2018

Hi,

Teste doch den Treiber mal mit einem Live System mit aktuellem Kernel 4.16.

Z.B. Ubuntu 18.04 oder so.

Vdr Pakete hat Seahawk ja.

MfG Stefan

chrisz · 19. September 2018

Zitat von kls
Und prompt sehe ich natürlich, dass meine Ausgabe drei Zeilen weiter hinten reingehört hätte:
Code
for (int i = 0; i < MAXRECEIVERS; i++) {
                     cMutexLock MutexLock(&mutexReceiver);
                     cReceiver *Receiver = receiver[i];
                     if (Receiver && Receiver->WantsPid(Pid)) {
                        fprintf(stderr, " %d", i);//XXX
                        Receiver->Receive(b, TS_SIZE);
Ist aber egal, denn so wie es aussieht kommen überhaupt keine TS-Pakete an (kein "FOO-DBG [005] d").

Warum sich das in den beiden Fällen unterschiedlich verhält kann ich mir leider auch nicht erklären.

Klaus
Alles anzeigen

Hallo Klaus, ich greife das Thema nochmal auf. Foo-DBG[005] d ist doch vorhanden in den logs...

[strace] 0kb 00001.ts

Jetzt mitmachen!

Teilen