SageTV V6.0.16 RC1 is Now Available

[salsbst]

Originally Posted by blade

I don't think it's as simple as Sage turning off FSE. According to what salsbst said Sage is still using FSE. Also if you use fraps you can see the actual framerate. With FSE enabled I'm typically getting 42-44 fps. If I actually turn it off I'm only getting 18-22 fps. So I have no doubts that FSE is doing something. If it wasn't for the fact that sometimes I get perfectly smooth playback at the full 60 fps I would just think my video card wasn't up to the task.

BTW the 60 fps is what you should expect with the Nvidia decoder. I didn't mention that before.

I am not stating that Sage is using FSE consistently and correctly on my box (maybe it is, maybe it isn't). I do agree that at the very least, I demonstrated that at some point, Sage is preventing other windows from being displayed, so at the very least, it is trying to benefit from FSE.

[salsbst]

I've linked to two log files:

http://stusals.com/sagelog1-medium-dx9.txt
http://stusals.com/sagelog2-medium-ovl.txt

The first is us watching Medium last night on a machine that is still able to do VMR9 without constant stuttering. The second shows us watching the same show (last third of it) on the machine that can no longer do VMR9, thus is using overlay.

Now, I can't read the log files with any degree of knowledge, but it's interesting to me that under VMR9, Sage is logging at the rate of 15.4k per minute, while under overlay, it's logging at a rate of 3.6k per minute.

Is the heavy logging causing stuttering on clients that are on the cusp of having enough CPU/video card juice? Or is 15.4k per minute a sign of problems in the rendering? Or does this mean nothing? Under overlay, Sage can go minutes at a time without logging anything. In VMR9, it appears that this stuff is pretty much constant:

Thu 12/14 21:52:23.211 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null])
Thu 12/14 21:52:23.212 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true
Thu 12/14 21:52:23.212 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null]
Thu 12/14 21:52:23.212 DShowMediaPlayer is consuming the events...
Thu 12/14 21:52:23.212 Event: 0x8065
Thu 12/14 21:52:23.212 VF processing job null nPlayin=true
Thu 12/14 21:52:23.213 isRec=false rd=3595675 base=1844813
Thu 12/14 21:52:23.213 VF thread is now waiting for 0:29:10.612
Thu 12/14 21:52:23.224 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null])
Thu 12/14 21:52:23.225 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true
Thu 12/14 21:52:23.225 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null]
Thu 12/14 21:52:23.225 DShowMediaPlayer is consuming the events...
Thu 12/14 21:52:23.225 Event: 0x8065
Thu 12/14 21:52:23.225 VF processing job null nPlayin=true
Thu 12/14 21:52:23.226 isRec=false rd=3595675 base=1844826
Thu 12/14 21:52:23.226 VF thread is now waiting for 0:29:10.599
Thu 12/14 21:52:23.234 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null])
Thu 12/14 21:52:23.234 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true
Thu 12/14 21:52:23.235 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null]
Thu 12/14 21:52:23.235 DShowMediaPlayer is consuming the events...
Thu 12/14 21:52:23.236 Event: 0x8065
Thu 12/14 21:52:23.236 VF processing job null nPlayin=true
Thu 12/14 21:52:23.236 isRec=false rd=3595675 base=1844836
Thu 12/14 21:52:23.236 VF thread is now waiting for 0:29:10.589
Thu 12/14 21:52:23.269 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null])
Thu 12/14 21:52:23.269 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true
Thu 12/14 21:52:23.270 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null]
Thu 12/14 21:52:23.270 DShowMediaPlayer is consuming the events...
Thu 12/14 21:52:23.270 Event: 0x8065
Thu 12/14 21:52:23.270 VF processing job null nPlayin=true
Thu 12/14 21:52:23.276 isRec=false rd=3595675 base=1844870
Thu 12/14 21:52:23.276 VF thread is now waiting for 0:29:10.555
Thu 12/14 21:52:23.279 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null])
Thu 12/14 21:52:23.279 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true
Thu 12/14 21:52:23.279 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null]
Thu 12/14 21:52:23.279 DShowMediaPlayer is consuming the events...
Thu 12/14 21:52:23.280 Event: 0x8065
Thu 12/14 21:52:23.280 VF processing job null nPlayin=true
Thu 12/14 21:52:23.280 isRec=false rd=3595675 base=1844870
Thu 12/14 21:52:23.280 VF thread is now waiting for 0:29:10.555
Thu 12/14 21:52:23.292 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null])
Thu 12/14 21:52:23.292 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true
Thu 12/14 21:52:23.293 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null]
Thu 12/14 21:52:23.293 DShowMediaPlayer is consuming the events...
Thu 12/14 21:52:23.293 Event: 0x8065
Thu 12/14 21:52:23.298 VF processing job null nPlayin=true
Thu 12/14 21:52:23.299 isRec=false rd=3595675 base=1844870
Thu 12/14 21:52:23.300 VF thread is now waiting for 0:29:10.555
Thu 12/14 21:52:23.420 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null])
Thu 12/14 21:52:23.420 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true
Thu 12/14 21:52:23.421 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null]
Thu 12/14 21:52:23.421 DShowMediaPlayer is consuming the events...
Thu 12/14 21:52:23.421 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null])
Thu 12/14 21:52:23.421 Event: 0x8065
Thu 12/14 21:52:23.422 Event: 0x8065
Thu 12/14 21:52:23.422 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true
Thu 12/14 21:52:23.422 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null]
Thu 12/14 21:52:23.423 DShowMediaPlayer is consuming the events...
Thu 12/14 21:52:23.423 VF processing job null nPlayin=true
Thu 12/14 21:52:23.423 isRec=false rd=3595675 base=1844870
Thu 12/14 21:52:23.424 VF thread is now waiting for 0:29:10.555
Thu 12/14 21:52:23.434 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null])
Thu 12/14 21:52:23.435 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true
Thu 12/14 21:52:23.435 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null]
Thu 12/14 21:52:23.435 DShowMediaPlayer is consuming the events...

