<div dir="ltr"><br><div class="gmail_extra"><br><div class="gmail_quote">On Wed, Feb 10, 2016 at 1:33 PM, faginbagin <span dir="ltr"><<a href="mailto:mythtv@hbuus.com" target="_blank">mythtv@hbuus.com</a>></span> wrote:<br><blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex"><span class="">On 2/9/2016 7:41 PM, Jason Zarin wrote:<br>
</span><blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex"><span class="">
<br>
<br>
On Tue, Feb 9, 2016 at 1:58 PM, Jim <<a href="mailto:lists@morton.hrcoxmail.com" target="_blank">lists@morton.hrcoxmail.com</a><br></span><span class="">
<mailto:<a href="mailto:lists@morton.hrcoxmail.com" target="_blank">lists@morton.hrcoxmail.com</a>>> wrote:<br>
<br>
On 2/9/2016 12:31 PM, Jason Zarin wrote:<br>
<br>
This discussion is falling into useless semantics.<br>
<br>
I've done all the recommended fixes in this thread, but nothing<br>
has worked.<br>
<br>
What types of logs should I collect so that the mythtv team can<br>
address the issue?<br>
<br>
Thanks!<br>
<br>
<br>
Earlier in the thread you said you were using Kodi as your frontend.<br>
Have you tried Myth FE and does it exhibit the same behavior? If so<br>
check the frontend logs for clues.<br>
<br>
<br>
<br>
Relevant portion of mythfrontend.log while playing a broken recording:<br>
<br>
Feb 9 19:20:01 MythHTPC mythfrontend.real: mythfrontend[11578]: I<br>
CoreContext tv_play.cpp:1280 (Init) TV: Created TvPlayWindow.<br>
<br>
Feb 9 19:20:01 MythHTPC mythfrontend.real: mythfrontend[11578]: I<br>
CoreContext tv_play.cpp:2225 (HandleStateChange) TV: Attempting to<br>
change from None to WatchingRecording<br>
<br>
Feb 9 19:20:01 MythHTPC mythfrontend.real: mythfrontend[11578]: I<br>
CoreContext mythcorecontext.cpp:426 (ConnectCommandSocket)<br>
MythCoreContext: Connecting to backend server: <a href="http://10.0.1.29:6543" rel="noreferrer" target="_blank">10.0.1.29:6543</a><br></span>
<<a href="http://10.0.1.29:6543" rel="noreferrer" target="_blank">http://10.0.1.29:6543</a>> (try 1 of 1)<div><div class="h5"><br>
<br>
Feb 9 19:20:01 MythHTPC mythfrontend.real: mythfrontend[11578]: E<br>
CoreContext audio/audiooutputalsa.cpp:172 (GetPCMInfo) ALSA:<br>
snd_pcm_info_get_card: Operation not permitted<br>
<br>
Feb 9 19:20:01 MythHTPC mythfrontend.real: mythfrontend[11578]: N<br>
CoreContext audioplayer.cpp:164 (ReinitAudio) AudioPlayer: Enabling Audio<br>
<br>
Feb 9 19:20:01 MythHTPC mythfrontend.real: mythfrontend[11578]: I<br>
CoreContext avformatdecoder.cpp:2141 (ScanStreams) AFD: codec AC3 has 2<br>
channels<br>
<br>
Feb 9 19:20:01 MythHTPC mythfrontend.real: mythfrontend[11578]: I<br>
CoreContext avformatdecoder.cpp:2632 (OpenAVCodec) AFD: Opened codec<br>
0x5958820, id(AC3) type(Audio)<br>
<br>
Feb 9 19:20:01 MythHTPC mythfrontend.real: mythfrontend[11578]: I<br>
CoreContext mythrender_vdpau.cpp:1751 (CheckHardwareSupport) VDPAU:<br>
Version 1<br>
<br>
Feb 9 19:20:01 MythHTPC mythfrontend.real: mythfrontend[11578]: I<br>
CoreContext mythrender_vdpau.cpp:1762 (CheckHardwareSupport) VDPAU:<br>
Information G3DVL VDPAU Driver Shared Library version 1.0<br>
<br>
Feb 9 19:20:01 MythHTPC mythfrontend.real: mythfrontend[11578]: I<br>
CoreContext avformatdecoder.cpp:2632 (OpenAVCodec) AFD: Opened codec<br>
0x587ace0, id(MPEG2VIDEO) type(Video)<br>
<br>
Feb 9 19:20:01 MythHTPC mythfrontend.real: mythfrontend[11578]: I<br>
CoreContext audio/audiooutputbase.cpp:792 (Reconfigure) AOBase: Opening<br>
audio device 'pulse' ch 6(2) sr 48000 sf 32 bit floating point reenc 0<br>
<br>
Feb 9 19:20:02 MythHTPC mythfrontend.real: mythfrontend[11578]: E<br>
CoreContext audio/audiooutputalsa.cpp:961 (OpenMixer) ALSA: no playback<br>
control PCM found on mixer device default<br>
<br>
Feb 9 19:20:02 MythHTPC mythfrontend.real: mythfrontend[11578]: E<br>
CoreContext audio/audiooutputalsa.cpp:497 (OpenDevice) ALSA: Unable to<br>
open audio mixer. Volume control disabled<br>
<br>
Feb 9 19:20:02 MythHTPC mythfrontend.real: mythfrontend[11578]: I<br>
CoreContext mythpainter_ogl.cpp:62 (ClearCache) Clearing OpenGL painter<br>
cache.<br>
<br>
Feb 9 19:20:02 MythHTPC mythfrontend.real: mythfrontend[11578]: I<br>
CoreContext mythrender_vdpau.cpp:1717 (CreatePresentationSurfaces)<br>
VDPAU: Created 2 output surfaces.<br>
<br>
Feb 9 19:20:02 MythHTPC mythfrontend.real: mythfrontend[11578]: I<br>
CoreContext mythrender_vdpau.cpp:424 (Create) VDPAU: Created VDPAU<br>
render device 1920x1080<br>
<br>
Feb 9 19:20:03 MythHTPC mythfrontend.real: mythfrontend[11578]: N<br>
CoreContext mythplayer.cpp:526 (CheckExtraAudioDecode) Player(0):<br>
Forcing decode extra audio option on (Video method requires it).<br>
<br>
Feb 9 19:20:03 MythHTPC mythfrontend.real: mythfrontend[11578]: I<br>
CoreContext mythplayer.cpp:1785 (InitAVSync) Player(0): Video timing<br>
method: DRM<br>
<br>
Feb 9 19:20:03 MythHTPC mythfrontend.real: mythfrontend[11578]: I<br>
CoreContext tv_play.cpp:5635 (StartPlayer) TV: Created player.<br>
<br>
Feb 9 19:20:03 MythHTPC mythfrontend.real: mythfrontend[11578]: I<br>
CoreContext tv_play.cpp:2485 (HandleStateChange) TV: Changing from None<br>
to WatchingRecording<br>
<br>
Feb 9 19:20:03 MythHTPC mythfrontend.real: mythfrontend[11578]: I<br>
CoreContext tv_play.cpp:2576 (HandleStateChange) TV: Main UI disabled.<br>
<br>
Feb 9 19:20:03 MythHTPC mythfrontend.real: mythfrontend[11578]: I<br>
CoreContext tv_play.cpp:412 (StartTV) TV: Entering main playback loop.<br>
<br>
Feb 9 19:20:03 MythHTPC mythfrontend.real: mythfrontend[11578]: N<br>
CoreContext mythplayer.cpp:2135 (PrebufferEnoughFrames) Player(0):<br>
Waited 105ms for video buffers AAAAAAAAAAAALL<br>
<br>
Feb 9 19:20:03 MythHTPC mythfrontend.real: mythfrontend[11578]: I<br>
CoreContext mythrender_vdpau.cpp:610 (CheckOutputSurfaces) VDPAU: Added<br>
2 output surfaces (total 4, max 4)<br>
<br>
[Playing fine; hit fast forward to jump ahead to known error point:]<br>
<br>
Feb 9 19:20:30 MythHTPC mythfrontend.real: mythfrontend[11578]: W<br>
Decoder avformatdecoder.cpp:4918 (GetFrame) AFD: Audio -99 ms behind<br>
video but already 220 video frames queued. AV-Sync might be broken.<br>
<br>
Feb 9 19:20:30 MythHTPC mythfrontend.real: mythfrontend[11578]: W<br>
Decoder avformatdecoder.cpp:4918 (GetFrame) AFD: Audio -66 ms behind<br>
video but already 220 video frames queued. AV-Sync might be broken.<br>
<br>
Feb 9 19:20:30 MythHTPC mythfrontend.real: mythfrontend[11578]: W<br>
Decoder avformatdecoder.cpp:4918 (GetFrame) AFD: Audio -33 ms behind<br>
video but already 220 video frames queued. AV-Sync might be broken.<br>
<br>
***<br>
**** [SNIP]<br>
***<br>
<br>
Feb 9 19:20:58 MythHTPC mythfrontend.real: mythfrontend[11578]: W<br>
Decoder avformatdecoder.cpp:4918 (GetFrame) AFD: Audio 10211 ms behind<br>
video but already 220 video frames queued. AV-Sync might be broken.<br>
<br>
Feb 9 19:20:58 MythHTPC mythfrontend.real: mythfrontend[11578]: W<br>
Decoder avformatdecoder.cpp:4918 (GetFrame) AFD: Audio 10244 ms behind<br>
video but already 220 video frames queued. AV-Sync might be broken.<br>
<br>
Feb 9 19:20:58 MythHTPC mythfrontend.real: mythfrontend[11578]: W<br>
Decoder avformatdecoder.cpp:4918 (GetFrame) AFD: Audio 10278 ms behind<br>
video but already 220 video frames queued. AV-Sync might be broken.<br>
<br>
[Pressed ESC to stop playing]<br>
<br>
<br>
Feb 9 19:20:58 MythHTPC mythfrontend.real: mythfrontend[11578]: I<br>
CoreContext tv_play.cpp:2225 (HandleStateChange) TV: Attempting to<br>
change from WatchingRecording to None<br>
<br>
Feb 9 19:20:58 MythHTPC mythfrontend.real: mythfrontend[11578]: W<br>
CoreContext mythpainter.cpp:36 (Teardown) MythPainter: 25 images not yet<br>
de-allocated.<br>
<br>
Feb 9 19:20:58 MythHTPC mythfrontend.real: mythfrontend[11578]: I<br>
CoreContext mythpainter_vdpau.cpp:108 (ClearCache) VDPAU Painter:<br>
Clearing VDPAU painter cache.<br>
<br>
Feb 9 19:20:58 MythHTPC mythfrontend.real: mythfrontend[11578]: I<br>
CoreContext tv_play.cpp:2485 (HandleStateChange) TV: Changing from<br>
WatchingRecording to None<br>
<br>
Feb 9 19:20:58 MythHTPC mythfrontend.real: mythfrontend[11578]: I<br>
CoreContext tv_play.cpp:414 (StartTV) TV: Exiting main playback loop.<br>
<br>
Feb 9 19:20:58 MythHTPC mythfrontend.real: mythfrontend[11578]: N<br>
CoreContext mythmainwindow.cpp:2742 (PauseIdleTimer) Resuming idle timer<br>
<br>
</div></div></blockquote>
<br>
The above log looks more like a playback problem. Since you're using a VDPAU profile, I'm guessing you're using an nVidia GPU, right?<br></blockquote><div><br></div><div>Hardware:</div><div><br></div><div>AMD 5350 and using the built-in GPU. VDPAU's been ported so that it works w/AMD graphics. Or at least as a framework around VAAPI. Or something. I'm certain someone more knowledgable will probably correct me. All I know is, selecting VDPAU works just fine for playing and MPEG2 decoding in hardware. </div><div><br></div><div> </div><blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex">
What GPU are you using?<br>
<br></blockquote><div><br></div><div>See above.</div><div><br></div><div> </div><blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex">
What playback profile are you using? Maybe you need to step it down from VDPAU High Quality to VDPAU Normal, or from VDPAU Normal to VDPAU Slim.<br>
<br></blockquote><div><br></div><div>Really, it's a recording problem. There's a chance I don't even have the mythtv frontend configured properly because I never ever use it, and I have mythbuntu set up so that it doesn't even launch the mythtv frontend at login. I recently changed pulseaudio setup so that it no longer does AC3 passthrough on kodi, but i didn't change the settings on mythfrontend, so that might be reflected in the log.</div><div><br></div><div>More importantly and relevant, an affected recorded mpg file doesn't play on other non-linux computers if i copy the file to them. In contrast, "Working" recordings play perfectly on other devices. </div><div><br></div><div> </div><blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex">
PBS stations generally broadcast in 1080i and 1080i content requires deinterlacing. The different playback profiles use different deinterlacing HW assisted algorithms and not all GPUs can do the more advanced deinterlacing algorithms.<br>
<br>
CBS and NBC also broadcast in 1080i, while FOX and ABC broadcast in 720p. If the problem is ONLY a playback problem, I would expect to see problems with CBS and NBC content. If you aren't seeing that, then you've probably got both a playback problem and a recording problem.<br>
<br></blockquote><div><br></div><div>It's only a problem recording on this particular PBS channel. The other PBS channel in my town records fine. They are both on the same Clear QAM transport/frequency/channel (501MHZ, channel 70) which is the weird thing. So doubtful that "interference" plays a part, since wouldn't it effect both channels equally??</div><div><br></div><div>Playback of all channels, whether 1080 or 720 is perfect. Even on a low-power AMD 5350 processor, I rarely have more than 25%/core utilization, and have no problem recording several channels simultaneously while comflagging in real-time. I seriously doubt the source of the problem is that the hardware is being taxed too hard recording one commercial-free PBS channel. </div><div><br></div><div> </div><blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex">
As for a recording problem, you said you didn't have a problem recording on Windows. Were you using the same HDHomerun Connect device, the same tuner, i.e. either 0 or 1? Maybe there's a problem with one of the tuners in the same device?<br>
<br></blockquote><div>Same device.</div><div><br></div><div><br></div><div> </div><div> </div></div></div></div>