XXV kann Aufnahmen nicht lesen

Twilek · 19. Februar 2011

Hallo zusammen,

nachdem ich nun lange an einer xxv Installation herumgefummelt habe läuft auch fast alles. Er kann nur noch die Aufnahmen nicht einlesen. Das Log sagt dann

Code

294 (501) [2011-02-19 13:16:00] RECORDS: DBD::mysql::st execute failed: Column 'priority' cannot be null at /opt/XXV/bin/../lib/XXV/MODULES/RECORDS.pm line 1152.
295 (501) [2011-02-19 13:16:00] RECORDS: Schreibe nur 0 Aufnahmen in die Datenbank. Kann 4 Aufnahmen nicht zuordnen.
Konnte Aufnahme 'Tatort: Seenot' nicht in Datenbank einfügen!

Ich kriege nicht raus wo die Einstellung für Priorität ist oder was ich wo ändern muß.

VDR ist der 1.7er

Danke

Twilek

anbr · 19. Februar 2011

Hi,

erst ab XXV-1.6 wird die neue Aufnahmestruktur des VDR seit Version 1.7.3 unterstützt. Aktuell ist XXV-1.6.1...

Die Priority steht bei VDR-Version 1.7.x in der zur Aufnahme gehörenden Datei "info"

Andreas

Twilek · 19. Februar 2011

Hallo Andreas,

ich benutze die 1.6.1(1496), deswegen dachte ich, daß er das können müsste.

Ich habe mal das recordings Verzeichnis meiner Reelbox durchgeschaut. Die Dateien heissen nur *.rec in einem entsprechenden Verzeichnisbaum. Ansonsten gibt es keine Dateien.

Grüße

Henning

anbr · 19. Februar 2011

Hi

Der Originale-VDR(TM) verwendet in Version 1.6 eine Struktur al

Code

/var/lib/video/Mankells_Wallander/Mankells_Wallander/Mankells_Wallander_-_Dunkle_Geheimnisse/2010-07-11.21.42.50.99.rec/001.vdr
/var/lib/video/Mankells_Wallander/Mankells_Wallander/Mankells_Wallander_-_Dunkle_Geheimnisse/2010-07-11.21.42.50.99.rec/002.vdr
/var/lib/video/Mankells_Wallander/Mankells_Wallander/Mankells_Wallander_-_Dunkle_Geheimnisse/2010-07-11.21.42.50.99.rec/index.vdr
/var/lib/video/Mankells_Wallander/Mankells_Wallander/Mankells_Wallander_-_Dunkle_Geheimnisse/2010-07-11.21.42.50.99.rec/info.vdr
/var/lib/video/Mankells_Wallander/Mankells_Wallander/Mankells_Wallander_-_Dunkle_Geheimnisse/2010-07-11.21.42.50.99.rec/marks.vdr
/var/lib/video/Mankells_Wallander/Mankells_Wallander/Mankells_Wallander_-_Dunkle_Geheimnisse/2010-07-11.21.42.50.99.rec/resume.vdr

bzw. ab Version 1.7.3

Code

/var/lib/video/Mankells_Wallander/Mankells_Wallander/%Mankells_Wallander_-_Der_unsichtbare_Gegner/2011-02-11.22.31.11-0.rec/00001.ts
/var/lib/video/Mankells_Wallander/Mankells_Wallander/%Mankells_Wallander_-_Der_unsichtbare_Gegner/2011-02-11.22.31.11-0.rec/00002.ts
/var/lib/video/Mankells_Wallander/Mankells_Wallander/%Mankells_Wallander_-_Der_unsichtbare_Gegner/2011-02-11.22.31.11-0.rec/index
/var/lib/video/Mankells_Wallander/Mankells_Wallander/%Mankells_Wallander_-_Der_unsichtbare_Gegner/2011-02-11.22.31.11-0.rec/info
/var/lib/video/Mankells_Wallander/Mankells_Wallander/%Mankells_Wallander_-_Der_unsichtbare_Gegner/2011-02-11.22.31.11-0.rec/marks
/var/lib/video/Mankells_Wallander/Mankells_Wallander/%Mankells_Wallander_-_Der_unsichtbare_Gegner/2011-02-11.22.31.11-0.rec/resume

Andere Strukturen werden durch XXV nicht erkannt ...

Zeige doch mal die Ausgabe von "find /video" sowie "svdrpsend.pl LSTR"

Andreas

Twilek · 19. Februar 2011

