5sec to open a .ts file with TsReader (another reason for Vista, NO Respondig Window) (1 Viewer)

[iosub]

Yes, GEMX has already added to the SVN version, so this friday it will be included..
Now I'm hunting for more slowing scenarios

Iosu

 

[Swede]

Just found the reason for my short "no responce" when stopping a movie. If you have tons of movies and prefer to view them in "Files" mode instead of "Titles"mode, MP takes too long time to show the list. It would be nice if "Files" mode could be faster somehow.

 

[iosub]

Just found the reason for my short "no responce" when stopping a movie. If you have tons of movies and prefer to view them in "Files" mode instead of "Titles"mode, MP takes too long time to show the list. It would be nice if "Files" mode could be faster somehow.

I will check on that...

Do you have some logs?
I don't have so many movies..
This is on mymovies right? and the movies are local or remote computer?

Iosu

 

[Swede]

Yeah, I wrote about it here https://forum.team-mediaportal.com/...elay-directsound-39502/index2.html#post266418 This link goes direktly to the log.

It's on MyMovies on a local computor on the same HD as MP

These are from today:
The only timetrap I can see is when VideoPlayerVMR9: Disabling DX9 exclusive mode

First log: The setting is "Actor". The behavior is OK. No "no resp..."

2008-05-21 17:17:28.248515 [Info.][GenericPCQueue]: Executing: key 0 / 0 / Action: 13 / ACTION_STOP
2008-05-21 17:17:28.269998 [Info.][MPMain]: GUIVideoFullscreen:stop
2008-05-21 17:17:28.270974 [Info.][MPMain]: g_Player.doStop() keepTimeShifting = False keepExclusiveModeOn = False
2008-05-21 17:17:28.271951 [Info.][MPMain]: g_Player.OnStopped()
2008-05-21 17:17:28.294410 [Info.][MPMain]: GUIVideoFiles: OnPlayBackStopped idFile=119 timeMovieStopped=2 resumeData=
2008-05-21 17:17:28.300269 [Debug][MPMain]: GUIVideoFiles: OnPlayBackStopped store resume time
2008-05-21 17:17:28.301246 [Info.][MPMain]: TvRecorded:OnStopped Video C:\Filmer\Order.avi
2008-05-21 17:17:28.301246 [Info.][MPMain]: g_Player.doStop() - stop
2008-05-21 17:17:28.302222 [Info.][MPMain]: VideoPlayer:ended C:\Filmer\Order.avi
2008-05-21 17:17:28.303199 [Info.][MPMain]: VideoPlayer9:cleanup DShow graph
2008-05-21 17:17:28.314917 [Info.][MPMain]: state: Stopped 0
2008-05-21 17:17:28.315893 [Debug][MPMain]: VMR9: Dispose
2008-05-21 17:17:28.316870 [Debug][MPMain]: VMR9: Inactive
2008-05-21 17:17:28.318823 [Info.][MPMain]: VMR9: ReleaseComObject(): 0
2008-05-21 17:17:28.319799 [Info.][MPMain]: PlaneScene: PresentImage() dispose surfaces
2008-05-21 17:17:28.320776 [Info.][MPMain]: PlaneScene: PresentSurface() dispose surfaces
2008-05-21 17:17:28.644974 [Info.][MPMain]: VideoPlayerVMR9: Disabling DX9 exclusive mode
2008-05-21 17:17:28.645950 [Info.][MPMain]: Main: Received DX exclusive mode switch message. Fullscreen && maximized == False
2008-05-21 17:17:28.646927 [Debug][MPMain]: Main: Goto windowed mode: True
2008-05-21 17:17:28.647903 [Info.][MPMain]: fonts.SetDevice()
2008-05-21 17:17:28.648880 [Debug][MPMain]: Windowmanager: Goto previous window
2008-05-21 17:17:28.649856 [Debug][MPMain]: Window: MediaPortal.GUI.Video.GUIVideoFullscreen deinit
2008-05-21 17:17:28.659621 [Debug][MPMain]: TextureManager: CleanupThumbs()
2008-05-21 17:17:28.701611 [Debug][MPMain]: Window: MediaPortal.GUI.Video.GUIVideoTitle init


