<div dir="ltr"><br><div class="gmail_extra"><br><div class="gmail_quote">On Tue, Feb 9, 2016 at 1:58 PM, Jim <span dir="ltr"><<a href="mailto:lists@morton.hrcoxmail.com" target="_blank">lists@morton.hrcoxmail.com</a>></span> wrote:<br><blockquote class="gmail_quote" style="margin:0px 0px 0px 0.8ex;border-left-width:1px;border-left-color:rgb(204,204,204);border-left-style:solid;padding-left:1ex"><span class="">On 2/9/2016 12:31 PM, Jason Zarin wrote:<br>
<blockquote class="gmail_quote" style="margin:0px 0px 0px 0.8ex;border-left-width:1px;border-left-color:rgb(204,204,204);border-left-style:solid;padding-left:1ex">
This discussion is falling into useless semantics.<br>
<br>
I've done all the recommended fixes in this thread, but nothing has worked.<br>
<br>
What types of logs should I collect so that the mythtv team can address the issue?<br>
<br>
Thanks!<br>
<br>
</blockquote>
<br></span>
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 check the frontend logs for clues.<span class=""><font color="#888888"><br>
<br></font></span><div class=""><div class="h5"><br></div></div></blockquote><div><br></div><div>Relevant portion of mythfrontend.log while playing a broken recording:</div><div><br></div>
<p class=""><span class="">Feb 9 19:20:01 MythHTPC mythfrontend.real: mythfrontend[11578]: I CoreContext tv_play.cpp:1280 (Init) TV: Created TvPlayWindow.</span></p>
<p class=""><span class="">Feb 9 19:20:01 MythHTPC mythfrontend.real: mythfrontend[11578]: I CoreContext tv_play.cpp:2225 (HandleStateChange) TV: Attempting to change from None to WatchingRecording</span></p>
<p class=""><span class="">Feb 9 19:20:01 MythHTPC mythfrontend.real: mythfrontend[11578]: I CoreContext mythcorecontext.cpp:426 (ConnectCommandSocket) MythCoreContext: Connecting to backend server: <a href="http://10.0.1.29:6543">10.0.1.29:6543</a> (try 1 of 1)</span></p>
<p class=""><span class="">Feb 9 19:20:01 MythHTPC mythfrontend.real: mythfrontend[11578]: E CoreContext audio/audiooutputalsa.cpp:172 (GetPCMInfo) ALSA: snd_pcm_info_get_card: Operation not permitted</span></p>
<p class=""><span class="">Feb 9 19:20:01 MythHTPC mythfrontend.real: mythfrontend[11578]: N CoreContext audioplayer.cpp:164 (ReinitAudio) AudioPlayer: Enabling Audio</span></p>
<p class=""><span class="">Feb 9 19:20:01 MythHTPC mythfrontend.real: mythfrontend[11578]: I CoreContext avformatdecoder.cpp:2141 (ScanStreams) AFD: codec AC3 has 2 channels</span></p>
<p class=""><span class="">Feb 9 19:20:01 MythHTPC mythfrontend.real: mythfrontend[11578]: I CoreContext avformatdecoder.cpp:2632 (OpenAVCodec) AFD: Opened codec 0x5958820, id(AC3) type(Audio)</span></p>
<p class=""><span class="">Feb 9 19:20:01 MythHTPC mythfrontend.real: mythfrontend[11578]: I CoreContext mythrender_vdpau.cpp:1751 (CheckHardwareSupport) VDPAU: Version 1</span></p>
<p class=""><span class="">Feb 9 19:20:01 MythHTPC mythfrontend.real: mythfrontend[11578]: I CoreContext mythrender_vdpau.cpp:1762 (CheckHardwareSupport) VDPAU: Information G3DVL VDPAU Driver Shared Library version 1.0</span></p>
<p class=""><span class="">Feb 9 19:20:01 MythHTPC mythfrontend.real: mythfrontend[11578]: I CoreContext avformatdecoder.cpp:2632 (OpenAVCodec) AFD: Opened codec 0x587ace0, id(MPEG2VIDEO) type(Video)</span></p>
<p class=""><span class="">Feb 9 19:20:01 MythHTPC mythfrontend.real: mythfrontend[11578]: I CoreContext audio/audiooutputbase.cpp:792 (Reconfigure) AOBase: Opening audio device 'pulse' ch 6(2) sr 48000 sf 32 bit floating point reenc 0</span></p>
<p class=""><span class="">Feb 9 19:20:02 MythHTPC mythfrontend.real: mythfrontend[11578]: E CoreContext audio/audiooutputalsa.cpp:961 (OpenMixer) ALSA: no playback control PCM found on mixer device default</span></p>
<p class=""><span class="">Feb 9 19:20:02 MythHTPC mythfrontend.real: mythfrontend[11578]: E CoreContext audio/audiooutputalsa.cpp:497 (OpenDevice) ALSA: Unable to open audio mixer. Volume control disabled</span></p>
<p class=""><span class="">Feb 9 19:20:02 MythHTPC mythfrontend.real: mythfrontend[11578]: I CoreContext mythpainter_ogl.cpp:62 (ClearCache) Clearing OpenGL painter cache.</span></p>
<p class=""><span class="">Feb 9 19:20:02 MythHTPC mythfrontend.real: mythfrontend[11578]: I CoreContext mythrender_vdpau.cpp:1717 (CreatePresentationSurfaces) VDPAU: Created 2 output surfaces.</span></p>
<p class=""><span class="">Feb 9 19:20:02 MythHTPC mythfrontend.real: mythfrontend[11578]: I CoreContext mythrender_vdpau.cpp:424 (Create) VDPAU: Created VDPAU render device 1920x1080</span></p>
<p class=""><span class="">Feb 9 19:20:03 MythHTPC mythfrontend.real: mythfrontend[11578]: N CoreContext mythplayer.cpp:526 (CheckExtraAudioDecode) Player(0): Forcing decode extra audio option on (Video method requires it).</span></p>
<p class=""><span class="">Feb 9 19:20:03 MythHTPC mythfrontend.real: mythfrontend[11578]: I CoreContext mythplayer.cpp:1785 (InitAVSync) Player(0): Video timing method: DRM</span></p>
<p class=""><span class="">Feb 9 19:20:03 MythHTPC mythfrontend.real: mythfrontend[11578]: I CoreContext tv_play.cpp:5635 (StartPlayer) TV: Created player.</span></p>
<p class=""><span class="">Feb 9 19:20:03 MythHTPC mythfrontend.real: mythfrontend[11578]: I CoreContext tv_play.cpp:2485 (HandleStateChange) TV: Changing from None to WatchingRecording</span></p>
<p class=""><span class="">Feb 9 19:20:03 MythHTPC mythfrontend.real: mythfrontend[11578]: I CoreContext tv_play.cpp:2576 (HandleStateChange) TV: Main UI disabled.</span></p>
<p class=""><span class="">Feb 9 19:20:03 MythHTPC mythfrontend.real: mythfrontend[11578]: I CoreContext tv_play.cpp:412 (StartTV) TV: Entering main playback loop.</span></p>
<p class=""><span class="">Feb 9 19:20:03 MythHTPC mythfrontend.real: mythfrontend[11578]: N CoreContext mythplayer.cpp:2135 (PrebufferEnoughFrames) Player(0): Waited 105ms for video buffers AAAAAAAAAAAALL</span></p>
<p class=""><span class="">Feb 9 19:20:03 MythHTPC mythfrontend.real: mythfrontend[11578]: I CoreContext mythrender_vdpau.cpp:610 (CheckOutputSurfaces) VDPAU: Added 2 output surfaces (total 4, max 4)</span></p>
<p class="">[Playing fine; hit fast forward to jump ahead to known error point:]</p><p class=""><span class="">Feb 9 19:20:30 MythHTPC mythfrontend.real: mythfrontend[11578]: W Decoder avformatdecoder.cpp:4918 (GetFrame) AFD: Audio -99 ms behind video but already 220 video frames queued. AV-Sync might be broken.</span></p>
<p class=""><span class="">Feb 9 19:20:30 MythHTPC mythfrontend.real: mythfrontend[11578]: W Decoder avformatdecoder.cpp:4918 (GetFrame) AFD: Audio -66 ms behind video but already 220 video frames queued. AV-Sync might be broken.</span></p>
<div>Feb 9 19:20:30 MythHTPC mythfrontend.real: mythfrontend[11578]: W Decoder avformatdecoder.cpp:4918 (GetFrame) AFD: Audio -33 ms behind video but already 220 video frames queued. AV-Sync might be broken.</div><div><br></div><div>*** </div><div>**** [SNIP]</div><div>***</div><div><br></div>
<p class=""><span class="">Feb 9 19:20:58 MythHTPC mythfrontend.real: mythfrontend[11578]: W Decoder avformatdecoder.cpp:4918 (GetFrame) AFD: Audio 10211 ms behind video but already 220 video frames queued. AV-Sync might be broken.</span></p>
<p class=""><span class="">Feb 9 19:20:58 MythHTPC mythfrontend.real: mythfrontend[11578]: W Decoder avformatdecoder.cpp:4918 (GetFrame) AFD: Audio 10244 ms behind video but already 220 video frames queued. AV-Sync might be broken.</span></p>
<p class=""><span class="">Feb 9 19:20:58 MythHTPC mythfrontend.real: mythfrontend[11578]: W Decoder avformatdecoder.cpp:4918 (GetFrame) AFD: Audio 10278 ms behind video but already 220 video frames queued. AV-Sync might be broken.</span></p>
<p class=""><span class="">[Pressed ESC to stop playing]</span></p><p class=""><span class=""><br></span></p><p class=""><span class="">Feb 9 19:20:58 MythHTPC mythfrontend.real: mythfrontend[11578]: I CoreContext tv_play.cpp:2225 (HandleStateChange) TV: Attempting to change from WatchingRecording to None</span></p>
<p class=""><span class="">Feb 9 19:20:58 MythHTPC mythfrontend.real: mythfrontend[11578]: W CoreContext mythpainter.cpp:36 (Teardown) MythPainter: 25 images not yet de-allocated.</span></p>
<p class=""><span class="">Feb 9 19:20:58 MythHTPC mythfrontend.real: mythfrontend[11578]: I CoreContext mythpainter_vdpau.cpp:108 (ClearCache) VDPAU Painter: Clearing VDPAU painter cache.</span></p>
<p class=""><span class="">Feb 9 19:20:58 MythHTPC mythfrontend.real: mythfrontend[11578]: I CoreContext tv_play.cpp:2485 (HandleStateChange) TV: Changing from WatchingRecording to None</span></p>
<p class=""><span class="">Feb 9 19:20:58 MythHTPC mythfrontend.real: mythfrontend[11578]: I CoreContext tv_play.cpp:414 (StartTV) TV: Exiting main playback loop.</span></p>
<div>Feb 9 19:20:58 MythHTPC mythfrontend.real: mythfrontend[11578]: N CoreContext mythmainwindow.cpp:2742 (PauseIdleTimer) Resuming idle timer </div></div><br></div></div>