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