Problem streaming certain channels.

Recently a few new channels were added to my dvb-c service, of wich at least two are not playable via the xvdr plugin.

VDR-Server: ubuntu 12.04 ya-vdr stable ppa (2.0) 2.0.2-3yavdr0~0.5 xvdr-plugin: 0.9.9.git20130512-0yavdr2~precise

XBMC-Client: openelec latest stable release (ion branch) 3.2.3

Relevant channels.conf part (channel names obfuscated):

WORKING: YYYYY HD 1,YYYYYHD 1;YYY:618000:C0M256:C:6900:255=27:0;258=deu@106,259=deu@106:33:1834,9C7,1861:105:133:12:0 NOT WORKING: YYYYY HD 2,YYYYYYHD 2;YYY:522000:C0M256:C:6900:2047=27:0;2050=deu@106,2051=deu@106,2052=deu@106:32:1834,9C7,1861:267:133:6:0 NOT WORKING: YYYYY HD 3,YYYYYHD 3;YYY:530000:C0M256:C:6900:2047=27:0;2050=deu@106,2051=deu@106,2052=deu@106:32:1834,9C7,1861:277:133:13:0

Tested Playback Combinations:

Working: vlc http stream via streamdev plugin Working: XBMC http stream, using .strm file and streamdev plugin Working: XBMC vnsi plugin

NOT Working: XBMC xvdr plugin

Already reinstalled openelec and started with a fresh configuration to exclude xbmc misconfiguration.

Please advise on how to further debug the problem.

Relevant logs for NOT working channel:

VDR

Oct 19 17:15:33 gw vdr: [32247] XVDR: Client 10.0.3.12:50382 with ID 20 connected. Oct 19 17:15:33 gw vdr: [4520] XVDR: Welcome client 'XVDR Client' with protocol version '5' Oct 19 17:15:33 gw vdr: [4520] XVDR: Preferred language: eng,dos / type: 0 Oct 19 17:15:33 gw vdr: [4520] XVDR: -------------------------------------- Oct 19 17:15:33 gw vdr: [4520] XVDR: Channel streaming request: 11 - YYYYY HD 2 Oct 19 17:15:33 gw vdr: [4520] XVDR: Found available device 1 Oct 19 17:15:33 gw vdr: [4520] XVDR: Successfully switched to channel 11 - YYYYY HD 2 Oct 19 17:15:33 gw vdr: [4520] XVDR: Started streaming of channel YYYYY HD 2 (timeout 10 seconds, priority 50) Oct 19 17:15:33 gw vdr: [4522] cLiveStreamer stream processor thread started (pid=32221, tid=4522, prio=high) Oct 19 17:15:33 gw vdr: [4521] XVDR: LiveQueue started Oct 19 17:15:33 gw vdr: [4522] XVDR: returning from streamer thread, receiver is no more attached Oct 19 17:15:33 gw vdr: [4522] XVDR: sending detach message Oct 19 17:15:33 gw vdr: [4522] cLiveStreamer stream processor thread ended (pid=32221, tid=4522) Oct 19 17:15:33 gw vdr: [4521] XVDR: LiveQueue stopped Oct 19 17:15:33 gw vdr: [4520] buffer stats: 0 (0%) used Oct 19 17:15:33 gw vdr: [32247] XVDR: Client with ID 20 seems to be disconnected, removing from client list

XBMC:

