Mist, da hab ich gr0ß getönt, dass ich ne ähnliche Konstellation hab - und jetzt muß ich feststellen, dass ich doch nur ext3 hab, kann mich gar nicht erinnern, dass ich das fs mal neu gemacht hab (war definitiv mal ext4) - man sollte Bastelsysteme sich nicht in den "Produktivbetrieb" einschleichen lassen...
Trotzdem beschreib ich mal, wie ich (mit Mühe und womöglich eher zufällig) deine Symptome nachvollziehen konnte (irgendwie muss ich ja deine 15-Stunden-Zwangspause überbrücken)
|
Source code
|
1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
|
Apr 29 19:10:32 yavdr1 vdr: [1451] channel 102 (ZDF HD) event Son 29.04.2012 19:
10-19:28 (VPS: 29.04 19:10) 'Berlin direkt' status 4
Apr 29 19:10:32 yavdr1 vdr: [1116] switching device 1 to channel 102
Apr 29 19:10:32 yavdr1 vdr: [1116] timer 47 (102 1910-1928 VPS 'Video-Archiv~Tem
p~Berlin direkt') start
<...>
Apr 29 19:10:32 yavdr1 vdr: [1116] recording to '/srv/vdr/video.00/Video-Archiv/
Temp/Berlin_direkt/2012-04-29.19.10.102-0.rec/00001.ts'
Apr 29 19:10:32 yavdr1 vdr: [8170] recording thread started (pid=1116, tid=8170)
Apr 29 19:10:32 yavdr1 vdr: [1116] markad: executing "/usr/bin"/markad -l "/var
/lib/markad" --online=2 before "/srv/vdr/video.00/Video-Archiv/Temp/Berlin_direk
t/2012-04-29.19.10.102-0.rec"
Apr 29 19:10:32 yavdr1 markad: [8172] starting v0.1.3 (64bit)
Apr 29 19:10:32 yavdr1 markad: [8172] on /media/Video-Archiv/Temp/Berlin_direkt/
2012-04-29.19.10.102-0.rec
|
Keinerlei Fehlermeldungen, keine Pufferüberläufe (obwohl markad ja auch noch dazwischenfunkt).
Zweite Aufnahme überlappend/parallel dazu:
|
Source code
|
1
2
3
4
5
6
7
|
Apr 29 19:19:58 yavdr1 vdr: [1451] channel 101 (Das Erste HD) event Son 29.04.2012 19:20-20:00 (VPS: 29.04 19:20) 'Weltspiegel' status 2
Apr 29 19:19:59 yavdr1 vdr: [1116] switching device 1 to channel 101
Apr 29 19:19:59 yavdr1 vdr: [1116] timer 46 (101 1920-2000 VPS 'Video-Archiv~Temp~Weltspiegel~Auslandskorrespondenten berichten - Moderation: Ute Brucker') start
<...>
Apr 29 19:19:59 yavdr1 vdr: [1116] recording to '/srv/vdr/video.00/Video-Archiv/Temp/Weltspiegel/Auslandskorrespondenten_berichten_-_Moderation:_Ute_Brucker/2012-04-29.19.20.101-0.rec/00001.ts'
Apr 29 19:19:59 yavdr1 vdr: [8207] recording thread started (pid=1116, tid=8207)
Apr 29 19:19:59 yavdr1 vdr: [1116] markad: no logo found for Video-Archiv~Temp~Weltspiegel~Auslandskorrespondenten berichten - Moderation: Ute Brucker
|
Einige Minuten lang keine besonderen Vorkommnisse, dann funkt versehentlich ein Autotimer dazwischen (allerdings nicht in HD und nur auf lokale Platte), und siehe da:
|
Source code
|
1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
|
Apr 29 19:25:07 yavdr1 vdr: [1116] timer 10 (22 1930-2000 VPS 'Bauerfeind') entered VPS margin
Apr 29 19:25:07 yavdr1 vdr: [1116] switching device 4 to channel 22
Apr 29 19:25:08 yavdr1 vdr: [7640] buffer usage: 70% (tid=8170)
Apr 29 19:25:08 yavdr1 vdr: [7640] buffer usage: 70% (tid=8207)
Apr 29 19:25:09 yavdr1 vdr: [7640] buffer usage: 80% (tid=8170)
Apr 29 19:25:09 yavdr1 vdr: [7640] buffer usage: 80% (tid=8207)
<... ca 30 sec mit 60%-90%-Meldungen ...>
pr 29 19:25:39 yavdr1 vdr: [7640] buffer usage: 90% (tid=8207)
Apr 29 19:25:39 yavdr1 vdr: [7640] buffer usage: 100% (tid=8170)
Apr 29 19:25:39 yavdr1 vdr: [7640] ERROR: 1 ring buffer overflow (1 bytes dropped)
Apr 29 19:25:39 yavdr1 vdr: [7640] buffer usage: 100% (tid=8207)
Apr 29 19:25:39 yavdr1 vdr: [7640] ERROR: 1 ring buffer overflow (1 bytes dropped)
Apr 29 19:25:44 yavdr1 vdr: [7640] buffer usage: 60% (tid=8207)
Apr 29 19:25:44 yavdr1 vdr: [7640] buffer usage: 60% (tid=8170)
Apr 29 19:25:44 yavdr1 vdr: [8207] ERROR: skipped 187 bytes to sync on start of TS packet
Apr 29 19:25:44 yavdr1 vdr: [8170] ERROR: skipped 187 bytes to sync on start of TS packet
Apr 29 19:26:01 yavdr1 markad: [8172] broken TS in queue, skipping
Apr 29 19:26:01 yavdr1 markad: [8172] sequence error (0x17de)
|
Das Merkwürdige daran: dieser timer nimmt zu der Zeit noch gar nicht auf, sondern schaltet nur schonmal auf den passenden Kanal - könne also zufällige Koinzidenz sein (vielleicht hab ich da auch grad per FB irgendwas am vdr gemacht).
Danach fängt sich das Ganze wieder, allerdings nähert sich die erste Testaufnahme da auch schon dem Ende.
|
Source code
|
1
2
3
4
5
|
Apr 29 19:28:35 yavdr1 vdr: [1116] timer 47 (102 1910-1928 VPS 'Video-Archiv~Temp~Berlin direkt') stop
<...>
Apr 29 19:29:33 yavdr1 vdr: [1116] replay /srv/vdr/video.00/Video-Archiv/Temp/Weltspiegel/Auslandskorrespondenten_berichten_-_Moderation:_Ute_Brucker/2012-04-29.19.20.101-0.rec
<...>
Apr 29 19:29:33 yavdr1 vdr: [8240] dvbplayer thread started (pid=1116, tid=8240)
|
Bei der Wiedergabe gibt's genau einmal einen kurzen Aussetzer, entsprechend den o.g. Bufferproblemen (im Log die oben schon auftauchenden "skipped 187 Bytes to sync..." gefolgt von einigen "TS continuity errors").
Auf dem Server keinerlei Auffälligkeiten (top lief mit, aber ich hab nicht permanent drauf geschaut), Hauptverbraucher war samba (etwa 5-25% CPU), gefolgt von kblockd und md_d127_raid5 (meist 1-2%). IO hab ich leider nicht verfolgt.
Fazit: ich kann die Symptome zwar auch provozieren, aber bei mir deutet alles daraufhin, dass sie vom Client (vdr) verursacht werden - ist halt nur ein Atömchen, das schon bei OSD-Aktivitäten ins ruckeln kommt. BTW: Server ist auch nur ein Atom, Netz nur 100Mb, also um Hardwäre-Schwächeleien brauchen wir uns bei dir keine Gedanken zu machen. Und dass nfs mehr Probleme macht als smb, würd mich überraschen. Bleibt die Frage nach ext4 (hab grad nicht den Mut, das mal eben zu konvertieren).