[vlc-devel] Re: Multicast udp streaming from playlist - problems

Dermot McGahon dermot at dspsrv.com
Thu Oct 14 10:25:16 CEST 2004 

On Thu, 2 Sep 2004 16:35:47 +0200, Gildas Bazin <gbazin at altern.org> wrote:

> On Thursday 02 September 2004 15:52, Derk-Jan Hartman wrote:
>> On 02 sep 2004, at 13:57, Dermot McGahon wrote:
[-]
>> first is because of an unimplemented StreamControl, not sure which one
>> though..
>> second one i don't really understand.. It seems almost like the buffer
>> is never emptied??
>>
>
> Yes, it seems like it. Don't know why either.
> You can activate some debug messages though. In src/input/demux.c,  
> uncomment
> the msg_Dbg() from DStreamRead() and DStreamPeek() and send the logs  
> again.

Hi Gildas/Derk-Jan,


New log at:

http://www.bqbsoftware.ie/vod_1310_extra_debug.log

Apologies for the delay. A reminder of what is happening. I've modified
LIVE.COM so that it speaks Kasenna. I was testing with vlc 0.7.2 and had
some problems so moved to testing with vlc-trunk. I've updated regularly,
this log is from yesterday's SVN trunk.

I'm trying to do two things:

(1) UDP multicast mpeg2-ts reception (from a streaming TV server)
(2) RTSP/UDP unicast mpeg2-ts reception (from a Kasenna VOD server)

The UDP multicast is fairly solid with 0.7.2, but not with 0.8.2-test2. I
will post a seperate bug report about that. I have not yet tested RTSP/UDP
with 0.7.2 as I have the FC2 RPM installed which does not have LIVE.COM
support. I tried yesterday to modify the spec file and create a new rpm,
but ran into problems building from the source rpm even without
modifications. I have downloaded 0.7.2 source and will compile that
today with the modified LIVE.COM.

For 0.8.0-test2 and RTSP/UDP there seem to be some problems as shown in
the log above. Some highlights:

[00000394] main playlist debug: adding playlist item  
`rtsp://omnibase/sync_test' ( rtsp://omnibase/sync_test )
[00000397] main input debug: `rtsp://omnibase/sync_test' gives access  
`rtsp' demux `' path `omnibase/sync_test'
[00000397] main input debug: demux2_New: access='rtsp' demux=''  
path='omnibase/sync_test'

Received OPTIONS response: RTSP/1.0 200 OK
CSeq: 1
Message: OPTIONS Successful
Public: OPTIONS, DESCRIBE, SETUP, PLAY, PAUSE, SET_PARAMETER,  
GET_PARAMETER, SET_PLAYMODE, TEARDOWN
Date: Thu, 14 Oct 2004 04:39:43 GMT

** Derk-Jan -- Notice, no mention of which vod server it is in the OPTIONS  
response!

Received DESCRIBE response: RTSP/1.0 200 OK
CSeq: 2
Date: Thu, 14 Oct 2004 04:39:43 GMT
Server: Kasenna MediaBase version 7.0.1
Content-type: application/x-rtsp-mh
Content-Length: 416

** Derk-Jan -- But here is a string that can be used to set a flag.

sdp=v=0
o=NoSpacesAllowed 1 1 IN IP4 192.168.3.3
s=rtsp://omnibase/sync_test
c=IN IP4 192.168.3.3
t=0 0
a=control:*
a=range:npt=0-
m=video 1554 RAW/RAW/UDP 33
a=control:trackID=4131

** Derk-Jan -- I have changed the SDP to request port 1554 instead of 554  
:)

