pipelka/xbmc-addon-xvdr — Issue #29: wrong recording length and jumping not working
Author: jemka
Created: 2011-12-19 22:02:54+00:00
State: open

Hi,
when i play a recording from the tv menu i get a wrong recording length. In this case 1 hour.
Also jumping forward or backward is not working. Playing the ts files with the video menu is working fine.

Is this a known bug? May be the video files splitting by vdr is a problem? Or should i upgrade to Ubuntu 11.10 for vdr 1.7.18?

Regards jemka.

I am running:
Ubuntu 11.04
Today git head: xbmc-addon-xvdr xbmc vdr-plugin-xvdr
vdr 1.7.17-1

vdr syslog

Dec 19 22:46:39 europa vdr: [5199] XVDR: Client with ID 23 connected: 127.0.0.1:48006
Dec 19 22:46:39 europa vdr: [5617] XVDR: Welcome client 'XBMC Media Center' with protocol version '3'
Dec 19 22:46:39 europa vdr: [5617] XVDR: Preferred language: deu,ger / type: 0
Dec 19 22:46:39 europa vdr: [5617] XVDR: Setting channel update method: 3
Dec 19 22:46:39 europa vdr: [5199] XVDR: Recordings state changed (285)
Dec 19 22:46:39 europa vdr: [5199] XVDR: Requesting clients to reload recordings list
Dec 19 22:46:49 europa vdr: [5199] XVDR-Error: Invalid or missing '/var/lib/vdr/plugins/xvdr/allowed_hosts.conf'. falling back to 'svdrphosts.conf'.
Dec 19 22:46:49 europa vdr: [5199] XVDR-Error: Invalid or missing /var/lib/vdr/plugins/xvdr/../svdrphosts.conf. Adding 127.0.0.1 to list of allowed hosts.
Dec 19 22:46:49 europa vdr: [5199] XVDR: Client with ID 24 connected: 127.0.0.1:48010
Dec 19 22:46:49 europa vdr: [5622] XVDR: Welcome client 'XBMC RecordingStream Receiver' with protocol version '3'
Dec 19 22:46:49 europa vdr: [5622] XVDR: Preferred language: deu,ger / type: 0
Dec 19 22:46:49 europa vdr: [5622] XVDR: File 0 found, size: 2098161968, totalLength now 2098161968
Dec 19 22:46:49 europa vdr: [5622] XVDR: File 1 found, size: 2097638764, totalLength now 4195800732
Dec 19 22:46:49 europa vdr: [5622] XVDR: File 2 found, size: 2097660008, totalLength now 6293460740
Dec 19 22:46:49 europa vdr: [5622] XVDR: File 3 found, size: 2097260696, totalLength now 8390721436
Dec 19 22:46:49 europa vdr: [5622] XVDR: File 4 found, size: 2097837668, totalLength now 10488559104
Dec 19 22:46:49 europa vdr: [5622] XVDR: File 5 found, size: 2097393988, totalLength now 12585953092
Dec 19 22:46:49 europa vdr: [5622] XVDR: File 6 found, size: 2097641208, totalLength now 14683594300
Dec 19 22:46:49 europa vdr: [5622] XVDR: File 7 found, size: 2097977352, totalLength now 16781571652
Dec 19 22:46:49 europa vdr: [5622] XVDR: File 8 found, size: 1426026436, totalLength now 18207598088
Dec 19 22:46:49 europa vdr: [5622] XVDR: total frames: 567947
Dec 19 22:46:49 europa vdr: [5622] XVDR: openFile called for index 0 string:/var/lib/video.00/Tatort/2011-12-18.20.16.1-0.rec/00001.ts
Dec 19 22:46:50 europa vdr: [5622] XVDR: file closed
Dec 19 22:46:50 europa vdr: [5622] XVDR: openFile called for index 8 string:/var/lib/video.00/Tatort/2011-12-18.20.16.1-0.rec/00009.ts
Dec 19 22:46:50 europa vdr: [5622] XVDR: file closed
Dec 19 22:46:50 europa vdr: [5622] XVDR: openFile called for index 0 string:/var/lib/video.00/Tatort/2011-12-18.20.16.1-0.rec/00001.ts

xbmc.log

