Forum

Full Version: problem with xvid files
You're currently viewing a stripped down version of our content. View the full version with proper formatting.
Hi guys, using latest version of xbian - fresh install. having drop frame issues on various xvid files.
here is a copy from the log for one of the files:
Does this mean anything to anyone?
Let me know if you need anything else.
BTW raspberry is rev b, running off 1500ma power supply with hard drive connected to powered hub. Does the same when played off a usb flash.
Also using dts and ac3 passthru setting and match video frame rate on.

Thanks
PHP Code:
COMXPlayerOpening: /media/WD Passport/Movies/Dear John.avi
14
:03:52 T:3041428000 WARNINGCDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
14
:03:52 T:3041428000   DEBUGCRenderManager::UpdateDisplayLatency Latency set to 0 msec
14
:03:52 T:3041428000  NOTICECXBMCRenderManager::ResetRenderBuffer using 5 render buffers
14
:03:52 T:3041428000   DEBUGLinuxRendererGLCleaning up GL resources
14
:03:52 T:2745148480  NOTICEThread COMXPlayer startauto deletefalse
14
:03:52 T:2745148480  NOTICECreating InputStream
14
:03:53 T:2745148480   DEBUGScanForExternalSubtitlesSearching for subtitles...
14:03:53 T:3041428000   DEBUG: ------ Window Init (DialogBusy.xml) ------
14:03:53 T:2745148480   DEBUGScanForExternalSubtitlesEND (total time676 ms)
14:03:53 T:2745148480  NOTICECreating Demuxer
14
:03:53 T:2745148480   DEBUGSECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avcodec-53-arm.so)
14:03:53 T:2745148480   DEBUGLoading: /usr/local/lib/xbmc/system/players/dvdplayer/avcodec-53-arm.so
14
:03:53 T:2745148480   DEBUGSECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avformat-53-arm.so)
14:03:53 T:2745148480   DEBUGLoading: /usr/local/lib/xbmc/system/players/dvdplayer/avformat-53-arm.so
14
:03:54 T:2745148480   DEBUGOpen probing detected format [avi]
14:03:55 T:2745148480   DEBUGOpen avformat_find_stream_info starting
14
:03:55 T:2745148480   DEBUGOpen av_find_stream_info finished
14
:03:55 T:2745148480    INFOffmpeg[A39FA440]: Input #0, avi, from '/media/WD Passport/Movies/Dear John.avi':
14:03:55 T:2745148480    INFOffmpeg[A39FA440]:   Duration01:47:55.85start0.000000bitrate1808 kb/s
14
:03:55 T:2745148480    INFOffmpeg[A39FA440]:     Stream #0:0: Video: mpeg4 (Advanced Simple Profile) (XVID / 0x44495658), yuv420p, 640x272 [SAR 1:1 DAR 40:17], 23.98 tbr, 23.98 tbn, 23.98 tbc
14:03:55 T:2745148480    INFOffmpeg[A39FA440]:     Stream #0:1: Audio: ac3 ([0] [0][0] / 0x2000), 48000 Hz, 5.1(side), s16, 448 kb/s
14:03:55 T:2745148480   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.clock handle 0x27e0200 dllopen 1
14
:03:55 T:2745148480   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.clock input port 80 output port 81
14
:03:55 T:2745148480   DEBUGOMXClock::OMXStop
14
:03:55 T:2745148480   DEBUGOMXClock::OMXSetSpeed(0.00pause_resume:1
14
:03:55 T:2745148480  NOTICEOpening video stream0 source256
14
:03:55 T:2745148480   DEBUGDllBcmUsing omx system library
14
:03:55 T:2745148480   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.video_decode handle 0x23b30f0 dllopen 1
14
:03:55 T:2745148480   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.video_decode input port 130 output port 131
14
:03:55 T:2745148480   DEBUGCOMXCoreComponent::AllocInputBuffers component(OMX.broadcom.video_decode) - port(130), nBufferCountMin(1), nBufferCountActual(120), nBufferSize(81920), nBufferAlignmen(16)
14:03:55 T:2745148480   DEBUGCOMXVideo::Open decoder_component(0x0x23b30f0), input_port(0x82), output_port(0x83deinterlace 0 hdmiclocksync 0
14
:03:55 T:2745148480    INFOOMXPlayerVideo::OpenDecoder Video codec omx-mpeg4 width 640 height 272 profile 15 fps 23.976025
14
:03:55 T:2745148480    INFOOMXPlayerVideo::OpenDecoder fps23.976025 hdmi_ntsc_freqs 1
14
:03:55 T:2745148480  NOTICECreating video thread
14
:03:55 T:2830103616  NOTICEThread COMXPlayerVideo startauto deletefalse
14
:03:55 T:2745148480  NOTICEOpening audio stream1 source256
14
:03:55 T:2745148480   DEBUGDllBcmUsing omx system library
14
:03:55 T:2830103616   DEBUGCOMXPlayerVideo CDVDMsg::PLAYER_STARTED 0
14
:03:55 T:2830103616   DEBUGCOMXPlayerVideo CDVDMsg::GENERAL_SYNCHRONIZE
14
:03:55 T:2745148480   DEBUGSECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/swresample-0-arm.so)
14:03:55 T:2745148480   DEBUGLoading: /usr/local/lib/xbmc/system/players/dvdplayer/swresample-0-arm.so
14
:03:55 T:2745148480  NOTICECreating audio thread
14
:03:55 T:2849494080  NOTICEThread COMXPlayerAudio startauto deletefalse
14
:03:55 T:2745148480   DEBUGReadEditDecisionLists Checking for edit decision lists (EDLon local drive or remote share for: /media/WD Passport/Movies/Dear John.avi
14
:03:55 T:3041428000   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.image_decode handle 0xa7b9c168 dllopen 1
14
:03:55 T:3041428000   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321
14
:03:55 T:2849494080   DEBUGCOMXPlayerAudio CDVDMsg::PLAYER_STARTED 0
14
:03:55 T:3041428000   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.resize handle 0xa7b2d570 dllopen 1
14
:03:55 T:2745148480   DEBUGCOMXPlayer::SetCaching caching state 3
14
:03:55 T:3041428000   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61
14
:03:55 T:2830103616   DEBUGCOMXPlayerVideo CDVDMsg::PLAYER_SETSPEED 0
14
:03:55 T:2830103616   DEBUGCOMXPlayerVideo CDVDMsg::PLAYER_STARTED 0
14
:03:55 T:3041428000   DEBUGCOMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(3), nBufferSize(81920), nBufferAlignmen(16)
14:03:55 T:2849494080   DEBUGCOMXPlayerAudio CDVDMsg::PLAYER_SETSPEED 0
14
:03:55 T:2849494080   DEBUGCOMXPlayerAudio CDVDMsg::PLAYER_STARTED 0
14
:03:55 T:2830103616    INFOCOMXPlayerVideo Stillframe leftswitching to normal playback
14
:03:55 T:2830103616   DEBUGOMXVideo::Decode VDec setStartTime 0.000000
14
:03:55 T:2830103616   ERROROutput renderer not started
14
:03:55 T:3041428000   DEBUGCOMXCoreComponent::AllocOutputBuffers component(OMX.broadcom.resize) - port(61), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(3686400nBufferAlignmen(16)
14:03:55 T:2745148480   DEBUGCOMXPlayer::HandleMessages player started 2 (tpa:0,a:0,v:1)
14:03:55 T:2849494080   DEBUGCOMXAudioCodecOMX::Decode(0x2b1c230,1792format=1(1chan=6 samples=1536 size=18432/18432,18432/18432,18432 data=0x27facd0,(nil),(nil),(nil),0x4800,(nil),(nil),(nil)
14:03:55 T:2849494080   DEBUGCOMXAudioCodecOMX::GetData size=18432/0/18432 cont=1 buf=0x27facd0
14
:03:55 T:2849494080   DEBUGCOMXAudio::SetCodingType OMX_AUDIO_CodingPCM
14
:03:55 T:2849494080   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.audio_decode handle 0x24f5c20 dllopen 1
14
:03:55 T:2849494080   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.audio_decode input port 120 output port 121
14
:03:55 T:2849494080   DEBUGCOMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_decode) - port(120), nBufferCountMin(4), nBufferCountActual(16), nBufferSize(49152), nBufferAlignmen(16)
14:03:55 T:2849494080   DEBUGCOMXAudio::Initialize Input bps 16 samplerate 48000 channels 6 buffer size 1728000 bytes per second 576000
14
:03:55 T:2849494080   DEBUGpcm->direction      input
14
:03:55 T:2849494080   DEBUGpcm->nPortIndex     0
14
:03:55 T:2849494080   DEBUGpcm->eNumData       0
14
:03:55 T:2849494080   DEBUGpcm->eEndian        1
14
:03:55 T:2849494080   DEBUGpcm->bInterleaved   1
14
:03:55 T:2849494080   DEBUGpcm->nBitPerSample  16
14
:03:55 T:2849494080   DEBUGpcm->ePCMMode       0
14
:03:55 T:2849494080   DEBUGpcm->nChannels      6
14
:03:55 T:2849494080   DEBUGpcm->nSamplingRate  48000
14
:03:55 T:2849494080   DEBUGOMX_AUDIO_ChannelLF
14
:03:55 T:2849494080   DEBUGOMX_AUDIO_ChannelRF
14
:03:55 T:2849494080   DEBUGOMX_AUDIO_ChannelCF
14
:03:55 T:2849494080   DEBUGOMX_AUDIO_ChannelLFE
14
:03:55 T:2849494080   DEBUGOMX_AUDIO_ChannelLS
14
:03:55 T:2849494080   DEBUGOMX_AUDIO_ChannelRS
14
:03:55 T:2849494080   DEBUGCOMXAudio::Initialize device passthrough 0 hwdecode 0
14
:03:55 T:2849494080    INFOAudio codec  channels 6 samplerate 48000 bitspersample 16
14
:03:55 T:2849494080   DEBUGCOMXAudio::Decode ADec setStartTime 0.000000
14
:03:55 T:2849494080   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.audio_mixer handle 0x23f8948 dllopen 1
14
:03:55 T:2849494080   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.audio_mixer input port 232 output port 231
14
:03:55 T:2849494080   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.audio_render handle 0x26fbaf8 dllopen 1
14
:03:55 T:2849494080   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100
14
:03:55 T:2849494080    INFOCOMXAudio::ApplyVolume Volume=0.00 (* 1.00 1.00)
14:03:55 T:2849494080   DEBUGCOMXAudio::PortSettingsChanged Output bps 16 samplerate 48000 channels 2 buffer size 1728000 bytes per second 576000
14
:03:55 T:2849494080   DEBUGpcm->direction      output
14
:03:55 T:2849494080   DEBUGpcm->nPortIndex     231
14
:03:55 T:2849494080   DEBUGpcm->eNumData       0
14
:03:55 T:2849494080   DEBUGpcm->eEndian        1
14
:03:55 T:2849494080   DEBUGpcm->bInterleaved   1
14
:03:55 T:2849494080   DEBUGpcm->nBitPerSample  16
14
:03:55 T:2849494080   DEBUGpcm->ePCMMode       0
14
:03:55 T:2849494080   DEBUGpcm->nChannels      2
14
:03:55 T:2849494080   DEBUGpcm->nSamplingRate  48000
14
:03:55 T:2849494080   DEBUGOMX_AUDIO_ChannelLF
14
:03:55 T:2849494080   DEBUGOMX_AUDIO_ChannelRF
14
:03:55 T:2849494080   DEBUGOMX_AUDIO_ChannelCF
14
:03:55 T:2849494080   DEBUGOMX_AUDIO_ChannelLFE
14
:03:55 T:2849494080   DEBUGOMX_AUDIO_ChannelLR
14
:03:55 T:2849494080   DEBUGOMX_AUDIO_ChannelRR
14
:03:55 T:2849494080   DEBUGCOMXAudio::PortSettingsChanged bits:16 mode:0 channels:6 srate:48000 nopassthrough
14
:03:55 T:3041428000   DEBUGCOMXCoreComponent::Deinitialize OMX.broadcom.resize handle 0xa7b2d570 dllopen 1
14
:03:55 T:3041428000   DEBUGCOMXCoreComponent::Deinitialize OMX.broadcom.image_decode handle 0xa7b9c168 dllopen 1
14
:03:55 T:2849494080    INFOCOMXPlayerAudio Switching to normal playback
14
:03:55 T:2745148480   DEBUGCOMXPlayer::HandleMessages player started RESET
14
:03:55 T:2745148480  NOTICEOMXClock using audio as reference
14
:03:55 T:2745148480   DEBUGOMXClock::OMXReset audio video 1 wait mask 0->3 state 2->1
14
:03:55 T:2745148480   DEBUGCOMXPlayer::HandleMessages player started 1 (tpa:0,a:1,v:1)
14:03:55 T:2745148480   DEBUGCOMXPlayer::SetCaching caching state 0
14
:03:55 T:2849494080   DEBUGCOMXPlayerAudio CDVDMsg::PLAYER_SETSPEED 1000
14
:03:55 T:2849494080   DEBUGCDVDPlayerAudio CDVDMsg::GENERAL_RESYNC(-4503599627370496.00000032000.0000001)
14:03:55 T:2830103616   DEBUGCOMXPlayerVideo CDVDMsg::PLAYER_SETSPEED 1000
14
:03:55 T:2830103616   DEBUGCDVDPlayerVideo CDVDMsg::GENERAL_RESYNC(-4503599627370496.0000000)
14:03:55 T:2830103616   ERROROutput renderer not started
14
:03:55 T:2830103616   ERRORPrevious line repeats 20 times.
14:03:55 T:2830103616   DEBUGResolutionUpdateCallBack change configurationvideo:1920x1080framerate23.98640x272 formatBYPASS
14
:03:55 T:2830103616  NOTICEDisplay resolution DESKTOP 1920x1080 60.00 Full Screen (16)
14:03:55 T:2830103616  NOTICECXBMCRenderManager::ResetRenderBuffer using 5 render buffers
14
:03:55 T:2830103616   DEBUGCXBMCRenderManager::EnableBuffering 1
14
:03:55 T:2997077056   DEBUGCecLogMessage GetPhysicalAddress physical address 3000
14
:03:55 T:2997077056   DEBUGCecLogMessage physical address changed to 3000
14
:03:55 T:2997077056   DEBUGCecLogMessage physical address unchanged (3000)
14:03:55 T:2830103616   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.video_render handle 0x271eb68 dllopen 1
14
:03:55 T:2830103616   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.video_render input port 90 output port 90
14
:03:55 T:2830103616   DEBUGCOMXVideo::PortSettingsChanged 640x272@23.98 interlace:0 deinterlace:0
14
:03:55 T:2830103616   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.video_scheduler handle 0x25109b0 dllopen 1
14
:03:55 T:2830103616   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.video_scheduler input port 10 output port 11
14
:03:55 T:3041428000  NOTICEUsing GL_TEXTURE_2D
14
:03:55 T:3041428000   DEBUGGLRequested render method0
14
:03:55 T:3041428000  NOTICEGLUsing BYPASS render method
14
:03:55 T:3041428000  NOTICEGLNPOT texture support detected
14
:03:55 T:2745148480   DEBUGResume 0.33,1.53 (A:01 V:01EOF:0 FULL:0 T:0.20
14
:03:55 T:2745148480   DEBUGOMXClock::OMXSetSpeed(1.00pause_resume:1
14
:03:55 T:3041428000    INFOCOMXAudio::ApplyVolume Volume=1.00 (* 1.00 1.00)
14:03:55 T:3041428000    INFOPrevious line repeats 1 times.
14:03:55 T:3041428000   DEBUGActivating window ID12005
14
:03:55 T:3041428000   DEBUG: ------ Window Deinit (MyVideoNav.xml) ------
14:03:55 T:3041428000   DEBUG: ------ Window Init (VideoFullScreen.xml) ------
14:03:56 T:3041428000   DEBUGPrepareNextRender no bufferout0current0display4
14
:03:56 T:3041428000   DEBUGdest_rect.x_offset 0 dest_rect.y_offset 132 dest_rect.width 1920 dest_rect.height 816
14
:03:56 T:3041428000   DEBUGCGUIInfoManager::SetCurrentMovie(/media/WD Passport/Movies/Dear John.avi)
14:03:56 T:3041428000   DEBUGGetMovieId (/media/WD Passport/Movies/Dear John.avi), query select idMovie from movie where idFile=27
14
:03:56 T:3041428000   DEBUGGetEpisodeId (/media/WD Passport/Movies/Dear John.avi), query select idEpisode from episode where idFile=27
14
:03:56 T:3041428000   DEBUGGetMusicVideoId (/media/WD Passport/Movies/Dear John.avi), query select idMVideo from musicvideo where idFile=27
14
:03:56 T:3041428000   DEBUGCAnnouncementManager AnnouncementOnPlay from xbmc
14
:03:56 T:3041428000   DEBUGGOT ANNOUNCEMENTtype1from xbmcmessage OnPlay
14
:03:56 T:3041428000   DEBUGPrepareNextRender no bufferout0current0display4
14
:03:56 T:3041428000   DEBUG: ------ Window Deinit (DialogBusy.xml) ------
14:03:57 T:3041428000   DEBUGPrepareNextRender no bufferout0current0display4
14
:04:10 T:3041428000   DEBUGPrevious line repeats 131 times.
14:04:10 T:3041428000    INFOCheckIdle Closing session to http://www.google.com (easy=0x25451e0, multi=(nil))
14:04:10 T:3041428000   DEBUGPrepareNextRender no bufferout0current0display4
14
:04:20 T:2772431936   DEBUGPrevious line repeats 104 times.
14:04:20 T:2772431936   DEBUGThread Jobworker 2772431936 terminating (autodelete)
14:04:20 T:3041428000   DEBUGPrepareNextRender no bufferout0current0display4
14
:04:27 T:2988688448   DEBUGPrevious line repeats 71 times.
14:04:27 T:2988688448   DEBUGCecLogMessage received dataheader:00030004 p0:00004401 p1:00000000 p2:00000000 p3:00000000 reason:4
14
:04:27 T:2962224192   DEBUGCecLogMessage - >> 01:44:00
14
:04:27 T:2962224192   DEBUGCecLogMessage - >> TV (0) -> Recorder 1 (1): user control pressed (44)
14:04:27 T:2962224192   DEBUGCecLogMessage key pressedselect (0)
14:04:27 T:2962224192   DEBUGPushCecKeypress received key  b duration 0
14
:04:27 T:3041428000   DEBUGPrepareNextRender no bufferout0current0display4
14
:04:27 T:3041428000   DEBUGOnKey11 (0bpressedaction is OSD
14
:04:27 T:3041428000   DEBUG: ------ Window Init (VideoOSD.xml) ------
14:04:27 T:2772431936  NOTICEThread Jobworker startauto deletetrue
14
:04:27 T:2772431936   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.image_decode handle 0x26bca00 dllopen 1
14
:04:27 T:2772431936   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321
14
:04:27 T:2772431936   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.resize handle 0x23667e8 dllopen 1
14
:04:27 T:2772431936   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61
14
:04:27 T:2772431936   DEBUGCOMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(3), nBufferSize(81920), nBufferAlignmen(16)
14:04:27 T:2988688448   DEBUGCecLogMessage received dataheader:00030008 p0:00004501 p1:00000000 p2:00000000 p3:00000000 reason:8
14
:04:27 T:2962224192   DEBUGCecLogMessage - >> 01:8b:00
14
:04:27 T:2962224192   DEBUGCecLogMessage - >> TV (0) -> Recorder 1 (1): vendor remote button up (8B)
14:04:27 T:2962224192   DEBUGCecLogMessage key releasedselect (0)
14:04:27 T:2962224192   DEBUGPushCecKeypress received key  b duration 228
14
:04:28 T:2772431936   DEBUGCOMXCoreComponent::AllocOutputBuffers component(OMX.broadcom.resize) - port(61), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(139264nBufferAlignmen(16)
14:04:28 T:2772431936   DEBUGCOMXCoreComponent::Deinitialize OMX.broadcom.resize handle 0x23667e8 dllopen 1
14
:04:28 T:2772431936   DEBUGCOMXCoreComponent::Deinitialize OMX.broadcom.image_decode handle 0x26bca00 dllopen 1
14
:04:28 T:3041428000   DEBUGPrepareNextRender no bufferout0current0display4
14
:04:31 T:2988688448   DEBUGPrevious line repeats 25 times.
14:04:31 T:2988688448   DEBUGCecLogMessage received dataheader:00030004 p0:000D4401 p1:00000000 p2:00000000 p3:00000000 reason:4
14
:04:31 T:2962224192   DEBUGCecLogMessage - >> 01:44:0d
14
:04:31 T:2962224192   DEBUGCecLogMessage - >> TV (0) -> Recorder 1 (1): user control pressed (44)
14:04:31 T:2962224192   DEBUGCecLogMessage key pressed: exit (d)
14:04:31 T:2962224192   DEBUGPushCecKeypress received key d8 duration 0
14
:04:31 T:3041428000   DEBUGPrepareNextRender no bufferout0current0display4
14
:04:31 T:3041428000   DEBUGOnKeymenu (d8pressedaction is Back
14
:04:31 T:3041428000   DEBUGPrepareNextRender no bufferout0current0display4
14
:04:31 T:2988688448   DEBUGPrevious line repeats 1 times.
14:04:31 T:2988688448   DEBUGCecLogMessage received dataheader:00030008 p0:000D4501 p1:00000000 p2:00000000 p3:00000000 reason:8
14
:04:31 T:2962224192   DEBUGCecLogMessage - >> 01:8b:0d
14
:04:31 T:2962224192   DEBUGCecLogMessage - >> TV (0) -> Recorder 1 (1): vendor remote button up (8B)
14:04:31 T:2962224192   DEBUGCecLogMessage key released: exit (d)
14:04:31 T:2962224192   DEBUGPushCecKeypress received key d8 duration 334
14
:04:31 T:3041428000   DEBUGPrepareNextRender no bufferout0current0display4
14
:04:31 T:3041428000   DEBUG: ------ Window Deinit (VideoOSD.xml) ------
14:04:31 T:3041428000   DEBUGPrepareNextRender no bufferout0current0display4
14
:04:58 T:2772431936   DEBUGPrevious line repeats 261 times.
14:04:58 T:2772431936   DEBUGThread Jobworker 2772431936 terminating (autodelete)
14:04:58 T:3041428000   DEBUGPrepareNextRender no bufferout0current0display

here is a copy of the log from another xvid file which has the same frame drop issue:
PHP Code:
14:18:21 T:3041428000  NOTICECOMXPlayerOpening: /media/WD Passport/Movies/Edge of Darkness.avi
14
:18:21 T:3041428000 WARNINGCDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
14
:18:21 T:3041428000   DEBUGCRenderManager::UpdateDisplayLatency Latency set to 0 msec
14
:18:21 T:3041428000  NOTICECXBMCRenderManager::ResetRenderBuffer using 5 render buffers
14
:18:21 T:3041428000   DEBUGLinuxRendererGLCleaning up GL resources
14
:18:21 T:2745148480  NOTICEThread COMXPlayer startauto deletefalse
14
:18:21 T:2745148480  NOTICECreating InputStream
14
:18:21 T:3041428000   DEBUG: ------ Window Init (DialogBusy.xml) ------
14:18:21 T:2745148480   DEBUGScanForExternalSubtitlesSearching for subtitles...
14:18:22 T:2745148480   DEBUGScanForExternalSubtitlesEND (total time1487 ms)
14:18:22 T:2745148480  NOTICECreating Demuxer
14
:18:22 T:2745148480   DEBUGOpen probing detected format [avi]
14:18:25 T:2745148480   DEBUGOpen avformat_find_stream_info starting
14
:18:25 T:2745148480   DEBUGOpen av_find_stream_info finished
14
:18:25 T:2745148480    INFOffmpeg[A39FA440]: Input #0, avi, from '/media/WD Passport/Movies/Edge of Darkness.avi':
14:18:25 T:2745148480    INFOffmpeg[A39FA440]:   Metadata:
14:18:25 T:2745148480    INFOffmpeg[A39FA440]:     encoder         VirtualDubMod 1.5.10.2 (build 2540/release)
14:18:25 T:2745148480    INFOffmpeg[A39FA440]:   Duration01:56:48.09start0.000000bitrate830 kb/s
14
:18:25 T:2745148480    INFOffmpeg[A39FA440]:     Stream #0:0: Video: mpeg4 (Advanced Simple Profile) (XVID / 0x44495658), yuv420p, 608x256 [SAR 1:1 DAR 19:8], 23.98 tbr, 23.98 tbn, 23.98 tbc
14:18:25 T:2745148480    INFOffmpeg[A39FA440]:     Stream #0:1: Audio: mp3 (U[0][0][0] / 0x0055), 48000 Hz, stereo, s16, 160 kb/s
14:18:25 T:2745148480   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.clock handle 0x23fde58 dllopen 1
14
:18:25 T:2745148480   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.clock input port 80 output port 81
14
:18:25 T:2745148480   DEBUGOMXClock::OMXStop
14
:18:25 T:2745148480   DEBUGOMXClock::OMXSetSpeed(0.00pause_resume:1
14
:18:25 T:2745148480  NOTICEOpening video stream0 source256
14
:18:25 T:2745148480   DEBUGDllBcmUsing omx system library
14
:18:25 T:2745148480   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.video_decode handle 0x2156370 dllopen 1
14
:18:25 T:2745148480   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.video_decode input port 130 output port 131
14
:18:25 T:2745148480   DEBUGCOMXCoreComponent::AllocInputBuffers component(OMX.broadcom.video_decode) - port(130), nBufferCountMin(1), nBufferCountActual(120), nBufferSize(81920), nBufferAlignmen(16)
14:18:25 T:2745148480   DEBUGCOMXVideo::Open decoder_component(0x0x2156370), input_port(0x82), output_port(0x83deinterlace 0 hdmiclocksync 0
14
:18:25 T:2745148480    INFOOMXPlayerVideo::OpenDecoder Video codec omx-mpeg4 width 608 height 256 profile 15 fps 23.976025
14
:18:25 T:2745148480    INFOOMXPlayerVideo::OpenDecoder fps23.976025 hdmi_ntsc_freqs 1
14
:18:25 T:2745148480  NOTICECreating video thread
14
:18:25 T:2772431936  NOTICEThread COMXPlayerVideo startauto deletefalse
14
:18:25 T:2745148480  NOTICEOpening audio stream1 source256
14
:18:25 T:2745148480   DEBUGDllBcmUsing omx system library
14
:18:25 T:2772431936   DEBUGCOMXPlayerVideo CDVDMsg::PLAYER_STARTED 0
14
:18:25 T:2772431936   DEBUGCOMXPlayerVideo CDVDMsg::GENERAL_SYNCHRONIZE
14
:18:25 T:2745148480  NOTICECreating audio thread
14
:18:25 T:2857882688  NOTICEThread COMXPlayerAudio startauto deletefalse
14
:18:25 T:2745148480   DEBUGReadEditDecisionLists Checking for edit decision lists (EDLon local drive or remote share for: /media/WD Passport/Movies/Edge of Darkness.avi
14
:18:25 T:2745148480   DEBUGCOMXPlayer::SetCaching caching state 3
14
:18:25 T:2857882688   DEBUGCOMXPlayerAudio CDVDMsg::PLAYER_STARTED 0
14
:18:25 T:2857882688   DEBUGCOMXPlayerAudio CDVDMsg::PLAYER_SETSPEED 0
14
:18:25 T:2857882688   DEBUGCOMXPlayerAudio CDVDMsg::PLAYER_STARTED 0
14
:18:25 T:2772431936   DEBUGCOMXPlayerVideo CDVDMsg::PLAYER_SETSPEED 0
14
:18:25 T:2772431936   DEBUGCOMXPlayerVideo CDVDMsg::PLAYER_STARTED 0
14
:18:25 T:2857882688   DEBUGCOMXAudioCodecOMX::Decode(0x2af79f0,480format=1(1chan=2 samples=1152 size=4608/4608,4608/4608,4608 data=0x2b1b5d0,(nil),(nil),(nil),0x1200,(nil),(nil),(nil)
14:18:25 T:2857882688   DEBUGCOMXAudioCodecOMX::GetData size=4608/0/4608 cont=1 buf=0x2b1b5d0
14
:18:25 T:2772431936    INFOCOMXPlayerVideo Stillframe leftswitching to normal playback
14
:18:25 T:2772431936   DEBUGOMXVideo::Decode VDec setStartTime 0.000000
14
:18:25 T:2772431936   ERROROutput renderer not started
14
:18:25 T:2745148480   DEBUGCOMXPlayer::HandleMessages player started 2 (tpa:0,a:0,v:1)
14:18:25 T:2857882688   DEBUGCOMXAudio::SetCodingType OMX_AUDIO_CodingPCM
14
:18:25 T:2857882688   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.audio_decode handle 0x21475e0 dllopen 1
14
:18:25 T:2857882688   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.audio_decode input port 120 output port 121
14
:18:25 T:2857882688   DEBUGCOMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_decode) - port(120), nBufferCountMin(4), nBufferCountActual(16), nBufferSize(49152), nBufferAlignmen(16)
14:18:25 T:2857882688   DEBUGCOMXAudio::Initialize Input bps 16 samplerate 48000 channels 2 buffer size 576000 bytes per second 192000
14
:18:25 T:2857882688   DEBUGpcm->direction      input
14
:18:25 T:2857882688   DEBUGpcm->nPortIndex     0
14
:18:25 T:2857882688   DEBUGpcm->eNumData       0
14
:18:25 T:2857882688   DEBUGpcm->eEndian        1
14
:18:25 T:2857882688   DEBUGpcm->bInterleaved   1
14
:18:25 T:2857882688   DEBUGpcm->nBitPerSample  16
14
:18:25 T:2857882688   DEBUGpcm->ePCMMode       0
14
:18:25 T:2857882688   DEBUGpcm->nChannels      2
14
:18:25 T:2857882688   DEBUGpcm->nSamplingRate  48000
14
:18:25 T:2857882688   DEBUGOMX_AUDIO_ChannelLF
14
:18:25 T:2857882688   DEBUGOMX_AUDIO_ChannelRF
14
:18:25 T:2857882688   DEBUGCOMXAudio::Initialize device passthrough 0 hwdecode 0
14
:18:25 T:2857882688    INFOAudio codec  channels 2 samplerate 48000 bitspersample 16
14
:18:25 T:2857882688   DEBUGCOMXAudio::Decode ADec setStartTime 0.000000
14
:18:25 T:2857882688   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.audio_mixer handle 0xae1907e8 dllopen 1
14
:18:25 T:2857882688   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.audio_mixer input port 232 output port 231
14
:18:25 T:2857882688   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.audio_render handle 0xae190848 dllopen 1
14
:18:25 T:2857882688   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100
14
:18:25 T:2857882688    INFOCOMXAudio::ApplyVolume Volume=0.00 (* 1.00 1.00)
14:18:25 T:2857882688   DEBUGCOMXAudio::PortSettingsChanged Output bps 16 samplerate 48000 channels 2 buffer size 576000 bytes per second 192000
14
:18:25 T:2857882688   DEBUGpcm->direction      output
14
:18:25 T:2857882688   DEBUGpcm->nPortIndex     231
14
:18:25 T:2857882688   DEBUGpcm->eNumData       0
14
:18:25 T:2857882688   DEBUGpcm->eEndian        1
14
:18:25 T:2857882688   DEBUGpcm->bInterleaved   1
14
:18:25 T:2857882688   DEBUGpcm->nBitPerSample  16
14
:18:25 T:2857882688   DEBUGpcm->ePCMMode       0
14
:18:25 T:2857882688   DEBUGpcm->nChannels      2
14
:18:25 T:2857882688   DEBUGpcm->nSamplingRate  48000
14
:18:25 T:2857882688   DEBUGOMX_AUDIO_ChannelLF
14
:18:25 T:2857882688   DEBUGOMX_AUDIO_ChannelRF
14
:18:25 T:2857882688   DEBUGCOMXAudio::PortSettingsChanged bits:16 mode:0 channels:2 srate:48000 nopassthrough
14
:18:26 T:3041428000    INFOCOMXAudio::ApplyVolume Volume=1.00 (* 1.00 1.00)
14:18:26 T:2745148480    INFOPrevious line repeats 1 times.
14:18:26 T:2745148480   DEBUGCOMXPlayer::HandleMessages player started RESET
14
:18:26 T:2745148480  NOTICEOMXClock using audio as reference
14
:18:26 T:2745148480   DEBUGOMXClock::OMXReset audio video 1 wait mask 0->3 state 2->1
14
:18:26 T:2745148480   DEBUGCOMXPlayer::HandleMessages player started 1 (tpa:0,a:1,v:1)
14:18:26 T:2745148480   DEBUGCOMXPlayer::SetCaching caching state 4
14
:18:26 T:2857882688   DEBUGCOMXPlayerAudio CDVDMsg::PLAYER_SETSPEED 1000
14
:18:26 T:2857882688   DEBUGCDVDPlayerAudio CDVDMsg::GENERAL_RESYNC(-4503599627370496.00000024000.0000001)
14:18:26 T:2772431936   DEBUGCOMXPlayerVideo CDVDMsg::PLAYER_SETSPEED 1000
14
:18:26 T:2772431936   DEBUGCDVDPlayerVideo CDVDMsg::GENERAL_RESYNC(-4503599627370496.0000000)
14:18:26 T:2772431936   ERROROutput renderer not started
14
:18:26 T:2772431936   ERRORPrevious line repeats 19 times.
14:18:26 T:2772431936   DEBUGResolutionUpdateCallBack change configurationvideo:1920x1080framerate23.98608x256 formatBYPASS
14
:18:26 T:2772431936  NOTICEDisplay resolution DESKTOP 1920x1080 60.00 Full Screen (16)
14:18:26 T:2772431936  NOTICECXBMCRenderManager::ResetRenderBuffer using 5 render buffers
14
:18:26 T:2772431936   DEBUGCXBMCRenderManager::EnableBuffering 1
14
:18:26 T:3041428000   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.image_decode handle 0xa8fcaa18 dllopen 1
14
:18:26 T:2997077056   DEBUGCecLogMessage GetPhysicalAddress physical address 3000
14
:18:26 T:2997077056   DEBUGCecLogMessage physical address changed to 3000
14
:18:26 T:2997077056   DEBUGCecLogMessage physical address unchanged (3000)
14:18:26 T:3041428000   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321
14
:18:26 T:2772431936   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.video_render handle 0xa5fd8d38 dllopen 1
14
:18:26 T:3041428000   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.resize handle 0xa8b78398 dllopen 1
14
:18:26 T:2772431936   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.video_render input port 90 output port 90
14
:18:26 T:2772431936   DEBUGCOMXVideo::PortSettingsChanged 608x256@23.98 interlace:0 deinterlace:0
14
:18:26 T:3041428000   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61
14
:18:26 T:2772431936   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.video_scheduler handle 0xa5fd8df8 dllopen 1
14
:18:26 T:3041428000   DEBUGCOMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(3), nBufferSize(81920), nBufferAlignmen(16)
14:18:26 T:2772431936   DEBUGCOMXCoreComponent::Initialize OMX.broadcom.video_scheduler input port 10 output port 11
14
:18:26 T:3041428000   DEBUGCOMXCoreComponent::AllocOutputBuffers component(OMX.broadcom.resize) - port(61), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(3686400nBufferAlignmen(16)
14:18:26 T:2745148480   DEBUGResume 0.22,0.83 (A:01 V:01EOF:0 FULL:0 T:0.20
14
:18:26 T:2745148480   DEBUGOMXClock::OMXSetSpeed(1.00pause_resume:1
14
:18:26 T:3041428000   DEBUGCOMXCoreComponent::Deinitialize OMX.broadcom.resize handle 0xa8b78398 dllopen 1
14
:18:26 T:3041428000   DEBUGCOMXCoreComponent::Deinitialize OMX.broadcom.image_decode handle 0xa8fcaa18 dllopen 1
14
:18:26 T:3041428000  NOTICEUsing GL_TEXTURE_2D
14
:18:26 T:3041428000   DEBUGGLRequested render method0
14
:18:26 T:3041428000  NOTICEGLUsing BYPASS render method
14
:18:26 T:3041428000  NOTICEGLNPOT texture support detected
14
:18:26 T:2857882688    INFOCOMXPlayerAudio Switching to normal playback
14
:18:26 T:2745148480   DEBUGCOMXPlayer::SetCaching caching state 0
14
:18:26 T:3041428000   DEBUGCGUIInfoManager::SetCurrentMovie(/media/WD Passport/Movies/Edge of Darkness.avi)
14:18:27 T:3041428000   DEBUGCAnnouncementManager AnnouncementOnPlay from xbmc
14
:18:27 T:3041428000   DEBUGGOT ANNOUNCEMENTtype1from xbmcmessage OnPlay
14
:18:27 T:3041428000   DEBUGActivating window ID12005
14
:18:27 T:3041428000   DEBUG: ------ Window Deinit (MyVideoNav.xml) ------
14:18:27 T:3041428000   DEBUG: ------ Window Init (VideoFullScreen.xml) ------
14:18:27 T:3041428000   DEBUGPrepareNextRender no bufferout0current0display4
14
:18:27 T:3041428000   DEBUGdest_rect.x_offset 0 dest_rect.y_offset 137 dest_rect.width 1920 dest_rect.height 809
14
:18:27 T:3041428000   DEBUG: ------ Window Deinit (DialogBusy.xml) ------
14:18:28 T:3041428000   DEBUGPrepareNextRender no bufferout0current0display4
14
:18:55 T:2830103616   DEBUGPrevious line repeats 272 times.
14:18:55 T:2830103616   DEBUGExtractThumb decode failed in /media/WD Passport/Movies/World War Z.mp4 after 161 packets.
14:18:55 T:3041428000   DEBUGPrepareNextRender no bufferout0current0display4
14
:18:55 T:2830103616   DEBUGExtractThumb measured 38617 ms to extract thumb from file </media/WD Passport/Movies/World War Z.mp4in 161 packets.
14:18:55 T:3041428000   DEBUGPrepareNextRender no bufferout0current0display
match video frame rate on = adjust display refresh rate to match video ?

or sync playback to match display ?

also do you have
Code:
<video>
     <adjustrefreshrate>  
       <override>
         <fps>23.976</fps>
         <refresh>24.0</refresh>
       </override>
     </adjustrefreshrate>
   </video>

in advancedsettings ?
Yes I have adjust display refresh rate to match video = on... sync plauback is not selected = off.

I have checked the advancedsettings.xml and yes that text is included.
What is it that is causing the problem? What does the text that you are referring to in the advancedsettings mean in simple terms lol

I have tried raspbmc just out of curiosity and I can say the same is happening with that???

Any help is greatly appreciated.

Thanks
Reference URL's