vlc 1.1.0 pre2 with GPU enabled

[dany99]

I got a bug with the freebox TV when GPU is enabled. This bug happens only for (bad débit) channels. The other ones works correctly. The logs are given later.
For theses channels the video remains a green picture, but the audio sometimes works.

main debug: incoming request - stopping current input
main debug: dying input
main debug: control type=0
ts debug: eof ?
main debug: control: stopping input
main debug: thread ended
main debug: dying input
main warning: can't get output picture
avcodec warning: disabling direct rendering
main warning: can't get output picture
main debug: thread times: real 0m22.165000s, kernel 0m0.031200s, user 0m1.544409s
avcodec debug: ffmpeg codec (MPEG-1/2 Video) stopped
main debug: removing module "avcodec"
main debug: killing decoder fourcc `mpgv', 26 PES in FIFO
main debug: [0] 2 0
main debug: [1] 2 0
main debug: [2] 2 0
main debug: [3] 2 0
main debug: [4] 2 0
main debug: [5] 2 0
main debug: [6] 2 0
main debug: [7] 2 0
main debug: [8] 2 0
main debug: [9] 2 0
main debug: [10] 2 0
main debug: [11] 2 0
main debug: [12] 2 0
main debug: [13] 4 0
main debug: [14] 2 0
main debug: [15] 4 0
main debug: [16] 4 0
main debug: [17] 2 0
main debug: [18] 2 0
main debug: saving a free vout
main debug: removing module "packetizer_mpegvideo"
main warning: received buffer in the future
main debug: thread times: real 0m22.164000s, kernel 0m0.000000s, user 0m0.015600s
main debug: removing module "mpeg_audio"
main debug: killing decoder fourcc `mpga', 4 PES in FIFO
main debug: removing module "mpgatofixed32"
main debug: removing module "scaletempo"
main debug: removing module "bandlimited_resampler"
aout_directx debug: closing audio device
aout_directx debug: DirectSoundThread exiting
main debug: thread ended
main debug: thread times: real 0m22.015000s, kernel 0m0.000000s, user 0m0.000000s
main debug: removing module "aout_directx"
main debug: removing module "audio_format"
main debug: removing module "float32_mixer"
main debug: releasing aout
main debug: thread times: real 0m22.293000s, kernel 0m0.000000s, user 0m0.015600s
ts debug: pid list:
ts debug: - pid[0] seen
ts debug: - pid[161] seen
ts debug: - pid[1281] seen
main debug: Program doesn't contain anymore ES
ts debug: - pid[1904] seen
ts debug: - pid[8191] seen
main debug: removing module "ts"
main debug: removing module "live555"
main debug: thread ended
main debug: dead input
main debug: thread times: real 0m22.505000s, kernel 0m0.031200s, user 0m0.015600s
main debug: processing request item rtsp://mafreebox.freebox.fr/fbxtv_pub/stream?namespace=1&service=374&flavour=ld node Freebox TV skip 0
main debug: resyncing on rtsp://mafreebox.freebox.fr/fbxtv_pub/stream?namespace=1&service=374&flavour=ld
main debug: rtsp://mafreebox.freebox.fr/fbxtv_pub/stream?namespace=1&service=374&flavour=ld is at 15
main debug: starting new item
main debug: creating new input thread
main debug: Creating an input for 'rtsp://mafreebox.freebox.fr/fbxtv_pub/stream?namespace=1&service=374&flavour=ld'
main debug: thread (input) created at priority 1 (../.././src/input/input.c:214)
main debug: thread started
main debug: using timeshift granularity of 50 MiB
main debug: using timeshift path 'C:\Users\Daniel\AppData\Local\Temp'
main debug: `rtsp://mafreebox.freebox.fr/fbxtv_pub/stream?namespace=1&service=374&flavour=ld' gives access `rtsp' demux `' path `mafreebox.freebox.fr/fbxtv_pub/stream?namespace=1&service=374&flavour=ld'
main debug: creating demux: access='rtsp' demux='' path='mafreebox.freebox.fr/fbxtv_pub/stream?namespace=1&service=374&flavour=ld'
main debug: looking for access_demux module: 1 candidate
live555 debug: RTP subsession 'video/MP2T'
qt4 debug: IM: Deleting the input
qt4 debug: Qt: Entering Fullscreen
main debug: TIMER input launching for 'rtsp://mafreebox.freebox.fr/fbxtv_pub/stream?namespace=1&service=374&flavour=sd' : 64.000 ms - Total 64.000 ms / 1 intvls (Avg 64.000 ms)
qt4 debug: IM: Setting an input
main debug: thread (stream out) created at priority 1 (../.././src/input/stream_demux.c:100)
live555 debug: setup start: 0.000000 stop:0.000000
main debug: thread started
main debug: creating demux: access='' demux='ts' path=''
live555 debug: play start: 0.000000 stop:0.000000
main debug: using access_demux module "live555"
main debug: TIMER module_need() : 53.000 ms - Total 53.000 ms / 1 intvls (Avg 53.000 ms)
main debug: looking for meta reader module: 2 candidates
lua debug: Trying Lua scripts in C:\Users\Daniel\AppData\Roaming\vlc\lua\meta\reader
lua debug: Trying Lua scripts in C:\Program Files\VideoLAN\VLC\lua\meta\reader
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\reader\filename.lua
main debug: no meta reader module matching "any" could be loaded
main debug: TIMER module_need() : 3.000 ms - Total 3.000 ms / 1 intvls (Avg 3.000 ms)
main debug: `rtsp://mafreebox.freebox.fr/fbxtv_pub/stream?namespace=1&service=374&flavour=ld' successfully opened
main debug: looking for demux module: 1 candidate
main debug: using demux module "ts"
main debug: TIMER module_need() : 1.000 ms - Total 1.000 ms / 1 intvls (Avg 1.000 ms)
ts debug: DEMUX_SET_GROUP -1 00000000
ts debug: pid[68] unknown
ts debug: pid[69] unknown
ts debug: pid[256] unknown
ts debug: PATCallBack called
ts debug: new PAT ts_id=711 version=2 current_next=1
ts debug: * number=1 pid=256
ts debug: PMTCallBack called
ts debug: new PMT program number=1 version=1 pid_pcr=68
ts debug: * es pid=68 type=27 dr->i_tag=0x28
ts debug: * es pid=68 type=27 fcc=h264
main debug: selecting program id=1
main debug: looking for decoder module: 33 candidates
avcodec debug: libavcodec already initialized
avcodec debug: trying to use direct rendering
avcodec debug: ffmpeg codec (H264 - MPEG-4 AVC (part 10)) started
main debug: using decoder module "avcodec"
main debug: TIMER module_need() : 2.000 ms - Total 2.000 ms / 1 intvls (Avg 2.000 ms)
main debug: looking for packetizer module: 21 candidates
main debug: using packetizer module "packetizer_h264"
main debug: TIMER module_need() : 0.000 ms - Total 0.000 ms / 1 intvls (Avg 0.000 ms)
main debug: thread (decoder) created at priority 0 (../.././src/input/decoder.c:301)
main debug: thread started
ts error: MPEG-4 descriptor not found
ts debug: * es pid=69 type=15 fcc=mp4a
main debug: looking for decoder module: 33 candidates
main debug: using decoder module "faad"
main debug: TIMER module_need() : 1.000 ms - Total 1.000 ms / 1 intvls (Avg 1.000 ms)
main debug: looking for packetizer module: 21 candidates
packetizer_mpeg4audio debug: running MPEG4 audio packetizer
packetizer_mpeg4audio debug: no decoder specific info, must be an ADTS or LOAS stream
main debug: using packetizer module "packetizer_mpeg4audio"
main debug: TIMER module_need() : 0.000 ms - Total 0.000 ms / 1 intvls (Avg 0.000 ms)
main debug: thread (decoder) created at priority 2 (../.././src/input/decoder.c:301)
main debug: thread started
main debug: Buffering 0%
ts warning: first packet for pid=69 cc=0xf
main debug: Buffering 2%
packetizer_h264 warning: waiting for SPS/PPS
main debug: Buffering 4%
main debug: Buffering 6%
packetizer_h264 warning: waiting for SPS/PPS
main debug: Buffering 8%
packetizer_mpeg4audio debug: detected ADTS format
packetizer_mpeg4audio info: AAC channels: 2 samplerate: 24000
faad warning: decoded zero sample
main debug: Buffering 10%
packetizer_h264 warning: waiting for SPS/PPS
main debug: Buffering 12%
packetizer_h264 warning: waiting for SPS/PPS
packetizer_h264 warning: waiting for SPS/PPS
main debug: Buffering 14%
main debug: Buffering 16%
faad debug: AAC SBR (channels: 2, samplerate: 48000)
main debug: reusing aout
main debug: looking for audio output module: 4 candidates
aout_directx debug: Opening DirectSound Audio Output
aout_directx debug: found device: Périphérique audio principal
aout_directx debug: found device: Haut-parleurs (Realtek HD Audio (With EDS))
aout_directx debug: device supports 2 channels (DEFAULT!)
aout_directx debug: device supports 1 channel
aout_directx debug: Windows says your SpeakerConfig is stereo
aout_directx debug: creating DirectSoundThread
main debug: thread (DirectSound Notification Thread) created at priority 15 (../../.././modules/audio_output/directx.c:321)
main debug: thread started
main debug: using audio output module "aout_directx"
aout_directx debug: DirectSoundThread ready
main debug: TIMER module_need() : 16.000 ms - Total 16.000 ms / 1 intvls (Avg 16.000 ms)
main debug: output 's16l' 48000 Hz Stereo frame=1 samples/4 bytes
main debug: mixer 'f32l' 48000 Hz Stereo frame=1 samples/8 bytes
main debug: filter(s) 'f32l'->'s16l' 48000 Hz->48000 Hz Stereo->Stereo
main debug: looking for audio filter module: 14 candidates
audio_format debug: f32l->s16l, bits per sample: 32->16
main debug: using audio filter module "audio_format"
main debug: TIMER module_need() : 0.000 ms - Total 0.000 ms / 1 intvls (Avg 0.000 ms)
main debug: found a filter for the whole conversion
main debug: looking for audio mixer module: 3 candidates
main debug: using audio mixer module "float32_mixer"
main debug: TIMER module_need() : 0.000 ms - Total 0.000 ms / 1 intvls (Avg 0.000 ms)
main debug: input 'f32l' 48000 Hz Stereo frame=1 samples/8 bytes
main debug: looking for audio filter module: 1 candidate
scaletempo debug: format: 48000 rate, 2 nch, 4 bps, fl32
scaletempo debug: params: 30 stride, 0.200 overlap, 14 search
scaletempo debug: 1.000 scale, 1440.000 stride_in, 1440 stride_out, 1152 standing, 288 overlap, 672 search, 2400 queue, fl32 mode
main debug: using audio filter module "scaletempo"
main debug: TIMER module_need() : 0.000 ms - Total 0.000 ms / 1 intvls (Avg 0.000 ms)
main debug: filter(s) 'f32l'->'f32l' 52800 Hz->48000 Hz Stereo->Stereo
main debug: looking for audio filter module: 14 candidates
bandlimited_resampler debug: f32l/52800KHz/2->f32l/48000KHz/2
main debug: using audio filter module "bandlimited_resampler"
main debug: TIMER module_need() : 0.000 ms - Total 0.000 ms / 1 intvls (Avg 0.000 ms)
main debug: found a filter for the whole conversion
main debug: End of audio preroll
main debug: Buffering 18%
packetizer_h264 warning: waiting for SPS/PPS
main debug: Buffering 21%
packetizer_h264 warning: waiting for SPS/PPS
main debug: Buffering 23%
packetizer_h264 warning: waiting for SPS/PPS
packetizer_h264 warning: waiting for SPS/PPS
main debug: Buffering 25%
main debug: Buffering 27%
main debug: Buffering 29%
packetizer_h264 warning: waiting for SPS/PPS
main debug: Buffering 31%
packetizer_h264 warning: waiting for SPS/PPS
main debug: Buffering 33%
main debug: Buffering 35%
main debug: Buffering 37%
main debug: Buffering 39%
main debug: Buffering 41%
main debug: Buffering 43%
main debug: Buffering 45%
packetizer_h264 warning: waiting for SPS/PPS
packetizer_h264 debug: found NAL_SPS (sps_id=0)
packetizer_h264 debug: found NAL_PPS (pps_id=0 sps_id=0)
main debug: Buffering 47%
avcodec debug: Available decoder output format 61 (PIX_FMT_DXVA2_VLD)
avcodec debug: Trying DXVA2
avcodec debug: DLLs loaded
main debug: Buffering 50%
main debug: Buffering 52%
main debug: Buffering 54%
main debug: Buffering 56%
main debug: Buffering 58%
main debug: Buffering 60%
main debug: Buffering 62%
main debug: Buffering 64%
main debug: Buffering 66%
main debug: Buffering 68%
main debug: Buffering 70%
main debug: Buffering 73%
main debug: Buffering 75%
main debug: Buffering 77%
main debug: Buffering 79%
main debug: Buffering 81%
main debug: Buffering 83%
main debug: Buffering 85%
main debug: Buffering 87%
main debug: Buffering 89%
main debug: Buffering 91%
main debug: Buffering 94%
main debug: Buffering 96%
main debug: Buffering 98%
main debug: Stream buffering done (1204 ms in 1207 ms)
avcodec debug: D3dCreateDevice succeed
avcodec debug: OurDirect3DCreateDeviceManager9 Success!
avcodec info: obtained IDirect3DDeviceManager9
avcodec info: DXVA2CreateVideoService Success!
avcodec debug: - 'DXVA2_ModeMPEG2_IDCT' is supported by hardware
avcodec warning: - Unknown GUID = BB0796AE-2ed4-468d-XXXX
avcodec warning: - Unknown GUID = B1A56F6C-2e7f-432f-XXXX
avcodec debug: - 'H.264 VLD, no FGT' is supported by hardware
avcodec warning: - Unknown GUID = 0184C6D4-f80c-4299-XXXX
avcodec debug: - 'VC-1 VLD' is supported by hardware
avcodec warning: - Unknown GUID = 51911E1A-9fad-424e-XXXX
avcodec warning: - Unknown GUID = 5B23D46D-fa5f-4fdc-XXXX
avcodec debug: Trying to use 'H.264 VLD, no FGT' as input
avcodec debug: NV12 is supported for output
avcodec debug: Using 'H.264 VLD, no FGT' to decode to 'NV12'
avcodec debug: DxCreateVideoDecoder id 28 544x576
avcodec debug: IDirectXVideoAccelerationService_CreateSurface succeed with 17 surfaces (544x576)
avcodec debug: we got 2 decoder configurations
avcodec debug: configuration[0] ConfigBitstreamRaw 2
avcodec debug: configuration[1] ConfigBitstreamRaw 0
avcodec debug: IDirectXVideoDecoderService_CreateVideoDecoder succeed
avcodec info: Using DXVA2 (ATI Mobility Radeon HD 2400 , vendor 4098(ATI), device 38089, revision 0) for hardware decoding.
main debug: trying to reuse free vout
main debug: Filter 065e5090 removed from chain
main debug: removing module "deinterlace"
direct3d debug: Direct3D scene released successfully
direct3d debug: DirectXEventThread terminating
direct3d debug: DirectXCloseWindow
direct3d debug: WinProc WM_DESTROY
qt4 debug: releasing video...
qt4 debug: Video is not needed anymore
main debug: removing module "qt4"
main debug: removing module "direct3d"
main debug: removing module "vout_wrapper"
main debug: no usable vout present, spawning one
main debug: looking for text renderer module: 2 candidates
freetype debug: Building font database.
freetype debug: Finished building font database.
freetype debug: Took 0 microseconds
freetype debug: Using Arial as font from file C:/Windows/fonts/arial.ttf
freetype debug: using fontsize: 2
main debug: using text renderer module "freetype"
main debug: TIMER module_need() : 8.000 ms - Total 8.000 ms / 1 intvls (Avg 8.000 ms)
main debug: looking for video filter2 module: 18 candidates
swscale debug: 32x32 chroma: YUVA -> 16x16 chroma: YUVA with scaling using Bicubic (good quality)
main debug: using video filter2 module "swscale"
main debug: TIMER module_need() : 3.000 ms - Total 3.000 ms / 1 intvls (Avg 3.000 ms)
main debug: looking for video filter2 module: 18 candidates
yuvp debug: YUVP to YUVA converter
main debug: using video filter2 module "yuvp"
main debug: TIMER module_need() : 1.000 ms - Total 1.000 ms / 1 intvls (Avg 1.000 ms)
main debug: window size: 768x576
main debug: Deinterlacing available
main debug: deinterlace 1, mode blend, is_needed 0
main debug: looking for video output module: 1 candidate
vout_wrapper debug: Opening vout display wrapper
main debug: looking for vout display module: 8 candidates
direct3d debug: creating Vout EventThread
direct3d debug: DirectXCreateWindow
main debug: looking for vout window hwnd module: 3 candidates
qt4 debug: requesting video...
qt4 debug: Video was requested 0, 0
main debug: using vout window hwnd module "qt4"
main debug: TIMER module_need() : 97.000 ms - Total 97.000 ms / 1 intvls (Avg 97.000 ms)
direct3d debug: created video sub-window
direct3d debug: Vout EventThread running
direct3d debug: disabling screen saver
main debug: VoutDisplayEvent 'resize' 784x612 window
direct3d warning: trying surface pixel format: YV12
direct3d debug: selected surface pixel format is YV12
direct3d debug: Direct3D scene created successfully
direct3d debug: Direct3D device adapter successfully initialized
main debug: using vout display module "direct3d"
main debug: TIMER module_need() : 739.000 ms - Total 739.000 ms / 1 intvls (Avg 739.000 ms)
main debug: using video output module "vout_wrapper"
main debug: TIMER module_need() : 740.000 ms - Total 740.000 ms / 1 intvls (Avg 740.000 ms)
main debug: got 1 direct buffer(s)
main debug: pic render sz 544x576, of (0,0), vsz 544x576, 4cc YV12, sar 24:17, msk r0x0 g0x0 b0x0
main debug: pic in sz 544x576, of (0,0), vsz 544x576, 4cc YV12, sar 24:17, msk r0x0 g0x0 b0x0
main debug: pic out sz 544x576, of (0,0), vsz 544x576, 4cc YV12, sar 24:17, msk r0x0 g0x0 b0x0
main debug: direct render, mapping render pictures 0-18 to system pictures 1-19
main debug: VoutDisplayEvent 'resize' 768x576 window
main debug: looking for video filter2 module: 1 candidate
deinterlace debug: using blend deinterlace method
deinterlace debug: deinterlacing
main debug: using video filter2 module "deinterlace"
main debug: TIMER module_need() : 1.000 ms - Total 1.000 ms / 1 intvls (Avg 1.000 ms)
main debug: Filter 'deinterlace' (065e6ad0) appended to chain
main debug: End of video preroll
main debug: Received first picture
freetype debug: using fontsize: 36
main debug: looking for video blending module: 1 candidate
blend debug: chroma: YUVA -> YV12
main debug: using video blending module "blend"
main debug: TIMER module_need() : 0.000 ms - Total 0.000 ms / 1 intvls (Avg 0.000 ms)
main debug: Post-processing available
main debug: Detected interlaced video
main debug: deinterlace 1, mode blend, is_needed 1
main debug: Filter 065e6ad0 removed from chain
main debug: removing module "deinterlace"
main debug: looking for video filter2 module: 1 candidate
deinterlace debug: using blend deinterlace method
deinterlace debug: deinterlacing
main debug: using video filter2 module "deinterlace"
main debug: TIMER module_need() : 0.000 ms - Total 0.000 ms / 1 intvls (Avg 0.000 ms)
main debug: Filter 'deinterlace' (065e6ad0) appended to chain
main warning: vlc_object_find_name(postproc) is not safe!
qt4 debug: Qt: Entering Fullscreen
main debug: Decoder buffering done in 1061 ms
main warning: PTS is out of range (491062), dropping buffer
main warning: PTS is out of range (449395), dropping buffer
main warning: PTS is out of range (406728), dropping buffer
main warning: PTS is out of range (365062), dropping buffer
main warning: PTS is out of range (323395), dropping buffer
main warning: PTS is out of range (280728), dropping buffer
main warning: PTS is out of range (239062), dropping buffer
main warning: PTS is out of range (197395), dropping buffer
main warning: PTS is out of range (154728), dropping buffer
main warning: PTS is out of range (113062), dropping buffer
main warning: PTS is out of range (70395), dropping buffer
main warning: PTS is out of range (28728), dropping buffer
main warning: PTS is out of range (-12938), dropping buffer
main warning: audio drift is too big (517694), dropping buffer
main warning: audio drift is too big (475027), dropping buffer
main warning: audio drift is too big (432361), dropping buffer
main warning: audio drift is too big (389694), dropping buffer
main warning: audio drift is too big (347027), dropping buffer
main warning: audio drift is too big (304361), dropping buffer
main warning: audio drift is too big (261694), dropping buffer
main warning: audio drift is too big (219027), dropping buffer
main warning: audio drift is too big (176361), dropping buffer
main warning: audio drift is too big (133694), dropping buffer
main warning: buffer is 91027 late, triggering upsampling
main warning: output date isn't PTS date, requesting resampling (42367)
main warning: audio drift is too big (138908), dropping buffer
main warning: resampling stopped after 20706000 usec (drift: 8899)

[Jean-Baptiste Kempf]

avcodec info: Using DXVA2 (ATI Mobility Radeon HD 2400 , vendor 4098(ATI), device 38089, revision 0) for hardware decoding.


ATI drivers are broken...