Hi,
we're suffering from continuous vdr restarts every few minutes during recording of certain programs, while this is spat into syslog:
Apr 16 20:56:26 ziggy vdr: [9916] switching device 2 to channel 7 Apr 16 20:56:26 ziggy vdr: [9916] timer 13 (7 2009-2132 'Die ProSieben M344rchenstunde~Mon 16.04.2007-20:14') start Apr 16 20:56:26 ziggy vdr: [9916] Title: 'Die ProSieben M344rchenstunde' Subtitle: '(null)' Apr 16 20:56:26 ziggy vdr: [9916] record /video0/Die_ProSieben_M344rchenstunde/Mon_16.04.2007-20:14/2007-04-16.20.09.50.99.rec Apr 16 20:56:26 ziggy vdr: [9916] recording to '/video0/Die_ProSieben_M344rchenstunde/Mon_16.04.2007-20:14/2007-04-16.20.09.50.99.rec/020.vdr' Apr 16 20:56:26 ziggy vdr: [9943] file writer thread started (pid=9916, tid=9943) Apr 16 20:56:26 ziggy vdr: [9944] recording thread started (pid=9916, tid=9944) Apr 16 20:56:26 ziggy vdr: [9945] receiver on device 2 thread started (pid=9916, tid=9945) Apr 16 20:56:26 ziggy vdr: [9946] TS buffer on device 2 thread started (pid=9916, tid=9946) Apr 16 20:56:26 ziggy vdr: [9944] cAudioRepacker(0xC0): skipped 576 bytes to sync on next audio frame Apr 16 20:56:26 ziggy vdr: [9943] ERROR: unknown picture type '6' Apr 16 20:56:27 ziggy vdr: [9936] channel 7 (ProSieben) event Mon 16.04.2007 20:14-21:21 'Die ProSieben M344rchenstunde' status 4 Apr 16 20:56:27 ziggy vdr: [9943] ERROR: unknown picture type '6' Apr 16 20:56:28 ziggy vdr: [9944] PES packet shortened to 3343 bytes (expected: 3470 bytes) Apr 16 20:56:28 ziggy vdr: [9944] cVideoRepacker: found system start code: stream seems to be scrambled or not demultiplexed Apr 16 20:56:33 ziggy vdr: [9944] PES packet shortened to 3347 bytes (expected: 3470 bytes) Apr 16 20:56:34 ziggy vdr: [9944] PES packet shortened to 3286 bytes (expected: 3470 bytes) Apr 16 20:56:35 ziggy vdr: [9944] PES packet shortened to 3372 bytes (expected: 3470 bytes) Apr 16 20:56:35 ziggy vdr: [9944] PES packet shortened to 3394 bytes (expected: 3470 bytes) Apr 16 20:56:35 ziggy vdr: [9944] PES packet shortened to 3312 bytes (expected: 3470 bytes) Apr 16 20:56:39 ziggy vdr: [9944] PES packet shortened to 3379 bytes (expected: 3470 bytes) Apr 16 20:56:39 ziggy vdr: [9944] PES packet shortened to 3390 bytes (expected: 3470 bytes) Apr 16 20:56:39 ziggy vdr: [9944] PES packet shortened to 3286 bytes (expected: 3470 bytes) Apr 16 20:56:40 ziggy vdr: [9944] PES packet shortened to 3431 bytes (expected: 3470 bytes) Apr 16 20:56:42 ziggy vdr: [9938] EPGSearch: search timer update started Apr 16 20:56:42 ziggy vdr: [9938] EPGSearch: search timer update finished Apr 16 20:56:44 ziggy vdr: [9944] PES packet shortened to 3325 bytes (expected: 3470 bytes) Apr 16 20:56:45 ziggy vdr: [9944] PES packet shortened to 3286 bytes (expected: 3470 bytes) Apr 16 20:56:49 ziggy vdr: [9944] PES packet shortened to 3394 bytes (expected: 3470 bytes) Apr 16 20:56:49 ziggy vdr: [9944] PES packet shortened to 3369 bytes (expected: 3470 bytes) Apr 16 20:56:53 ziggy vdr: [9944] PES packet shortened to 3451 bytes (expected: 3470 bytes) Apr 16 20:56:54 ziggy vdr: [9944] PES packet shortened to 3348 bytes (expected: 3470 bytes) Apr 16 20:56:57 ziggy vdr: [9944] PES packet shortened to 3374 bytes (expected: 3470 bytes) Apr 16 20:57:02 ziggy vdr: [9944] PES packet shortened to 3343 bytes (expected: 3470 bytes) Apr 16 20:57:02 ziggy vdr: [9944] PES packet shortened to 3286 bytes (expected: 3470 bytes) Apr 16 20:57:03 ziggy vdr: [9944] PES packet shortened to 3312 bytes (expected: 3470 bytes) Apr 16 20:57:04 ziggy vdr: [9944] PES packet shortened to 3463 bytes (expected: 3470 bytes) Apr 16 20:57:06 ziggy vdr: [9944] PES packet shortened to 2252 bytes (expected: 3470 bytes) Apr 16 20:57:06 ziggy vdr: [9944] PES packet shortened to 3354 bytes (expected: 3470 bytes) Apr 16 20:57:07 ziggy vdr: [9944] PES packet shortened to 3286 bytes (expected: 3470 bytes) Apr 16 20:57:08 ziggy vdr: [9944] PES packet shortened to 3451 bytes (expected: 3470 bytes) Apr 16 20:57:08 ziggy vdr: [9944] PES packet shortened to 1691 bytes (expected: 3470 bytes) Apr 16 20:57:09 ziggy vdr: [9944] PES packet shortened to 3353 bytes (expected: 3470 bytes) Apr 16 20:57:10 ziggy vdr: [9944] PES packet shortened to 3377 bytes (expected: 3470 bytes) Apr 16 20:57:11 ziggy vdr: [9944] PES packet shortened to 3385 bytes (expected: 3470 bytes) Apr 16 20:57:16 ziggy vdr: [9944] PES packet shortened to 3329 bytes (expected: 3470 bytes) Apr 16 20:57:16 ziggy vdr: [9944] PES packet shortened to 3312 bytes (expected: 3470 bytes) Apr 16 20:57:17 ziggy vdr: [9943] ERROR: unknown picture type '6' Apr 16 20:57:17 ziggy vdr: [9944] PES packet shortened to 3446 bytes (expected: 3470 bytes) Apr 16 20:57:17 ziggy vdr: [9944] PES packet shortened to 3276 bytes (expected: 3470 bytes) Apr 16 20:57:18 ziggy vdr: [9944] PES packet shortened to 3416 bytes (expected: 3470 bytes) Apr 16 20:57:18 ziggy vdr: [9944] PES packet shortened to 3453 bytes (expected: 3470 bytes) Apr 16 20:57:19 ziggy vdr: [9944] PES packet shortened to 1814 bytes (expected: 3470 bytes) Apr 16 20:57:21 ziggy vdr: [9944] PES packet shortened to 3460 bytes (expected: 3470 bytes) Apr 16 20:57:23 ziggy vdr: [9944] PES packet shortened to 3312 bytes (expected: 3470 bytes) Apr 16 20:57:23 ziggy vdr: [9944] PES packet shortened to 3312 bytes (expected: 3470 bytes) Apr 16 20:57:23 ziggy vdr: [9944] PES packet shortened to 3286 bytes (expected: 3470 bytes) Apr 16 20:57:26 ziggy vdr: [9944] PES packet shortened to 3463 bytes (expected: 3470 bytes) Apr 16 20:57:27 ziggy vdr: [9944] PES packet shortened to 3286 bytes (expected: 3470 bytes) Apr 16 20:57:28 ziggy vdr: [9944] PES packet shortened to 3441 bytes (expected: 3470 bytes) Apr 16 20:57:28 ziggy vdr: [9944] PES packet shortened to 3381 bytes (expected: 3470 bytes) Apr 16 20:57:30 ziggy vdr: [9944] PES packet shortened to 3353 bytes (expected: 3470 bytes) Apr 16 20:57:30 ziggy vdr: [9944] PES packet shortened to 3460 bytes (expected: 3470 bytes) Apr 16 20:57:32 ziggy vdr: [9944] PES packet shortened to 3378 bytes (expected: 3470 bytes) Apr 16 20:57:32 ziggy vdr: [9944] PES packet shortened to 3315 bytes (expected: 3470 bytes)
Consequently, the recording looks like this: -rw-r--r-- 1 root root 46206106 16. Apr 20:10 001.vdr -rw-r--r-- 1 root root 74572590 16. Apr 20:13 002.vdr -rw-r--r-- 1 root root 66506990 16. Apr 20:16 003.vdr -rw-r--r-- 1 root root 26305741 16. Apr 20:17 004.vdr -rw-r--r-- 1 root root 52148572 16. Apr 20:20 005.vdr -rw-r--r-- 1 root root 44534932 16. Apr 20:22 006.vdr -rw-r--r-- 1 root root 46697082 16. Apr 20:25 007.vdr -rw-r--r-- 1 root root 44775953 16. Apr 20:27 008.vdr -rw-r--r-- 1 root root 89219748 16. Apr 20:31 009.vdr -rw-r--r-- 1 root root 64450050 16. Apr 20:34 010.vdr -rw-r--r-- 1 root root 62903307 16. Apr 20:37 011.vdr -rw-r--r-- 1 root root 62823090 16. Apr 20:40 012.vdr -rw-r--r-- 1 root root 76741400 16. Apr 20:43 013.vdr -rw-r--r-- 1 root root 43414533 16. Apr 20:45 014.vdr -rw-r--r-- 1 root root 48439977 16. Apr 20:47 015.vdr -rw-r--r-- 1 root root 69417766 16. Apr 20:50 016.vdr -rw-r--r-- 1 root root 30641331 16. Apr 20:52 017.vdr -rw-r--r-- 1 root root 33559155 16. Apr 20:54 018.vdr -rw-r--r-- 1 root root 38918804 16. Apr 20:56 019.vdr -rw-r--r-- 1 root root 66729752 16. Apr 20:59 020.vdr -rw-r--r-- 1 root root 42214919 16. Apr 21:01 021.vdr -rw-r--r-- 1 root root 7577021 16. Apr 21:01 022.vdr
The signal quality looks fine. Since this problem already destroyed the "Deutschland sucht den Superstar" recording from saturday, the household peace is in danger. Any idea, whats going wrong here, is appreciated.
Sys info: openSUSE 10.2, pretty actual vdr drivers from hg server, vdr 1.46, 2 Hauppauge FF 2.1 dvb-s cards.
TIA, Pete
Hans-Peter Jansen wrote:
Hi,
we're suffering from continuous vdr restarts every few minutes during recording of certain programs, while this is spat into syslog: [...] The signal quality looks fine.
Did you check the signal quality of the second card, or just the first card? The femon plugin allows to manually switch to the second card for receiving.
Does this only happen on Pro7/Sat1/Kabel1? If yes, its most probably DECT telephone interference, in rare cases it may be related to all vertical transmissions. In any case you may want to switch to the new transponder. See http://www.vdr-portal.de/board/thread.php?threadid=60914
There may be additional side effects, for example, what channel the first card is tuned to, or whether the first card is tuned at all (recording playback), and others.
Generally, keep an eye on cables and connectors, bad connections are a common source of trouble.
Cheers,
Udo
Am Montag, 16. April 2007 21:57 schrieb Udo Richter:
Hans-Peter Jansen wrote:
Hi,
we're suffering from continuous vdr restarts every few minutes during recording of certain programs, while this is spat into syslog: [...] The signal quality looks fine.
Did you check the signal quality of the second card, or just the first card? The femon plugin allows to manually switch to the second card for receiving.
Ahh, just learned that now, but testing it with a ZDF recording leads to restarts every minute. Checking femon on #2 showed the upper stroke at 65% (slightly in yellow area), the lower at about 82%, but Video/Audio rates were zero.
Funny, I started the recording while femon was active on #2, thus vdr took #1 for the recording, and this succeeded (001.vdr). Stopped femon, stopped and restarted the recording via vdradmin, vdr took #2 for the recording as expected, and the restart loop got going again. Something is definitely wrong with #2.
This is reflected in the recording dir and the log:
Apr 17 01:13:03 ziggy vdr: [19815] switching device 2 to channel 2 Apr 17 01:13:03 ziggy vdr: [19815] timer 29 (2 0035-0230 'Kleines Fernsehspiel Dancefloor Caballeros ') start Apr 17 01:13:03 ziggy vdr: [19815] Title: 'Kleines Fernsehspiel Dancefloor Caballeros' Subtitle: 'TV -Roadmovie D/2006' Apr 17 01:13:03 ziggy vdr: [19815] record /video0/Kleines_Fernsehspiel_Dancefloor_Caballeros/2007-04 -17.00.35.99.99.rec Apr 17 01:13:03 ziggy vdr: [19815] cFileName::SetOffset: removing zero-sized file /video0/Kleines_Fe rnsehspiel_Dancefloor_Caballeros/2007-04-17.00.35.99.99.rec/002.vdr Apr 17 01:13:03 ziggy vdr: [19815] recording to '/video0/Kleines_Fernsehspiel_Dancefloor_Caballeros/ 2007-04-17.00.35.99.99.rec/002.vdr' Apr 17 01:13:03 ziggy vdr: [19831] file writer thread started (pid=19815, tid=19831) Apr 17 01:13:03 ziggy vdr: [19832] recording thread started (pid=19815, tid=19832) Apr 17 01:13:03 ziggy vdr: [19833] receiver on device 2 thread started (pid=19815, tid=19833) Apr 17 01:13:03 ziggy vdr: [19834] TS buffer on device 2 thread started (pid=19815, tid=19834) Apr 17 01:13:05 ziggy vdr: [19820] channel 2 (ZDF) event Die 17.04.2007 00:40-02:20 (VPS: 17.04 00:4 0) 'Kleines Fernsehspiel Dancefloor Caballeros' status 4 Apr 17 01:13:05 ziggy vdr: [19820] channel 13 (KiKa) event Mon 16.04.2007 21:00-06:00 (VPS: 16.04 21 :00) 'Sendeschluss' status 4 Apr 17 01:13:19 ziggy vdr: [19825] EPGSearch: search timer update started Apr 17 01:13:20 ziggy vdr: [19825] EPGSearch: search timer update finished Apr 17 01:13:34 ziggy vdr: [19831] ERROR: video data stream broken Apr 17 01:13:34 ziggy vdr: [19831] initiating emergency exit Apr 17 01:13:34 ziggy vdr: [19815] emergency exit requested - shutting down
Does this only happen on Pro7/Sat1/Kabel1? If yes, its most probably DECT telephone interference, in rare cases it may be related to all vertical transmissions. In any case you may want to switch to the new transponder. See http://www.vdr-portal.de/board/thread.php?threadid=60914
Did that, but unfortunately, it wasn't the reason :-(. But thanks for the heads up - didn't notice before.
There may be additional side effects, for example, what channel the first card is tuned to, or whether the first card is tuned at all (recording playback), and others.
Generally, keep an eye on cables and connectors, bad connections are a common source of trouble.
Will check #2 cabling tomorrow. Thanks, Udo.
Pete
Hi,
Hans-Peter Jansen wrote:
we're suffering from continuous vdr restarts every few minutes during recording of certain programs, while this is spat into syslog:
[..]
Apr 16 20:56:33 ziggy vdr: [9944] PES packet shortened to 3347 bytes (expected: 3470 bytes) Apr 16 20:56:34 ziggy vdr: [9944] PES packet shortened to 3286 bytes (expected: 3470 bytes) Apr 16 20:56:35 ziggy vdr: [9944] PES packet shortened to 3372 bytes (expected: 3470 bytes) Apr 16 20:56:35 ziggy vdr: [9944] PES packet shortened to 3394 bytes (expected: 3470 bytes)
Looks like TS packets get lost.
[..]
Sys info: openSUSE 10.2, pretty actual vdr drivers from hg server, vdr 1.46, 2 Hauppauge FF 2.1 dvb-s cards.
Most likely, the DVB drivers are to blame. Do you see any relationship between updating the drivers and the occurrence of these messages in the logfiles?
Bye.
Hi Reinhard,
Am Montag, 16. April 2007 21:57 schrieb Reinhard Nissl:
Hi,
Hans-Peter Jansen wrote:
we're suffering from continuous vdr restarts every few minutes during recording of certain programs, while this is spat into syslog:
[..]
Apr 16 20:56:33 ziggy vdr: [9944] PES packet shortened to 3347 bytes (expected: 3470 bytes) Apr 16 20:56:34 ziggy vdr: [9944] PES packet shortened to 3286 bytes (expected: 3470 bytes) Apr 16 20:56:35 ziggy vdr: [9944] PES packet shortened to 3372 bytes (expected: 3470 bytes) Apr 16 20:56:35 ziggy vdr: [9944] PES packet shortened to 3394 bytes (expected: 3470 bytes)
Looks like TS packets get lost.
[..]
Sys info: openSUSE 10.2, pretty actual vdr drivers from hg server, vdr 1.46, 2 Hauppauge FF 2.1 dvb-s cards.
Most likely, the DVB drivers are to blame. Do you see any relationship between updating the drivers and the occurrence of these messages in the logfiles?
Not really. Hmm, I thought, I had updated them lately, but they're from Feb 22 :-(. Will update soon.
One thing changed: my 15 month old son has learned to open the glass doors of the vdr cabinet, and loves to switch on/off that equipment. Thus we had to close the doors completely, which where partly open before and lock the doors which possibly raised the temperature inside vdr a bit (together with the extraordinary warm weather..). Unfortunately, the board isn't supported by lm_sensors :-(, thus I'm not sure, and the dvb cards get pretty warm anyway. Could this result in such effects?
On the old system with 1.2.6, we suffered from damaged recordings with heavy blocked pixel trash from time to time, which seemed to be fixed by update to the current stuff.
Hmm, Pete
-
Hans-Peter Jansen -
Reinhard Nissl -
Udo Richter