I was about to test the performance of vdr when I stumbled on this message
ERROR: /dev/dvb/adapter0/demux0: Too many open files
I do not recall seeing this earlier. This came when fourth simultaneous recording started.
Is this a vdr, dvb, or firmware issue? Seems like dvb but I really do not know.
This is what was in the log after the fourth recording
Feb 19 21:53:00 vdr: [2226] timer 4 (7 2153-2200 'TestRec4') start Feb 19 21:53:00 vdr: [2226] record /srv/vdr/TestRec4/2007-02-19.21.53.50.99.rec Feb 19 21:53:00 vdr: [2226] ERROR: /dev/dvb/adapter0/demux0: Too many open files Feb 19 21:53:00 vdr: [2226] ERROR (dvbdevice.c,673): Too many open files Feb 19 21:53:00 vdr: [2226] ERROR: can't set PID 680 on device 1 Feb 19 21:53:00 vdr: [2226] ERROR (dvbdevice.c,688): Bad file descriptor Feb 19 21:53:01 vdr: [2226] timer 4 (7 2153-2200 'TestRec4') stop Feb 19 21:53:01 vdr: [2226] timer 4 (7 2153-2200 'TestRec4') start Feb 19 21:53:01 vdr: [2226] record /srv/vdr/TestRec4/2007-02-19.21.53.50.99.rec Feb 19 21:53:01 vdr: [2226] ERROR: /dev/dvb/adapter0/demux0: Too many open files Feb 19 21:53:01 vdr: [2226] ERROR (dvbdevice.c,673): Too many open files Feb 19 21:53:01 vdr: [2226] ERROR: can't set PID 680 on device 1 Feb 19 21:53:01 vdr: [2226] ERROR (dvbdevice.c,688): Bad file descriptor Feb 19 21:53:02 vdr: [2226] timer 4 (7 2153-2200 'TestRec4') stop Feb 19 21:53:03 vdr: [2226] timer 4 (7 2153-2200 'TestRec4') start Feb 19 21:53:03 vdr: [2226] record /srv/vdr/TestRec4/2007-02-19.21.53.50.99.rec Feb 19 21:53:03 vdr: [2226] ERROR: /dev/dvb/adapter0/demux0: Too many open files Feb 19 21:53:03 vdr: [2226] ERROR (dvbdevice.c,673): Too many open files Feb 19 21:53:03 vdr: [2226] ERROR: can't set PID 680 on device 1 Feb 19 21:53:03 vdr: [2226] ERROR (dvbdevice.c,688): Bad file descriptor Feb 19 21:53:04 vdr: [2226] timer 4 (7 2153-2200 'TestRec4') stop Feb 19 21:53:05 vdr: [2226] timer 4 (7 2153-2200 'TestRec4') start Feb 19 21:53:05 vdr: [2226] record /srv/vdr/TestRec4/2007-02-19.21.53.50.99.rec Feb 19 21:53:05 vdr: [2226] ERROR: /dev/dvb/adapter0/demux0: Too many open files Feb 19 21:53:05 vdr: [2226] ERROR (dvbdevice.c,673): Too many open files Feb 19 21:53:05 vdr: [2226] ERROR: can't set PID 680 on device 1 Feb 19 21:53:05 vdr: [2226] ERROR (dvbdevice.c,688): Bad file descriptor Feb 19 21:53:06 vdr: [2226] timer 4 (7 2153-2200 'TestRec4') stop Feb 19 21:53:07 vdr: [2226] timer 4 (7 2153-2200 'TestRec4') start Feb 19 21:53:07 vdr: [2226] record /srv/vdr/TestRec4/2007-02-19.21.53.50.99.rec Feb 19 21:53:07 vdr: [2226] ERROR: /dev/dvb/adapter0/demux0: Too many open files Feb 19 21:53:07 vdr: [2226] ERROR (dvbdevice.c,673): Too many open files Feb 19 21:53:07 vdr: [2226] ERROR: can't set PID 680 on device 1 Feb 19 21:53:07 vdr: [2226] ERROR (dvbdevice.c,688): Bad file descriptor Feb 19 21:53:08 vdr: [2226] timer 4 (7 2153-2200 'TestRec4') stop Feb 19 21:53:09 vdr: [2226] timer 4 (7 2153-2200 'TestRec4') start Feb 19 21:53:09 vdr: [2226] record /srv/vdr/TestRec4/2007-02-19.21.53.50.99.rec Feb 19 21:53:10 vdr: [2226] ERROR: /dev/dvb/adapter0/demux0: Too many open files Feb 19 21:53:10 vdr: [2226] ERROR (dvbdevice.c,673): Too many open files Feb 19 21:53:10 vdr: [2226] ERROR: can't set PID 680 on device 1 Feb 19 21:53:10 vdr: [2226] ERROR (dvbdevice.c,688): Bad file descriptor Feb 19 21:53:11 vdr: [2226] timer 4 (7 2153-2200 'TestRec4') stop Feb 19 21:53:12 vdr: [2226] timer 4 (7 2153-2200 'TestRec4') start Feb 19 21:53:12 vdr: [2226] record /srv/vdr/TestRec4/2007-02-19.21.53.50.99.rec Feb 19 21:53:12 kernel: dvb-ttpci: StartHWFilter error buf 0b07 0010 0101 b96a ret 0 handle ffff Feb 19 21:53:12 vdr: [2330] ERROR: can't set filter (pid=257, tid=02, mask=FF): Operation not permitted Feb 19 21:53:12 kernel: dvb-ttpci: StartHWFilter error buf 0b07 0010 0104 b96a ret 0 handle ffff Feb 19 21:53:12 vdr: [2330] ERROR: can't set filter (pid=260, tid=02, mask=FF): Operation not permitted Feb 19 21:53:12 vdr: [2330] ERROR: can't set filter (pid=263, tid=02, mask=FF): Device or resource busy Feb 19 21:53:13 vdr: [2330] ERROR: can't set filter (pid=261, tid=02, mask=FF): Device or resource busy Feb 19 21:53:13 vdr: [2330] ERROR: can't set filter (pid=266, tid=02, mask=FF): Device or resource busy Feb 19 21:53:13 vdr: [2330] ERROR: can't set filter (pid=257, tid=02, mask=FF): Device or resource busy a lot of these same lines here just the pid changes Feb 19 21:54:00 vdr: [2226] ERROR: can't set filter (pid=16, tid=40, mask=FF): Device or resource busy Feb 19 21:54:00 vdr: [2226] ERROR: can't set filter (pid=0, tid=00, mask=FF): Device or resource busy Feb 19 21:54:00 vdr: [2226] ERROR (dvbdevice.c,683): Device or resource busy Feb 19 21:54:00 vdr: [2226] ERROR: can't set PID 2321 on device 1 Feb 19 21:54:00 vdr: [2226] timer 5 (8 2154-2200 'TestRec5') start Feb 19 21:54:00 vdr: [2226] record /srv/vdr/TestRec5/2007-02-19.21.54.50.99.rec Feb 19 21:55:48 vdr: [2726] cAudioRepacker(0xC1): skipped 488 bytes to sync on next audio frame Feb 19 21:57:29 vdr: [2749] cAudioRepacker(0xC0): skipped 296 bytes to sync on next audio frame Feb 19 21:57:36 vdr: [2734] cAudioRepacker(0xC0): skipped 488 bytes to sync on next audio frame Feb 19 21:57:36 vdr: [2737] ERROR: unknown picture type '4' Feb 19 21:57:36 vdr: [2749] cAudioRepacker(0xC1): skipped 296 bytes to sync on next audio frame Feb 19 21:57:36 vdr: [2738] cAudioRepacker(0xC0): skipped 488 bytes to sync on next audio frame Feb 19 21:57:36 vdr: [2753] cAudioRepacker(0xC0): skipped 488 bytes to sync on next audio frame Feb 19 21:57:36 vdr: [2749] cAudioRepacker(0xC3): skipped 432 bytes to sync on next audio frame Feb 19 22:00:00 vdr: [2226] timer 1 (1 2150-2200 'TestRec1') stop Feb 19 22:00:00 vdr: [2226] timer 2 (2 2151-2200 'TestRec2') stop Feb 19 22:00:00 vdr: [2226] timer 3 (6 2152-2200 'TestRec3') stop Feb 19 22:00:00 vdr: [2226] timer 4 (7 2153-2200 'TestRec4') stop Feb 19 22:00:01 vdr: [2226] timer 5 (8 2154-2200 'TestRec5') stop Feb 19 22:01:29 vdr: [2226] deleting timer 1 (1 2150-2200 'TestRec1') Feb 19 22:01:29 vdr: [2226] deleting timer 1 (2 2151-2200 'TestRec2') Feb 19 22:01:29 vdr: [2226] deleting timer 1 (6 2152-2200 'TestRec3') Feb 19 22:01:29 vdr: [2226] deleting timer 1 (7 2153-2200 'TestRec4') Feb 19 22:01:29 vdr: [2226] deleting timer 1 (8 2154-2200 'TestRec5') And then it calms down.
And the testrec4 has been recorded on the disk.
\Kartsa