[vdr] Too many open files - error

Kartsa kari at kniivila.com
Mon Feb 19 21:11:37 CET 2007


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



More information about the vdr mailing list