Code

220 ReelBox SVDRP VideoDiskRecorder 1.7.16; Sat Feb 19 17:16:42 2011; UTF-8
250-1 18.02.11 12:20  Oiski! Poiski! - Neues von Noahs Insel
250-2 18.02.11 12:28  Oiski! Poiski! - Neues von Noahs Insel~Elefantenentführung
250-3 19.02.11 14:30* Rosamunde Pilcher Karussell des Lebens
250 4 18.02.11 22:05* Tatort: Seenot
221 ReelBox closing connection

Die Aufzeichnungen sind in /media/reel/recordings und darin sieht es dann so aus

Code

[  16]  ./LiveBuffer
[869M]  ./LiveBuffer/00001.ts
[   0]  ./LiveBuffer/index
[1.1K]  ./noadonlinestat
[  16]  ./Oiski!_Poiski!_-_Neues_von_Noahs_Insel
[  56]  ./Oiski!_Poiski!_-_Neues_von_Noahs_Insel/2011-02-18.12.20.16-0.rec
[1.4G]  ./Oiski!_Poiski!_-_Neues_von_Noahs_Insel/2011-02-18.12.20.16-0.rec/00001.ts
[524K]  ./Oiski!_Poiski!_-_Neues_von_Noahs_Insel/2011-02-18.12.20.16-0.rec/index
[1.3K]  ./Oiski!_Poiski!_-_Neues_von_Noahs_Insel/2011-02-18.12.20.16-0.rec/info.txt
[  22]  ./Oiski!_Poiski!_-_Neues_von_Noahs_Insel/2011-02-18.12.20.16-0.rec/marks
[   8]  ./Oiski!_Poiski!_-_Neues_von_Noahs_Insel/2011-02-18.12.20.16-0.rec/resume
[   8]  ./Oiski!_Poiski!_-_Neues_von_Noahs_Insel/Elefantenentf\303\274hrung
[  56]  ./Oiski!_Poiski!_-_Neues_von_Noahs_Insel/Elefantenentf\303\274hrung/2011-02-18.12.28.16-0.rec
[1.1G]  ./Oiski!_Poiski!_-_Neues_von_Noahs_Insel/Elefantenentf\303\274hrung/2011-02-18.12.28.16-0.rec/00001.ts
[432K]  ./Oiski!_Poiski!_-_Neues_von_Noahs_Insel/Elefantenentf\303\274hrung/2011-02-18.12.28.16-0.rec/index
[1.4K]  ./Oiski!_Poiski!_-_Neues_von_Noahs_Insel/Elefantenentf\303\274hrung/2011-02-18.12.28.16-0.rec/info.txt
[  22]  ./Oiski!_Poiski!_-_Neues_von_Noahs_Insel/Elefantenentf\303\274hrung/2011-02-18.12.28.16-0.rec/marks
[   7]  ./Oiski!_Poiski!_-_Neues_von_Noahs_Insel/Elefantenentf\303\274hrung/2011-02-18.12.28.16-0.rec/resume
[   8]  ./Rosamunde_Pilcher_Karussell_des_Lebens
[4.0K]  ./Rosamunde_Pilcher_Karussell_des_Lebens/2011-02-19.14.30.2-0.rec
[2.0G]  ./Rosamunde_Pilcher_Karussell_des_Lebens/2011-02-19.14.30.2-0.rec/00001.ts
[2.0G]  ./Rosamunde_Pilcher_Karussell_des_Lebens/2011-02-19.14.30.2-0.rec/00002.ts
[431M]  ./Rosamunde_Pilcher_Karussell_des_Lebens/2011-02-19.14.30.2-0.rec/00003.ts
[1.3M]  ./Rosamunde_Pilcher_Karussell_des_Lebens/2011-02-19.14.30.2-0.rec/index
[ 899]  ./Rosamunde_Pilcher_Karussell_des_Lebens/2011-02-19.14.30.2-0.rec/info.txt
[ 108]  ./Rosamunde_Pilcher_Karussell_des_Lebens/2011-02-19.14.30.2-0.rec/marks
[   8]  ./Tatort#3A_Seenot
[  64]  ./Tatort#3A_Seenot/2011-02-18.22.05.1-0.rec
[2.0G]  ./Tatort#3A_Seenot/2011-02-18.22.05.1-0.rec/00001.ts
[2.0G]  ./Tatort#3A_Seenot/2011-02-18.22.05.1-0.rec/00002.ts
[1.3G]  ./Tatort#3A_Seenot/2011-02-18.22.05.1-0.rec/00003.ts
[1.2M]  ./Tatort#3A_Seenot/2011-02-18.22.05.1-0.rec/index
[ 609]  ./Tatort#3A_Seenot/2011-02-18.22.05.1-0.rec/info.txt
[  22]  ./Tatort#3A_Seenot/2011-02-18.22.05.1-0.rec/marks

