Playback freezing

[Foggy]

A few of my recordings are freezing partway through. This is not happening to all recordings. Seems to happen when watching some files from CBMT.

Here is a snippet from the sagetvclient_0.txt file.
Windows 10, SageTV v9.0.13.536, Java 1.8.0_111

In this case, I could get about 25 minutes into the file and the picture and sound freeze.
Happens both when watching on my sageTV server and when using the Shield. (have not tried the HD200 yet)

The interesting line appears to be:
Seems stream 3 codec frame rate differs from container frame rate: inf (1/0) -> nan (0/0)

Any thoughts?

Edit: The program shows as 1 hour long in SageTV, with no indication that the recording was interrupted. The file size is about 1.7G, which is in line with other recordings of that same show that play all the way through. However, Windows reports that the "Length" is 25m 2s.
File is a MPEG-2 TS.

Fri 2/17 21:22:55.504 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@2c8f54] isRec=false rd=3600002 base=245825 eos=false
Fri 2/17 21:22:55.505 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@2c8f54] VF thread is now waiting for 0:55:53.927
Fri 2/17 21:22:56.644 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@829d4a] =======>Get getMediaTimeMillis0 cur:246679 s0:0 s1:0 new:246679.
Fri 2/17 21:22:57.617 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@829d4a] =======>Get getMediaTimeMillis0 cur:247663 s0:0 s1:0 new:247663.
Fri 2/17 21:22:58.452 [AWT-EventQueue-0@110406] VF.submitJob(VFJob[TimeSet r=0.0 t=1481659839168 file=null ifn=null])
Fri 2/17 21:22:58.453 [AWT-EventQueue-0@110406] processUserEvent-UserEvent[anything] evtTime=Fri 2/17 21:22:58.454
Fri 2/17 21:22:58.454 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@2c8f54] VF processing job VFJob[TimeSet r=0.0 t=1481659839168 file=null ifn=null] nPlayin=true
Fri 2/17 21:22:58.455 [AWT-EventQueue-0@110406] VF processing on UI Thread VFJob[TimeSet r=0.0 t=1481659839168 file=null ifn=null]
Fri 2/17 21:22:58.456 [AWT-EventQueue-0@110406] =======>Get getMediaTimeMillis0 cur:248508 s0:0 s1:0 new:248508.
Fri 2/17 21:22:58.456 [AWT-EventQueue-0@110406] VideoFrame.timeSelected(Tue 12/13 15:10:39.168, true) currFile=MediaFile[id=2287799 A[2247297,2247265,"Grand Designs Australia",10092@1213.15:00,60,T] mask=TV host=DVR encodedBy=SageDCT-HDHomeRun Prime Tuner 13212AA5-0 on 127.0.0.1:6970 CBMT format=MPEG2-TS 0:05:00 2634 kbps [#0 Video[MPEG2-Video 29.97003 fps 544x480 4:3 interlaced id=12e7]#1 Audio[AC3 48000 Hz 6 channels 384 kbps MAIN idx=1 id=12e8]] G:\TV\GrandDesignsAustralia-S01E04-ClovellyHouse-2247297-0.ts, Seg0[Tue 12/13 15:00:00.009-Tue 12/13 16:00:00.011]]
Fri 2/17 21:22:58.456 [AWT-EventQueue-0@110406] VideoFrame.timeSelected2(Tue 12/13 15:10:39.168, true) currFile=MediaFile[id=2287799 A[2247297,2247265,"Grand Designs Australia",10092@1213.15:00,60,T] mask=TV host=DVR encodedBy=SageDCT-HDHomeRun Prime Tuner 13212AA5-0 on 127.0.0.1:6970 CBMT format=MPEG2-TS 0:05:00 2634 kbps [#0 Video[MPEG2-Video 29.97003 fps 544x480 4:3 interlaced id=12e7]#1 Audio[AC3 48000 Hz 6 channels 384 kbps MAIN idx=1 id=12e8]] G:\TV\GrandDesignsAustralia-S01E04-ClovellyHouse-2247297-0.ts, Seg0[Tue 12/13 15:00:00.009-Tue 12/13 16:00:00.011]] realDur=0
Fri 2/17 21:22:58.457 [AWT-EventQueue-0@110406] About to perform media time selection for 639159
Fri 2/17 21:22:58.505 [AWT-EventQueue-0@110406] Sending event to server for PlaybackSeek args={MediaFile=MediaFile[id=2287799 A[2247297,2247265,"Grand Designs Australia",10092@1213.15:00,60,T] mask=TV host=DVR encodedBy=SageDCT-HDHomeRun Prime Tuner 13212AA5-0 on 127.0.0.1:6970 CBMT format=MPEG2-TS 0:05:00 2634 kbps [#0 Video[MPEG2-Video 29.97003 fps 544x480 4:3 interlaced id=12e7]#1 Audio[AC3 48000 Hz 6 channels 384 kbps MAIN idx=1 id=12e8]] G:\TV\GrandDesignsAustralia-S01E04-ClovellyHouse-2247297-0.ts, Seg0[Tue 12/13 15:00:00.009-Tue 12/13 16:00:00.011]], ChapterNum=0, UIContext=/127.0.0.1:24517, MediaTime=1481659839168, Duration=3600002, TitleNum=0}
Fri 2/17 21:22:58.505 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@2c8f54] VF processing job null nPlayin=true
Fri 2/17 21:22:58.506 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@2c8f54] isRec=false rd=3600002 base=639159 eos=false
Fri 2/17 21:22:58.506 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@2c8f54] VF thread is now waiting for 0:49:20.593
Fri 2/17 21:22:59.094 [ThumbnailGen@118a8b3] Error creating thumbnail from video file:MediaFile[id=2287799 A[2247297,2247265,"Grand Designs Australia",10092@1213.15:00,60,T] mask=TV host=DVR encodedBy=SageDCT-HDHomeRun Prime Tuner 13212AA5-0 on 127.0.0.1:6970 CBMT format=MPEG2-TS 0:05:00 2634 kbps [#0 Video[MPEG2-Video 29.97003 fps 544x480 4:3 interlaced id=12e7]#1 Audio[AC3 48000 Hz 6 channels 384 kbps MAIN idx=1 id=12e8]] G:\TV\GrandDesignsAustralia-S01E04-ClovellyHouse-2247297-0.ts, Seg0[Tue 12/13 15:00:00.009-Tue 12/13 16:00:00.011]] res=FFmpeg version SVN-r93, Copyright (c) 2000-2010 the FFmpeg developers
  built on Jan 28 2011 10:48:22 with gcc 4.2.4
  configuration: --target-os=mingw32 --prefix=/cygdrive/c/dev/src/buildwin/stage --disable-ffplay --disable-ffserver --enable-gpl --enable-nonfree --disable-encoder=aac --disable-demuxer=ea --disable-devices --enable-libxvid --enable-libx264 --enable-libfaac --enable-libfaad --enable-static --disable-shared --enable-pthreads --disable-debug --enable-memalign-hack --arch=x86 --extra-cflags='-fno-common -march=i686 -mtune=i686 -DWIN32 -I/cygdrive/c/dev/src/buildwin/stage/include' --extra-ldflags=-L/cygdrive/c/dev/src/buildwin/stage/lib --enable-cross-compile --cross-prefix=i686-pc-mingw32-
  libavutil     50.22. 0 / 50.22. 0
  libavcodec    52.83. 0 / 52.83. 0
  libavformat   52.73. 0 / 52.73. 0
  libavdevice   52. 2. 0 / 52. 2. 0
  libavfilter    1.22. 0 /  1.22. 0
  libswscale     0.11. 0 /  0.11. 0
STV:// socket recv tcp window size 262144
[mpeg2video @ 0x19b0980] mpeg_decode_postinit() failure
    Last message repeated 4 times
[mpegts @ 0x1b17d80] max_analyze_duration reached
[NULL @ 0x1b1adb0] start time is not set in av_estimate_timings_from_pts

Seems stream 3 codec frame rate differs from container frame rate: inf (1/0) -> nan (0/0)
Input #0, mpegts, from 'stv://127.0.0.1/G:\TV\GrandDesignsAustralia-S01E04-ClovellyHouse-2247297-0.ts':
  Duration: 03:06:38.02, start: 7598.495167, bitrate: 1295 kb/s
  Program 2 
    Stream #0.0[0x12e7]: Video: mpeg2video, yuv420p, 544x480, AR: 4:3, interlaced, 18000 kb/s, 30.57 fps, 29.97 tbr, 90k tbn, 59.94 tbc
    Stream #0.1[0x12e8]: Audio: ac3, 48000 Hz, 5.1, s16, 384 kb/s
    Stream #0.2[0x12e9]: Data: [134][0][0][0] / 0x0086
  No Program
    Stream #0.3[0x12fc]: Video: mpeg2video, progressive, 90k tbn
    Stream #0.4[0x12fd]: Audio: ac3, 0 channels
picture size invalid (0x0)
Cannot allocate temp picture, check pix fmt

Fri 2/17 21:22:59.645 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@829d4a] =======>Get getMediaTimeMillis0 cur:640094 s0:0 s1:0 new:640094.
Fri 2/17 21:23:00.022 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@829d4a] =======>Get getMediaTimeMillis0 cur:640094 s0:0 s1:0 new:640094.
Fri 2/17 21:23:00.420 [AWT-EventQueue-0@110406] VF.submitJob(VFJob[TimeSet r=0.0 t=1481659998960 file=null ifn=null])
Fri 2/17 21:23:00.421 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@2c8f54] VF processing job VFJob[TimeSet r=0.0 t=1481659998960 file=null ifn=null] nPlayin=true
Fri 2/17 21:23:00.421 [AWT-EventQueue-0@110406] processUserEvent-UserEvent[anything] evtTime=Fri 2/17 21:23:00.423
Fri 2/17 21:23:00.422 [AWT-EventQueue-0@110406] VF processing on UI Thread VFJob[TimeSet r=0.0 t=1481659998960 file=null ifn=null]
Fri 2/17 21:23:00.423 [AWT-EventQueue-0@110406] VideoFrame.timeSelected(Tue 12/13 15:13:18.960, true) currFile=MediaFile[id=2287799 A[2247297,2247265,"Grand Designs Australia",10092@1213.15:00,60,T] mask=TV host=DVR encodedBy=SageDCT-HDHomeRun Prime Tuner 13212AA5-0 on 127.0.0.1:6970 CBMT format=MPEG2-TS 0:05:00 2634 kbps [#0 Video[MPEG2-Video 29.97003 fps 544x480 4:3 interlaced id=12e7]#1 Audio[AC3 48000 Hz 6 channels 384 kbps MAIN idx=1 id=12e8]] G:\TV\GrandDesignsAustralia-S01E04-ClovellyHouse-2247297-0.ts, Seg0[Tue 12/13 15:00:00.009-Tue 12/13 16:00:00.011]]
Fri 2/17 21:23:00.423 [AWT-EventQueue-0@110406] VideoFrame.timeSelected2(Tue 12/13 15:13:18.960, true) currFile=MediaFile[id=2287799 A[2247297,2247265,"Grand Designs Australia",10092@1213.15:00,60,T] mask=TV host=DVR encodedBy=SageDCT-HDHomeRun Prime Tuner 13212AA5-0 on 127.0.0.1:6970 CBMT format=MPEG2-TS 0:05:00 2634 kbps [#0 Video[MPEG2-Video 29.97003 fps 544x480 4:3 interlaced id=12e7]#1 Audio[AC3 48000 Hz 6 channels 384 kbps MAIN idx=1 id=12e8]] G:\TV\GrandDesignsAustralia-S01E04-ClovellyHouse-2247297-0.ts, Seg0[Tue 12/13 15:00:00.009-Tue 12/13 16:00:00.011]] realDur=0
Fri 2/17 21:23:00.423 [AWT-EventQueue-0@110406] About to perform media time selection for 798951
Fri 2/17 21:23:00.463 [AWT-EventQueue-0@110406] Sending event to server for PlaybackSeek args={MediaFile=MediaFile[id=2287799 A[2247297,2247265,"Grand Designs Australia",10092@1213.15:00,60,T] mask=TV host=DVR encodedBy=SageDCT-HDHomeRun Prime Tuner 13212AA5-0 on 127.0.0.1:6970 CBMT format=MPEG2-TS 0:05:00 2634 kbps [#0 Video[MPEG2-Video 29.97003 fps 544x480 4:3 interlaced id=12e7]#1 Audio[AC3 48000 Hz 6 channels 384 kbps MAIN idx=1 id=12e8]] G:\TV\GrandDesignsAustralia-S01E04-ClovellyHouse-2247297-0.ts, Seg0[Tue 12/13 15:00:00.009-Tue 12/13 16:00:00.011]], ChapterNum=0, UIContext=/127.0.0.1:24517, MediaTime=1481659998960, Duration=3600002, TitleNum=0}
Fri 2/17 21:23:00.463 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@2c8f54] VF processing job null nPlayin=true
Fri 2/17 21:23:00.464 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@2c8f54] isRec=false rd=3600002 base=798951 eos=false
Fri 2/17 21:23:00.464 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@2c8f54] VF thread is now waiting for 0:46:40.801
Fri 2/17 21:23:01.629 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@829d4a] =======>Get getMediaTimeMillis0 cur:800068 s0:0 s1:0 new:800068.
Fri 2/17 21:23:02.444 [AWT-EventQueue-0@110406] VF.submitJob(VFJob[TimeSet r=0.0 t=1481660195627 file=null ifn=null])
Fri 2/17 21:23:02.445 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@2c8f54] VF processing job VFJob[TimeSet r=0.0 t=1481660195627 file=null ifn=null] nPlayin=true
Fri 2/17 21:23:02.445 [AWT-EventQueue-0@110406] processUserEvent-UserEvent[anything] evtTime=Fri 2/17 21:23:02.446
Fri 2/17 21:23:02.446 [AWT-EventQueue-0@110406] VF processing on UI Thread VFJob[TimeSet r=0.0 t=1481660195627 file=null ifn=null]
Fri 2/17 21:23:02.447 [AWT-EventQueue-0@110406] =======>Get getMediaTimeMillis0 cur:800068 s0:0 s1:0 new:800068.
Fri 2/17 21:23:02.447 [AWT-EventQueue-0@110406] VideoFrame.timeSelected(Tue 12/13 15:16:35.627, true) currFile=MediaFile[id=2287799 A[2247297,2247265,"Grand Designs Australia",10092@1213.15:00,60,T] mask=TV host=DVR encodedBy=SageDCT-HDHomeRun Prime Tuner 13212AA5-0 on 127.0.0.1:6970 CBMT format=MPEG2-TS 0:05:00 2634 kbps [#0 Video[MPEG2-Video 29.97003 fps 544x480 4:3 interlaced id=12e7]#1 Audio[AC3 48000 Hz 6 channels 384 kbps MAIN idx=1 id=12e8]] G:\TV\GrandDesignsAustralia-S01E04-ClovellyHouse-2247297-0.ts, Seg0[Tue 12/13 15:00:00.009-Tue 12/13 16:00:00.011]]
Fri 2/17 21:23:02.447 [AWT-EventQueue-0@110406] VideoFrame.timeSelected2(Tue 12/13 15:16:35.627, true) currFile=MediaFile[id=2287799 A[2247297,2247265,"Grand Designs Australia",10092@1213.15:00,60,T] mask=TV host=DVR encodedBy=SageDCT-HDHomeRun Prime Tuner 13212AA5-0 on 127.0.0.1:6970 CBMT format=MPEG2-TS 0:05:00 2634 kbps [#0 Video[MPEG2-Video 29.97003 fps 544x480 4:3 interlaced id=12e7]#1 Audio[AC3 48000 Hz 6 channels 384 kbps MAIN idx=1 id=12e8]] G:\TV\GrandDesignsAustralia-S01E04-ClovellyHouse-2247297-0.ts, Seg0[Tue 12/13 15:00:00.009-Tue 12/13 16:00:00.011]] realDur=0
Fri 2/17 21:23:02.447 [AWT-EventQueue-0@110406] About to perform media time selection for 995618
Fri 2/17 21:23:02.489 [AWT-EventQueue-0@110406] Sending event to server for PlaybackSeek args={MediaFile=MediaFile[id=2287799 A[2247297,2247265,"Grand Designs Australia",10092@1213.15:00,60,T] mask=TV host=DVR encodedBy=SageDCT-HDHomeRun Prime Tuner 13212AA5-0 on 127.0.0.1:6970 CBMT format=MPEG2-TS 0:05:00 2634 kbps [#0 Video[MPEG2-Video 29.97003 fps 544x480 4:3 interlaced id=12e7]#1 Audio[AC3 48000 Hz 6 channels 384 kbps MAIN idx=1 id=12e8]] G:\TV\GrandDesignsAustralia-S01E04-ClovellyHouse-2247297-0.ts, Seg0[Tue 12/13 15:00:00.009-Tue 12/13 16:00:00.011]], ChapterNum=0, UIContext=/127.0.0.1:24517, MediaTime=1481660195627, Duration=3600002, TitleNum=0}
Fri 2/17 21:23:02.490 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@2c8f54] VF processing job null nPlayin=true
Fri 2/17 21:23:02.490 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@2c8f54] isRec=false rd=3600002 base=995618 eos=false
Fri 2/17 21:23:02.491 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@2c8f54] VF thread is now waiting for 0:43:24.134
Fri 2/17 21:23:03.637 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@829d4a] =======>Get getMediaTimeMillis0 cur:996526 s0:0 s1:0 new:996526.
Fri 2/17 21:23:04.642 [ActiveRender-SAGETV_PROCESS_LOCAL_UI@829d4a] =======>Get getMediaTimeMillis0 cur:996789 s0:0 s1:0 new:996789.
Fri 2/17 21:23:05.388 [AWT-EventQueue-0@110406] VF.submitJob(VFJob[TimeSet r=0.0 t=1481660330836 file=null ifn=null])
Fri 2/17 21:23:05.389 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@2c8f54] VF processing job VFJob[TimeSet r=0.0 t=1481660330836 file=null ifn=null] nPlayin=true
Fri 2/17 21:23:05.389 [AWT-EventQueue-0@110406] processUserEvent-UserEvent[anything] evtTime=Fri 2/17 21:23:05.390
Fri 2/17 21:23:05.390 [AWT-EventQueue-0@110406] VF processing on UI Thread VFJob[TimeSet r=0.0 t=1481660330836 file=null ifn=null]
Fri 2/17 21:23:05.390 [AWT-EventQueue-0@110406] =======>Get getMediaTimeMillis0 cur:997118 s0:0 s1:0 new:997118.
Fri 2/17 21:23:05.390 [AWT-EventQueue-0@110406] VideoFrame.timeSelected(Tue 12/13 15:18:50.836, true) currFile=MediaFile[id=2287799 A[2247297,2247265,"Grand Designs Australia",10092@1213.15:00,60,T] mask=TV host=DVR encodedBy=SageDCT-HDHomeRun Prime Tuner 13212AA5-0 on 127.0.0.1:6970 CBMT format=MPEG2-TS 0:05:00 2634 kbps [#0 Video[MPEG2-Video 29.97003 fps 544x480 4:3 interlaced id=12e7]#1 Audio[AC3 48000 Hz 6 channels 384 kbps MAIN idx=1 id=12e8]] G:\TV\GrandDesignsAustralia-S01E04-ClovellyHouse-2247297-0.ts, Seg0[Tue 12/13 15:00:00.009-Tue 12/13 16:00:00.011]]
Fri 2/17 21:23:05.391 [AWT-EventQueue-0@110406] VideoFrame.timeSelected2(Tue 12/13 15:18:50.836, true) currFile=MediaFile[id=2287799 A[2247297,2247265,"Grand Designs Australia",10092@1213.15:00,60,T] mask=TV host=DVR encodedBy=SageDCT-HDHomeRun Prime Tuner 13212AA5-0 on 127.0.0.1:6970 CBMT format=MPEG2-TS 0:05:00 2634 kbps [#0 Video[MPEG2-Video 29.97003 fps 544x480 4:3 interlaced id=12e7]#1 Audio[AC3 48000 Hz 6 channels 384 kbps MAIN idx=1 id=12e8]] G:\TV\GrandDesignsAustralia-S01E04-ClovellyHouse-2247297-0.ts, Seg0[Tue 12/13 15:00:00.009-Tue 12/13 16:00:00.011]] realDur=0
Fri 2/17 21:23:05.391 [AWT-EventQueue-0@110406] About to perform media time selection for 1130827
Fri 2/17 21:23:05.434 [AWT-EventQueue-0@110406] Sending event to server for PlaybackSeek args={MediaFile=MediaFile[id=2287799 A[2247297,2247265,"Grand Designs Australia",10092@1213.15:00,60,T] mask=TV host=DVR encodedBy=SageDCT-HDHomeRun Prime Tuner 13212AA5-0 on 127.0.0.1:6970 CBMT format=MPEG2-TS 0:05:00 2634 kbps [#0 Video[MPEG2-Video 29.97003 fps 544x480 4:3 interlaced id=12e7]#1 Audio[AC3 48000 Hz 6 channels 384 kbps MAIN idx=1 id=12e8]] G:\TV\GrandDesignsAustralia-S01E04-ClovellyHouse-2247297-0.ts, Seg0[Tue 12/13 15:00:00.009-Tue 12/13 16:00:00.011]], ChapterNum=0, UIContext=/127.0.0.1:24517, MediaTime=1481660330836, Duration=3600002, TitleNum=0}
Fri 2/17 21:23:05.436 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@2c8f54] VF processing job null nPlayin=true
Fri 2/17 21:23:05.437 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@2c8f54] isRec=false rd=3600002 base=1130827 eos=false
Fri 2/17 21:23:05.437 [VideoFrame-SAGETV_PROCESS_LOCAL_UI@2c8f54] VF thread is now waiting for 0:41:08.925

[Narflex]

Have you tried playing back that file in VLC to see if things get weird at that same point in time? Also try it on the HD200...I'm very familiar with the playback engine on that device, so based on its behavior then I'd probably know what's wrong with it.

The FFMPEG output does look a little weird...there's multiple programs in the transport stream and I didn't think SageDCT output streams that way.