Second log: The setting is "Files". Short "No resp..."
2008-05-21 17:18:15.556034 [Info.][GenericPCQueue]: Executing: key 0 / 0 / Action: 13 / ACTION_STOP
2008-05-21 17:18:15.563846 [Info.][MPMain]: GUIVideoFullscreen:stop
2008-05-21 17:18:15.564822 [Info.][MPMain]: g_Player.doStop() keepTimeShifting = False keepExclusiveModeOn = False
2008-05-21 17:18:15.565799 [Info.][MPMain]: g_Player.OnStopped()
2008-05-21 17:18:15.584352 [Info.][MPMain]: GUIVideoFiles: OnPlayBackStopped idFile=357 timeMovieStopped=229 resumeData=
2008-05-21 17:18:15.590211 [Debug][MPMain]: GUIVideoFiles: OnPlayBackStopped store resume time
2008-05-21 17:18:15.591188 [Info.][MPMain]: TvRecorded:OnStopped Video C:\Filmer\10,000 BC.avi
2008-05-21 17:18:15.592164 [Info.][MPMain]: g_Player.doStop() - stop
2008-05-21 17:18:15.593141 [Info.][MPMain]: VideoPlayer:ended C:\Filmer\10,000 BC.avi
2008-05-21 17:18:15.594117 [Info.][MPMain]: VideoPlayer9:cleanup DShow graph
2008-05-21 17:18:15.606812 [Info.][MPMain]: state: Stopped 0
2008-05-21 17:18:15.607788 [Debug][MPMain]: VMR9: Dispose
2008-05-21 17:18:15.609741 [Debug][MPMain]: VMR9: Inactive
2008-05-21 17:18:15.611694 [Info.][MPMain]: VMR9: ReleaseComObject(): 0
2008-05-21 17:18:15.611694 [Info.][MPMain]: PlaneScene: PresentImage() dispose surfaces
2008-05-21 17:18:15.613647 [Info.][MPMain]: PlaneScene: PresentSurface() dispose surfaces
2008-05-21 17:18:16.299150 [Info.][MPMain]: VideoPlayerVMR9: Disabling DX9 exclusive mode
2008-05-21 17:18:16.300127 [Info.][MPMain]: Main: Received DX exclusive mode switch message. Fullscreen && maximized == False
2008-05-21 17:18:16.301103 [Debug][MPMain]: Main: Goto windowed mode: True
2008-05-21 17:18:16.302080 [Info.][MPMain]: fonts.SetDevice()
2008-05-21 17:18:16.302080 [Debug][MPMain]: Windowmanager: Goto previous window
2008-05-21 17:18:16.304033 [Debug][MPMain]: Window: MediaPortal.GUI.Video.GUIVideoFullscreen deinit
2008-05-21 17:18:16.313798 [Debug][MPMain]: TextureManager: CleanupThumbs()
2008-05-21 17:18:16.354811 [Debug][MPMain]: Window: MediaPortal.GUI.Video.GUIVideoFiles init


This is the VMR log for the time wasted
21-05-2008 17:18:15.601 [910]OnClockPause
21-05-2008 17:18:15.605 [910]OnClockStop
21-05-2008 17:18:15.605 [910]ProcessMessage 4
21-05-2008 17:18:15.609 [910]QueryInterface
21-05-2008 17:18:15.609 [910]riid: {FA99388A-4383-415A-A930-DD472A8CF6F7}
21-05-2008 17:18:15.609 [910]EVRCustomPresenter::AddRef()
21-05-2008 17:18:15.609 [910]ReleaseServicePointers
21-05-2008 17:18:15.610 [910]EVRCustomPresenter::Release()
21-05-2008 17:18:15.610 [910]EVRCustomPresenter::Release()
21-05-2008 17:18:15.610 [910]EVRCustomPresenter::Release()
21-05-2008 17:18:15.611 [910]EVRCustomPresenter::Release()
21-05-2008 17:18:15.611 [910]EVRCustomPresenter::Cleanup()
21-05-2008 17:18:15.612 [910]Stopping workers...
21-05-2008 17:18:15.612 [910]Threads running : TRUE
21-05-2008 17:18:15.612 [910]Ending thread 0x1c4, 0x1a4935a0
21-05-2008 17:18:15.612 [910]Got lock.
21-05-2008 17:18:15.612 [910]Notifying thread...
21-05-2008 17:18:15.612 [910]Set done.
21-05-2008 17:18:15.612 [adc]Scheduler done.
21-05-2008 17:18:15.612 [910]Waiting for thread to end...
21-05-2008 17:18:15.613 [910]Waiting done
21-05-2008 17:18:15.613 [910]Ending thread 0xf5c, 0x1a4935c4
21-05-2008 17:18:15.613 [910]Got lock.
21-05-2008 17:18:15.613 [910]Notifying thread...
21-05-2008 17:18:15.613 [910]Set done.
21-05-2008 17:18:15.613 [910]Waiting for thread to end...
21-05-2008 17:18:15.613 [844]Worker done.
21-05-2008 17:18:15.613 [910]Waiting done
21-05-2008 17:18:15.613 [910]ReleaseSurfaces()
21-05-2008 17:18:15.614 [910]Releasing device
21-05-2008 17:18:15.614 [910]ReleaseSurfaces() done
21-05-2008 17:18:15.614 [910]Done
21-05-2008 17:18:15.614 [910]EVRDeinit:m_evrPresenter release:0
21-05-2008 17:18:15.614 [910]Unloading EVR libraries
21-05-2008 17:18:15.614 [910]Freeing library DXVA2.dll
21-05-2008 17:18:15.614 [910]Freeing lib: EVR.dll
21-05-2008 17:18:15.614 [910]Freeing lib: MFPLAT.dll