Alles anzeigen

Die Infos sind doch da, ich hatte nicht gesehen, daß die .rec Dateien nochmal selbst folder sind. Allerdings heissen die Dateien bei mir info.txt nicht nur info.

anbr · 19. Februar 2011

Hmm, da hat sich reel wohl keinen wirklichen Gefallen getan, vom allgemeinen File-Standard VDR abzuweichen, im Grunde muss jede Originalsoftware an die reel-Verzeichnisstruktur angepasst werden um sie einsetzen können.

Als Workaround für XXV sollte erstmal folgende Modifikation helfen :

Diff

--- RECORDS.pm	(Revision 1500)
+++ RECORDS.pm	(Arbeitskopie)
@@ -1415,7 +1416,7 @@
 
     my $f;
     if($filever && $filever == 2) {
-      $f = "info";
+      $f = "info.txt";
     } else {
       $f = "info.vdr";
     }

Alles anzeigen

Twilek · 19. Februar 2011

Perfekt, vielen vielen Dank.

Jetzt zeigt er die Aufnahmen an.

Jetzt muß ich nur noch rausfinden warum er bei beim "jason" skin ewig auf "Verbinde..." im Hauptbildschirm stehen bleibt und er über lange Zeit mysqld auf 100% Prozessorlast hochzieht und schon ist meine Weboberfläche perfekt

anbr · 19. Februar 2011

Zitat

Original von Twilek
Jetzt muß ich nur noch rausfinden warum er bei beim "jason" skin ewig auf "Verbinde..." im Hauptbildschirm stehen bleibt und er über lange Zeit mysqld auf 100% Prozessorlast hochzieht und schon ist meine Weboberfläche perfekt

Am Anfang wird die komplette Channelliste gelesen, vielleicht gibt es Probleme wenn die Anzahl zu hoch ist und dein System geht dabei in die Knie. Momentan gibt ist noch kein Einlesen in kleineren Schritten.

Momentan könnte Firefox + Plugin Firebug als Javascript-Debugger helfen, zu sehen an welcher Stelle der Browser hängen bleibt.

Twilek · 19. Februar 2011

Komisch ist das er manchmal links schon die Kanäle alle hat und alle anderen Tabs gehen. Nur das erste Tab nicht. Wenn ich Firebug aktiviere lädt er an

Code

http://192.168.1.95:8080/?ajax=json&_dc=1298154595335&cmd=n&__cgrp=all&groupBy=grpname&groupDir=ASC&start=0&limit=100
__cgrp	all
_dc	1298154595335
ajax	json
cmd	n
groupBy	grpname
groupDir	ASC
limit	100
start	0

und

Code

http://192.168.1.95:8080/?ajax=json&_dc=1298154595343&cmd=vl&start=0&limit=100
_dc	1298154595343
ajax	json
cmd	vl
limit	100
start	0

bis er abbricht
zusätzlich wirft er ein

Code

e is undefined
http://192.168.1.95:8080/now.js
Line 184

Kann natürlich die Hardwareperformance sein, die Reelbox ist ja nicht so ein Bolide. Wäre sehr schade, das Jason Interface sieht wirklich super aus.

Irgendwie scheint mysql nicht schnell genug nachzukommen (nur mit dem Skin wird die Datenbank so bansprucht). Ich weiss aber auch nicht was er da so heftig nachfragt...

Aufrufen einzelner Kanäle aus der linken führt nicht zur Belastung von mysql und öffnet richtig einen neuen Tab. Ebenso alle anderen Funktionen laufen problemlos. Nur im nicht schliessbaren ersten Tab im Dropdownmenü rechts oben eine neue Zeit auswählen bringt wieder 100% mysql.

Ach ja xstyle und die Standard Skin funktionieren mit Chrome 10 Beta und teilweise mit IE 9 nicht (Firefox geht). Sicher sollte man da abwarten bis die Dinger Final sind, aber das kann man sicherlich schonmal als Vorwarnung nutzen.

anbr · 21. Februar 2011

