[other] Problems with dropping frames with EVR (1 Viewer)

[tourettes]

So the audio dropouts have something to do with LiveTV and timeshifting IMO because the TS file is fine...

Any ideas what is causing this?

I still bet on the audio and video clock drifting. Did you test with the analog audio souce? EVR doesn't show any dropped frames as TsReader is patching the gap between audio and video stream.

 

[MPUserFromGER]

Cannot test analog audio because I do not have an analog sound card...

Is it possible to do the test in any other way?
Maybe you can provide a modified MP file that disables audio...

Also, assuming that you are right tourettes with "the audio and video clock drifting", what could I do to fix this?

 

[tourettes]

Maybe you can provide a modified MP file that disables audio...

Only way would be to let audio and video clocks run non-syncrhonized, but at least currently I don't have enough free time to provide such. Maybe someone else can provide the modified binaries?

Most likely TsReader needs to be modified to not to patch timestamps and TsReaderPlayer to not to set the audio renderer as sync source.

 

[MPUserFromGER]

Only way would be to let audio and video clocks run non-syncrhonized

But would that not cause that audio and video get completely out of sync?

The question for me really is, why does this only happen occasionaly and if it happens, it happens more or less constantly until MP is restarted...

 

[tourettes]

Only way would be to let audio and video clocks run non-syncrhonized

But would that not cause that audio and video get completely out of sync?

As much as the audio and video clocks dift apart.

The question for me really is, why does this only happen occasionaly and if it happens, it happens more or less constantly until MP is restarted...

Sorry, no clue why restarting MP is clearing the situation.

 

[Justchill]

Sorry for this question, but what are dropped frames, how can you see that?

I have 1.1.0BETA + 30-11SVN and I'm experiencing some stuttering video playback (vista/EVR/MPC-HC/FFDSHOW audio), but only when using MPC-HC subtitle decoder..

evr.log

