Buffering...debug log what bit do you need?
#1
Ok so i have been getting buffering especially on HD content. I thought maybe it was my server getting slow and was building a freenas box anyways so thought it would be good to switch it over anyways.

I have the entire log from switch on, play movie buffer a couple of times and then shut down but its too big too post. Im guessing you only need a bit of it but i have no idea what bit you need.

Here is the entire log anyways: http://iqkrma.blu.livefilestore.com/y1pi...oad&psid=1
Reply
#2
Ok i think the problem is in this section if not check out the full version.

Code:
16:16:20 T:2732 M:3176144896   DEBUG: CEdl::ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: smb://CHENBRO NAS/Chenbro NAS/Media/Movies/T/The Neverending Story/The Neverending Story.mkv
16:16:20 T:1844 M:3176140800   DEBUG: thread start, auto delete: 0
16:16:20 T:1844 M:3176136704  NOTICE: running thread: CDVDPlayerAudio::Process()
16:16:20 T:1300 M:3174449152   DEBUG: thread start, auto delete: 0
16:16:20 T:1300 M:3174682624  NOTICE: running thread: video_thread
16:16:20 T:2732 M:3174690816   DEBUG: CDVDPlayer::Process - Start position set to last stopped position: 638000
16:16:20 T:2732 M:3175170048   DEBUG: CDVDDemuxFFmpeg::SeekTime - seek ended up on time 639722
16:16:20 T:2732 M:3175284736   DEBUG: CDVDPlayer::Process - starting demuxer from: 638000
16:16:20 T:2732 M:3175284736   DEBUG: CDVDPlayer::SetCaching - caching state 2
16:16:20 T:2016 M:3175280640   DEBUG: CGUIAudioManager::DeInitialize
16:16:20 T:2016 M:3175280640   DEBUG: CAnnouncementManager - Announcement: PlaybackStarted from xbmc
16:16:20 T:2016 M:3175452672   DEBUG: CGUIInfoManager::SetCurrentMovie(smb://CHENBRO NAS/Chenbro NAS/Media/Movies/T/The Neverending Story/The Neverending Story.mkv)
16:16:20 T:2016 M:3175460864   DEBUG: ------ Window Deinit (DialogBusy.xml) ------
16:16:20 T:1300 M:3176509440   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
16:16:20 T:1300 M:3176509440   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(639722000.000000, 1)
16:16:20 T:1300 M:3176509440    INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
16:16:20 T:1844 M:3176509440   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(639776000.000000, 0)
16:16:20 T:1844 M:3176488960    INFO:   msg: Stream with high frequencies VQ coding
16:16:20 T:1844 M:3176443904  NOTICE: Creating audio device with codec id: 86021, channels: 5, sample rate: 48000, no pass-through
16:16:20 T:1844 M:3176439808    INFO: AudioRendererFactory:  not a explicit device, trying to autodetect.
16:16:20 T:1844 M:3176423424    INFO: CPCMRemap: Configured speaker layout: 2.0
16:16:20 T:1844 M:3176423424    INFO: CPCMRemap: I channel map: CE,FL,FR,SL,SR
16:16:20 T:1844 M:3176423424   DEBUG: CPCMRemap: Forcing side channel map to back channels
16:16:20 T:1844 M:3176423424    INFO: CPCMRemap: O channel map: FL,FR
16:16:20 T:1844 M:3176423424   DEBUG: CPCMRemap: Downmix normalization is disabled
16:16:20 T:1844 M:3176423424   DEBUG: CPCMRemap: FL = CE(0.707107) FL(1.000000) BL(1.000000)
16:16:20 T:1844 M:3176423424   DEBUG: CPCMRemap: FR = CE(0.707107) FR(1.000000) BR(1.000000)
16:16:20 T:1844 M:3176423424   DEBUG: CWin32DirectSound::Initialize: Packet Size = 12384. Avg Bytes Per Second = 192000.
16:16:20 T:1844 M:3176386560   DEBUG: CWin32DirectSound::Initialize: secondary buffer created
16:16:20 T:1844 M:3176386560   DEBUG: CWin32DirectSound::Initialize - Channels: 5 - SampleRate: 48000 - SampleBit: 16 - Resample false - IsMusic false - IsPassthrough false - audioDevice: Default
16:16:20 T:1844 M:3176386560   DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback
16:16:20 T:1300 M:3176378368   DEBUG: DXVA - supports 'MPEG2 IDCT'
16:16:20 T:1300 M:3176378368   DEBUG: DXVA - supports 'H.264 VLD, no FGT'
16:16:20 T:1300 M:3176378368   DEBUG: DXVA - supports 4245F676-2bbc-4166-a0bb-54e7b849c380
16:16:20 T:1300 M:3176378368   DEBUG: DXVA - supports 6719B6FB-5cad-4acb-b00a-f3bfdec38727
16:16:20 T:1300 M:3176378368   DEBUG: DXVA - supports 'VC-1 VLD'
16:16:20 T:1300 M:3176378368   DEBUG: DXVA - supports CA15D19A-2b48-43d6-979e-7a6e9c802ff8
16:16:20 T:1300 M:3176378368   DEBUG: DXVA - supports 5B23D46D-fa5f-4fdc-b78a-7eb2787942ec
16:16:20 T:1300 M:3176378368   DEBUG: DXVA - trying 'H.264 VLD, no FGT'
16:16:20 T:1300 M:3176374272   DEBUG: DXVA - source requires 5 references
16:16:20 T:1300 M:3176370176   DEBUG: DXVA - bitstream type 2
16:16:20 T:1300 M:3176345600   DEBUG: Previous line repeats 1 times.
16:16:20 T:1300 M:3176345600   DEBUG: DXVA - processor found 5A54A0C9-c7ec-4bd9-8ede-f3c75dc4393b
16:16:20 T:1300 M:3176345600   DEBUG: DXVA - processor selected 5A54A0C9-c7ec-4bd9-8ede-f3c75dc4393b
16:16:20 T:1300 M:3176341504   DEBUG: DXVA - processor requires 0 past frames and 0 future frames
16:16:20 T:1300 M:3176316928   DEBUG: DXVA - allocating 10 surfaces
16:16:21 T:1300 M:3172085760    INFO: ffmpeg[514]: [h264] Cannot parallelize deblocking type 1, decoding such frames in sequential order
16:16:21 T:1300 M:3167612928  NOTICE:  fps: 23.976044, pwidth: 1920, pheight: 800, dwidth: 1920, dheight: 800
16:16:21 T:1300 M:3167580160   DEBUG: CDVDPlayerVideo::OutputPicture - change configuration. 1920x800. framerate: 23.98. format: DXVA
16:16:21 T:1300 M:3167580160  NOTICE: Display resolution DESKTOP : 1920x1080 @ 60.00 - Full Screen (12)
16:16:21 T:1300 M:3167576064   DEBUG: CWinRenderer::SelectRenderMethod: Selected render method 3: DXVA
16:16:21 T:2016 M:3167133696   DEBUG: Activating window ID: 12005
16:16:21 T:2016 M:3167105024   DEBUG: Checking if window ID 12005 is locked.
16:16:21 T:2016 M:3167039488   DEBUG: ------ Window Deinit (MyVideoNav.xml) ------
16:16:21 T:2016 M:3177783296   DEBUG: ------ Window Init (VideoFullScreen.xml) ------
16:16:21 T:2016 M:3177783296    INFO: Loading skin file: VideoFullScreen.xml
16:16:21 T:2016 M:3175428096   DEBUG: created video buffer 0
16:16:21 T:2016 M:3175428096   DEBUG: created video buffer 1
16:16:22 T:2732 M:3176878080   DEBUG: CDVDPlayer::HandleMessages - player started 1
16:16:22 T:2732 M:3176878080   DEBUG: CDVDPlayer::HandleMessages - player started 2
16:16:22 T:2732 M:3176878080   DEBUG: CDVDPlayer::SetCaching - caching state 3
16:16:22 T:1844 M:3176873984   DEBUG: CDVDPlayerAudio:: Discontinuity - was:638975380.354409, should be:639776000.000000, error:800619.645591
16:16:22 T:2732 M:3172687872   DEBUG: CDVDPlayer::SetCaching - caching state 0
16:16:22 T:1844 M:3173928960   DEBUG: CWin32DirectSound::CheckPlayStatus: Resuming Playback
16:16:22 T:1844 M:3173818368 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
16:16:22 T:1300 M:3165454336 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
16:16:23 T:1300 M:3165102080    INFO: CDVDPlayerVideo - Stillframe detected, switching to forced 23.976044 fps
16:16:23 T:2732 M:3162091520   DEBUG: CDVDPlayer::SetCaching - caching state 1
16:16:23 T:2732 M:3162091520   DEBUG: CDVDPlayer::HandleMessages - player started 1
16:16:23 T:2016 M:3162140672   DEBUG: ------ Window Init (DialogSeekBar.xml) ------
16:16:23 T:2016 M:3162140672    INFO: Loading skin file: DialogSeekBar.xml
16:16:25 T:2732 M:3163185152   DEBUG: CDVDPlayer::HandleMessages - player started 2
16:16:39 T:2732 M:3145957376   DEBUG: CDVDPlayer::SetCaching - caching state 0
16:16:39 T:1300 M:3145957376    INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
16:16:39 T:1844 M:3145957376   DEBUG: CDVDPlayerAudio:: Discontinuity - was:641332893.981825, should be:640457002.188910, error:-875891.792916
16:16:39 T:1844 M:3145957376   DEBUG: CWin32DirectSound::CheckPlayStatus: Resuming Playback
16:16:40 T:2016 M:3138056192   DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------
16:16:41 T:516 M:3153944576   DEBUG: Thread 516 terminating (autodelete)
16:16:41 T:1948 M:3153952768   DEBUG: Thread 1948 terminating (autodelete)
16:16:41 T:1844 M:3153952768   DEBUG: CDVDPlayerAudio:: Discontinuity - was:642490913.190637, should be:642458929.589370, error:-31983.601267
16:16:42 T:648 M:3153956864   DEBUG: Thread 648 terminating (autodelete)
16:16:42 T:2884 M:3153940480   DEBUG: Thread 2884 terminating (autodelete)
16:16:44 T:1300 M:3153059840   DEBUG: CPullupCorrection: detected pattern of length 24: 42000.00 42000.00 42000.00 41000.00 42000.00 42000.00 41000.00 42000.00 42000.00 42000.00 41000.00 42000.00 42000.00 41000.00 42000.00 42000.00 42000.00 41000.00 42000.00 42000.00 41000.00 42000.00 42000.00 41000.00
16:16:48 T:1844 M:3149258752 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
16:16:50 T:1300 M:3147714560 WARNING: Previous line repeats 1 times.
16:16:50 T:1300 M:3147714560 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
16:16:50 T:1844 M:3146743808 WARNING: CWin32DirectSound::GetSpace - buffer underrun - W:99840, P:94080, O:99072.
16:16:50 T:1844 M:3147874304   DEBUG: CWin32DirectSound::CheckPlayStatus: Resuming Playback
16:16:50 T:1844 M:3147874304 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
16:16:50 T:1300 M:3147710464 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available
16:16:51 T:1300 M:3147644928    INFO: CDVDPlayerVideo - Stillframe detected, switching to forced 23.976044 fps
16:16:51 T:1300 M:3147644928   DEBUG: CPullupCorrection: pattern lost
16:16:51 T:2732 M:3145900032   DEBUG: CDVDPlayer::SetCaching - caching state 1
16:16:51 T:2732 M:3145900032   DEBUG: CDVDPlayer::HandleMessages - player started 2
16:16:51 T:2732 M:3145900032   DEBUG: CDVDPlayer::HandleMessages - player started 1
16:16:51 T:2016 M:3146313728   DEBUG: ------ Window Init (DialogSeekBar.xml) ------
16:17:07 T:2732 M:3129810944   DEBUG: CDVDPlayer::SetCaching - caching state 0
16:17:07 T:1300 M:3129810944    INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
16:17:07 T:1844 M:3129810944   DEBUG: CDVDPlayerAudio:: Discontinuity - was:652237921.530960, should be:651796002.188910, error:-441919.342050
16:17:07 T:1844 M:3129810944   DEBUG: CWin32DirectSound::CheckPlayStatus: Resuming Playback
16:17:07 T:2016 M:3130810368   DEBUG: ------ Window Deinit (DialogSeekBar.xml) ------
Reply

Logout Mark Read Team Forum Stats Members Help
Buffering...debug log what bit do you need?0