Eventuell hilft es schon die folgende Bremse zu entschärfen.
Sie dient in der Funktion runningNow, dem Zusammenfassen von EPG-Einträgen eine Multi-VDR-Umgebung. Bei mir sinkt die Dauer der Abfrage hiermit von 3s auf 100ms

Einfach probehalber mal folgende Zeile entfernen.

Diff

Index: EPG.pm
===================================================================
--- EPG.pm	(Revision 1500)
+++ EPG.pm	(Arbeitskopie)
@@ -1298,8 +1298,6 @@
 WHERE
     e.channel_id = c.id
     AND c.grp = g.id
-    AND e.vid = c.vid
-    AND c.vid = g.vid
     AND ? BETWEEN UNIX_TIMESTAMP(e.starttime)
     AND (UNIX_TIMESTAMP(e.starttime) + e.duration)
 |;

Alles anzeigen

Folgender Patch baut die SQL-Abfrage dann dynamisch gemäß der VDR-Anzahl zusammen.

Diff

--- EPG.pm	(Revision 1502)
+++ EPG.pm	(Arbeitskopie)
@@ -1323,13 +1323,19 @@
 FROM
     EPG as e, CHANNELS as c, CHANNELGROUPS as g
 WHERE
-    e.channel_id = c.id
+    ? BETWEEN UNIX_TIMESTAMP(e.starttime)
+    AND (UNIX_TIMESTAMP(e.starttime) + e.duration)
+    AND e.channel_id = c.id
     AND c.grp = g.id
+|;
+
+    if(scalar @{$self->{svdrp}->list_hosts()} > 1) {
+        $sql .=
+qq|
     AND e.vid = c.vid
     AND c.vid = g.vid
-    AND ? BETWEEN UNIX_TIMESTAMP(e.starttime)
-    AND (UNIX_TIMESTAMP(e.starttime) + e.duration)
 |;
+    }
 
     my $cmod = main::getModule('CHANNELS');
     my $cgroups = $cmod->ChannelGroupsArray('name');

Alles anzeigen

Twilek · 21. Februar 2011

Hmm, vielen Dank für die schnelle Antwort
Der erste Patch ist nach nem Subversion Update auf die 1502 schon drin oder ?!

Irgendwie hat beim zweiten Patch (der hunk wurde rejected, warum auch immer) bei mir das automatische patchen nicht geklappt. Ich habe dann den Patch von Hand eingepflegt. Die Stelle sieht bei mir jetzt so aus

Code

FROM
    EPG as e, CHANNELS as c, CHANNELGROUPS as g
WHERE
    ? BETWEEN UNIX_TIMESTAMP(e.starttime)
    AND (UNIX_TIMESTAMP(e.starttime) + e.duration)
    AND e.channel_id = c.id
    AND c.grp = g.id
|;


    if(scalar @{$self->{svdrp}->list_hosts()} > 1) {
        $sql .=
qq|
    AND e.vid = c.vid
    AND c.vid = g.vid
|;
}
    my $cmod = main::getModule('CHANNELS');
    my $cgroups = $cmod->ChannelGroupsArray('name');

Alles anzeigen

stimmt das so? Falls ja bringt es leider nicht die Lösung. MySQL schiesst immer noch auf 100% CPU Last hoch und der Tab bleibt leer (firebug Fehler bleiben auch).

Ansonsten hätte ich noch aus dem Log folgende Fehler, die alle paar Minuten auftreten anzubieten, wobei ich bezweifele, daß die etwas mit dem Problem zu tun haben

Code

1031 (501) [2011-02-21 23:09:59] TIMERS: Use of uninitialized value in sprintf at /opt/XXV/bin/../lib/XXV/MODULES/TIMERS.pm line 1023.
1032 (501) [2011-02-21 23:09:59] TIMERS: Couldn't get channel from this timer: 10 ''
1033 (550) [2011-02-21 23:09:59] Carp:
not well-formed (invalid token) at line 1, column 58, byte 58 at /usr/local/lib/perl/5.10.1/XML/Parser.pm line 187
1034 (550) [2011-02-21 23:09:59] Parser:
not well-formed (invalid token) at line 1, column 58, byte 58 at /usr/local/lib/perl/5.10.1/XML/Parser.pm line 187
1035 (501) [2011-02-21 23:09:59] TIMERS: Can't parse xml data
1036 (270) [2011-02-21 23:10:02] TIMERS: Call command "lstt" on localhost successful.
1037 (501) [2011-02-21 23:10:02] TIMERS: Use of uninitialized value in sprintf at /opt/XXV/bin/../lib/XXV/MODULES/TIMERS.pm line 1023.
1038 (501) [2011-02-21 23:10:02] TIMERS: Couldn't get channel from this timer: 10 ''
1039 (550) [2011-02-21 23:10:02] Carp:
not well-formed (invalid token) at line 1, column 58, byte 58 at /usr/local/lib/perl/5.10.1/XML/Parser.pm line 187