Final note: huge bonus points if anyone reading these logs can figure out why both machines pause/choke several times during a show for 15 seconds at a time. I believe these are two separate problems (since this latter one effects both VMR9 and overlay).

[mitchgibbs]

Sorry if this has already been addressed. I searched the forums and couldn't find anything.

Even though I don't have any HD tuners, I'd like to include some of the digital channels on my sage box. They occasionally have standard def shows that are either different from their non-digital equivalents or the scheduling is different.

However, I don't want Sage to try to record any HD content. Is there a property I can set, sort of the opposite of prefer_hdtv_recordings_over_sdtv, or do I have to resort to channel restricting my favorites?

Thanks!

Mitch

[cummings66]

I don't think there is a flag for that. However, recording a digital channel requires a tuner capable of that, and if it can do that it can record HD. You said you can't do that so adding the channel lineup will cause you problems. Just because a digital channel shows a SD program does not mean they show it in an analog format.

So you will not be able to watch it no matter what you do unless you buy a tuner card for digital reception such as the Vbox DTA150 which is a pretty good card.

[Narflex]

This stuff in the log:

Thu 12/14 21:52:23.225 Event: 0x8065
Thu 12/14 21:52:23.225 VF processing job null nPlayin=true
Thu 12/14 21:52:23.226 isRec=false rd=3595675 base=1844826
Thu 12/14 21:52:23.226 VF thread is now waiting for 0:29:10.599
Thu 12/14 21:52:23.234 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null])
Thu 12/14 21:52:23.234 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true
Thu 12/14 21:52:23.235 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null]
Thu 12/14 21:52:23.235 DShowMediaPlayer is consuming the events...


Refers to errors detected by the decoder in the stream. Don't know why it only outputs them when using VMR9....only NVidia would know the answer to that (or whoever makes the decoder you're using).

V6.0.17 RC2 has debug logging off by default so you can try that and you won't see any of that stuff logged. It could very possibly be what's causing your stuttering problems.

[salsbst]

Originally Posted by Narflex

This stuff in the log:

Thu 12/14 21:52:23.225 Event: 0x8065
Thu 12/14 21:52:23.225 VF processing job null nPlayin=true
Thu 12/14 21:52:23.226 isRec=false rd=3595675 base=1844826
Thu 12/14 21:52:23.226 VF thread is now waiting for 0:29:10.599
Thu 12/14 21:52:23.234 VF.submitJob(VFJob[DirectControl r=0.0 t=0 file=null ifn=null])
Thu 12/14 21:52:23.234 VF processing job VFJob[DirectControl r=0.0 t=0 file=null ifn=null] nPlayin=true
Thu 12/14 21:52:23.235 VF processing on UI Thread VFJob[DirectControl r=0.0 t=0 file=null ifn=null]
Thu 12/14 21:52:23.235 DShowMediaPlayer is consuming the events...


Refers to errors detected by the decoder in the stream. Don't know why it only outputs them when using VMR9....only NVidia would know the answer to that (or whoever makes the decoder you're using).

V6.0.17 RC2 has debug logging off by default so you can try that and you won't see any of that stuff logged. It could very possibly be what's causing your stuttering problems.

Makes sense. The first client (with all the errors listed) is running Nvidia/VMR9. It's a more powerful machine, which is, I assume, why it is still able to do this combo.

The second client (with fewer errors) is runnign PowerDVD/Overlay. I guess PowerDVD isn't being as wordy about the errors (or possibly it is not noticing them at all).

I'll try with logging off tonight. It would be thrilling to go back to VMR9!