22:46:50 T:140074115716864 DEBUG: Initialize - using alsa device xbmc
22:46:50 T:140074876778464 DEBUG: CGUIInfoManager::SetCurrentMovie(pvr://recordings/20111218_204500/Tatort.pvr)
22:46:50 T:140074876778464 DEBUG: GetMovieId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idMovie from movie where idFile=471
22:46:50 T:140074876778464 DEBUG: GetEpisodeId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idEpisode from episode where idFile=471
22:46:50 T:140074876778464 DEBUG: GetMusicVideoId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idMVideo from musicvideo where idFile=471
22:46:50 T:140074876778464 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
22:46:50 T:140074876778464 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
22:46:50 T:140074124109568 NOTICE: (VDPAU) screenWidth:0 vidWidth:1280 surfaceWidth:1280
22:46:50 T:140074124109568 NOTICE: (VDPAU) screenHeight:0 vidHeight:720 surfaceHeight:720
22:46:50 T:140074124109568 NOTICE: Creating 1280x720 pixmap
22:46:50 T:140074124109568 DEBUG: Found 4 fbconfigs.
22:46:50 T:140074124109568 DEBUG: Using fbconfig index 0.
22:46:50 T:140074876778464 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
22:46:50 T:140074159445760 DEBUG: CDVDPlayer::SetCaching - caching state 0
22:46:50 T:140074124109568 NOTICE: (VDPAU) Total Output Surfaces Available: 4 of a max (tmp: 4 const: 4)
22:46:50 T:140074124109568 NOTICE: (VDPAU) Creating the video mixer
22:46:50 T:140074115716864 DEBUG: CALSADirectSound::Initialize - frame count:512, packet count:16, buffer size:8192
22:46:50 T:140074115716864 DEBUG: CALSADirectSound::Initialize - Channels: 2 - SampleRate: 48000 - SampleBit: 16 - Resample false - IsMusic false - IsPassthrough 0 - audioDevice: xbmc
22:46:50 T:140074115716864 DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback
22:46:50 T:140074115716864 DEBUG: CDVDPlayerAudio:: Discontinuity - was:1087533.342223, should be:0.000000, error:-1087533.342223
22:46:50 T:140074159445760 DEBUG: CDVDPlayer::HandleMessages - player started 1
22:46:50 T:140074124109568 ERROR: ffmpeg[8C68E700]: [h264_vdpau] number of reference frames exceeds max (probably corrupt input), discarding one
22:46:50 T:140074124109568 ERROR: Previous line repeats 1 times.
22:46:50 T:140074124109568 ERROR: ffmpeg[8C68E700]: [h264_vdpau] mmco: unref short failure
22:46:50 T:140074124109568 NOTICE: fps: 50.000000, pwidth: 1280, pheight: 720, dwidth: 1280, dheight: 720
22:46:50 T:140074124109568 DEBUG: OutputPicture - change configuration. 1280x720. framerate: 50.00. format: VDPAU
22:46:50 T:140074124109568 DEBUG: Found Resolution 1920x1080 @ 50.00 - Full Screen (12) from override of fps 50.000 (fpsmin:49.000 fpsmax:51.000 refreshmin:49.990 refreshmax:50.010)
22:46:50 T:140074124109568 NOTICE: Display resolution ADJUST : 1920x1080 @ 50.00 - Full Screen (12) (weight: 0.000)
22:46:50 T:140074876778464 DEBUG: Activating window ID: 12005
22:46:50 T:140074876778464 DEBUG: ------ Window Deinit (MyPVR.xml) ------
22:46:50 T:140074876778464 DEBUG: ------ Window Init (VideoFullScreen.xml) ------
22:46:50 T:140074876778464 INFO: Loading skin file: VideoFullScreen.xml
22:46:50 T:140074876778464 DEBUG: Load VideoFullScreen.xml: 8.78ms
22:46:50 T:140074876778464 DEBUG: Alloc resources: 9.78ms (9.11 ms skin load)
22:46:50 T:140074876778464 NOTICE: Using GL_TEXTURE_2D
22:46:50 T:140074876778464 NOTICE: GL: Using VDPAU render method
22:46:50 T:140074876778464 NOTICE: GL: NPOT texture support detected
22:46:50 T:140074876778464 NOTICE: GL: Using GL_ARB_pixel_buffer_object
22:46:50 T:140074124109568 ERROR: ffmpeg[8C68E700]: [h264_vdpau] number of reference frames exceeds max (probably corrupt input), discarding one
22:46:50 T:140074159445760 DEBUG: CDVDPlayer::HandleMessages - player started 2
22:46:51 T:140074159445760 DEBUG: CGUIInfoManager::SetCurrentMovie(pvr://recordings/20111218_204500/Tatort.pvr)
22:46:51 T:140074159445760 DEBUG: GetMovieId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idMovie from movie where idFile=471
22:46:51 T:140074159445760 DEBUG: GetEpisodeId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idEpisode from episode where idFile=471
22:46:51 T:140074159445760 DEBUG: GetMusicVideoId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idMVideo from musicvideo where idFile=471
22:46:52 T:140074159445760 DEBUG: CGUIInfoManager::SetCurrentMovie(pvr://recordings/20111218_204500/Tatort.pvr)
22:46:52 T:140074159445760 DEBUG: GetMovieId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idMovie from movie where idFile=471
22:46:52 T:140074159445760 DEBUG: GetEpisodeId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idEpisode from episode where idFile=471
22:46:52 T:140074159445760 DEBUG: GetMusicVideoId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idMVideo from musicvideo where idFile=471
22:46:53 T:140074159445760 DEBUG: CGUIInfoManager::SetCurrentMovie(pvr://recordings/20111218_204500/Tatort.pvr)
22:46:53 T:140074159445760 DEBUG: GetMovieId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idMovie from movie where idFile=471
22:46:53 T:140074159445760 DEBUG: GetEpisodeId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idEpisode from episode where idFile=471
22:46:53 T:140074159445760 DEBUG: GetMusicVideoId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idMVideo from musicvideo where idFile=471
22:46:54 T:140074159445760 DEBUG: CGUIInfoManager::SetCurrentMovie(pvr://recordings/20111218_204500/Tatort.pvr)
22:46:54 T:140074159445760 DEBUG: GetMovieId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idMovie from movie where idFile=471
22:46:54 T:140074159445760 DEBUG: GetEpisodeId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idEpisode from episode where idFile=471
22:46:54 T:140074159445760 DEBUG: GetMusicVideoId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idMVideo from musicvideo where idFile=471
22:46:54 T:140074124109568 DEBUG: CPullupCorrection: detected pattern of length 1: 20000.00, frameduration: 20000.000000
22:46:55 T:140074202507008 DEBUG: AddOnLog: VDR XVDR Client: SendPing
22:46:55 T:140074159445760 DEBUG: CGUIInfoManager::SetCurrentMovie(pvr://recordings/20111218_204500/Tatort.pvr)
22:46:55 T:140074159445760 DEBUG: GetMovieId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idMovie from movie where idFile=471
22:46:55 T:140074159445760 DEBUG: GetEpisodeId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idEpisode from episode where idFile=471
22:46:55 T:140074159445760 DEBUG: GetMusicVideoId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idMVideo from musicvideo where idFile=471
22:46:56 T:140074159445760 DEBUG: CGUIInfoManager::SetCurrentMovie(pvr://recordings/20111218_204500/Tatort.pvr)
22:46:56 T:140074159445760 DEBUG: GetMovieId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idMovie from movie where idFile=471
22:46:56 T:140074159445760 DEBUG: GetEpisodeId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idEpisode from episode where idFile=471
22:46:56 T:140074159445760 DEBUG: GetMusicVideoId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idMVideo from musicvideo where idFile=471
22:46:57 T:140074159445760 DEBUG: CGUIInfoManager::SetCurrentMovie(pvr://recordings/20111218_204500/Tatort.pvr)
22:46:57 T:140074159445760 DEBUG: GetMovieId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idMovie from movie where idFile=471
22:46:57 T:140074159445760 DEBUG: GetEpisodeId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idEpisode from episode where idFile=471
22:46:57 T:140074159445760 DEBUG: GetMusicVideoId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idMVideo from musicvideo where idFile=471
22:46:57 T:140074876778464 DEBUG: SDLKeyboard: scancode: 1f, sym: 0069, unicode: 0069, modifier: 0
22:46:57 T:140074876778464 DEBUG: OnKey: i (f049) pressed, action is Info
22:46:58 T:140074159445760 DEBUG: CGUIInfoManager::SetCurrentMovie(pvr://recordings/20111218_204500/Tatort.pvr)
22:46:58 T:140074159445760 DEBUG: GetMovieId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idMovie from movie where idFile=471
22:46:58 T:140074159445760 DEBUG: GetEpisodeId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idEpisode from episode where idFile=471
22:46:58 T:140074159445760 DEBUG: GetMusicVideoId (pvr://recordings/20111218_204500/Tatort.pvr), query = select idMVideo from musicvideo where idFile=471
22:46:59 T:140074159445760 DEBUG: CGUIInfoManager::SetCurrentMovie(pvr://recordings/20111218_204500/Tatort.pvr)