Good luck Iosu!

 

[iosub]

Try this...

 

[Swede]

Test results: Faster but still a short "no resp..." when stopping movie in "Files" mode.

Something is funny here, The log says 1 second, but the real time from pressing stop until the "no resp..." window is 5 sec. That is not shown in any log.

Here I did an exit exactly when the Videos menu came back. The "no resp..." window comes in between these lines. No log has any information about that time.

2008-05-22 10:32:56.085529 [Debug][MPMain]: Window: MediaPortal.GUI.Video.GUIVideoFiles init
2008-05-22 10:33:02.605619 [Info.][MPMain]: D3D: Minimizing to tray on GUI exit
[

B]Log "Title" mode:[/B]
2008-05-22 09:45:24.777225 [Info.][MPMain]: g_Player.OnStopped()
2008-05-22 09:45:24.789919 [Info.][MPMain]: GUIVideoFiles: OnPlayBackStopped idFile=357 timeMovieStopped=242 resumeData=
2008-05-22 09:45:24.795778 [Debug][MPMain]: GUIVideoFiles: OnPlayBackStopped store resume time
2008-05-22 09:45:24.796755 [Info.][MPMain]: TvRecorded:OnStopped Video C:\Filmer\10,000 BC.avi
2008-05-22 09:45:24.796755 [Info.][MPMain]: g_Player.doStop() - stop
2008-05-22 09:45:24.797731 [Info.][MPMain]: VideoPlayer:ended C:\Filmer\10,000 BC.avi
2008-05-22 09:45:24.797731 [Info.][MPMain]: VideoPlayer9:cleanup DShow graph
2008-05-22 09:45:24.802614 [Info.][17]: planescene: PresentSurface() frame:25 enabled:False allowed:True 688x272
2008-05-22 09:45:24.822144 [Info.][MPMain]: state: Stopped 0
2008-05-22 09:45:24.823120 [Debug][MPMain]: VMR9: Dispose
2008-05-22 09:45:24.824097 [Debug][MPMain]: VMR9: Inactive
2008-05-22 09:45:24.825073 [Info.][MPMain]: VMR9: ReleaseComObject(): 0
2008-05-22 09:45:24.826050 [Info.][MPMain]: PlaneScene: PresentImage() dispose surfaces
2008-05-22 09:45:24.827026 [Info.][MPMain]: PlaneScene: PresentSurface() dispose surfaces
2008-05-22 09:45:25.134624 [Info.][MPMain]: VideoPlayerVMR9: Disabling DX9 exclusive mode
2008-05-22 09:45:25.135600 [Info.][MPMain]: Main: Received DX exclusive mode switch message. Fullscreen && maximized == False
2008-05-22 09:45:25.136577 [Debug][MPMain]: Main: Goto windowed mode: True
2008-05-22 09:45:25.136577 [Info.][MPMain]: fonts.SetDevice()
2008-05-22 09:45:25.137553 [Debug][MPMain]: Windowmanager: Goto previous window
2008-05-22 09:45:25.138530 [Debug][MPMain]: Window: MediaPortal.GUI.Video.GUIVideoFullscreen deinit
2008-05-22 09:45:25.141459 [Debug][MPMain]: TextureManager: CleanupThumbs()
2008-05-22 09:45:25.206885 [Debug][MPMain]: Window: MediaPortal.GUI.Video.GUIVideoTitle init


