[vlc] Timeshifting, rtsp, freebox

[Vincent Bernat]

Hi !

vlc   seems   to  support   timeshifting   with   the  access   filter
"timeshift". I have enabled it and  tried it with a RTSP stream from a
Freebox.  No luck.  Since RTSP  can  sometimes be  streamable, I  have
enabled  the option to  force use  of timeshift  module (force  use of
timeshift module) without any change.

Should timeshift work with such a stream ?

$ vlc -v2 --access-filter timeshift --timeshift-force --timeshift-dir ~/tmp 'rtsp://mafreebox.freebox.fr/freeboxtv/stream?id=373'
vlc: /usr/lib/libtheora.so.0: no version information available (required by /usr/lib/libvlc.so.0)
VLC media player 0.8.6 Janus
[00000001] main vlc debug: checking builtin modules
[00000001] main vlc debug: checking plugin modules
[00000001] main vlc debug: loading plugins cache file /home/bernat/.vlc/cache/plugins-04041e.dat
[00000001] main vlc debug: recursively browsing `modules'
[00000001] main vlc debug: recursively browsing `/usr/lib/vlc'
[00000001] main vlc debug: recursively browsing `plugins'
[00000001] main vlc debug: module bank initialized, found 214 modules
[00000001] main vlc warning: Unable to get HAL device properties
[00000001] main vlc debug: opening config file /home/bernat/.vlc/vlcrc
[00000001] main vlc debug: CPU has capabilities 486 586 MMX 3DNow! MMXEXT SSE FPU 
[00000001] main vlc debug: looking for memcpy module: 1 candidate
[00000001] main vlc debug: using memcpy module "memcpy"
[00000279] main playlist debug: waiting for thread completion
[00000279] main playlist debug: thread 3078814640 (playlist) created at priority 0 (playlist/playlist.c:184)
[00000280] main private debug: waiting for thread completion
[00000280] main private debug: thread 3070421936 (preparser) created at priority 0 (playlist/playlist.c:210)
[00000281] main interface debug: looking for interface module: 1 candidate
[00000281] main interface debug: using interface module "hotkeys"
[00000281] main interface debug: thread 3062029232 (interface) created at priority 0 (interface/interface.c:231)
[00000283] main interface debug: looking for interface module: 1 candidate
[00000283] main interface debug: using interface module "screensaver"
[00000283] main interface debug: thread 3052403632 (interface) created at priority 0 (interface/interface.c:231)
[00000279] main playlist debug: adding playlist item `rtsp://mafreebox.freebox.fr/freeboxtv/stream?id=373' ( rtsp://mafreebox.freebox.fr/freeboxtv/stream?id=373 )
[00000285] main interface debug: looking for interface module: 5 candidates
[00000285] main interface debug: using interface module "wxwidgets"
[00000285] main interface debug: thread 3029568432 (manager) created at priority 0 (interface/interface.c:216)
[00000285] wxwidgets interface debug: Using last windows config '(-1,0,0,1152,864)(0,124,149,768,648)(1,650,29,500,300)(6,0,0,-1,150)'
[00000285] wxwidgets interface debug: id=0 p=(124,149) s=(768,648)
[00000285] wxwidgets interface debug: id=1 p=(650,29) s=(500,300)
[00000285] wxwidgets interface debug: id=6 p=(0,0) s=(-1,150)

** (.:23085): CRITICAL **: gtk_pizza_set_size: assertion `pizza != NULL' failed
[00000279] main playlist debug: nothing requested, starting
[00000279] main playlist debug: creating new input thread
[00000288] main input debug: waiting for thread completion
[00000288] main input debug: thread 3018173360 (input) created at priority 0 (input/input.c:263)
[00000288] main input debug: creating statistics handler
[00000288] main input debug: `rtsp://mafreebox.freebox.fr/freeboxtv/stream?id=373' gives access `rtsp' demux `' path `mafreebox.freebox.fr/freeboxtv/stream?id=373'
[00000288] main input debug: creating demux: access='rtsp' demux='' path='mafreebox.freebox.fr/freeboxtv/stream?id=373'
[00000290] main demuxer debug: looking for access_demux module: 1 candidate