17:15:09 T:140646297610048 DEBUG: CPlayerCoreFactory::GetPlayers(pvr://channels/tv/All TV channels/10.pvr) 17:15:09 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 17:15:09 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 17:15:09 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv 17:15:09 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp 17:15:09 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 17:15:09 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 17:15:09 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 17:15:09 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 17:15:09 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 17:15:09 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 17:15:09 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 17:15:09 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 17:15:09 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 17:15:09 T:140646297610048 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 17:15:09 T:140646297610048 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1) 17:15:09 T:140646297610048 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 17:15:09 T:140646297610048 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 17:15:09 T:140646297610048 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1) 17:15:09 T:140646297610048 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 17:15:09 T:140646297610048 NOTICE: DVDPlayer: Opening: pvr://channels/tv/All TV channels/10.pvr 17:15:09 T:140646297610048 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 17:15:09 T:140646297610048 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec 17:15:09 T:140646297610048 NOTICE: CXBMCRenderManager::ResetRenderBuffer - using 5 render buffers 17:15:09 T:140646297610048 DEBUG: LinuxRendererGL: Cleaning up GL resources 17:15:09 T:140646297610048 DEBUG: CLinuxRendererGL::PreInit - precision of luminance 16 is 16 17:15:09 T:140646297610048 DEBUG: DllSwScale: Using libswscale system library 17:15:09 T:140644534183680 NOTICE: Thread CDVDPlayer start, auto delete: false 17:15:09 T:140644534183680 NOTICE: Creating InputStream 17:15:09 T:140644534183680 DEBUG: PVRManager - OpenLiveStream - opening live stream on channel 'YYYYY HD 2' 17:15:09 T:140644534183680 DEBUG: opening live stream for channel 'YYYYY HD 2' 17:15:09 T:140644534183680 DEBUG: AddOnLog: VDR XVDR Client: Possible leak caused by workaround in GetLanguageCode 17:15:09 T:140644534183680 INFO: AddOnLog: VDR XVDR Client: Logged in at '1382195733+7200' to 'VDR-XVDR Server' Version: '0.9.9' with protocol version '5' 17:15:09 T:140644534183680 INFO: AddOnLog: VDR XVDR Client: Preferred Audio Language: eng 17:15:09 T:140644534183680 DEBUG: AddOnLog: VDR XVDR Client: changing to channel 1682460683 (priority 50) 17:15:09 T:140644534183680 INFO: AddOnLog: VDR XVDR Client: sucessfully switched channel 17:15:09 T:140644207032064 INFO: AddOnLog: VDR XVDR Client: received detach command. aborting session ... 17:15:09 T:140644534183680 DEBUG: PVRFile - Open - playback has started on filename pvr://channels/tv/All TV channels/10.pvr 17:15:09 T:140644534183680 DEBUG: CDVDInputStreamPVRManager::Open - stream opened: pvr://channels/tv/All TV channels/10.pvr 17:15:09 T:140644534183680 NOTICE: Creating Demuxer 17:15:09 T:140644534183680 DEBUG: DllAvCodec: Using libavcodec system library 17:15:09 T:140644534183680 DEBUG: CDVDPlayer::SetCaching - caching state 2 17:15:09 T:140644534183680 WARNING: CDVDMessageQueue(audio)::Put MSGQ_NOT_INITIALIZED 17:15:09 T:140644534183680 WARNING: CDVDMessageQueue(video)::Put MSGQ_NOT_INITIALIZED 17:15:09 T:140646297610048 DEBUG: ------ Window Init (DialogSeekBar.xml) ------ 17:15:09 T:140644534183680 DEBUG: CDVDInputStreamPVRManager::Close - stream closed 17:15:09 T:140644534183680 DEBUG: CDVDPlayer::SetCaching - caching state 0 17:15:09 T:140644534183680 NOTICE: CDVDPlayer::OnExit() 17:15:09 T:140644534183680 NOTICE: DVDPlayer: eof, waiting for queues to empty 17:15:09 T:140644534183680 NOTICE: CDVDPlayer::OnExit() deleting demuxer 17:15:09 T:140644534183680 NOTICE: CDVDPlayer::OnExit() deleting input stream 17:15:09 T:140644534183680 DEBUG: CDVDInputStreamPVRManager::Close - stream closed 17:15:09 T:140644534183680 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 17:15:09 T:140644534183680 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 17:15:09 T:140644534183680 DEBUG: Thread CDVDPlayer 140644534183680 terminating 17:15:09 T:140646297610048 DEBUG: CGUIInfoManager::SetCurrentMovie(pvr://channels/tv/All TV channels/10.pvr) 17:15:09 T:140646297610048 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 17:15:09 T:140646297610048 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 17:15:09 T:140646297610048 DEBUG: Building didl for object 'pvr://channels/tv/All TV channels/10.pvr' 17:15:09 T:140646297610048 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------ 17:15:09 T:140646297610048 NOTICE: CDVDPlayer::CloseFile() 17:15:09 T:140646297610048 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 17:15:09 T:140646297610048 NOTICE: DVDPlayer: waiting for threads to exit 17:15:09 T:140646297610048 NOTICE: DVDPlayer: finished waiting 17:15:09 T:140646297610048 DEBUG: LinuxRendererGL: Cleaning up GL resources

WORKING CHANNEL:

VDR:

Oct 19 17:15:37 gw vdr: [32247] XVDR: Client 10.0.3.12:50638 with ID 21 connected. Oct 19 17:15:37 gw vdr: [4531] XVDR: Welcome client 'XVDR Client' with protocol version '5' Oct 19 17:15:37 gw vdr: [4531] XVDR: Preferred language: eng,dos / type: 0 Oct 19 17:15:37 gw vdr: [4531] XVDR: -------------------------------------- Oct 19 17:15:37 gw vdr: [4531] XVDR: Channel streaming request: 10 - YYYYY HD 1 Oct 19 17:15:37 gw vdr: [4531] XVDR: Found available device 1 Oct 19 17:15:37 gw vdr: [4531] XVDR: Channel information found in cache Oct 19 17:15:37 gw vdr: [4532] XVDR: LiveQueue started Oct 19 17:15:37 gw vdr: [4531] XVDR: Stream: TELETEXT PID: 33 TXT (parsed: yes) Oct 19 17:15:37 gw vdr: [4531] XVDR: Stream: H264 PID: 255 1920x1080 DAR: 1.78 FPS: 25.000 (parsed: yes) Oct 19 17:15:37 gw vdr: [4531] XVDR: Stream: AC3 PID: 258 48000 Hz, 2 channels, Lang: deu (parsed: yes) Oct 19 17:15:37 gw vdr: [4531] XVDR: Stream: AC3 PID: 259 48000 Hz, 6 channels, Lang: deu (parsed: yes) Oct 19 17:15:37 gw vdr: [4531] XVDR: Successfully switched to channel 10 - YYYYY HD 1 Oct 19 17:15:37 gw vdr: [4533] receiver on device 1 thread started (pid=32221, tid=4533, prio=high) Oct 19 17:15:37 gw vdr: [4531] XVDR: Started streaming of channel YYYYY 1 (timeout 10 seconds, priority 50) Oct 19 17:15:37 gw vdr: [4534] cLiveStreamer stream processor thread started (pid=32221, tid=4534, prio=high) Oct 19 17:15:37 gw vdr: [4535] TS buffer on device 1 thread started (pid=32221, tid=4535, prio=high) Oct 19 17:15:37 gw vdr: [4534] XVDR: streaming of channel started Oct 19 17:15:37 gw vdr: [4534] XVDR: Stored channel information in cache: Oct 19 17:15:37 gw vdr: [4534] XVDR: Stream: TELETEXT PID: 33 TXT (parsed: yes) Oct 19 17:15:37 gw vdr: [4534] XVDR: Stream: H264 PID: 255 1920x1080 DAR: 1.78 FPS: 25.000 (parsed: yes) Oct 19 17:15:37 gw vdr: [4534] XVDR: Stream: AC3 PID: 258 48000 Hz, 2 channels, Lang: deu (parsed: yes) Oct 19 17:15:37 gw vdr: [4534] XVDR: Stream: AC3 PID: 259 48000 Hz, 6 channels, Lang: deu (parsed: yes) Oct 19 17:15:43 gw vdr: [4534] cLiveStreamer stream processor thread ended (pid=32221, tid=4534) Oct 19 17:15:43 gw vdr: [4532] XVDR: LiveQueue stopped Oct 19 17:15:43 gw vdr: [4531] buffer stats: 77832 (0%) used Oct 19 17:15:43 gw vdr: [4535] TS buffer on device 1 thread ended (pid=32221, tid=4535) Oct 19 17:15:43 gw vdr: [4533] buffer stats: 99828 (2%) used Oct 19 17:15:43 gw vdr: [4533] receiver on device 1 thread ended (pid=32221, tid=4533) Oct 19 17:15:43 gw vdr: [32247] XVDR: Client with ID 21 seems to be disconnected, removing from client list

XBMC:

17:15:12 T:140646297610048 DEBUG: CPlayerCoreFactory::GetPlayers(pvr://channels/tv/All TV channels/9.pvr) 17:15:12 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 17:15:12 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 17:15:12 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv 17:15:12 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/mms/udp 17:15:12 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 17:15:12 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 17:15:12 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 17:15:12 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 17:15:12 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 17:15:12 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 17:15:12 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 17:15:12 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 17:15:12 T:140646297610048 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 17:15:12 T:140646297610048 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 17:15:12 T:140646297610048 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1) 17:15:12 T:140646297610048 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 17:15:12 T:140646297610048 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 17:15:12 T:140646297610048 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1) 17:15:12 T:140646297610048 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 17:15:12 T:140646297610048 NOTICE: DVDPlayer: Opening: pvr://channels/tv/All TV channels/9.pvr 17:15:12 T:140646297610048 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 17:15:12 T:140646297610048 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec 17:15:12 T:140646297610048 NOTICE: CXBMCRenderManager::ResetRenderBuffer - using 5 render buffers 17:15:12 T:140646297610048 DEBUG: LinuxRendererGL: Cleaning up GL resources 17:15:12 T:140646297610048 DEBUG: CLinuxRendererGL::PreInit - precision of luminance 16 is 16 17:15:12 T:140646297610048 DEBUG: DllSwScale: Using libswscale system library 17:15:12 T:140644534183680 NOTICE: Thread CDVDPlayer start, auto delete: false 17:15:12 T:140644534183680 NOTICE: Creating InputStream 17:15:12 T:140644534183680 DEBUG: PVRManager - OpenLiveStream - opening live stream on channel 'YYYYY HD 1' 17:15:12 T:140644534183680 DEBUG: opening live stream for channel 'YYYYY HD 1' 17:15:12 T:140644534183680 DEBUG: AddOnLog: VDR XVDR Client: Possible leak caused by workaround in GetLanguageCode 17:15:12 T:140644534183680 INFO: AddOnLog: VDR XVDR Client: Logged in at '1382195737+7200' to 'VDR-XVDR Server' Version: '0.9.9' with protocol version '5' 17:15:12 T:140644534183680 INFO: AddOnLog: VDR XVDR Client: Preferred Audio Language: eng 17:15:12 T:140644534183680 DEBUG: AddOnLog: VDR XVDR Client: changing to channel 776359190 (priority 50) 17:15:12 T:140644534183680 INFO: AddOnLog: VDR XVDR Client: sucessfully switched channel 17:15:12 T:140644534183680 DEBUG: PVRFile - Open - playback has started on filename pvr://channels/tv/All TV channels/9.pvr 17:15:12 T:140644534183680 DEBUG: CDVDInputStreamPVRManager::Open - stream opened: pvr://channels/tv/All TV channels/9.pvr 17:15:12 T:140644534183680 NOTICE: Creating Demuxer 17:15:12 T:140644534183680 DEBUG: DllAvCodec: Using libavcodec system library 17:15:12 T:140644534183680 DEBUG: CDVDPlayer::SetCaching - caching state 2 17:15:12 T:140644534183680 WARNING: CDVDMessageQueue(audio)::Put MSGQ_NOT_INITIALIZED 17:15:12 T:140644534183680 WARNING: CDVDMessageQueue(video)::Put MSGQ_NOT_INITIALIZED 17:15:12 T:140646297610048 DEBUG: ------ Window Init (DialogSeekBar.xml) ------ 17:15:12 T:140646297610048 DEBUG: CGUIInfoManager::SetCurrentMovie(pvr://channels/tv/All TV channels/9.pvr) 17:15:12 T:140646297610048 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 17:15:12 T:140646297610048 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 17:15:12 T:140646297610048 DEBUG: Building didl for object 'pvr://channels/tv/All TV channels/9.pvr' 17:15:12 T:140646297610048 DEBUG: LIRC: Update - NEW at 276267:160 0 KEY_OK_UP devinput (KEY_OK_UP) 17:15:12 T:140644534183680 DEBUG: CDVDDemuxPVRClient::RequestStreams(): added/updated stream 0:255 with codec_id 28 17:15:12 T:140644534183680 DEBUG: CDVDDemuxPVRClient::RequestStreams(): added/updated stream 1:259 with codec_id 86019 17:15:12 T:140644534183680 DEBUG: CDVDDemuxPVRClient::RequestStreams(): added/updated stream 2:258 with codec_id 86019 17:15:12 T:140644534183680 DEBUG: CDVDDemuxPVRClient::RequestStreams(): added/updated stream 3:33 with codec_id 94215 17:15:12 T:140644534183680 NOTICE: Opening video stream: 0 source: 256 17:15:12 T:140644534183680 NOTICE: Creating video codec with codec id: 28 17:15:12 T:140644534183680 DEBUG: CDVDFactoryCodec: compiled in hardware support: CrystalHD:no OpenMax:no VDPAU:yes VAAPI:no XVBA:no 17:15:12 T:140644534183680 DEBUG: FactoryCodec - Video: - Opening 17:15:12 T:140644534183680 DEBUG: DllAvUtilBase: Using libavutil system library 17:15:12 T:140644534183680 DEBUG: DllAvCodec: Using libavcodec system library 17:15:12 T:140644534183680 DEBUG: DllSwScale: Using libswscale system library 17:15:12 T:140644534183680 DEBUG: DllAvFilter: Using libavfilter system library 17:15:12 T:140644534183680 NOTICE: CDVDVideoCodecFFmpeg::Open() Creating VDPAU(1920x1080, 28) 17:15:12 T:140644534183680 DEBUG: DllAvUtilBase: Using libavutil system library 17:15:12 T:140644534183680 NOTICE: vdp_device = 0x00000001 vdp_st = 0x00000000 17:15:12 T:140644534183680 NOTICE: VDPAU Decoder capabilities: 17:15:12 T:140644534183680 NOTICE: name level macbs width height 17:15:12 T:140644534183680 NOTICE: ------------------------------------ 17:15:12 T:140644534183680 NOTICE: MPEG1 0 8192 2048 2048 17:15:12 T:140644534183680 NOTICE: MPEG2_SIMPLE 3 8192 2048 2048 17:15:12 T:140644534183680 NOTICE: MPEG2_MAIN 3 8192 2048 2048 17:15:12 T:140644534183680 NOTICE: H264_MAIN 41 8190 2032 2048 17:15:12 T:140644534183680 NOTICE: H264_HIGH 41 8190 2032 2048 17:15:12 T:140644534183680 NOTICE: VC1_SIMPLE 1 8190 2048 2048 17:15:12 T:140644534183680 NOTICE: VC1_MAIN 2 8190 2048 2048 17:15:12 T:140644534183680 NOTICE: VC1_ADVANCED 4 8190 2048 2048 17:15:12 T:140644534183680 NOTICE: ------------------------------------ 17:15:12 T:140644534183680 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_NOISE_REDUCTION 17:15:12 T:140644534183680 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_SHARPNESS 17:15:12 T:140644534183680 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_DEINTERLACE_TEMPORAL 17:15:12 T:140644534183680 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_DEINTERLACE_TEMPORAL_SPATIAL 17:15:12 T:140644534183680 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_INVERSE_TELECINE 17:15:13 T:140644534183680 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 (VDPAU acceleration) 17:15:13 T:140644534183680 DEBUG: FactoryCodec - Video: ff-h264_vdpau-vdpau - Opened 17:15:13 T:140645867968256 NOTICE: Thread CVideoReferenceClock start, auto delete: false 17:15:13 T:140645867968256 DEBUG: CVideoReferenceClock: Setting up GLX 17:15:13 T:140645867968256 DEBUG: CVideoReferenceClock: Detected refreshrate: 50 hertz 17:15:13 T:140644534183680 NOTICE: Creating video thread 17:15:13 T:140644525790976 NOTICE: Thread CDVDPlayerVideo start, auto delete: false 17:15:13 T:140644525790976 NOTICE: running thread: video_thread 17:15:13 T:140644534183680 NOTICE: Opening audio stream: 1 source: 256 17:15:13 T:140644534183680 NOTICE: Finding audio codec for: 86019 17:15:13 T:140644534183680 DEBUG: DllAvUtilBase: Using libavutil system library 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE 17:15:13 T:140644534183680 DEBUG: FactoryCodec - Audio: passthrough - Opening 17:15:13 T:140644534183680 DEBUG: FactoryCodec - Audio: passthrough - Failed 17:15:13 T:140644534183680 DEBUG: FactoryCodec - Audio: FFmpeg - Opening 17:15:13 T:140644534183680 DEBUG: DllAvUtilBase: Using libavutil system library 17:15:13 T:140644534183680 DEBUG: DllAvCodec: Using libavcodec system library 17:15:13 T:140644534183680 DEBUG: DllAvFormat: Using libswresample system library 17:15:13 T:140644534183680 DEBUG: FactoryCodec - Audio: FFmpeg - Opened 17:15:13 T:140644534183680 NOTICE: Creating audio thread 17:15:13 T:140644542576384 NOTICE: Thread CDVDPlayerAudio start, auto delete: false 17:15:13 T:140644542576384 NOTICE: running thread: CDVDPlayerAudio::Process() 17:15:13 T:140644534183680 NOTICE: Opening teletext stream: 3 source: 256 17:15:13 T:140644534183680 NOTICE: Creating teletext data thread 17:15:13 T:140644495636224 NOTICE: Thread CDVDTeletextData start, auto delete: false 17:15:13 T:140644495636224 NOTICE: running thread: CDVDTeletextData 17:15:13 T:140644534183680 ERROR: ffmpeg[5B7FE700]: [NULL] non-existing PPS referenced 17:15:13 T:140644534183680 DEBUG: ParsePacket - {0} level changed from 0 to -99 17:15:13 T:140644534183680 NOTICE: Opening video stream: 0 source: 256 17:15:13 T:140644534183680 NOTICE: Creating video codec with codec id: 28 17:15:13 T:140644534183680 DEBUG: CDVDFactoryCodec: compiled in hardware support: CrystalHD:no OpenMax:no VDPAU:yes VAAPI:no XVBA:no 17:15:13 T:140644534183680 DEBUG: FactoryCodec - Video: - Opening 17:15:13 T:140644534183680 DEBUG: DllAvUtilBase: Using libavutil system library 17:15:13 T:140644534183680 DEBUG: DllAvCodec: Using libavcodec system library 17:15:13 T:140644534183680 DEBUG: DllSwScale: Using libswscale system library 17:15:13 T:140644534183680 DEBUG: DllAvFilter: Using libavfilter system library 17:15:13 T:140644534183680 NOTICE: CDVDVideoCodecFFmpeg::Open() Creating VDPAU(1920x1080, 28) 17:15:13 T:140644534183680 DEBUG: DllAvUtilBase: Using libavutil system library 17:15:13 T:140644534183680 NOTICE: vdp_device = 0x00000002 vdp_st = 0x00000000 17:15:13 T:140644534183680 NOTICE: VDPAU Decoder capabilities: 17:15:13 T:140644534183680 NOTICE: name level macbs width height 17:15:13 T:140644534183680 NOTICE: ------------------------------------ 17:15:13 T:140644534183680 NOTICE: MPEG1 0 8192 2048 2048 17:15:13 T:140644534183680 NOTICE: MPEG2_SIMPLE 3 8192 2048 2048 17:15:13 T:140644534183680 NOTICE: MPEG2_MAIN 3 8192 2048 2048 17:15:13 T:140644534183680 NOTICE: H264_MAIN 41 8190 2032 2048 17:15:13 T:140644534183680 NOTICE: H264_HIGH 41 8190 2032 2048 17:15:13 T:140644534183680 NOTICE: VC1_SIMPLE 1 8190 2048 2048 17:15:13 T:140644534183680 NOTICE: VC1_MAIN 2 8190 2048 2048 17:15:13 T:140644534183680 NOTICE: VC1_ADVANCED 4 8190 2048 2048 17:15:13 T:140644534183680 NOTICE: ------------------------------------ 17:15:13 T:140644534183680 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_NOISE_REDUCTION 17:15:13 T:140644534183680 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_SHARPNESS 17:15:13 T:140644534183680 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_DEINTERLACE_TEMPORAL 17:15:13 T:140644534183680 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_DEINTERLACE_TEMPORAL_SPATIAL 17:15:13 T:140644534183680 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_INVERSE_TELECINE 17:15:13 T:140644534183680 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 (VDPAU acceleration) 17:15:13 T:140644534183680 DEBUG: FactoryCodec - Video: ff-h264_vdpau-vdpau - Opened 17:15:13 T:140644525790976 NOTICE: (VDPAU) Close 17:15:13 T:140644534183680 ERROR: ffmpeg[5B7FE700]: [NULL] non-existing PPS referenced 17:15:13 T:140644534183680 ERROR: Previous line repeats 6 times. 17:15:13 T:140644534183680 DEBUG: ParsePacket - {1} level changed from 0 to -99 17:15:13 T:140644534183680 NOTICE: Opening audio stream: 1 source: 256 17:15:13 T:140644534183680 NOTICE: Finding audio codec for: 86019 17:15:13 T:140644534183680 DEBUG: DllAvUtilBase: Using libavutil system library 17:15:13 T:140644534183680 DEBUG: FactoryCodec - Audio: passthrough - Opening 17:15:13 T:140644534183680 DEBUG: FactoryCodec - Audio: passthrough - Failed 17:15:13 T:140644534183680 DEBUG: FactoryCodec - Audio: FFmpeg - Opening 17:15:13 T:140644534183680 DEBUG: DllAvUtilBase: Using libavutil system library 17:15:13 T:140644534183680 DEBUG: DllAvCodec: Using libavcodec system library 17:15:13 T:140644534183680 DEBUG: DllAvFormat: Using libswresample system library 17:15:13 T:140644534183680 DEBUG: FactoryCodec - Audio: FFmpeg - Opened 17:15:13 T:140644542576384 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(59627813456.000000, 0) 17:15:13 T:140644534183680 ERROR: ffmpeg[5B7FE700]: [NULL] non-existing PPS referenced 17:15:13 T:140644542576384 ERROR: Previous line repeats 2 times. 17:15:13 T:140644542576384 NOTICE: Creating audio stream (codec id: 86019, channels: 6, sample rate: 48000, no pass-through) 17:15:13 T:140644542576384 INFO: CSoftAE::MakeStream - AE_FMT_S16NE, 48000, FL,FR,FC,LFE,SL,SR 17:15:13 T:140644534183680 ERROR: ffmpeg[5B7FE700]: [NULL] non-existing PPS referenced 17:15:13 T:140644525790976 ERROR: Previous line repeats 2 times. 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(59628383878.000000, 1) 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] non-existing PPS 0 referenced 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] decode_slice_header error 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] no frame! 17:15:13 T:140644525790976 ERROR: Decode - avcodec_decode_video returned failure 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo - video decoder returned error 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] non-existing PPS 0 referenced 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] decode_slice_header error 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] no frame! 17:15:13 T:140644525790976 ERROR: Decode - avcodec_decode_video returned failure 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo - video decoder returned error 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] non-existing PPS 0 referenced 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] decode_slice_header error 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] no frame! 17:15:13 T:140644525790976 ERROR: Decode - avcodec_decode_video returned failure 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo - video decoder returned error 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] non-existing PPS 0 referenced 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] decode_slice_header error 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] no frame! 17:15:13 T:140644525790976 ERROR: Decode - avcodec_decode_video returned failure 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo - video decoder returned error 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] non-existing PPS 0 referenced 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] decode_slice_header error 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] no frame! 17:15:13 T:140644525790976 ERROR: Decode - avcodec_decode_video returned failure 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo - video decoder returned error 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] non-existing PPS 0 referenced 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] decode_slice_header error 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] no frame! 17:15:13 T:140644525790976 ERROR: Decode - avcodec_decode_video returned failure 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo - video decoder returned error 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] non-existing PPS 0 referenced 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] decode_slice_header error 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] no frame! 17:15:13 T:140644525790976 ERROR: Decode - avcodec_decode_video returned failure 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo - video decoder returned error 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] non-existing PPS 0 referenced 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] decode_slice_header error 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] no frame! 17:15:13 T:140644525790976 ERROR: Decode - avcodec_decode_video returned failure 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo - video decoder returned error 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] non-existing PPS 0 referenced 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] decode_slice_header error 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] no frame! 17:15:13 T:140644525790976 ERROR: Decode - avcodec_decode_video returned failure 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo - video decoder returned error 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] non-existing PPS 0 referenced 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] decode_slice_header error 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] no frame! 17:15:13 T:140644525790976 ERROR: Decode - avcodec_decode_video returned failure 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo - video decoder returned error 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] non-existing PPS 0 referenced 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] decode_slice_header error 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] no frame! 17:15:13 T:140644525790976 ERROR: Decode - avcodec_decode_video returned failure 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo - video decoder returned error 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] non-existing PPS 0 referenced 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] decode_slice_header error 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] no frame! 17:15:13 T:140644525790976 ERROR: Decode - avcodec_decode_video returned failure 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo - video decoder returned error 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] non-existing PPS 0 referenced 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] decode_slice_header error 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] no frame! 17:15:13 T:140644525790976 ERROR: Decode - avcodec_decode_video returned failure 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo - video decoder returned error 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] non-existing PPS 0 referenced 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] decode_slice_header error 17:15:13 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] no frame! 17:15:13 T:140644525790976 ERROR: Decode - avcodec_decode_video returned failure 17:15:13 T:140644525790976 DEBUG: CDVDPlayerVideo - video decoder returned error 17:15:13 T:140644525790976 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available 17:15:13 T:140644534183680 DEBUG: ParsePacket - {2} level changed from 0 to -99 17:15:13 T:140646295193344 INFO: CAESinkALSA::Initialize - Attempting to open device "iec958:CARD=NVidia,DEV=0" 17:15:13 T:140646295193344 INFO: CAESinkALSA::Initialize - Opened device "iec958:CARD=NVidia,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00" 17:15:13 T:140646295193344 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 17:15:13 T:140646295193344 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE 17:15:13 T:140646295193344 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2048, bufferSize 8192 17:15:13 T:140646295193344 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2048, bufferSize 8192 17:15:13 T:140646295193344 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 186 ms 17:15:13 T:140646295193344 DEBUG: CSoftAE::Run - Sink was forgotten 17:15:13 T:140646295193344 DEBUG: CSoftAE::Run - Sink restart flagged 17:15:13 T:140646295193344 INFO: CSoftAE::InternalOpenSink - sink incompatible, re-starting 17:15:13 T:140646295193344 INFO: CAESinkALSA::Initialize - Attempting to open device "iec958:CARD=NVidia,DEV=0" 17:15:13 T:140646295193344 INFO: CAESinkALSA::Initialize - Opened device "iec958:CARD=NVidia,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x02" 17:15:13 T:140646295193344 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 17:15:13 T:140646295193344 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE 17:15:13 T:140646295193344 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2048, bufferSize 8192 17:15:13 T:140646295193344 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2048, bufferSize 8192 17:15:13 T:140646295193344 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 171 ms 17:15:13 T:140646295193344 DEBUG: CSoftAE::InternalOpenSink - ALSA Initialized: 17:15:13 T:140646295193344 DEBUG: Output Device : HDA NVidia 17:15:13 T:140646295193344 DEBUG: Sample Rate : 48000 17:15:13 T:140646295193344 DEBUG: Sample Format : AE_FMT_S32NE 17:15:13 T:140646295193344 DEBUG: Channel Count : 2 17:15:13 T:140646295193344 DEBUG: Channel Layout: FL,FR 17:15:13 T:140646295193344 DEBUG: Frames : 2048 17:15:13 T:140646295193344 DEBUG: Frame Samples : 4096 17:15:13 T:140646295193344 DEBUG: Frame Size : 8 17:15:13 T:140646295193344 DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0 17:15:13 T:140646295193344 DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 16384 17:15:13 T:140646295193344 DEBUG: AERemap: Downmix normalization is disabled 17:15:13 T:140644534183680 DEBUG: ParsePacket - {0} profile changed from -99 to 100 17:15:13 T:140644534183680 DEBUG: ParsePacket - {0} level changed from -99 to 40 17:15:13 T:140644534183680 NOTICE: Opening video stream: 0 source: 256 17:15:13 T:140644534183680 NOTICE: Creating video codec with codec id: 28 17:15:13 T:140644534183680 DEBUG: CDVDFactoryCodec: compiled in hardware support: CrystalHD:no OpenMax:no VDPAU:yes VAAPI:no XVBA:no 17:15:13 T:140644534183680 DEBUG: FactoryCodec - Video: - Opening 17:15:13 T:140644534183680 DEBUG: DllAvUtilBase: Using libavutil system library 17:15:13 T:140644534183680 DEBUG: DllAvCodec: Using libavcodec system library 17:15:13 T:140644534183680 DEBUG: DllSwScale: Using libswscale system library 17:15:13 T:140644534183680 DEBUG: DllAvFilter: Using libavfilter system library 17:15:13 T:140644534183680 NOTICE: CDVDVideoCodecFFmpeg::Open() Creating VDPAU(1920x1080, 28) 17:15:13 T:140644534183680 DEBUG: DllAvUtilBase: Using libavutil system library 17:15:13 T:140644534183680 NOTICE: vdp_device = 0x00000001 vdp_st = 0x00000000 17:15:13 T:140644534183680 NOTICE: VDPAU Decoder capabilities: 17:15:13 T:140644534183680 NOTICE: name level macbs width height 17:15:13 T:140644534183680 NOTICE: ------------------------------------ 17:15:13 T:140644534183680 NOTICE: MPEG1 0 8192 2048 2048 17:15:13 T:140644534183680 NOTICE: MPEG2_SIMPLE 3 8192 2048 2048 17:15:13 T:140644534183680 NOTICE: MPEG2_MAIN 3 8192 2048 2048 17:15:13 T:140644534183680 NOTICE: H264_MAIN 41 8190 2032 2048 17:15:13 T:140644534183680 NOTICE: H264_HIGH 41 8190 2032 2048 17:15:13 T:140644534183680 NOTICE: VC1_SIMPLE 1 8190 2048 2048 17:15:13 T:140644534183680 NOTICE: VC1_MAIN 2 8190 2048 2048 17:15:13 T:140644534183680 NOTICE: VC1_ADVANCED 4 8190 2048 2048 17:15:13 T:140644534183680 NOTICE: ------------------------------------ 17:15:13 T:140644534183680 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_NOISE_REDUCTION 17:15:13 T:140644534183680 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_SHARPNESS 17:15:13 T:140644534183680 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_DEINTERLACE_TEMPORAL 17:15:13 T:140644534183680 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_DEINTERLACE_TEMPORAL_SPATIAL 17:15:13 T:140644534183680 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_INVERSE_TELECINE 17:15:13 T:140646295193344 DEBUG: AERemap: Downmix normalization is disabled 17:15:14 T:140646295193344 DEBUG: Previous line repeats 2 times. 17:15:14 T:140646295193344 DEBUG: CSoftAEStream::CSoftAEStream - Converting from AE_FMT_S16NE to AE_FMT_FLOAT 17:15:14 T:140644542576384 DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback 17:15:14 T:140644534183680 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 (VDPAU acceleration) 17:15:14 T:140644534183680 DEBUG: FactoryCodec - Video: ff-h264_vdpau-vdpau - Opened 17:15:14 T:140644534183680 DEBUG: CDVDPlayer::HandleMessages - player started 1 17:15:14 T:140644525790976 NOTICE: (VDPAU) Close 17:15:14 T:140644525790976 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:15:14 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] mmco: unref short failure 17:15:14 T:140644525790976 ERROR: Previous line repeats 1 times. 17:15:14 T:140644525790976 DEBUG: CVDPAU::SetWidthHeight Setting OutWidth: 1920 OutHeight: 1080 17:15:14 T:140644525790976 NOTICE: (VDPAU) screenWidth:1920 vidWidth:1920 surfaceWidth:1920 17:15:14 T:140644525790976 NOTICE: (VDPAU) screenHeight:1080 vidHeight:1080 surfaceHeight:1088 17:15:14 T:140644487243520 NOTICE: Thread Vdpau Output Thread start, auto delete: false 17:15:14 T:140644487243520 NOTICE: COutput::OnStartup: Output Thread created 17:15:14 T:140644487243520 NOTICE: VDPAU::COutput::CreateGlxContext - created context 17:15:14 T:140644487243520 NOTICE: VDPAU::COutput GL interop supported 17:15:14 T:140644487243520 NOTICE: VDPAU::COutput: vdpau gl interop initialized 17:15:14 T:140644198639360 NOTICE: Thread Vdpau Mixer Thread start, auto delete: false 17:15:14 T:140644198639360 NOTICE: CMixer::OnStartup: Output Thread created 17:15:14 T:140644198639360 NOTICE: (VDPAU) Creating the video mixer 17:15:14 T:140644487243520 NOTICE: VDPAU::COutput::InitBufferPool - Output Surface created 17:15:14 T:140644525790976 NOTICE: Previous line repeats 3 times. 17:15:14 T:140644525790976 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:15:14 T:140644525790976 DEBUG: Previous line repeats 1 times. 17:15:14 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] mmco: unref short failure 17:15:14 T:140644525790976 ERROR: Previous line repeats 1 times. 17:15:14 T:140644525790976 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:15:14 T:140644525790976 DEBUG: ffmpeg[5AFFD700]: [h264_vdpau] Increasing reorder buffer to 1 17:15:14 T:140644525790976 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:15:14 T:140644525790976 DEBUG: Previous line repeats 1 times. 17:15:14 T:140644525790976 DEBUG: ffmpeg[5AFFD700]: [h264_vdpau] Increasing reorder buffer to 2 17:15:14 T:140644525790976 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:15:14 T:140644525790976 DEBUG: Previous line repeats 2 times. 17:15:14 T:140644525790976 ERROR: ffmpeg[5AFFD700]: [h264_vdpau] mmco: unref short failure 17:15:14 T:140644525790976 ERROR: Previous line repeats 1 times. 17:15:14 T:140644525790976 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:15:14 T:140644487243520 DEBUG: Previous line repeats 6 times. 17:15:14 T:140644487243520 NOTICE: VDPAU::COutput::InitBufferPool - Output Surface created 17:15:14 T:140644525790976 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:15:14 T:140644487243520 NOTICE: VDPAU::COutput::InitBufferPool - Output Surface created 17:15:14 T:140644525790976 NOTICE: Previous line repeats 1 times. 17:15:14 T:140644525790976 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:15:14 T:140644487243520 NOTICE: VDPAU::COutput::InitBufferPool - Output Surface created 17:15:14 T:140644487243520 NOTICE: Previous line repeats 1 times. 17:15:14 T:140644487243520 NOTICE: VDPAU::COutput registered output surfaces 17:15:14 T:140644525790976 NOTICE: fps: 25.000000, pwidth: 1920, pheight: 1080, dwidth: 1920, dheight: 1080 17:15:14 T:140644525790976 DEBUG: OutputPicture - change configuration. 1920x1080. framerate: 25.00. format: VDPAU 17:15:14 T:140644525790976 NOTICE: Display resolution ADJUST : HDMI-0: 1920x1080 @ 50.00Hz (20) (weight: 0.000) 17:15:14 T:140644525790976 NOTICE: CXBMCRenderManager::ResetRenderBuffer - using 5 render buffers 17:15:14 T:140644525790976 DEBUG: CXBMCRenderManager::EnableBuffering - 1 17:15:14 T:140646297610048 NOTICE: Using GL_TEXTURE_2D 17:15:14 T:140646297610048 NOTICE: GL: Using VDPAU render method 17:15:14 T:140646297610048 NOTICE: GL: NPOT texture support detected 17:15:14 T:140646297610048 NOTICE: GL: Using GL_ARB_pixel_buffer_object 17:15:14 T:140644534183680 DEBUG: CDVDPlayer::HandleMessages - player started 2 17:15:15 T:140644534183680 DEBUG: set caching from pvr to done. audio (1) = 21. video (1) = 13 17:15:15 T:140644534183680 DEBUG: CDVDPlayer::SetCaching - caching state 0 17:15:15 T:140644525790976 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:15:15 T:140644542576384 DEBUG: Previous line repeats 1 times. 17:15:15 T:140644542576384 DEBUG: CDVDPlayerAudio:: Discontinuity1 - was:59628384877.402000, should be:59627625254.131668, error:-759623.270332 17:15:15 T:140644525790976 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0 17:15:15 T:140646295193344 DEBUG: Previous line repeats 1 times. 17:15:15 T:140646295193344 DEBUG: CSoftAE::Run - Sink restart flagged 17:15:15 T:140646295193344 INFO: CSoftAE::InternalOpenSink - keeping old sink with : AE_FMT_FLOAT, FL,FR, 48000hz 17:15:15 T:140646295193344 DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0 17:15:15 T:140646295193344 DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 16384 17:15:15 T:140644525790976 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1 17:15:15 T:140644525790976 DEBUG: Previous line repeats 1 times. 17:15:15 T:140644525790976 WARNING: CVDPAU::DrawSlice - VdpDecoderRender long decoding: 31 ms, dec: 1, proc: 0, rend: 1 17:15:15 T:140646297610048 DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------ 17:15:15 T:140644525790976 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer 17:15:17 T:140644542576384 WARNING: Previous line repeats 6 times. 17:15:17 T:140644542576384 DEBUG: CDVDPlayerAudio:: Discontinuity2 - was:59629736286.027672, should be:59629776286.027672, error:40000.000000 17:15:18 T:140644525790976 WARNING: CVDPAU::DrawSlice - VdpDecoderRender long decoding: 32 ms, dec: 2, proc: 0, rend: 0 17:15:18 T:140644525790976 WARNING: CVDPAU::DrawSlice - VdpDecoderRender long decoding: 33 ms, dec: 2, proc: 0, rend: 0 17:15:18 T:140646297610048 DEBUG: LIRC: Update - NEW at 282469:80 0 KEY_STOP devinput (KEY_STOP) 17:15:18 T:140646297610048 DEBUG: OnKey: 224 (e0) pressed, action is Stop 17:15:18 T:140646297610048 DEBUG: PVR - SaveCurrentChannelSettings - no custom channel settings for channel 'YYYYY HD 1' 17:15:18 T:140646297610048 NOTICE: CDVDPlayer::CloseFile() 17:15:18 T:140646297610048 NOTICE: DVDPlayer: waiting for threads to exit 17:15:18 T:140644534183680 NOTICE: CDVDPlayer::OnExit() 17:15:18 T:140644534183680 NOTICE: DVDPlayer: closing audio stream 17:15:18 T:140644534183680 NOTICE: Closing audio stream 17:15:18 T:140644534183680 NOTICE: Waiting for audio thread to exit 17:15:18 T:140644542576384 NOTICE: thread end: CDVDPlayerAudio::OnExit() 17:15:18 T:140644542576384 DEBUG: Thread CDVDPlayerAudio 140644542576384 terminating 17:15:18 T:140644534183680 NOTICE: Closing audio device 17:15:18 T:140644534183680 DEBUG: CSoftAEStream::~CSoftAEStream - Destructed 17:15:18 T:140644534183680 NOTICE: Deleting audio codec 17:15:18 T:140644534183680 NOTICE: DVDPlayer: closing video stream 17:15:18 T:140644534183680 NOTICE: Closing video stream 17:15:18 T:140644534183680 NOTICE: waiting for video thread to exit 17:15:18 T:140646295193344 DEBUG: CSoftAE::Run - Sink restart flagged 17:15:18 T:140646295193344 INFO: CSoftAE::InternalOpenSink - sink incompatible, re-starting 17:15:19 T:140644525790976 NOTICE: thread end: video_thread 17:15:19 T:140644525790976 DEBUG: Thread CDVDPlayerVideo 140644525790976 terminating 17:15:19 T:140644534183680 NOTICE: deleting video codec 17:15:19 T:140644534183680 NOTICE: CVDPAU::Release pre-cleanup 17:15:19 T:140644198639360 NOTICE: CMixer::OnExit: Output Thread terminated 17:15:19 T:140644198639360 DEBUG: Thread Vdpau Mixer Thread 140644198639360 terminating 17:15:19 T:140644487243520 DEBUG: VDPAU::PreCleanup - released output surface 17:15:19 T:140644534183680 DEBUG: Previous line repeats 2 times. 17:15:19 T:140644534183680 NOTICE: DVDPlayer: closing teletext stream 17:15:19 T:140644534183680 NOTICE: Closing teletext stream 17:15:19 T:140644534183680 NOTICE: waiting for teletext data thread to exit 17:15:19 T:140644495636224 ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true (-1) 17:15:19 T:140644495636224 NOTICE: thread end: data_thread 17:15:19 T:140644495636224 DEBUG: Thread CDVDTeletextData 140644495636224 terminating 17:15:19 T:140644534183680 NOTICE: CDVDPlayer::OnExit() deleting demuxer 17:15:19 T:140644534183680 NOTICE: CDVDPlayer::OnExit() deleting input stream 17:15:19 T:140646295193344 INFO: CAESinkALSA::Initialize - Attempting to open device "iec958:CARD=NVidia,DEV=0" 17:15:19 T:140646295193344 INFO: CAESinkALSA::Initialize - Opened device "iec958:CARD=NVidia,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00" 17:15:19 T:140646295193344 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats 17:15:19 T:140646295193344 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE 17:15:19 T:140646295193344 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2048, bufferSize 8192 17:15:19 T:140646295193344 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2048, bufferSize 8192 17:15:19 T:140646295193344 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 186 ms 17:15:19 T:140646295193344 DEBUG: CSoftAE::InternalOpenSink - ALSA Initialized: 17:15:19 T:140646295193344 DEBUG: Output Device : HDA NVidia 17:15:19 T:140646295193344 DEBUG: Sample Rate : 44100 17:15:19 T:140646295193344 DEBUG: Sample Format : AE_FMT_S32NE 17:15:19 T:140646295193344 DEBUG: Channel Count : 2 17:15:19 T:140646295193344 DEBUG: Channel Layout: FL,FR 17:15:19 T:140646295193344 DEBUG: Frames : 2048 17:15:19 T:140646295193344 DEBUG: Frame Samples : 4096 17:15:19 T:140646295193344 DEBUG: Frame Size : 8 17:15:19 T:140646295193344 DEBUG: CSoftAE::InternalOpenSink - Using speaker layout: 2.0 17:15:19 T:140646295193344 DEBUG: CSoftAE::InternalOpenSink - Internal Buffer Size: 16384 17:15:19 T:140646295193344 DEBUG: AERemap: Downmix normalization is disabled 17:15:20 T:140644534183680 DEBUG: Previous line repeats 2 times. 17:15:20 T:140644534183680 DEBUG: CDVDInputStreamPVRManager::Close - stream closed 17:15:20 T:140644534183680 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 17:15:20 T:140644534183680 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 17:15:20 T:140644534183680 DEBUG: Thread CDVDPlayer 140644534183680 terminating 17:15:20 T:140646297610048 NOTICE: DVDPlayer: finished waiting 17:15:20 T:140646297610048 DEBUG: LinuxRendererGL: Cleaning up GL resources 17:15:20 T:140646297610048 NOTICE: (VDPAU) Close 17:15:20 T:140646297610048 NOTICE: (VDPAU) FiniVDPAUOutput 17:15:20 T:140644487243520 NOTICE: VDPAU::COutput: vdpau gl interop finished 17:15:20 T:140644487243520 NOTICE: COutput::OnExit: Output Thread terminated 17:15:20 T:140644487243520 DEBUG: Thread Vdpau Output Thread 140644487243520 terminating 17:15:20 T:140646297610048 DEBUG: CVDPAU::FiniVDPAUOutput destroying 7 video surfaces 17:15:20 T:140646297610048 NOTICE: CDVDPlayer::CloseFile() 17:15:20 T:140646297610048 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 17:15:20 T:140646297610048 NOTICE: DVDPlayer: waiting for threads to exit 17:15:20 T:140646297610048 NOTICE: DVDPlayer: finished waiting 17:15:20 T:140646297610048 DEBUG: LinuxRendererGL: Cleaning up GL resources 17:15:20 T:140645867968256 DEBUG: CVideoReferenceClock: Cleaning up GLX 17:15:20 T:140645867968256 DEBUG: Thread CVideoReferenceClock 140645867968256 terminating 17:15:20 T:140646297610048 DEBUG: LIRC: Update - NEW at 283719:80 0 KEY_STOP_UP devinput (KEY_STOP_UP) 17:15:29 T:140646295193344 DEBUG: Suspended the Sink

pipelka / xbmc-addon-xvdr

Problem streaming certain channels. #120