Log "Files" mode:
2008-05-22 09:44:42.961542 [Info.][MPMain]: g_Player.OnStopped()
2008-05-22 09:44:42.982048 [Info.][MPMain]: GUIVideoFiles: OnPlayBackStopped idFile=357 timeMovieStopped=238 resumeData=
2008-05-22 09:44:42.988884 [Debug][MPMain]: GUIVideoFiles: OnPlayBackStopped store resume time
2008-05-22 09:44:42.992790 [Info.][MPMain]: TvRecorded:OnStopped Video C:\Filmer\10,000 BC.avi
2008-05-22 09:44:42.993766 [Info.][MPMain]: g_Player.doStop() - stop
2008-05-22 09:44:42.996696 [Info.][MPMain]: VideoPlayer:ended C:\Filmer\10,000 BC.avi
2008-05-22 09:44:42.997672 [Info.][MPMain]: VideoPlayer9:cleanup DShow graph
2008-05-22 09:44:42.999625 [Info.][12]: planescene: PresentSurface() frame:17 enabled:False allowed:True 688x272
2008-05-22 09:44:43.022085 [Info.][MPMain]: state: Stopped 0
2008-05-22 09:44:43.024038 [Debug][MPMain]: VMR9: Dispose
2008-05-22 09:44:43.030873 [Debug][MPMain]: VMR9: Inactive
2008-05-22 09:44:43.032826 [Info.][MPMain]: VMR9: ReleaseComObject(): 0
2008-05-22 09:44:43.034779 [Info.][MPMain]: PlaneScene: PresentImage() dispose surfaces
2008-05-22 09:44:43.036732 [Info.][MPMain]: PlaneScene: PresentSurface() dispose surfaces
2008-05-22 09:44:43.606032 [Info.][MPMain]: VideoPlayerVMR9: Disabling DX9 exclusive mode
2008-05-22 09:44:43.607008 [Info.][MPMain]: Main: Received DX exclusive mode switch message. Fullscreen && maximized == False
2008-05-22 09:44:43.607008 [Debug][MPMain]: Main: Goto windowed mode: True
2008-05-22 09:44:43.607985 [Info.][MPMain]: fonts.SetDevice()
2008-05-22 09:44:43.611891 [Debug][MPMain]: Windowmanager: Goto previous window
2008-05-22 09:44:43.612867 [Debug][MPMain]: Window: MediaPortal.GUI.Video.GUIVideoFullscreen deinit
2008-05-22 09:44:43.616773 [Debug][MPMain]: TextureManager: CleanupThumbs()
2008-05-22 09:44:43.685128 [Debug][MPMain]: Window: MediaPortal.GUI.Video.GUIVideoFiles init


VMR log:
22-05-2008 09:44:43.016 [f58]OnClockPause
22-05-2008 09:44:43.020 [f58]OnClockStop
22-05-2008 09:44:43.020 [f58]ProcessMessage 4
22-05-2008 09:44:43.030 [f58]QueryInterface
22-05-2008 09:44:43.030 [f58]riid: {FA99388A-4383-415A-A930-DD472A8CF6F7}
22-05-2008 09:44:43.030 [f58]EVRCustomPresenter::AddRef()
22-05-2008 09:44:43.030 [f58]ReleaseServicePointers
22-05-2008 09:44:43.030 [f58]EVRCustomPresenter::Release()
22-05-2008 09:44:43.031 [f58]EVRCustomPresenter::Release()
22-05-2008 09:44:43.031 [f58]EVRCustomPresenter::Release()
22-05-2008 09:44:43.032 [f58]EVRCustomPresenter::Release()
22-05-2008 09:44:43.032 [f58]EVRCustomPresenter::Cleanup()
22-05-2008 09:44:43.035 [f58]Stopping workers...
22-05-2008 09:44:43.035 [f58]Threads running : TRUE
22-05-2008 09:44:43.035 [f58]Ending thread 0x9bc, 0xdb22860
22-05-2008 09:44:43.035 [f58]Got lock.
22-05-2008 09:44:43.035 [f58]Notifying thread...
22-05-2008 09:44:43.035 [f58]Set done.
22-05-2008 09:44:43.035 [f58]Waiting for thread to end...
22-05-2008 09:44:43.035 [d64]Scheduler done.
22-05-2008 09:44:43.035 [f58]Waiting done
22-05-2008 09:44:43.035 [f58]Ending thread 0x9c0, 0xdb22884
22-05-2008 09:44:43.035 [f58]Got lock.
22-05-2008 09:44:43.035 [f58]Notifying thread...
22-05-2008 09:44:43.035 [f58]Set done.
22-05-2008 09:44:43.035 [f58]Waiting for thread to end...
22-05-2008 09:44:43.035 [ba0]Worker done.
22-05-2008 09:44:43.035 [f58]Waiting done
22-05-2008 09:44:43.035 [f58]ReleaseSurfaces()
22-05-2008 09:44:43.036 [f58]Releasing device
22-05-2008 09:44:43.036 [f58]ReleaseSurfaces() done
22-05-2008 09:44:43.036 [f58]Done
22-05-2008 09:44:43.036 [f58]EVRDeinit:m_evrPresenter release:0
22-05-2008 09:44:43.036 [f58]Unloading EVR libraries
22-05-2008 09:44:43.036 [f58]Freeing library DXVA2.dll
22-05-2008 09:44:43.036 [f58]Freeing lib: EVR.dll
22-05-2008 09:44:43.036 [f58]Freeing lib: MFPLAT.dll
22-05-2008 09:45:18.986 [f58]Loading EVR libraries
22-05-2008 09:45:18.986 [f58]Found dxva2.dll
22-05-2008 09:45:18.986 [f58]Found method DXVA2CreateDirect3DDeviceManager9
22-05-2008 09:45:18.987 [f58]Found method MFCreateVideoSampleFromSurface
22-05-2008 09:45:18.987 [f58]Found method MFCreateMediaType
22-05-2008 09:45:18.987 [f58]Successfully loaded EVR dlls

 