23-12-2009 00:10:54.920 [d48]Loading EVR libraries
23-12-2009 00:10:54.920 [d48]Found dxva2.dll
23-12-2009 00:10:54.920 [d48]Found method DXVA2CreateDirect3DDeviceManager9
23-12-2009 00:10:54.920 [d48]Found method MFCreateVideoSampleFromSurface
23-12-2009 00:10:54.920 [d48]Found method MFCreateVideoMediaType
23-12-2009 00:10:54.920 [d48]Found method MFCreateMediaType
23-12-2009 00:10:54.920 [d48]Successfully loaded EVR dlls
23-12-2009 00:10:54.921 [d48]----------v0.4---------------------------
23-12-2009 00:10:54.921 [d48]GetDeviceID
23-12-2009 00:10:54.921 [d48]GetService
23-12-2009 00:10:54.921 [d48]guid: {1092A86C-AB1A-459A-A336-831FBC4D11FF}
23-12-2009 00:10:54.921 [d48]riid: {A0CADE0F-06D5-4CF4-A1C7-F3CDD725AA75}
23-12-2009 00:10:55.011 [d48]InitServicePointers
23-12-2009 00:10:55.011 [d48]ReleaseServicePointers
23-12-2009 00:10:55.011 [d48]Found mixers: 1
23-12-2009 00:10:55.011 [d48]ERR: Could not get IMFClock interface
23-12-2009 00:10:55.011 [d48]Found event sink: 1
23-12-2009 00:10:55.011 [d48]ReleaseServicePointers
23-12-2009 00:10:55.011 [d48]InitServicePointers
23-12-2009 00:10:55.011 [d48]ReleaseServicePointers
23-12-2009 00:10:55.011 [d48]Found mixers: 1
23-12-2009 00:10:55.011 [d48]ERR: Could not get IMFClock interface
23-12-2009 00:10:55.011 [d48]Found event sink: 1
23-12-2009 00:10:55.011 [d48]ReleaseServicePointers
23-12-2009 00:10:55.011 [d48]InitServicePointers
23-12-2009 00:10:55.011 [d48]ReleaseServicePointers
23-12-2009 00:10:55.011 [d48]Found mixers: 1
23-12-2009 00:10:55.011 [d48]ERR: Could not get IMFClock interface
23-12-2009 00:10:55.011 [d48]Found event sink: 1
23-12-2009 00:10:55.011 [d48]ReleaseServicePointers
23-12-2009 00:10:55.132 [d48]InitServicePointers
23-12-2009 00:10:55.133 [d48]ReleaseServicePointers
23-12-2009 00:10:55.133 [d48]Found mixers: 1
23-12-2009 00:10:55.133 [d48]ERR: Could not get IMFClock interface
23-12-2009 00:10:55.133 [d48]Found event sink: 1
23-12-2009 00:10:55.133 [d48]ReleaseServicePointers
23-12-2009 00:10:55.133 [d48]InitServicePointers
23-12-2009 00:10:55.133 [d48]ReleaseServicePointers
23-12-2009 00:10:55.133 [d48]Found mixers: 1
23-12-2009 00:10:55.133 [d48]ERR: Could not get IMFClock interface
23-12-2009 00:10:55.133 [d48]Found event sink: 1
23-12-2009 00:10:55.133 [d48]ReleaseServicePointers
23-12-2009 00:10:55.133 [d48]InitServicePointers
23-12-2009 00:10:55.133 [d48]ReleaseServicePointers
23-12-2009 00:10:55.133 [d48]Found mixers: 1
23-12-2009 00:10:55.133 [d48]ERR: Could not get IMFClock interface
23-12-2009 00:10:55.133 [d48]Found event sink: 1
23-12-2009 00:10:55.133 [d48]ReleaseServicePointers
23-12-2009 00:10:55.229 [d48]InitServicePointers
23-12-2009 00:10:55.229 [d48]ReleaseServicePointers
23-12-2009 00:10:55.229 [d48]Found mixers: 1
23-12-2009 00:10:55.229 [d48]ERR: Could not get IMFClock interface
23-12-2009 00:10:55.229 [d48]Found event sink: 1
23-12-2009 00:10:55.229 [d48]ReleaseServicePointers
23-12-2009 00:10:55.229 [d48]InitServicePointers
23-12-2009 00:10:55.229 [d48]ReleaseServicePointers
23-12-2009 00:10:55.229 [d48]Found mixers: 1
23-12-2009 00:10:55.229 [d48]ERR: Could not get IMFClock interface
23-12-2009 00:10:55.229 [d48]Found event sink: 1
23-12-2009 00:10:55.229 [d48]ReleaseServicePointers
23-12-2009 00:10:55.229 [d48]InitServicePointers
23-12-2009 00:10:55.229 [d48]ReleaseServicePointers
23-12-2009 00:10:55.229 [d48]Found mixers: 1
23-12-2009 00:10:55.229 [d48]ERR: Could not get IMFClock interface
23-12-2009 00:10:55.229 [d48]Found event sink: 1
23-12-2009 00:10:55.230 [d48]ProcessMessage MFVP_MESSAGE_INVALIDATEMEDIATYPE
23-12-2009 00:10:55.230 [d48]RenegotiateMediaOutputType
23-12-2009 00:10:55.230 [d48]Testing media type...
23-12-2009 00:10:55.230 [d48]Successfully cloned media type
23-12-2009 00:10:55.230 [d48]Setting MFVideoTransferMatrix_BT601
23-12-2009 00:10:55.230 [d48]Frame size: 672x368
23-12-2009 00:10:55.230 [d48]Aperture size: 0:0, 672x368
23-12-2009 00:10:55.230 [d48]New media type successfully negotiated!
23-12-2009 00:10:55.230 [d48]Media frame rate: 25 / 1
23-12-2009 00:10:55.230 [d48]Getting aspect ratio 'DirectShow style'
23-12-2009 00:10:55.230 [d48]New format: 672x368, Ratio: 42:23
23-12-2009 00:10:55.230 [d48]guid: {00000016-0000-0010-8000-00AA00389B71}
23-12-2009 00:10:55.230 [d48]ReallocSurfaces
23-12-2009 00:10:55.230 [d48]ReleaseSurfaces()
23-12-2009 00:10:55.230 [d48]Flushing: size=0
23-12-2009 00:10:55.230 [d48]Releasing device
23-12-2009 00:10:55.230 [d48]ReleaseSurfaces() done
23-12-2009 00:10:55.230 [d48]Textures will be 672x368
23-12-2009 00:10:55.231 [d48]Adding sample: 0x952bf40
23-12-2009 00:10:55.231 [d48]Adding sample: 0x952be98
23-12-2009 00:10:55.231 [d48]Adding sample: 0x952bdf0
23-12-2009 00:10:55.231 [d48]Adding sample: 0x952bd48
23-12-2009 00:10:55.231 [d48]Adding sample: 0x952c480
23-12-2009 00:10:55.231 [d48]Releasing device: 274
23-12-2009 00:10:55.231 [d48]ReallocSurfaces done
23-12-2009 00:10:55.231 [d48]Setting media type on mixer
23-12-2009 00:10:55.274 [d48]ReleaseServicePointers
23-12-2009 00:10:55.274 [d48]InitServicePointers
23-12-2009 00:10:55.274 [d48]ReleaseServicePointers
23-12-2009 00:10:55.274 [d48]Found mixers: 1
23-12-2009 00:10:55.274 [d48]Found clock: 1
23-12-2009 00:10:55.274 [d48]Found event sink: 1
23-12-2009 00:10:55.288 [d48]ProcessMessage MFVP_MESSAGE_BEGINSTREAMING
23-12-2009 00:10:55.288 [d48]Starting thread!
23-12-2009 00:10:55.288 [d48]Started thread. id: 0xc44 (3140), handle: 0xc84
23-12-2009 00:10:55.289 [d48]Starting thread!
23-12-2009 00:10:55.289 [d48]Started thread. id: 0x418 (1048), handle: 0x83c
23-12-2009 00:10:55.295 [418]Should not be processing data in pause mode
23-12-2009 00:10:55.379 [f70]ProcessMessage MFVP_MESSAGE_INVALIDATEMEDIATYPE
23-12-2009 00:10:55.379 [f70]RenegotiateMediaOutputType
23-12-2009 00:10:55.379 [f70]Testing media type...
23-12-2009 00:10:55.379 [f70]Successfully cloned media type
23-12-2009 00:10:55.379 [f70]Setting MFVideoTransferMatrix_BT601
23-12-2009 00:10:55.379 [f70]Frame size: 672x368
23-12-2009 00:10:55.379 [f70]Aperture size: 0:0, 672x368
23-12-2009 00:10:55.379 [f70]New media type successfully negotiated!
23-12-2009 00:10:55.379 [f70]Media frame rate: 25 / 1
23-12-2009 00:10:55.379 [f70]Getting aspect ratio 'DirectShow style'
23-12-2009 00:10:55.379 [f70]New format: 672x368, Ratio: 42:23
23-12-2009 00:10:55.379 [f70]guid: {00000016-0000-0010-8000-00AA00389B71}
23-12-2009 00:10:55.379 [f70]ReallocSurfaces
23-12-2009 00:10:55.379 [f70]ReleaseSurfaces()
23-12-2009 00:10:55.393 [f70]Flushing: size=0
23-12-2009 00:10:55.393 [f70]Releasing device
23-12-2009 00:10:55.393 [f70]ReleaseSurfaces() done
23-12-2009 00:10:55.393 [f70]Textures will be 672x368
23-12-2009 00:10:55.393 [f70]Adding sample: 0x952c480
23-12-2009 00:10:55.393 [f70]Adding sample: 0x952bd48
23-12-2009 00:10:55.394 [f70]Adding sample: 0x952bdf0
23-12-2009 00:10:55.394 [f70]Adding sample: 0x952be98
23-12-2009 00:10:55.394 [f70]Adding sample: 0x952bf40
23-12-2009 00:10:55.394 [f70]Releasing device: 241
23-12-2009 00:10:55.394 [f70]ReallocSurfaces done
23-12-2009 00:10:55.394 [f70]Setting media type on mixer
23-12-2009 00:10:55.396 [f70]Should not be processing data in pause mode
23-12-2009 00:10:55.404 [418]Should not be processing data in pause mode
23-12-2009 00:10:55.472 [3f0]OnClockStart
23-12-2009 00:10:55.472 [3f0]Flushing: size=0
23-12-2009 00:10:55.491 [418]Scheduling sample from the past (43 ms, last call to NotifyWorker: 18 ms)
23-12-2009 00:10:55.493 [c44]Dropping frame, behind 45 ms, last sleep time 40 ms.
23-12-2009 00:10:55.496 [c44]Dropping frame, behind 6 ms, last sleep time 40 ms.
23-12-2009 00:10:55.567 [d48]OnClockPause
23-12-2009 00:10:55.567 [c44]Flushing: size=5
23-12-2009 00:10:55.568 [d48]OnClockRestart
23-12-2009 00:10:56.110 [f70]Scheduling sample from the past (566 ms, last call to NotifyWorker: 542 ms)
23-12-2009 00:10:56.110 [c44]Dropping frame, behind 566 ms, last sleep time 40 ms.
23-12-2009 00:10:56.118 [f70]Scheduling sample from the past (533 ms, last call to NotifyWorker: 7 ms)
23-12-2009 00:10:56.118 [c44]Dropping frame, behind 533 ms, last sleep time 40 ms.
23-12-2009 00:10:56.123 [f70]Scheduling sample from the past (498 ms, last call to NotifyWorker: 4 ms)
23-12-2009 00:10:56.123 [c44]Dropping frame, behind 499 ms, last sleep time 40 ms.
23-12-2009 00:10:56.129 [f70]Scheduling sample from the past (464 ms, last call to NotifyWorker: 5 ms)
23-12-2009 00:10:56.129 [c44]Dropping frame, behind 464 ms, last sleep time 40 ms.
23-12-2009 00:10:56.142 [f70]Scheduling sample from the past (437 ms, last call to NotifyWorker: 12 ms)
23-12-2009 00:10:56.142 [c44]Dropping frame, behind 437 ms, last sleep time 40 ms.
23-12-2009 00:10:56.149 [f70]Scheduling sample from the past (404 ms, last call to NotifyWorker: 6 ms)
23-12-2009 00:10:56.149 [c44]Dropping frame, behind 404 ms, last sleep time 40 ms.
23-12-2009 00:10:56.154 [f70]Scheduling sample from the past (369 ms, last call to NotifyWorker: 5 ms)
23-12-2009 00:10:56.155 [c44]Dropping frame, behind 370 ms, last sleep time 40 ms.
23-12-2009 00:10:56.160 [f70]Scheduling sample from the past (335 ms, last call to NotifyWorker: 4 ms)
23-12-2009 00:10:56.160 [c44]Dropping frame, behind 335 ms, last sleep time 40 ms.
23-12-2009 00:10:56.166 [f70]Scheduling sample from the past (301 ms, last call to NotifyWorker: 6 ms)
23-12-2009 00:10:56.167 [c44]Dropping frame, behind 301 ms, last sleep time 40 ms.
23-12-2009 00:10:56.173 [f70]Scheduling sample from the past (268 ms, last call to NotifyWorker: 6 ms)
23-12-2009 00:10:56.173 [c44]Dropping frame, behind 268 ms, last sleep time 40 ms.
23-12-2009 00:10:56.180 [f70]Scheduling sample from the past (235 ms, last call to NotifyWorker: 6 ms)
23-12-2009 00:10:56.180 [c44]Dropping frame, behind 235 ms, last sleep time 40 ms.
23-12-2009 00:10:56.186 [f70]Scheduling sample from the past (200 ms, last call to NotifyWorker: 5 ms)
23-12-2009 00:10:56.186 [c44]Dropping frame, behind 201 ms, last sleep time 40 ms.
23-12-2009 00:10:56.191 [f70]Scheduling sample from the past (166 ms, last call to NotifyWorker: 5 ms)
23-12-2009 00:10:56.191 [c44]Dropping frame, behind 166 ms, last sleep time 40 ms.
23-12-2009 00:10:56.196 [f70]Scheduling sample from the past (131 ms, last call to NotifyWorker: 4 ms)
23-12-2009 00:10:56.196 [c44]Dropping frame, behind 132 ms, last sleep time 40 ms.
23-12-2009 00:10:56.205 [f70]Scheduling sample from the past (100 ms, last call to NotifyWorker: 8 ms)
23-12-2009 00:10:56.205 [c44]Dropping frame, behind 100 ms, last sleep time 40 ms.
23-12-2009 00:10:56.211 [f70]Scheduling sample from the past (67 ms, last call to NotifyWorker: 6 ms)
23-12-2009 00:10:56.212 [c44]Dropping frame, behind 68 ms, last sleep time 40 ms.
23-12-2009 00:10:56.218 [f70]Scheduling sample from the past (34 ms, last call to NotifyWorker: 6 ms)
23-12-2009 00:10:56.218 [c44]Dropping frame, behind 34 ms, last sleep time 40 ms.
23-12-2009 00:10:56.225 [c44]Dropping frame, behind 1 ms, last sleep time 40 ms.
23-12-2009 00:11:08.542 [d48]OnClockPause
23-12-2009 00:11:08.542 [c44]Flushing: size=5
23-12-2009 00:11:08.544 [d48]OnClockRestart
23-12-2009 00:11:08.545 [d48]NotifyRateChange: 1.000000
23-12-2009 00:11:08.674 [f70]Scheduling sample from the past (176 ms, last call to NotifyWorker: 129 ms)
23-12-2009 00:11:08.674 [c44]Dropping frame, behind 176 ms, last sleep time 40 ms.
23-12-2009 00:11:08.679 [f70]Scheduling sample from the past (135 ms, last call to NotifyWorker: 4 ms)
23-12-2009 00:11:08.679 [c44]Dropping frame, behind 135 ms, last sleep time 40 ms.
23-12-2009 00:11:08.685 [f70]Scheduling sample from the past (98 ms, last call to NotifyWorker: 5 ms)
23-12-2009 00:11:08.685 [c44]Dropping frame, behind 98 ms, last sleep time 40 ms.
23-12-2009 00:11:08.690 [f70]Scheduling sample from the past (49 ms, last call to NotifyWorker: 4 ms)
23-12-2009 00:11:08.690 [c44]Dropping frame, behind 50 ms, last sleep time 40 ms.
23-12-2009 00:11:08.695 [f70]Scheduling sample from the past (12 ms, last call to NotifyWorker: 4 ms)
23-12-2009 00:11:08.695 [c44]Dropping frame, behind 12 ms, last sleep time 40 ms.
23-12-2009 00:11:14.054 [d48]OnClockPause
23-12-2009 00:11:14.057 [d48]OnClockStop
23-12-2009 00:11:14.057 [d48]Flushing: size=5
23-12-2009 00:11:14.057 [d48]riid: {60AA1030-904B-4412-88EE-276E8D03D5A1}
23-12-2009 00:11:14.057 [d48]QueryInterface failed
23-12-2009 00:11:14.057 [d48]ProcessMessage MFVP_MESSAGE_ENDSTREAMING
23-12-2009 00:11:14.057 [c44]Flushing: size=0
23-12-2009 00:11:14.059 [d48]ReleaseServicePointers
23-12-2009 00:11:14.059 [d48]InitServicePointers
23-12-2009 00:11:14.060 [d48]ReleaseServicePointers
23-12-2009 00:11:14.060 [d48]Found mixers: 1
23-12-2009 00:11:14.060 [d48]ERR: Could not get IMFClock interface
23-12-2009 00:11:14.060 [d48]Found event sink: 1
23-12-2009 00:11:14.061 [d48]ReleaseServicePointers
23-12-2009 00:11:14.097 [d48]MPEVRCustomPresenter::Cleanup()
23-12-2009 00:11:14.097 [d48]Stopping workers...
23-12-2009 00:11:14.097 [d48]Threads running : TRUE
23-12-2009 00:11:14.097 [d48]Ending thread 0xc84, 0x10731320
23-12-2009 00:11:14.097 [d48]Got lock.
23-12-2009 00:11:14.097 [d48]Notifying thread...
23-12-2009 00:11:14.097 [d48]Set done.
23-12-2009 00:11:14.097 [d48]Waiting for thread to end...
23-12-2009 00:11:14.097 [c44]Scheduler done.
23-12-2009 00:11:14.098 [d48]Waiting done
23-12-2009 00:11:14.098 [d48]Ending thread 0x83c, 0x10731344
23-12-2009 00:11:14.098 [d48]Got lock.
23-12-2009 00:11:14.098 [d48]Notifying thread...
23-12-2009 00:11:14.098 [d48]Set done.
23-12-2009 00:11:14.098 [d48]Waiting for thread to end...
23-12-2009 00:11:14.098 [418]Worker done.
23-12-2009 00:11:14.098 [d48]Waiting done
23-12-2009 00:11:14.098 [d48]ReleaseSurfaces()
23-12-2009 00:11:14.099 [d48]Flushing: size=0
23-12-2009 00:11:14.099 [d48]Releasing device
23-12-2009 00:11:14.099 [d48]ReleaseSurfaces() done
23-12-2009 00:11:14.099 [d48]Done
23-12-2009 00:11:14.099 [d48]EVRDeinit:m_evrPresenter release:0
23-12-2009 00:11:14.099 [d48]Unloading EVR libraries
23-12-2009 00:11:14.099 [d48]Freeing library DXVA2.dll
23-12-2009 00:11:14.099 [d48]Freeing lib: EVR.dll
23-12-2009 00:11:14.099 [d48]Freeing lib: MFPLAT.dll

 