** (.:23085): CRITICAL **: gtk_pizza_set_size: assertion `pizza != NULL' failed
Sending request: OPTIONS rtsp://mafreebox.freebox.fr/freeboxtv/stream?id=373 RTSP/1.0
CSeq: 1
User-Agent: VLC media player (LIVE555 Streaming Media v2006.07.03)


Received OPTIONS response: RTSP/1.0 200 OK
Cseq: 1
Server: fbxrtspd/1.1 Freebox minimal RTSP server
Public: DESCRIBE, SETUP, TEARDOWN, PLAY


Sending request: DESCRIBE rtsp://mafreebox.freebox.fr/freeboxtv/stream?id=373 RTSP/1.0
CSeq: 2
Accept: application/sdp
User-Agent: VLC media player (LIVE555 Streaming Media v2006.07.03)


Received DESCRIBE response: RTSP/1.0 200 OK
Cseq: 2
Content-Length: 181
Content-Type: application/sdp
Content-Language: fr
Server: fbxrtspd/1.1 Freebox minimal RTSP server


Need to read 181 extra bytes
Read 181 extra bytes: v=0
o=leCDN 1162586660 1162586660 IN IP4 kapoueh.proxad.net
s=France 2
i=France 2
c=IN IP4 0.0.0.0
t=0 0
m=video 0 RTP/AVP 33
a=control:rtsp://212.27.38.253/freeboxtv/stream?id=373

[00000290] live555 demuxer debug: RTP subsession 'video/MP2T'
Sending request: SETUP rtsp://212.27.38.253/freeboxtv/stream?id=373 RTSP/1.0
CSeq: 3
Transport: RTP/AVP;unicast;client_port=33964-33965
User-Agent: VLC media player (LIVE555 Streaming Media v2006.07.03)


Received SETUP response: RTSP/1.0 200 OK
Cseq: 3
Session: ptWMxE9exAKJhgQrkdwU4dQZF3VCPb15vNISiHXF8yffEVxOZTyTXfIs8uVOvMK
Server: fbxrtspd/1.1 Freebox minimal RTSP server
Transport: RTP/AVP;unicast;mode=play;destination=192.168.116.1;client_port=33964-33965;server_port=32768-32769


Sending request: PLAY rtsp://mafreebox.freebox.fr/freeboxtv/stream?id=373 RTSP/1.0
CSeq: 4
Session: ptWMxE9exAKJhgQrkdwU4dQZF3VCPb15vNISiHXF8yffEVxOZTyTXfIs8uVOvMK
Range: npt=0.000-
User-Agent: VLC media player (LIVE555 Streaming Media v2006.07.03)


Received PLAY response: RTSP/1.0 200 OK
Cseq: 4
Session: ptWMxE9exAKJhgQrkdwU4dQZF3VCPb15vNISiHXF8yffEVxOZTyTXfIs8uVOvMK
Server: fbxrtspd/1.1 Freebox minimal RTSP server


[00000293] main private debug: thread 3009178544 (stream out) created at priority 0 (input/demux.c:341)
[00000290] main demuxer debug: using access_demux module "live555"
[00000288] main input debug: `rtsp://mafreebox.freebox.fr/freeboxtv/stream?id=373' successfully opened
[00000293] main private debug: creating demux: access='' demux='ts' path=''
[00000294] main demuxer debug: looking for demux2 module: 1 candidate
[00000294] main demuxer debug: using demux2 module "ts"
[00000294] ts demuxer debug: pid[69] unknown
[00000294] ts demuxer debug: pid[68] unknown
[00000294] ts demuxer debug: pid[70] unknown
libdvbpsi error (PSI decoder): TS discontinuity (received 13, expected 0) for PID 0
[00000294] ts demuxer debug: PATCallBack called
[00000294] ts demuxer debug: new PAT ts_id=9 version=15 current_next=1
[00000294] ts demuxer debug:   * number=1 pid=66
libdvbpsi error (PSI decoder): TS discontinuity (received 13, expected 0) for PID 66
[00000294] ts demuxer debug: PMTCallBack called
[00000294] ts demuxer debug: new PMT program number=1 version=31 pid_pcr=68
[00000294] ts demuxer debug:   * es pid=69 type=3 fcc=mpga
[00000288] main input debug: selecting program id=1
[00000296] main decoder debug: looking for decoder module: 24 candidates
[00000296] main decoder debug: using decoder module "mpeg_audio"
[00000296] main decoder debug: thread 2998782896 (decoder) created at priority 0 (input/decoder.c:159)
[00000294] ts demuxer debug:   * es pid=68 type=2 fcc=mpgv
[00000311] main decoder debug: looking for decoder module: 24 candidates
[00000311] main decoder debug: using decoder module "libmpeg2"
[00000311] main decoder debug: thread 2989165488 (decoder) created at priority 0 (input/decoder.c:159)
[00000294] ts demuxer debug:   * es pid=70 type=6 dr->i_tag=0x56
[00000294] ts demuxer debug:     * EBU Teletext descriptor
[00000294] ts demuxer debug:   * es pid=70 type=6 fcc=telx
[00000294] ts demuxer warning: first packet for pid=68 cc=0xa
[00000294] ts demuxer warning: first packet for pid=70 cc=0x8
[00000294] ts demuxer warning: first packet for pid=69 cc=0xa
[00000296] mpeg_audio decoder debug: MPGA channels:2 samplerate:48000 bitrate:256
[00000296] main decoder debug: no aout present, spawning one
[00000312] main audio output debug: looking for audio output module: 3 candidates
[00000312] alsa audio output debug: opening ALSA device `default'
[00000312] main audio output debug: thread 2980707248 (aout) created at priority 0 (alsa.c:662)
[00000312] main audio output debug: using audio output module "alsa"
[00000312] main audio output debug: output 'fl32' 48000 Hz Stereo frame=1 samples/8 bytes
[00000312] main audio output debug: mixer 'fl32' 48000 Hz Stereo frame=1 samples/8 bytes
[00000312] main audio output debug: no need for any filter
[00000312] main audio output debug: looking for audio mixer module: 3 candidates
[00000312] main audio output debug: using audio mixer module "trivial_mixer"
[00000312] main audio output debug: input 'mpga' 48000 Hz Stereo frame=1152 samples/1161 bytes
[00000312] main audio output debug: filter(s) 'mpga'->'fl32' 48000 Hz->48000 Hz Stereo->Stereo
[00000315] main private debug: looking for audio filter module: 24 candidates
[00000315] main private debug: using audio filter module "mpgatofixed32"
[00000312] main audio output debug: found a filter for the whole conversion
[00000312] main audio output debug: filter(s) 'fl32'->'fl32' 52800 Hz->48000 Hz Stereo->Stereo
[00000322] main private debug: looking for audio filter module: 24 candidates
[00000322] main private debug: using audio filter module "bandlimited_resampler"
[00000312] main audio output debug: found a filter for the whole conversion
[00000311] libmpeg2 decoder debug: 720x576 (display 720,576), aspect 576000, sar 16:15, 25.000 fps
[00000311] main decoder debug: no usable vout present, spawning one
[00000324] main video output debug: window size: 768x576
[00000324] main video output debug: looking for video output module: 6 candidates
[00000325] main private debug: Registering subpicture channel, ID: 2
[00000325] main private debug: Registering subpicture channel, ID: 3
[00000325] main private debug: Registering subpicture channel, ID: 4
[00000325] main private debug: Registering subpicture channel, ID: 5
[00000324] xvideo video output debug: adaptor 0, port 99, format 0x32315659 (YV12) planar
[00000324] xvideo video output debug: Window manager supports NetWM
[00000324] xvideo video output debug: Window manager supports _NET_WM_STATE_ABOVE
[00000324] xvideo video output debug: Window manager supports _NET_WM_STATE_BELOW
[00000324] xvideo video output debug: Window manager supports _NET_WM_STATE_FULLSCREEN
[00000324] xvideo video output debug: Window manager supports _NET_WM_STATE_STAYS_ON_TOP
[00000324] main video output debug: using video output module "xvideo"
[00000324] main video output debug: waiting for thread completion
[00000324] main video output debug: got 8 direct buffer(s)
[00000324] main video output debug: picture in 720x576 (0,0,720x576), chroma I420, ar 4:3, sar 16:15
[00000324] main video output debug: picture user 720x576 (0,0,720x576), chroma I420, ar 4:3, sar 16:15
[00000324] main video output debug: picture out 720x576 (0,0,720x576), chroma I420, ar 4:3, sar 16:15
[00000324] main video output debug: direct render, mapping render pictures 0-6 to system pictures 1-7
[00000324] main video output debug: thread 2970614704 (video output) created at priority 0 (video_output/video_output.c:421)
[00000327] main private warning: dts != current_pts (2511376)
[00000327] main private warning: vout synchro warning: pts != current_date (-39978)
[00000324] main video output warning: late picture skipped (2172582)
[00000324] main video output warning: late picture skipped (1452763)
[00000324] main video output warning: late picture skipped (733507)
[00000324] main video output warning: late picture skipped (13524)
[00000324] main video output warning: late picture skipped (93624)
[00000324] main video output warning: late picture skipped (53814)
[00000324] main video output warning: late picture skipped (13832)
[00000327] main private debug: decoded 52/108 pictures
[00000324] main video output warning: late picture skipped (33020)
[00000324] main video output warning: late picture skipped (5354)
[00000288] main input debug: control type=1
[00000288] main input debug: control type=1
[00000288] main input debug: control type=1
[00000324] main video output warning: late picture skipped (3942)
[00000001] main vlc debug: removing all interfaces
[00000285] main interface debug: thread 3029568432 joined (interface/interface.c:258)
[00000285] main interface debug: removing module "wxwidgets"
[00000283] main interface debug: thread 3052403632 joined (interface/interface.c:258)
[00000283] main interface debug: removing module "screensaver"
[00000281] main interface debug: thread 3062029232 joined (interface/interface.c:258)
[00000281] main interface debug: removing module "hotkeys"
[00000001] main vlc debug: removing playlist handler
[00000280] main private debug: thread 3070421936 joined (playlist/playlist.c:247)
[00000288] main input debug: control type=0
[00000288] main input debug: control: stopping input
[00000288] main input debug: closing input
[00000294] ts demuxer debug: eof ?
[00000293] main private debug: thread 3009178544 joined (input/demux.c:366)
[00000294] ts demuxer debug: pid list:
[00000294] ts demuxer debug:   - pid[0] seen
[00000294] ts demuxer debug:   - pid[66] seen
[00000311] main decoder debug: removing module "libmpeg2"
[00000311] main decoder debug: thread 2989165488 joined (input/decoder.c:191)
[00000311] main decoder debug: killing decoder fourcc `mpgv', 39 PES in FIFO
[00000311] main decoder debug: cannot find playlist, destroying vout
[00000324] main video output debug: removing module "xvideo"
[00000324] main video output debug: thread 2970614704 joined (video_output/video_output.c:461)
[00000294] ts demuxer debug:   - pid[68] seen
[00000296] main decoder debug: removing module "mpeg_audio"
[00000296] main decoder debug: thread 2998782896 joined (input/decoder.c:191)
[00000296] main decoder debug: killing decoder fourcc `mpga', 222 PES in FIFO
[00000315] main private debug: removing module "mpgatofixed32"
[00000322] main private debug: removing module "bandlimited_resampler"
[00000312] main audio output debug: thread 2980707248 joined (alsa.c:714)
[00000312] main audio output debug: removing module "alsa"
[00000312] main audio output debug: removing module "trivial_mixer"
[00000294] ts demuxer debug:   - pid[69] seen
[00000288] main input debug: Program doesn't contain anymore ES
[00000294] ts demuxer debug:   - pid[70] seen
[00000294] ts demuxer debug:   - pid[8191] seen
[00000294] main demuxer debug: removing module "ts"
Sending request: TEARDOWN rtsp://mafreebox.freebox.fr/freeboxtv/stream?id=373 RTSP/1.0
CSeq: 5
Session: ptWMxE9exAKJhgQrkdwU4dQZF3VCPb15vNISiHXF8yffEVxOZTyTXfIs8uVOvMK
User-Agent: VLC media player (LIVE555 Streaming Media v2006.07.03)


Received TEARDOWN response: RTSP/1.0 200 OK
Cseq: 5
Server: fbxrtspd/1.1 Freebox minimal RTSP server


[00000290] main demuxer debug: removing module "live555"
[00000288] main input debug: thread 3018173360 joined (input/input.c:401)
[00000279] main playlist debug: thread 3078814640 joined (playlist/playlist.c:248)
[00000279] main playlist: stopping playback
[00000279] main playlist debug: deleting playlist item `rtsp://mafreebox.freebox.fr/freeboxtv/stream?id=373'
[00000001] main vlc debug: removing all video outputs
[00000001] main vlc debug: removing all audio outputs
[00000001] main vlc debug: removing module "memcpy"
[00000001] main vlc debug: opening config file /home/bernat/.vlc/vlcrc

-- 
BOFH excuse #192:
runaway cat on system.

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