[iosub]

Here I did an exit exactly when the Videos menu came back. The "no resp..." window comes in between these lines. No log has any information about that time.

2008-05-22 10:32:56.085529 [Debug][MPMain]: Window: MediaPortal.GUI.Video.GUIVideoFiles init
2008-05-22 10:33:02.605619 [Info.][MPMain]: D3D: Minimizing to tray on GUI exit


ReCheck the above with the new file

 

[Swede]

Hmm, strange, it doesn't seem to be faster but I didn't get any "no resp..."
I did an exit exactly when MP Videos showed up, 7 sec after pressing stop

2008-05-22 20:21:36.091046 [Info.][MPMain]: g_Player.OnStopped()
2008-05-22 20:21:36.108623 [Info.][MPMain]: GUIVideoFiles: OnPlayBackStopped idFile=357 timeMovieStopped=257 resumeData=
2008-05-22 20:21:36.113505 [Debug][MPMain]: GUIVideoFiles: OnPlayBackStopped store resume time
2008-05-22 20:21:36.114482 [Info.][MPMain]: TvRecorded:OnStopped Video C:\Filmer\10,000 BC.avi
2008-05-22 20:21:36.115458 [Info.][MPMain]: g_Player.doStop() - stop
2008-05-22 20:21:36.116435 [Info.][MPMain]: VideoPlayer:ended C:\Filmer\10,000 BC.avi
2008-05-22 20:21:36.117411 [Info.][MPMain]: VideoPlayer9:cleanup DShow graph
2008-05-22 20:21:36.130106 [Info.][3]: planescene: PresentSurface() frame:11 enabled:False allowed:True 688x272
2008-05-22 20:21:36.144753 [Info.][MPMain]: state: Stopped 0
2008-05-22 20:21:36.145730 [Debug][MPMain]: VMR9: Dispose
2008-05-22 20:21:36.146706 [Debug][MPMain]: VMR9: Inactive
2008-05-22 20:21:36.148659 [Info.][MPMain]: VMR9: ReleaseComObject(): 0
2008-05-22 20:21:36.148659 [Info.][MPMain]: PlaneScene: PresentImage() dispose surfaces
2008-05-22 20:21:36.150612 [Info.][MPMain]: PlaneScene: PresentSurface() dispose surfaces
2008-05-22 20:21:36.830256 [Info.][MPMain]: VideoPlayerVMR9: Disabling DX9 exclusive mode
2008-05-22 20:21:36.831233 [Info.][MPMain]: Main: Received DX exclusive mode switch message. Fullscreen && maximized == False
2008-05-22 20:21:36.832209 [Debug][MPMain]: Main: Goto windowed mode: True
2008-05-22 20:21:36.833186 [Info.][MPMain]: fonts.SetDevice()
2008-05-22 20:21:36.833186 [Debug][MPMain]: Windowmanager: Goto previous window
2008-05-22 20:21:36.835139 [Debug][MPMain]: Window Iosu SpeepUp: MediaPortal.GUI.Video.GUIVideoFullscreen deinit
2008-05-22 20:21:36.839045 [Debug][MPMain]: TextureManager: CleanupThumbs()
2008-05-22 20:21:36.934742 [Debug][MPMain]: Window Iosu Speedup: MediaPortal.GUI.Video.GUIVideoFiles init
2008-05-22 20:21:43.211684 [Info.][MPMain]: D3D: Minimizing to tray on GUI exit

 

[iosub]

Yes I now, is no faster, What I'm doing is giving time to other precess so, Vista "thinks" that the app is "responding" is a trick...
Keep testing.. If works.. I will tell some dev to try to include on a SVN

Iosu

 

[Swede]

You smart man

This log is from when I started TV this morning. It felt like it took unnessesary long time, so I checked the log and wonder over some things marked with colors.

Why stop radio when no radio exists and no radio plugin is enabled?

Why is BASS doing anything now? Is BASS used by g_Player for playing TV? Visualization??? BASS is not enabled in music config

Why is this happening twize? Once without cropping.

What does Video database have to to with playing TV?