[VASkO]

I posted my findings here:https://forum.team-mediaportal.com/watch-edit-videos-104/stutter-after-refresh-rate-change-71311/index7.html#post550898

As a total fix for the above-mentioned problems with EVR is the change to VMR9. TSReader is not to blame. It's MediaPortal+EVR that sucks. Don't need DXVA, have CoreAVC with CUDA for HD and all troubles are gone.

 

[tourettes]

I posted my findings here:https://forum.team-mediaportal.com/watch-edit-videos-104/stutter-after-refresh-rate-change-71311/index7.html#post550898

As a total fix for the above-mentioned problems with EVR is the change to VMR9. TSReader is not to blame. It's MediaPortal+EVR that sucks. Don't need DXVA, have CoreAVC with CUDA for HD and all troubles are gone.

I didn't see anywhere what OS you are using. If it is XP then using VMR9 is the correct way to go (EVR is not supported by the team under XP). If you are using Windows 7 or Vista, then without using the EVR you are getting tearing as VMR9 would require exclusive directx mode to be used and we dont support such under Vista / Windows 7.

 

[VASkO]

Windows7, but EVR is unusable after last few of SVNs. Heavy dropping of frames and finally freezing of MP happens with DXVA with every single codec available, this is just in MediaPortal. If I rebuilt the same graph as MP builds in GraphStudio and start it from there and it doesn't give a single issue with any source I throw at it. I'm in the process to checkout the whole damn thing from SVN and find what's going on there. Maybe I'll be lucky and can fix something by myself. Maybe not. We'll see.
Under VMR9 there's no DXVA support, thank god for CoreAVC with CUDA. Will try out now if the ION330 HTPC is able to do 1080i with coreAVC CUDA under VMR9 at reasonable FPS...

 

[tourettes]

Windows7, but EVR is unusable after last few of SVNs. Heacy dropping of frames happens with DXVA with every single codec available, this is just in MediaPortal. If I rebuild the same graph as MP builds in GraphStudio and start it from there, there isn't a single issue with any source I throw at it. I'm in the process to checkout the whole damn thing from SVN and find what's going on there. Maybe I'll be lucky and can fix something by myself. Maybe not. We'll see.

For majority it works well, so it would be indeed good if you could dig a bit deeper and try to find the cause for the issues you are experiencing. It would help other people who are seeing the same issues (team's devs and testers haven't reported such issue).

Under VMR9 there's no DXVA support, thank god for CoreAVC with CUDA. Will try out now if the ION HTPC is able to do 1080i with coreAVC CUDA under VMR9 at reasonable FPS...

But with VMR9 you are having tearing, that is a fact. Something that cannot be fixed with any other means than creating a personal version of MP code base that enabled DirectX exclusive mode use for the Windows 7. So it would be better to figure out the issues around the EVR.