Alles anzeigen

anbr · 25. Februar 2011

Zitat

Original von Twilek
stimmt das so? Falls ja bringt es leider nicht die Lösung. MySQL schiesst immer noch auf 100% CPU Last hoch und der Tab bleibt leer (firebug Fehler bleiben auch).

Dann muss erst einmal passen, da ich das ganze Problem nicht reproduzieren kann, wie gesagt dauert bei mir die Abfrage jetzt insgesamt unter 100 Millisekunden. Ich habe zwar nicht die kleinste Kiste, es ist aber auch nur ein kleiner AMD 4850e mit 2GB RAM.

Übrigens folgende SQL-Abfrage wird von xxv an mysql-geschickt, kannst ja mal austesten, ob es nur an mysql hängen bleibt.

Code

mysql -u root xxv
mysql> 




SELECT SQL_CACHE 
    e.eventid,
    e.title,
    e.subtitle,
    c.name,
    c.hash,
    g.name,
    DATE_FORMAT(e.starttime, "%H:%i"),
    DATE_FORMAT(FROM_UNIXTIME(UNIX_TIMESTAMP(starttime) + e.duration), "%H:%i"),
    e.description,
    (unix_timestamp(e.starttime) + e.duration - unix_timestamp())/e.duration*100,
    ( SELECT 
        t.id
        FROM TIMERS as t
        WHERE t.eventid = e.eventid
        LIMIT 1) as __timerid,
    ( SELECT 
        (t.flags & 1) 
        FROM TIMERS as t
        WHERE t.eventid = e.eventid
        LIMIT 1) as __timeractiv,
    ( SELECT 
        NOW() between t.starttime and t.stoptime AND (t.flags & 1) 
        FROM TIMERS as t
        WHERE t.eventid = e.eventid
        LIMIT 1) as __running,
    IF(e.vpstime!=0,DATE_FORMAT(e.vpstime, '%H:%i'),'') as __PDC,
    ( SELECT 
      s.level
      FROM SHARE as s
      WHERE s.eventid = e.eventid
      LIMIT 1) as __level
FROM
    EPG as e, CHANNELS as c, CHANNELGROUPS as g
WHERE
    UNIX_TIMESTAMP(NOW()) BETWEEN UNIX_TIMESTAMP(e.starttime)
    AND (UNIX_TIMESTAMP(e.starttime) + e.duration)
    AND e.channel_id = c.id
    AND c.grp = g.id
    GROUP BY c.id 
    ORDER BY g.pos, c.pos, c.vid
    LIMIT 100;










...
...
100 rows in set (0.07 sec)

Alles anzeigen

Twilek · 25. Februar 2011

Wenn ich die Query von Hand starte kommt bei mir auch

100 rows in set (0.61 sec)

Interessanterweise konnte er gerade eben beim starten von xxv auch die Seite "Jetzt" darstellen... Wenn ich dann "Folgend" oder irgendeine Uhrzeit aus der Dropdownbox anwähle kommt wieder mysql.

Gibt es ne Möglichkeit zu überwachen wer gerade die Datenbank abfragt?

Update: Jetzt gehen plötzlich alle Abfragen schnell. Kann es sein, daß Mysql irgendwelchen internen Indexe anlegt oder so?! Ich teste mal wie es nach nem Reboot aussieht...

Update2: Wunder über Wunder... Auch nach einem Restart rennt xxv jetzt problemlos. Vielleicht mußte Mysql wirklich irgendwas intern machen. Mir ist allerdings noch eine Sache aufgefallen. Suchtimer, die ich in VDRAdmin angelegt habe tauchen nicht in xxv auf. Suchtimer aus xxv nicht in vdradmin. Soll das so sein (ist das der Unterschied zwischen "Autotimer" durch xxv und "Searchtimer" durch epgsearch?!)?

XXV kann Aufnahmen nicht lesen

Jetzt mitmachen!

Teilen

Benutzer online in diesem Thema