[vdr] Problem with streamdev-cvs and subtitles

Anssi Hannula anssi.hannula at gmail.com
Wed Jul 6 19:45:34 CEST 2005


Hi!

Is anyone using subtitles (with subtitles-plugin) successfully in a 
streamdev-cvs client?

When I switch to any channel (subtitles or not), the video may stay 
black, and jnettop confirms that no data is sent to the client. Same 
thing happens with either dxr3 or xine as client's frontend. The client 
is is running in the same host as the server. I suspect some race 
condition in the plugin.

I defined DEBUG for streamdev.
Here are the log parts of both successful and unsuccessful channel 
switches (vdrstd1 is the stdout+stderr of the server, vdrstd3 is the 
stdout+stderr of the client):

-------------------------
Successful change:
-------------------------

Jul  6 19:42:49 delta vdr[30668]: switching to channel 5
Jul  6 19:42:49 delta vdr[30719]: transfer thread ended (pid=30719, 
tid=376840)
Jul  6 19:42:49 delta vdr[30668]: buffer stats: 0 (0%) used
Jul  6 19:42:49 delta vdrstd1: Killing live receiver
Jul  6 19:42:49 delta vdrstd1: Creating Receiver to respect changed pids
Jul  6 19:42:49 delta vdrstd1: OUT: |220 Pid 417 stopped|
Jul  6 19:42:49 delta vdrstd1: Killing live receiver
Jul  6 19:42:49 delta vdrstd1: Creating Receiver to respect changed pids
Jul  6 19:42:49 delta vdrstd1: OUT: |220 Pid 673 stopped|
Jul  6 19:42:49 delta vdrstd1:  * GetDevice(const cChannel*, int)
Jul  6 19:42:49 delta vdrstd1:  * -------------------------------
Jul  6 19:42:49 delta vdrstd1:  * Found following device: 0x82a5ad0 (3)
Jul  6 19:42:49 delta vdrstd1:  * NOT suspended
Jul  6 19:42:49 delta vdrstd3: SetPlayMode: 0
Jul  6 19:42:49 delta vdrstd3: SetPid, Pid=417, Type=5, On=0, used=0
Jul  6 19:42:49 delta vdrstd3: connection open
Jul  6 19:42:49 delta vdrstd3: select said nothing happened
Jul  6 19:42:49 delta vdrstd3: OUT: |DELP 417|
Jul  6 19:42:49 delta vdrstd3: ReadUntil: Served from Linebuffer: 20, 
|220 Pid 417 stopped|
Jul  6 19:42:49 delta vdrstd3: IN: |220 Pid 417 stopped|
Jul  6 19:42:49 delta vdrstd3: SetPid, Pid=673, Type=6, On=0, used=0
Jul  6 19:42:49 delta vdrstd3: connection open
Jul  6 19:42:49 delta vdrstd3: select said nothing happened
Jul  6 19:42:49 delta vdrstd3: OUT: |DELP 673|
Jul  6 19:42:49 delta vdrstd3: ReadUntil: Served from Linebuffer: 20, 
|220 Pid 673 stopped|
Jul  6 19:42:49 delta vdrstd3: IN: |220 Pid 673 stopped|
Jul  6 19:42:49 delta vdrstd3: ProvidesChannel, Channel=Subtv, Prio=0
Jul  6 19:42:49 delta vdrstd3: connection open
Jul  6 19:42:49 delta vdrstd3: select said nothing happened
Jul  6 19:42:49 delta vdrstd3: OUT: |PROV 0 T-8438-8193-97|
Jul  6 19:42:49 delta vdrstd3: ReadUntil: Served from Linebuffer: 22, 
|220 Channel available|
Jul  6 19:42:49 delta vdrstd3: IN: |220 Channel available|
Jul  6 19:42:49 delta vdrstd1: OUT: |220 Channel available|
Jul  6 19:42:49 delta vdrstd3: prov res = 1, ndr = 1
Jul  6 19:42:49 delta vdrstd3: SetPid, Pid=929, Type=7, On=0, used=0
Jul  6 19:42:49 delta vdrstd3: connection open
Jul  6 19:42:49 delta vdrstd3: select said nothing happened
Jul  6 19:42:49 delta vdrstd3: OUT: |DELP 929|
Jul  6 19:42:49 delta vdrstd3: ReadUntil: Served from Linebuffer: 20, 
|220 Pid 929 stopped|
Jul  6 19:42:49 delta vdrstd3: IN: |220 Pid 929 stopped|
Jul  6 19:42:49 delta vdrstd3: CloseDvr
Jul  6 19:42:49 delta vdrstd1: Killing live receiver
Jul  6 19:42:49 delta vdrstd1: OUT: |220 Pid 929 stopped|
Jul  6 19:42:49 delta vdr[30681]: TS buffer on device 6 thread ended 
(pid=30681, tid=163851)
Jul  6 19:42:49 delta vdr[30677]: buffer stats: 173336 (8%) used
Jul  6 19:42:49 delta vdr[30615]: buffer stats: 0 (0%) used
Jul  6 19:42:49 delta vdr[30677]: receiver on device 6 thread ended 
(pid=30677, tid=131081)
Jul  6 19:42:49 delta vdrstd3: connection open
Jul  6 19:42:49 delta vdrstd3: select said nothing happened
Jul  6 19:42:49 delta vdrstd3: OUT: |ABRT 0|
Jul  6 19:42:49 delta vdrstd3: ReadUntil: Served from Linebuffer: 27, 
|220 Data connection closed|
Jul  6 19:42:49 delta vdrstd3: IN: |220 Data connection closed|
Jul  6 19:42:49 delta vdrstd1: Desctructing Live streamer
Jul  6 19:42:49 delta vdrstd1: Desctructing streamer
Jul  6 19:42:49 delta vdrstd1: OUT: |220 Data connection closed|
Jul  6 19:42:49 delta vdr[30668]: buffer stats: 0 (0%) used
Jul  6 19:42:49 delta vdr[30668]: OSDTeletext: Did not find appropriate 
device for teletext receiver for channel Subtv, PID 865
Jul  6 19:42:49 delta vdr[30726]: transfer thread started (pid=30726, 
tid=425992)
Jul  6 19:42:49 delta vdr[30727]: receiver on device 6 thread started 
(pid=30727, tid=442377)
Jul  6 19:42:49 delta vdr[30615]: Streamdev: Setting data connection to 
10.0.0.1:32839
Jul  6 19:42:49 delta vdrstd3: SetChannelDevice Channel: Subtv, 
LiveView: false
Jul  6 19:42:49 delta vdrstd3: connection open
Jul  6 19:42:49 delta vdrstd3: select said nothing happened
Jul  6 19:42:49 delta vdrstd3: OUT: |TUNE T-8438-8193-97|
Jul  6 19:42:49 delta vdrstd3: ReadUntil: Served from Linebuffer: 18, 
|220 Channel tuned|
Jul  6 19:42:49 delta vdrstd3: IN: |220 Channel tuned|
Jul  6 19:42:49 delta vdrstd3: setchanneldevice r=1
Jul  6 19:42:49 delta vdrstd3: OpenFilter
Jul  6 19:42:49 delta last message repeated 6 times
Jul  6 19:42:49 delta vdrstd1:  * GetDevice(const cChannel*, int)
Jul  6 19:42:49 delta vdrstd3: OpenFilter
Jul  6 19:42:49 delta vdrstd3: SetPid, Pid=353, Type=5, On=1, used=1
Jul  6 19:42:49 delta vdrstd3: connection open
Jul  6 19:42:49 delta vdrstd3: select said nothing happened
Jul  6 19:42:49 delta vdrstd3: OUT: |ADDP 353|
Jul  6 19:42:49 delta vdrstd3: ReadUntil: Served from Linebuffer: 22, 
|220 Pid 353 available|
Jul  6 19:42:49 delta vdrstd3: IN: |220 Pid 353 available|
Jul  6 19:42:49 delta vdrstd3: SetPid, Pid=609, Type=6, On=1, used=1
Jul  6 19:42:49 delta vdrstd3: connection open
Jul  6 19:42:49 delta vdrstd3: select said nothing happened
Jul  6 19:42:49 delta vdrstd3: OUT: |ADDP 609|
Jul  6 19:42:49 delta vdrstd3: ReadUntil: Served from Linebuffer: 22, 
|220 Pid 609 available|
Jul  6 19:42:49 delta vdrstd3: IN: |220 Pid 609 available|
Jul  6 19:42:49 delta vdrstd3: SetPid, Pid=1121, Type=7, On=1, used=1
Jul  6 19:42:49 delta vdrstd3: connection open
Jul  6 19:42:49 delta vdrstd3: select said nothing happened
Jul  6 19:42:49 delta vdrstd3: OUT: |ADDP 1121|
Jul  6 19:42:49 delta vdrstd1:  * -------------------------------
Jul  6 19:42:49 delta vdrstd3: ReadUntil: Served from Linebuffer: 23, 
|220 Pid 1121 available|
Jul  6 19:42:49 delta vdrstd3: IN: |220 Pid 1121 available|
Jul  6 19:42:49 delta vdrstd3: ProvidesChannel, Channel=Subtv, Prio=0
Jul  6 19:42:49 delta vdrstd3: prov res = 0, ndr = 1
Jul  6 19:42:49 delta vdrstd3: OpenDvr
Jul  6 19:42:49 delta vdrstd3: CloseDvr
Jul  6 19:42:49 delta vdrstd3: connection open
Jul  6 19:42:49 delta vdrstd3: select said nothing happened
Jul  6 19:42:49 delta vdrstd3: connection open
Jul  6 19:42:49 delta vdrstd3: select said nothing happened
Jul  6 19:42:49 delta vdrstd3: OUT: |PORT 0 10,0,0,1,128,71|
Jul  6 19:42:49 delta vdrstd1:  * Found following device: 0x82a5ad0 (3)
Jul  6 19:42:49 delta vdrstd1:  * NOT suspended
Jul  6 19:42:49 delta vdrstd1: Initializing Remuxer for full channel 
transfer
Jul  6 19:42:49 delta vdrstd1: pid streaming mode
Jul  6 19:42:49 delta vdrstd1: OUT: |220 Channel tuned|
Jul  6 19:42:49 delta vdrstd1: Creating Receiver to respect changed pids
Jul  6 19:42:49 delta vdrstd1: OUT: |220 Pid 353 available|
Jul  6 19:42:49 delta vdrstd1: Killing live receiver
Jul  6 19:42:49 delta vdrstd1: Creating Receiver to respect changed pids
Jul  6 19:42:49 delta vdrstd1: OUT: |220 Pid 609 available|
Jul  6 19:42:49 delta vdrstd1: Killing live receiver
Jul  6 19:42:49 delta vdrstd1: Creating Receiver to respect changed pids
Jul  6 19:42:49 delta vdrstd1: OUT: |220 Pid 1121 available|
Jul  6 19:42:49 delta vdrstd1: start streamer
Jul  6 19:42:49 delta vdrstd3: SetPlayMode: 1
Jul  6 19:42:49 delta vdr[30729]: Text2Skin: channelInfo display update 
thread started (pid=30729, tid=475147)
Jul  6 19:42:50 delta vdr[30730]: streamdev-writer thread started 
(pid=30730, tid=294928)
Jul  6 19:42:50 delta vdr[30731]: streamdev-livestreaming thread started 
(pid=30731, tid=311313)
Jul  6 19:42:50 delta vdr[30732]: receiver on device 3 thread started 
(pid=30732, tid=327698)
Jul  6 19:42:50 delta vdr[30733]: TS buffer on device 6 thread started 
(pid=30733, tid=491532)
Jul  6 19:42:50 delta vdrstd1: LiveReceiver->Activate(1)
Jul  6 19:42:50 delta vdrstd1: activate streamer
Jul  6 19:42:50 delta vdrstd1: OUT: |220 Port command ok, data 
connection opened|
Jul  6 19:42:50 delta vdrstd1: Writer start
Jul  6 19:42:50 delta vdrstd3: ReadUntil: Served from Linebuffer: 44, 
|220 Port command ok, data connection opened|
Jul  6 19:42:50 delta vdrstd3: IN: |220 Port command ok, data connection 
opened|
Jul  6 19:42:50 delta vdrstd3: waiting
Jul  6 19:42:50 delta vdrstd3: resuming
Jul  6 19:42:50 delta vdr[30734]: TS buffer on device 3 thread started 
(pid=30734, tid=344083)
Jul  6 19:42:51 delta vdr[30726]: setting audio track to 1
Jul  6 19:42:51 delta vdrstd3: [vVMSetDigitalAudioDevice: 0


-------------------------
Unsuccessful change:
-------------------------

Jul  6 19:49:10 delta vdr[30668]: switching to channel 7
Jul  6 19:49:10 delta vdr[32281]: transfer thread ended (pid=32281, 
tid=1409032)
Jul  6 19:49:10 delta vdrstd3: SetPlayMode: 0
Jul  6 19:49:10 delta vdrstd3: SetPid, Pid=305, Type=5, On=0, used=0
Jul  6 19:49:10 delta vdrstd3: connection open
Jul  6 19:49:10 delta vdrstd3: select said nothing happened
Jul  6 19:49:10 delta vdrstd3: OUT: |DELP 305|
Jul  6 19:49:10 delta vdrstd1: Killing live receiver
Jul  6 19:49:10 delta vdrstd1: LiveReceiver->Activate(0)
Jul  6 19:49:10 delta vdr[32288]: TS buffer on device 3 thread ended 
(pid=32288, tid=3620883)
Jul  6 19:49:10 delta vdr[32287]: buffer stats: 69936 (3%) used
Jul  6 19:49:10 delta vdr[32287]: receiver on device 3 thread ended 
(pid=32287, tid=3604498)
Jul  6 19:49:10 delta vdr[32385]: receiver on device 3 thread started 
(pid=32385, tid=3670034)
Jul  6 19:49:10 delta vdr[32385]: receiver on device 3 thread ended 
(pid=32385, tid=3670034)
Jul  6 19:49:10 delta vdrstd3: ReadUntil: Served from Linebuffer: 20, 
|220 Pid 305 stopped|
Jul  6 19:49:10 delta vdrstd3: IN: |220 Pid 305 stopped|
Jul  6 19:49:10 delta vdrstd3: SetPid, Pid=561, Type=6, On=0, used=0
Jul  6 19:49:10 delta vdrstd3: connection open
Jul  6 19:49:10 delta vdrstd3: select said nothing happened
Jul  6 19:49:10 delta vdrstd3: OUT: |DELP 561|
Jul  6 19:49:10 delta vdr[30668]: buffer stats: 89864 (4%) used
Jul  6 19:49:10 delta vdr[32386]: receiver on device 3 thread started 
(pid=32386, tid=3686418)
Jul  6 19:49:10 delta vdr[32387]: TS buffer on device 3 thread started 
(pid=32387, tid=3702803)
Jul  6 19:49:10 delta vdrstd1: Creating Receiver to respect changed pids
Jul  6 19:49:10 delta vdrstd1: Attaching new receiver
Jul  6 19:49:10 delta vdrstd3: ReadUntil: Served from Linebuffer: 20, 
|220 Pid 561 stopped|
Jul  6 19:49:10 delta vdrstd3: IN: |220 Pid 561 stopped|
Jul  6 19:49:10 delta vdrstd3: ProvidesChannel, Channel=The Voice, Prio=0
Jul  6 19:49:10 delta vdrstd3: connection open
Jul  6 19:49:10 delta vdrstd3: select said nothing happened
Jul  6 19:49:10 delta vdrstd3: OUT: |PROV 0 T-8438-12289-241|
Jul  6 19:49:10 delta vdrstd3: ReadUntil: Served from Linebuffer: 22, 
|220 Channel available|
Jul  6 19:49:10 delta vdrstd3: IN: |220 Channel available|
Jul  6 19:49:10 delta vdrstd3: prov res = 1, ndr = 1
Jul  6 19:49:10 delta vdrstd3: SetPid, Pid=817, Type=8, On=0, used=0
Jul  6 19:49:10 delta vdrstd3: connection open
Jul  6 19:49:10 delta vdrstd3: select said nothing happened
Jul  6 19:49:10 delta vdrstd3: OUT: |DELP 817|
Jul  6 19:49:10 delta vdrstd1: LiveReceiver->Activate(1)
Jul  6 19:49:10 delta vdrstd1: OUT: |220 Pid 305 stopped|
Jul  6 19:49:10 delta vdrstd1: Killing live receiver
Jul  6 19:49:10 delta vdrstd1: LiveReceiver->Activate(0)
Jul  6 19:49:10 delta vdrstd1: Creating Receiver to respect changed pids
Jul  6 19:49:10 delta vdrstd1: Attaching new receiver
Jul  6 19:49:10 delta vdrstd1: LiveReceiver->Activate(1)
Jul  6 19:49:10 delta vdrstd1: OUT: |220 Pid 561 stopped|
Jul  6 19:49:10 delta vdrstd1:  * GetDevice(const cChannel*, int)
Jul  6 19:49:10 delta vdrstd1:  * -------------------------------
Jul  6 19:49:10 delta vdrstd1:  * Found following device: 0x82a1d98 (2)
Jul  6 19:49:10 delta vdrstd1: OUT: |220 Channel available|
Jul  6 19:49:10 delta vdrstd1: Killing live receiver
Jul  6 19:49:10 delta vdrstd1: LiveReceiver->Activate(0)
Jul  6 19:49:10 delta vdr[32387]: TS buffer on device 3 thread ended 
(pid=32387, tid=3702803)
Jul  6 19:49:10 delta vdr[32386]: buffer stats: 376 (0%) used
Jul  6 19:49:10 delta vdr[32386]: receiver on device 3 thread ended 
(pid=32386, tid=3686418)
Jul  6 19:49:10 delta vdr[32388]: receiver on device 3 thread started 
(pid=32388, tid=3719186)
Jul  6 19:49:10 delta vdr[30668]: buffer stats: 0 (0%) used
Jul  6 19:49:10 delta vdr[32389]: TS buffer on device 3 thread started 
(pid=32389, tid=3735571)
Jul  6 19:49:10 delta vdrstd1: Creating Receiver to respect changed pids
Jul  6 19:49:10 delta vdrstd1: Attaching new receiver
Jul  6 19:49:10 delta vdrstd1: LiveReceiver->Activate(1)
Jul  6 19:49:10 delta vdrstd1: OUT: |220 Pid 817 stopped|
Jul  6 19:49:10 delta vdrstd1:  * GetDevice(const cChannel*, int)
Jul  6 19:49:10 delta vdrstd1:  * -------------------------------
Jul  6 19:49:10 delta vdrstd1:  * Found following device: 0x82a1d98 (2)
Jul  6 19:49:10 delta vdrstd1: Desctructing Live streamer
Jul  6 19:49:10 delta vdrstd3: ReadUntil: Served from Linebuffer: 20, 
|220 Pid 817 stopped|
Jul  6 19:49:10 delta vdrstd3: IN: |220 Pid 817 stopped|
Jul  6 19:49:10 delta vdrstd3: SetChannelDevice Channel: The Voice, 
LiveView: false
Jul  6 19:49:10 delta vdrstd3: connection open
Jul  6 19:49:10 delta vdrstd3: select said nothing happened
Jul  6 19:49:10 delta vdrstd3: OUT: |TUNE T-8438-12289-241|
Jul  6 19:49:10 delta vdr[30731]: streamdev-livestreaming thread ended 
(pid=30731, tid=311313)
Jul  6 19:49:10 delta vdrstd1: stopping streamer
Jul  6 19:49:10 delta vdrstd1: LiveReceiver->Activate(0)
Jul  6 19:49:10 delta vdr[32389]: TS buffer on device 3 thread ended 
(pid=32389, tid=3735571)
Jul  6 19:49:10 delta vdr[32388]: buffer stats: 376 (0%) used
Jul  6 19:49:10 delta vdr[32388]: receiver on device 3 thread ended 
(pid=32388, tid=3719186)
Jul  6 19:49:10 delta vdrstd1: destructing writer
Jul  6 19:49:10 delta vdr[30730]: streamdev-writer thread ended 
(pid=30730, tid=294928)
Jul  6 19:49:10 delta vdr[30615]: buffer stats: 71252 (1%) used
Jul  6 19:49:10 delta vdr[32390]: transfer thread started (pid=32390, 
tid=1458184)
Jul  6 19:49:10 delta vdrstd1: Max. Transmit Blocksize was: 133480
Jul  6 19:49:10 delta vdrstd1: Killing live receiver
Jul  6 19:49:10 delta vdrstd1: Desctructing streamer
Jul  6 19:49:10 delta vdrstd1: Initializing Remuxer for full channel 
transfer
Jul  6 19:49:10 delta vdrstd1: pid streaming mode
Jul  6 19:49:10 delta vdrstd1: OUT: |220 Channel tuned|
Jul  6 19:49:10 delta vdrstd1: Creating Receiver to respect changed pids
Jul  6 19:49:10 delta vdrstd1: OUT: |220 Pid 513 available|
Jul  6 19:49:10 delta vdrstd1: Killing live receiver
Jul  6 19:49:10 delta vdrstd3: ReadUntil: Served from Linebuffer: 18, 
|220 Channel tuned|
Jul  6 19:49:10 delta vdrstd3: IN: |220 Channel tuned|
Jul  6 19:49:10 delta vdrstd3: setchanneldevice r=1
Jul  6 19:49:10 delta vdrstd3: OpenFilter
Jul  6 19:49:10 delta last message repeated 7 times
Jul  6 19:49:10 delta vdrstd1: Creating Receiver to respect changed pids
Jul  6 19:49:10 delta vdrstd1: OUT: |220 Pid 660 available|
Jul  6 19:49:10 delta vdrstd3: SetPid, Pid=513, Type=5, On=1, used=1
Jul  6 19:49:10 delta vdrstd3: connection open
Jul  6 19:49:10 delta vdrstd3: select said nothing happened
Jul  6 19:49:10 delta vdrstd3: OUT: |ADDP 513|
Jul  6 19:49:10 delta vdrstd3: ReadUntil: Served from Linebuffer: 22, 
|220 Pid 513 available|
Jul  6 19:49:10 delta vdrstd3: IN: |220 Pid 513 available|
Jul  6 19:49:10 delta vdrstd3: SetPid, Pid=660, Type=6, On=1, used=1
Jul  6 19:49:10 delta vdrstd3: connection open
Jul  6 19:49:10 delta vdrstd3: select said nothing happened
Jul  6 19:49:10 delta vdrstd3: OUT: |ADDP 660|
Jul  6 19:49:10 delta vdrstd3: ReadUntil: Served from Linebuffer: 22, 
|220 Pid 660 available|
Jul  6 19:49:10 delta vdrstd3: IN: |220 Pid 660 available|
Jul  6 19:49:10 delta vdr[30668]: buffer stats: 0 (0%) used
Jul  6 19:49:10 delta vdrstd3: SetPid, Pid=1073, Type=7, On=0, used=0
Jul  6 19:49:10 delta vdrstd3: connection open
Jul  6 19:49:10 delta vdrstd3: select said nothing happened
Jul  6 19:49:10 delta vdrstd1: Killing live receiver
Jul  6 19:49:10 delta vdrstd1: Creating Receiver to respect changed pids
Jul  6 19:49:10 delta vdrstd1: OUT: |220 Pid 1073 stopped|
Jul  6 19:49:10 delta vdrstd3: OUT: |DELP 1073|
Jul  6 19:49:10 delta vdrstd3: ReadUntil: Served from Linebuffer: 21, 
|220 Pid 1073 stopped|
Jul  6 19:49:10 delta vdrstd3: IN: |220 Pid 1073 stopped|
Jul  6 19:49:10 delta vdrstd3: SetPlayMode: 1


-- 
Anssi Hannula




More information about the vdr mailing list