[00000399] main private debug: demux2_New: access='' demux='ts' path=''
[00000013] main module debug: using access_demux module "livedotcom"
[00000397] main input debug: `rtsp://omnibase/sync_test' sucessfully opened
[00000397] main input debug: control type=1
[00000399] main private debug: DStreamPeek: buffer 96068
[00000399] main private debug: DStreamPeek: wanted 613 bytes
[00000399] main private debug: DStreamPeek: buffer 101332
[00000363] main module debug: using demux2 module "ts"
[00000399] main private debug: DStreamRead: wanted 188 bytes
[00000399] main private debug: DStreamRead: buffer 101332
[00000399] main private debug: DStreamRead: read 188 buffer 101332
[00000400] ts demuxer debug: pid[0x1fff] unknown
[00000399] main private debug: DStreamRead: wanted 188 bytes
[00000399] main private debug: DStreamRead: buffer 101144

etc..

[00000399] main private debug: DStreamRead: read 188 buffer 494816
[00000399] message private warning: message queue overflowed

** Gildas -- is this a problem?

[00000399] main private debug: DStreamRead: wanted 188 bytes
[00000399] main private debug: DStreamRead: buffer 510420

etc..

[00000399] main private debug: DStreamRead: read 188 buffer 994144
[00000399] main private debug: stream_DemuxSend: realloc to 1001316
[00000399] main private debug: stream_DemuxSend: realloc to 1002632
[00000399] main private debug: stream_DemuxSend: realloc to 1003948
[00000399] main private debug: stream_DemuxSend: realloc to 1005264
[00000399] main private debug: stream_DemuxSend: realloc to 1006580
[00000399] main private debug: stream_DemuxSend: realloc to 1007896
[00000399] main private debug: stream_DemuxSend: realloc to 1009212
[00000399] main private debug: stream_DemuxSend: realloc to 1010528
[00000399] main private debug: stream_DemuxSend: realloc to 1011844
[00000399] main private debug: DStreamRead: wanted 188 bytes
[00000399] main private debug: DStreamRead: buffer 1011064
[00000399] main private debug: DStreamRead: read 188 buffer 1011064
[00000399] main private debug: stream_DemuxSend: realloc to 1013160

** Gildas -- now the reallocs start. Interspersed are successful
    DStreamRead calls.

[00000399] main private debug: stream_DemuxSend: realloc to 3046380
libdvbpsi error (PSI decoder): TS discontinuity (received 9, expected 0)
[00000399] main private debug: stream_DemuxSend: realloc to 3047696

[00000399] main private debug: stream_DemuxSend: realloc to 3062172
[00000400] ts demuxer debug: PATCallBack called
[00000399] main private debug: stream_DemuxSend: realloc to 3063488

[00000399] main private debug: stream_DemuxSend: realloc to 3079280
[00000400] ts demuxer debug: new PAT ts_id=0x1 version=0 current_next=1
[00000400] ts demuxer debug:   * number=1 pid=0x500
[00000399] main private debug: stream_DemuxSend: realloc to 3080596

[00000399] main private debug: stream_DemuxSend: realloc to 3163504
[00000400] ts demuxer debug: new PMT program number=1 version=0  
pid_pcr=0x1023
[00000399] main private debug: stream_DemuxSend: realloc to 3164820

[00000399] main private debug: stream_DemuxSend: realloc to 3180612
[00000400] ts demuxer debug:   * es pid=0x1022 type=0x3 fcc=mpga
[00000399] main private debug: stream_DemuxSend: realloc to 3181928

[00000399] main private debug: stream_DemuxSend: realloc to 3247728
[00000253] main module debug: using decoder module "mpeg_audio"
[00000401] main decoder debug: thread 1141623728 (decoder) created at  
priority 0 (src/input/decoder.c:157)

[00000399] main private debug: stream_DemuxSend: realloc to 3264836
[00000400] ts demuxer debug:   * es pid=0x1023 type=0x2 fcc=mpgv
[00000399] main private debug: stream_DemuxSend: realloc to 3266152
[00000399] main private debug: stream_DemuxSend: realloc to 3316160
[00000255] main module debug: using decoder module "libmpeg2"
[00000402] main decoder debug: thread 1153334192 (decoder) created at  
priority 0 (src/input/decoder.c:157)

[00000399] main private debug: DStreamRead: read 188 buffer 3802864
[00000401] main decoder debug: thread 1141623728: secret message triggered  
at src/misc/block.c:227 (Connection timed out)
[00000399] main private debug: stream_DemuxSend: realloc to 3804396

** Gildas -- What is this secret message about?

[00000399] main private debug: DStreamRead: wanted 188 bytes
[00000399] main private debug: stream_DemuxSend: realloc to 4998008
[00000399] main private debug: stream_DemuxSend: realloc to 4999324
[00000399] main private debug: stream_DemuxSend: realloc to 5000640
[00000399] main private error: stream_DemuxSend: buffer size > 5000000
[00000399] main private error: stream_DemuxSend: buffer size > 5000000
[00000399] main private error: stream_DemuxSend: buffer size > 5000000
[00000399] main private error: stream_DemuxSend: buffer size > 5000000
[00000399] main private error: stream_DemuxSend: buffer size > 5000000
[00000399] main private error: stream_DemuxSend: buffer size > 5000000
[00000399] main private error: stream_DemuxSend: buffer size > 5000000
[00000399] main private error: stream_DemuxSend: buffer size > 5000000
[00000399] main private error: stream_DemuxSend: buffer size > 5000000
[00000399] main private error: stream_DemuxSend: buffer size > 5000000
[00000399] main private debug: DStreamRead: buffer 5000236
[00000399] main private debug: DStreamRead: read 188 buffer 5000236

** Gildas -- buffer size goes above 5000000


Sending request: TEARDOWN rtsp://omnibase/sync_test RTSP/1.0
CSeq: 5
Session: 1097675221
User-Agent: VLC Media Player (LIVE.COM Streaming Media v2004.06.11)


Received TEARDOWN response: RTSP/1.0 200 OK
CSeq: 5
Date: Thu, 14 Oct 2004 04:40:00 GMT


[00000013] main module debug: unlocking module "livedotcom"
[00000397] main input debug: thread 1120164784 joined  
(src/input/input.c:290)
[00000394] main playlist debug: thread 1094241200 joined  
(src/playlist/playlist.c:130)
[00000394] main playlist debug: deleting playlist item  
`rtsp://omnibase/sync_test'
[00000001] main vlc debug: removing all video outputs
[00000001] main vlc debug: removing all audio outputs
[00000001] main vlc debug: removing announce handler
[00000010] main module debug: unlocking module "memcpymmxext"
[00000001] main vlc debug: saving plugins cache file  
/home/dermot/.vlc/vlcplugins



Dermot.
--

-- 
This is the vlc-devel mailing-list, see http://www.videolan.org/vlc/
To unsubscribe, please read http://developers.videolan.org/lists.html

More information about the vlc-devel mailing list