2008-05-23 09:30:13.026458 [Info.][GenericPCQueue]: Executing: key 0 / 0 / Action: 7 / ACTION_SELECT_ITEM
2008-05-23 09:30:13.125084 [Info.][MPMain]: TVHome.ViewChannelAndCheck(): View channel=TV4 Göteborg
2008-05-23 09:30:15.404235 [Info.][MPMain]: succeeded: Succeeded TvControl.VirtualCard
2008-05-23 09:30:15.428648 [Info.][MPMain]: tvhome:startplay
2008-05-23 09:30:15.437436 [Info.][MPMain]: tvhome:file: D:\\live1-0.ts.tsbuffer
2008-05-23 09:30:15.447201 [Warn.][MPMain]: tvhome:startplay. Phase 1 - 27 ms - Done method initialization
2008-05-23 09:30:15.448178 [Info.][MPMain]: tvhome:startplay: D:\\live1-0.ts.tsbuffer - using rtsp mode:True
2008-05-23 09:30:15.589770 [Debug][MPMain]: CommandProcessor: add cmd: MediaPortal.TV.Recording.StopRadioCommand #1
2008-05-23 09:30:15.592700 [Info.][MPMain]: g_Player.Play(D:\\live1-0.ts.tsbuffer TV)
2008-05-23 09:30:15.609300 [Info.][CommandProcessor]: Commandprocessor: MediaPortal.TV.Recording.StopRadioCommand failed reason: Inga tv-kort installerade time: 9,765 msec
2008-05-23 09:30:15.780188 [Info.][MPMain]: BASS: Initialize BASS environment ...
2008-05-23 09:30:16.049702 [Info.][MPMain]: Visualization Window: Loading skin settings...
2008-05-23 09:30:16.068255 [Info.][MPMain]: BASS: Creating visualization...
2008-05-23 09:30:16.073138 [Info.][MPMain]: Visualization Manager: Closing current visualization plugin...
2008-05-23 09:30:16.074114 [Info.][MPMain]: Visualization Manager: Visualization plugin close not required - nothing loaded
2008-05-23 09:30:16.075091 [Debug][MPMain]: BASS: Create visualization failed
2008-05-23 09:30:16.078020 [Info.][MPMain]: BASS: Loading audio decoder add-ins...
2008-05-23 09:30:16.145399 [Debug][MPMain]: BASS: Added DecoderPlugin: C:\Program Files\Team MediaPortal\MediaPortal\musicplayer\plugins\audio decoders\basscd.dll
2008-05-23 09:30:16.177623 [Debug][MPMain]: BASS: Added DecoderPlugin: C:\Program Files\Team MediaPortal\MediaPortal\musicplayer\plugins\audio decoders\bassflac.dll
2008-05-23 09:30:16.234260 [Debug][MPMain]: BASS: Added DecoderPlugin: C:\Program Files\Team MediaPortal\MediaPortal\musicplayer\plugins\audio decoders\basswma.dll
2008-05-23 09:30:16.288944 [Debug][MPMain]: BASS: Added DecoderPlugin: C:\Program Files\Team MediaPortal\MediaPortal\musicplayer\plugins\audio decoders\bass_aac.dll
2008-05-23 09:30:16.342652 [Debug][MPMain]: BASS: Added DecoderPlugin: C:\Program Files\Team MediaPortal\MediaPortal\musicplayer\plugins\audio decoders\bass_ac3.dll
2008-05-23 09:30:16.396359 [Debug][MPMain]: BASS: Added DecoderPlugin: C:\Program Files\Team MediaPortal\MediaPortal\musicplayer\plugins\audio decoders\bass_alac.dll
2008-05-23 09:30:16.458855 [Debug][MPMain]: BASS: Added DecoderPlugin: C:\Program Files\Team MediaPortal\MediaPortal\musicplayer\plugins\audio decoders\bass_ape.dll
2008-05-23 09:30:16.518422 [Debug][MPMain]: BASS: Added DecoderPlugin: C:\Program Files\Team MediaPortal\MediaPortal\musicplayer\plugins\audio decoders\bass_mpc.dll
2008-05-23 09:30:16.583847 [Debug][MPMain]: BASS: Added DecoderPlugin: C:\Program Files\Team MediaPortal\MediaPortal\musicplayer\plugins\audio decoders\bass_wv.dll
2008-05-23 09:30:16.584824 [Info.][MPMain]: BASS: Loaded 9 Audio Decoders.
2008-05-23 09:30:16.593612 [Debug][MPMain]: BASS: Loading DSP plugins ...
2008-05-23 09:30:17.134593 [Debug][MPMain]: BASS: Finished loading DSP plugins ...
2008-05-23 09:30:17.135570 [Info.][MPMain]: BASS: Initializing BASS environment done.
2008-05-23 09:30:17.172677 [Info.][MPMain]: TSReaderPlayer play: D:\\live1-0.ts.tsbuffer radio:False
2008-05-23 09:30:17.173653 [Info.][MPMain]: TSReaderPlayer: live tv
2008-05-23 09:30:17.174630 [Info.][MPMain]: TSReaderPlayer: Enabling DX9 exclusive mode
2008-05-23 09:30:17.175606 [Info.][MPMain]: Main: Received DX exclusive mode switch message. Fullscreen && maximized == True
2008-05-23 09:30:17.175606 [Debug][MPMain]: Main: Goto fullscreen: True
2008-05-23 09:30:17.178536 [Info.][MPMain]: fonts.SetDevice()
2008-05-23 09:30:17.179512 [Info.][MPMain]: TSReaderPlayerlay D:\\live1-0.ts.tsbuffer
2008-05-23 09:30:17.217596 [Info.][MPMain]: TSReaderPlayer:cleanup DShow graph False
2008-05-23 09:30:17.217596 [Info.][MPMain]: TSReaderPlayer:grapbuilder=null
2008-05-23 09:30:17.233220 [Info.][MPMain]: TSReaderPlayer: Cleanup done
2008-05-23 09:30:17.263491 [Info.][MPMain]: TSReaderPlayer: GetInterfaces()
2008-05-23 09:30:17.263491 [Info.][MPMain]: TSReaderPlayer:cleanup DShow graph False
2008-05-23 09:30:17.264468 [Info.][MPMain]: TSReaderPlayer:grapbuilder=null
2008-05-23 09:30:17.280092 [Info.][MPMain]: TSReaderPlayer: Cleanup done
2008-05-23 09:30:17.377742 [Info.][MPMain]: TSReaderPlayer: add _vmr9
2008-05-23 09:30:17.441214 [Info.][MPMain]: VMR9: added EVR Renderer to graph
2008-05-23 09:30:17.990007 [Debug][MPMain]: VMR9: Now active
2008-05-23 09:30:17.990984 [Debug][MPMain]: VMR9: Renderer successfully added
2008-05-23 09:30:17.991960 [Info.][MPMain]: TSReaderPlayer: add codecs
2008-05-23 09:30:17.993913 [Info.][MPMain]: Iosu TsReaderPlayer: IsVideoFile TV == Tv or Recording
2008-05-23 09:30:20.750573 [Info.][MPMain]: added filter:Microsoft MPEG-2 Video Decoder to graph
2008-05-23 09:30:20.827716 [Info.][MPMain]: added filter:ffdshow Video Decoder to graph
2008-05-23 09:30:20.837481 [Info.][MPMain]: added filter:ffdshow Audio Decoder to graph
2008-05-23 09:30:20.857011 [Info.][MPMain]: added filter:MONOGRAM AAC Decoder to graph
2008-05-23 09:30:20.870682 [Info.][MPMain]: DirectShowUtils: First try to insert new audio renderer Realtek Digital Output (Realtek
2008-05-23 09:30:20.871659 [Info.][MPMain]: DirectShowUtils: Found audio renderer
2008-05-23 09:30:20.873612 [Debug][MPMain]: DirectShowUtils: added filter:Realtek Digital Output (Realtek to graph
2008-05-23 09:30:20.875565 [Debug][MPMain]: setAsReferenceClock sync source No DX Error
2008-05-23 09:30:20.907789 [Info.][MPMain]: TSReaderPlayer:add TsReader to graph
2008-05-23 09:30:20.908766 [Info.][MPMain]: TSReaderPlayer: open file: D:\\live1-0.ts.tsbuffer
2008-05-23 09:30:20.930249 [Info.][MPMain]: Iosu Termina Abrir
2008-05-23 09:30:20.930249 [Info.][MPMain]: TSReaderPlayer:render TsReader outputs
2008-05-23 09:30:21.464394 [Info.][MPMain]: PlaneScene: PresentSurface() dispose surfaces
2008-05-23 09:30:22.919379 [Info.][MPMain]: TSReaderPlayer: OnInitialized
2008-05-23 09:30:22.920356 [Info.][MPMain]: TSReaderPlayer:running pos:5,59999990463257 duration:-0,034000001847744 0
2008-05-23 09:30:22.923285 [Info.][MPMain]: g_Player.OnStarted() D:\\live1-0.ts.tsbuffer media:TV
2008-05-23 09:30:22.940862 [Debug][MPMain]: GUITVCropManager.g_Player_PlackBackStarted: media: TV tv:True ts:True
2008-05-23 09:30:22.944768 [Info.][MPMain]: TvCropManager.SendCropMessage(): 9, 9, 12, 12
2008-05-23 09:30:22.956486 [Warn.][MPMain]: tvhome:startplay. Phase 2 - 7508 ms - Done starting g_Player.Play()
2008-05-23 09:30:22.959416 [Debug][MPMain]: g_Player: ShowFullScreenWindow
2008-05-23 09:30:22.964298 [Info.][MPMain]: g_Player: ShowFullScreenWindow switching to fullscreen tv
2008-05-23 09:30:22.966251 [Debug][MPMain]: Window Iosu SpeepUp: TvPlugin.TVGuide deinit
2008-05-23 09:30:23.012147 [Info.][16]: PlaneScene: PresentSurface() dispose surfaces
2008-05-23 09:30:23.205494 [Debug][MPMain]: TextureManager: CleanupThumbs()
2008-05-23 09:30:23.266037 [Debug][MPMain]: Window Iosu Speedup: TvPlugin.TvFullScreen init
2008-05-23 09:30:23.405676 [Info.][MPMain]: xml:C:\Program Files\Team MediaPortal\MediaPortal\Skin\Xface\tvOSD.xml image id:304 width:0 height:0 gfx:-
2008-05-23 09:30:23.415441 [Info.][MPMain]: xml:C:\Program Files\Team MediaPortal\MediaPortal\Skin\Xface\tvOSD.xml image id:350 width:0 height:0 gfx:-
2008-05-23 09:30:23.853890 [Info.][MPMain]: TexturePacker: Loaded C:\ProgramData\Team MediaPortal\MediaPortal\Cache\Xface\packedgfx25.png texture:2048x2048 miplevels:1
2008-05-23 09:30:23.854866 [Info.][MPMain]: TexturePacker: fontengine add texure:1993
2008-05-23 09:30:23.872443 [Debug][MPMain]: TvFullScreen:init->OSD:Off
2008-05-23 09:30:23.877326 [Debug][MPMain]: TvFullScreen: init, playing True, player.CurrentFile D:\\live1-0.ts.tsbuffer, TVHome.Card.TimeShiftFileName D:\\live1-0.ts.tsbuffer
2008-05-23 09:30:23.926151 [Info.][17]: PlaneScene: crop T, B : 0, 0
2008-05-23 09:30:23.927127 [Info.][17]: PlaneScene: crop L, R : 0, 0
2008-05-23 09:30:23.927127 [Info.][17]: PlaneScene: video WxH : 720x576
2008-05-23 09:30:23.928104 [Info.][17]: PlaneScene: video AR : 16:9
2008-05-23 09:30:23.928104 [Info.][17]: PlaneScene: screen WxH : 1360x768
2008-05-23 09:30:23.929080 [Info.][17]: PlaneScene: AR type : Zoom
2008-05-23 09:30:23.929080 [Info.][17]: PlaneScene: PixelRatio : 1
2008-05-23 09:30:23.930057 [Info.][17]: PlaneScene: src : (1,0)-(718,576)
2008-05-23 09:30:23.930057 [Info.][17]: PlaneScene: dst : (0,0)-(1360,768)
2008-05-23 09:30:23.958375 [Info.][MPMain]: PlaneScene: Crop: top:9, bottom:9, left:12, right:12
2008-05-23 09:30:23.981811 [Info.][17]: opening video database
2008-05-23 09:30:24.017942 [Info.][17]: video database opened
2008-05-23 09:30:24.072626 [Info.][17]: PlaneScene: crop T, B : 9, 9
2008-05-23 09:30:24.074579 [Info.][17]: PlaneScene: crop L, R : 12, 12
2008-05-23 09:30:24.075555 [Info.][17]: PlaneScene: video WxH : 720x576
2008-05-23 09:30:24.076532 [Info.][17]: PlaneScene: video AR : 16:9
2008-05-23 09:30:24.077508 [Info.][17]: PlaneScene: screen WxH : 1360x768
2008-05-23 09:30:24.078485 [Info.][17]: PlaneScene: AR type : Zoom
2008-05-23 09:30:24.078485 [Info.][17]: PlaneScene: PixelRatio : 1
2008-05-23 09:30:24.079461 [Info.][17]: PlaneScene: src : (13,9)-(706,567)
2008-05-23 09:30:24.080438 [Info.][17]: PlaneScene: dst : (0,0)-(1360,768)
2008-05-23 09:30:24.363623 [Debug][MPMain]: VMR9Helper: Playing -> Repainting, Frames 67
2008-05-23 09:30:24.365576 [Info.][17]: planescene: PresentSurface() frame:67 enabled:True allowed:False 720x576
2008-05-23 09:30:24.385106 [Info.][17]: planescene: PresentSurface() frame:68 enabled:True allowed:False 720x576
2008-05-23 09:30:24.404636 [Info.][17]: planescene: PresentSurface() frame:69 enabled:True allowed:False 720x576
2008-05-23 09:30:24.413424 [Debug][MPMain]: VMR9: Repainting -> Playing, Frames: 70