SageTV Community  

Go Back   SageTV Community > SageTV Products > SageTV Software

Notices

SageTV Software Discussion related to the SageTV application produced by SageTV. Questions, issues, problems, suggestions, etc. relating to the SageTV software application should be posted here. (Check the descriptions of the other forums; all hardware related questions go in the Hardware Support forum, etc. And, post in the customizations forum instead if any customizations are active.)

Reply
 
Thread Tools Search this Thread Display Modes
  #1  
Old 01-30-2022, 09:18 PM
CptKirk CptKirk is offline
Sage Aficionado
 
Join Date: Sep 2010
Posts: 266
Problem playing a ripped MKV file

Working on turning some of my optical media rips into MKV files so they take up less space on the server.

I use Handbrake and was doing multiple 60 seconds samples to fine tune my Handbrake settings. All the small samples played on my main viewing system with my HD300. But after I did the complete movie using the exact same settings I get an error message on the screen

Quote:
There was a Playback Error in playback. Details:
sage.PlaybackException
It then kicks me out and for some reason starts playing live tv.

Info from sagetv_0.txt for two samples that play with no problems:

sample 1, plays ok
Quote:
Sun 1/30 20:49:53.320 [VideoFrame-0023a50010d8@6d171805] initDriver0()
Sun 1/30 20:49:53.320 [VideoFrame-0023a50010d8@6d171805] Issuing MCSR client socket to 0023a50010d8
Sun 1/30 20:49:53.320 [VideoFrame-0023a50010d8@6d171805] MiniPlayer established for 0023a50010d8
Sun 1/30 20:49:53.390 [ActiveRender-0023a50010d8@1ddb977c] VideoFrame got registration of a subtitle UI component: sage.ZCCLabel[loc=java.awt.Point[x=38,y=110] size=java.awt.Dimension[width=180,height=29]]
Sun 1/30 20:49:53.390 [ActiveRender-0023a50010d8@1ddb977c] VideoFrame got registration of a cc UI component: sage.ZCCLabel[loc=java.awt.Point[x=25,y=14] size=java.awt.Dimension[width=206,height=116]]
Sun 1/30 20:49:53.406 [AsyncWatch@70c263a1] VideoFrame got registration of a subtitle UI component: null
Sun 1/30 20:49:53.406 [AsyncWatch@70c263a1] VideoFrame got registration of a cc UI component: null
Sun 1/30 20:49:53.419 [FinalRender-0023a50010d8@51dcbc9d] MiniClient did not succeed with menu hint change to:menuName:Browser - Videos, popupName:null, hasTextInput:false, errcode=1
Sun 1/30 20:49:53.543 [VideoFrame-0023a50010d8@6d171805] getEstimatedBW=131168000 estimatedBWBytes=16396000 estimatedBWTime=1000
Sun 1/30 20:49:53.543 [VideoFrame-0023a50010d8@6d171805] MiniPlayer got an estimate from the UI on bandwidth of 131168Kbps
Sun 1/30 20:49:53.543 [VideoFrame-0023a50010d8@6d171805] MiniPlayer is using Pull mode playback
Sun 1/30 20:49:53.543 [VideoFrame-0023a50010d8@6d171805] openURL0(stv://192.168.99.70/\\KJCUBED\Videos\Videos\DVD\Shang-chi_preview 3.mkv)
Sun 1/30 20:49:53.815 [Fork-OPUS4-111999@2053894b] ENDING background video thumb preloader thread, ID = 0.7519450654866402
Sun 1/30 20:49:54.230 [VideoFrame-0023a50010d8@6d171805] Sigma video dim=java.awt.Dimension[width=720,height=480]
Sun 1/30 20:49:54.230 [VideoFrame-0023a50010d8@6d171805] setMute0()
Sun 1/30 20:49:54.231 [VideoFrame-0023a50010d8@6d171805] getDuration : 0
Sun 1/30 20:49:54.232 [VideoFrame-0023a50010d8@6d171805] VideoFrame.timeSelected2(Sun 1/30 20:15:13.102, true) currFile=MediaFile[id=562246 A[562249,562247,"Shang-chi_preview 3",0@0130.20:15,1,V] mask=V host=KJCUBED encodedBy= format=MATROSKA 0:01:00 7711 kbps [#0 Video[H.264 23.976025 fps 1920x1080 8:4 progressive id=0]#1 Audio[DCA 48000 Hz 8 channels idx=1 id=0 eng]#2 Audio[DCA 48000 Hz 6 channels 1536 kbps idx=2 id=0 eng]#3 Audio[AC3 48000 Hz 6 channels 640 kbps idx=3 id=0 eng]#4 Audio[MP3 48000 Hz 2 channels 160 kbps idx=4 id=0 eng]#5 Subpic[PGSSUB id=0 eng]] \\KJCUBED\Videos\Videos\DVD\Shang-chi_preview 3.mkv, Seg0[Sun 1/30 20:15:13.102-Sun 1/30 20:16:13.140]] realDur=0
Sun 1/30 20:49:54.232 [VideoFrame-0023a50010d8@6d171805] playPush0()
Sun 1/30 20:49:54.259 [VideoFrame-0023a50010d8@6d171805] Channel Change Time=1643597394259 NOTE: Not valid if this was not a direct channel change!
Sun 1/30 20:49:54.263 [VideoFrame-0023a50010d8@6d171805] Default audio language is already selected
Sun 1/30 20:49:54.264 [VideoFrame-0023a50010d8@6d171805] VF processing job null nPlayin=true
Sun 1/30 20:49:54.264 [VideoFrame-0023a50010d8@6d171805] isRec=false rd=60038 base=0 eos=false
Sun 1/30 20:49:54.264 [VideoFrame-0023a50010d8@6d171805] VF thread is now waiting for 0:00:59.788
Sun 1/30 20:49:54.268 [ActiveRender-0023a50010d8@1ddb977c] VideoFrame got registration of a subtitle UI component: sage.ZCCLabel[loc=java.awt.Point[x=182,y=519] size=java.awt.Dimension[width=849,height=136]]
Sun 1/30 20:49:54.268 [ActiveRender-0023a50010d8@1ddb977c] VideoFrame got registration of a cc UI component: sage.ZCCLabel[loc=java.awt.Point[x=121,y=68] size=java.awt.Dimension[width=971,height=547]]
Sun 1/30 20:49:54.269 [FinalRender-0023a50010d8@51dcbc9d] MiniClient did not succeed with menu hint change to:menuName:MediaPlayer OSD, popupName:null, hasTextInput:false, errcode=1
Sun 1/30 20:49:54.270 [FinalRender-0023a50010d8@51dcbc9d] Allocated image-5 for C:\SageTV64\SageTV\STVs\SageTV7\Themes\Standard\OSDBGTop.png width=8 height=150 ptr=851450664
Sun 1/30 20:49:54.275 [FinalRender-0023a50010d8@51dcbc9d] Allocated image-5 for C:\SageTV64\SageTV\STVs\SageTV7\Themes\Standard\OSDVolBarVertical.png width=4 height=64 ptr=851450552
Sun 1/30 20:49:54.279 [FinalRender-0023a50010d8@51dcbc9d] Allocated image-5 for C:\SageTV64\SageTV\STVs\SageTV7\Themes\Standard\OSDVolSliderVertical.png width=15 height=13 ptr=851452232
Sun 1/30 20:49:54.280 [FinalRender-0023a50010d8@51dcbc9d] Allocated image-5 for C:\SageTV64\SageTV\STVs\SageTV7\Themes\Standard\OSDVolOn.png width=16 height=13 ptr=851450384
Sun 1/30 20:49:54.283 [FinalRender-0023a50010d8@51dcbc9d] Allocated image-5 for MetaFont[fonts\DejaVuSansMono, size=21, style=0, height=24.0, ascent=20.0, descent=5.0, leading=-1.0, class=class sage.FreetypeFont] width=128 height=128 ptr=851450944
Sun 1/30 20:49:54.284 [ReProcessHook@70c263a1] Start looking for max channel digits
Sun 1/30 20:49:54.284 [ReProcessHook@70c263a1] New max channel = 4, from channel 1579 on lineup 'Comcast - Digital - Houston (sdepg)'
Sun 1/30 20:49:54.286 [ReProcessHook@70c263a1] Done looking for max channel digits; elapsed time: 2
Sun 1/30 20:49:54.286 [Fork-JREkiwi-615771@2053894b] Starting Comskip Playback v2.1.3 Thread: Thread[Fork-JREkiwi-615771,5,main], for UI context 0023a50010d8
Sun 1/30 20:49:54.297 [FinalRender-0023a50010d8@51dcbc9d] Allocated image-5 for MetaFont[fonts\DejaVuSansMono, size=21, style=0, height=24.0, ascent=20.0, descent=5.0, leading=-1.0, class=class sage.FreetypeFont] width=128 height=128 ptr=851451952
Sun 1/30 20:49:54.309 [FinalRender-0023a50010d8@51dcbc9d] Allocated image-5 for C:\SageTV64\SageTV\STVs\SageTV7\Themes\Standard\OSDBGBottom.png width=8 height=150 ptr=851447472
Sun 1/30 20:49:54.323 [FinalRender-0023a50010d8@51dcbc9d] Allocated image-5 for C:\SageTV64\SageTV\STVs\SageTV7\Themes\Standard\OSDStatusPlay.png width=8 height=8 ptr=851446744
Sun 1/30 20:49:58.637 [Ministry@6cc0ead8] Ministry is waiting for 180 sec
Sun 1/30 20:50:15.336 [EventRouter-0023a50010d8@39e658dc] processUserEvent-UserEvent[stop] evtTime=Sun 1/30 20:50:14.380
Sun 1/30 20:50:15.337 [EventRouter-0023a50010d8@39e658dc] VF.submitJob(VFJob[CloseMF r=0.0 t=0 file=null ifn=null])
Sun 1/30 20:50:15.337 [VideoFrame-0023a50010d8@6d171805] VF processing job VFJob[CloseMF r=0.0 t=0 file=null ifn=null] nPlayin=true
Sun 1/30 20:50:15.337 [VideoFrame-0023a50010d8@6d171805] VF processing on UI Thread VFJob[CloseMF r=0.0 t=0 file=null ifn=null]
Sun 1/30 20:50:15.337 [VideoFrame-0023a50010d8@6d171805] Added:Watched[id=562250 Airing=A[562249,562247,"Shang-chi_preview 3",0@0130.20:15,1,V], WatchStart=Sun 1/30 20:15:13.102, WatchEnd=Sun 1/30 20:15:34.203, RealStart=Sun 1/30 20:49:53.320, RealEnd=Sun 1/30 20:50:15.337]
Sun 1/30 20:50:15.337 [VideoFrame-0023a50010d8@6d171805] VF logFileWatch doneAir=A[562249,562247,"Shang-chi_preview 3",0@0130.20:15,1,V] theTime=Sun 1/30 20:15:34.203 recTime=Sun 1/30 20:15:13.102
Sun 1/30 20:50:15.337 [VideoFrame-0023a50010d8@6d171805] stopPush0()
Sun 1/30 20:50:15.383 [VideoFrame-0023a50010d8@6d171805] Closing down MiniPlayer
Sun 1/30 20:50:15.383 [VideoFrame-0023a50010d8@6d171805] closeDriver0()
Sun 1/30 20:50:15.424 [VideoFrame-0023a50010d8@6d171805] VF processing job null nPlayin=false
Sun 1/30 20:50:15.424 [EventRouter-0023a50010d8@39e658dc] Seeker.finishWatch(UIManager:localhost@@0023a50010d8-3cb4d2d4)
Sun 1/30 20:50:15.424 [VideoFrame-0023a50010d8@6d171805] VF thread is now waiting for 0:00:00.000
sample 2, plays ok
Quote:
Sun 1/30 20:50:19.605 [VideoFrame-0023a50010d8@6d171805] initDriver0()
Sun 1/30 20:50:19.605 [VideoFrame-0023a50010d8@6d171805] Issuing MCSR client socket to 0023a50010d8
Sun 1/30 20:50:19.606 [VideoFrame-0023a50010d8@6d171805] MiniPlayer established for 0023a50010d8
Sun 1/30 20:50:19.669 [ActiveRender-0023a50010d8@1ddb977c] VideoFrame got registration of a subtitle UI component: sage.ZCCLabel[loc=java.awt.Point[x=38,y=110] size=java.awt.Dimension[width=180,height=29]]
Sun 1/30 20:50:19.669 [ActiveRender-0023a50010d8@1ddb977c] VideoFrame got registration of a cc UI component: sage.ZCCLabel[loc=java.awt.Point[x=25,y=14] size=java.awt.Dimension[width=206,height=116]]
Sun 1/30 20:50:19.684 [AsyncWatch@2053894b] VideoFrame got registration of a subtitle UI component: null
Sun 1/30 20:50:19.685 [AsyncWatch@2053894b] VideoFrame got registration of a cc UI component: null
Sun 1/30 20:50:19.702 [FinalRender-0023a50010d8@51dcbc9d] MiniClient did not succeed with menu hint change to:menuName:Browser - Videos, popupName:null, hasTextInput:false, errcode=1
Sun 1/30 20:50:19.821 [VideoFrame-0023a50010d8@6d171805] getEstimatedBW=131168000 estimatedBWBytes=16396000 estimatedBWTime=1000
Sun 1/30 20:50:19.821 [VideoFrame-0023a50010d8@6d171805] MiniPlayer got an estimate from the UI on bandwidth of 131168Kbps
Sun 1/30 20:50:19.821 [VideoFrame-0023a50010d8@6d171805] MiniPlayer is using Pull mode playback
Sun 1/30 20:50:19.821 [VideoFrame-0023a50010d8@6d171805] openURL0(stv://192.168.99.70/\\KJCUBED\Videos\Videos\DVD\Shang-chi_preview 2.mkv)
Sun 1/30 20:50:19.986 [Fork-OPUS4-111999@70c263a1] ENDING background video thumb preloader thread, ID = 0.9638612442455786
Sun 1/30 20:50:20.621 [VideoFrame-0023a50010d8@6d171805] Sigma video dim=java.awt.Dimension[width=720,height=480]
Sun 1/30 20:50:20.621 [VideoFrame-0023a50010d8@6d171805] setMute0()
Sun 1/30 20:50:20.622 [VideoFrame-0023a50010d8@6d171805] getDuration : 0
Sun 1/30 20:50:20.622 [VideoFrame-0023a50010d8@6d171805] VideoFrame.timeSelected2(Sun 1/30 20:13:55.417, true) currFile=MediaFile[id=562242 A[562245,562243,"Shang-chi_preview 2",0@0130.20:13,1,V] mask=V host=KJCUBED encodedBy= format=MATROSKA 0:01:00 11531 kbps [#0 Video[H.264 23.976025 fps 1920x1080 8:4 progressive id=0]#1 Audio[DCA 48000 Hz 8 channels idx=1 id=0 eng]#2 Audio[DCA 48000 Hz 6 channels 1536 kbps idx=2 id=0 eng]#3 Audio[AC3 48000 Hz 6 channels 640 kbps idx=3 id=0 eng]#4 Audio[MP3 48000 Hz 2 channels 160 kbps idx=4 id=0 eng]#5 Subpic[PGSSUB id=0 eng]] \\KJCUBED\Videos\Videos\DVD\Shang-chi_preview 2.mkv, Seg0[Sun 1/30 20:13:55.417-Sun 1/30 20:14:55.441]] realDur=0
Sun 1/30 20:50:20.623 [VideoFrame-0023a50010d8@6d171805] playPush0()
Sun 1/30 20:50:20.657 [VideoFrame-0023a50010d8@6d171805] Channel Change Time=1643597420657 NOTE: Not valid if this was not a direct channel change!
Sun 1/30 20:50:20.661 [VideoFrame-0023a50010d8@6d171805] Default audio language is already selected
Sun 1/30 20:50:20.661 [VideoFrame-0023a50010d8@6d171805] VF processing job null nPlayin=true
Sun 1/30 20:50:20.661 [VideoFrame-0023a50010d8@6d171805] isRec=false rd=60024 base=0 eos=false
Sun 1/30 20:50:20.661 [VideoFrame-0023a50010d8@6d171805] VF thread is now waiting for 0:00:59.774
Sun 1/30 20:50:20.668 [ActiveRender-0023a50010d8@1ddb977c] VideoFrame got registration of a subtitle UI component: sage.ZCCLabel[loc=java.awt.Point[x=182,y=519] size=java.awt.Dimension[width=849,height=136]]
Sun 1/30 20:50:20.668 [ActiveRender-0023a50010d8@1ddb977c] VideoFrame got registration of a cc UI component: sage.ZCCLabel[loc=java.awt.Point[x=121,y=68] size=java.awt.Dimension[width=971,height=547]]
Sun 1/30 20:50:20.669 [FinalRender-0023a50010d8@51dcbc9d] MiniClient did not succeed with menu hint change to:menuName:MediaPlayer OSD, popupName:null, hasTextInput:false, errcode=1
Sun 1/30 20:50:20.684 [ReProcessHook@2053894b] Start looking for max channel digits
Sun 1/30 20:50:20.684 [ReProcessHook@2053894b] New max channel = 4, from channel 1579 on lineup 'Comcast - Digital - Houston (sdepg)'
Sun 1/30 20:50:20.686 [ReProcessHook@2053894b] Done looking for max channel digits; elapsed time: 2
Sun 1/30 20:50:20.686 [Fork-JREkiwi-615771@70c263a1] Starting Comskip Playback v2.1.3 Thread: Thread[Fork-JREkiwi-615771,5,main], for UI context 0023a50010d8
Sun 1/30 20:50:32.241 [EventRouter-0023a50010d8@39e658dc] processUserEvent-UserEvent[stop] evtTime=Sun 1/30 20:50:31.285
Sun 1/30 20:50:32.241 [EventRouter-0023a50010d8@39e658dc] VF.submitJob(VFJob[CloseMF r=0.0 t=0 file=null ifn=null])
Sun 1/30 20:50:32.241 [VideoFrame-0023a50010d8@6d171805] VF processing job VFJob[CloseMF r=0.0 t=0 file=null ifn=null] nPlayin=true
Sun 1/30 20:50:32.241 [VideoFrame-0023a50010d8@6d171805] VF processing on UI Thread VFJob[CloseMF r=0.0 t=0 file=null ifn=null]
Sun 1/30 20:50:32.254 [VideoFrame-0023a50010d8@6d171805] Added:Watched[id=562251 Airing=A[562245,562243,"Shang-chi_preview 2",0@0130.20:13,1,V], WatchStart=Sun 1/30 20:13:55.417, WatchEnd=Sun 1/30 20:14:07.037, RealStart=Sun 1/30 20:50:19.605, RealEnd=Sun 1/30 20:50:32.254]
Sun 1/30 20:50:32.255 [VideoFrame-0023a50010d8@6d171805] VF logFileWatch doneAir=A[562245,562243,"Shang-chi_preview 2",0@0130.20:13,1,V] theTime=Sun 1/30 20:14:07.037 recTime=Sun 1/30 20:13:55.417
Sun 1/30 20:50:32.255 [VideoFrame-0023a50010d8@6d171805] stopPush0()
Sun 1/30 20:50:32.298 [VideoFrame-0023a50010d8@6d171805] Closing down MiniPlayer
Sun 1/30 20:50:32.298 [VideoFrame-0023a50010d8@6d171805] closeDriver0()
Sun 1/30 20:50:32.341 [VideoFrame-0023a50010d8@6d171805] VF processing job null nPlayin=false
Sun 1/30 20:50:32.341 [EventRouter-0023a50010d8@39e658dc] Seeker.finishWatch(UIManager:localhost@@0023a50010d8-3cb4d2d4)
Sun 1/30 20:50:32.341 [VideoFrame-0023a50010d8@6d171805] VF thread is now waiting for 0:00:00.000
Error trying to play the whole movie
Quote:
Sun 1/30 20:51:08.007 [TimeoutHandler@4d13b3e8] TIMEOUT occurred - close the socket asynchronously for java.nio.channels.SocketChannel[connected local=/192.168.99.70:31099 remote=/192.168.99.118:58289]
Sun 1/30 20:51:08.007 [VideoFrame-0023a50010d8@6d171805] java.nio.channels.AsynchronousCloseException
Sun 1/30 20:51:08.008 [VideoFrame-0023a50010d8@6d171805] VideoFrame had an error loading the file. It must abort the file load.
The whole piece where that error shows up
Quote:
Sun 1/30 20:50:37.769 [VideoFrame-0023a50010d8@6d171805] initDriver0()
Sun 1/30 20:50:37.769 [VideoFrame-0023a50010d8@6d171805] Issuing MCSR client socket to 0023a50010d8
Sun 1/30 20:50:37.769 [VideoFrame-0023a50010d8@6d171805] MiniPlayer established for 0023a50010d8
Sun 1/30 20:50:37.834 [ActiveRender-0023a50010d8@1ddb977c] VideoFrame got registration of a subtitle UI component: sage.ZCCLabel[loc=java.awt.Point[x=38,y=110] size=java.awt.Dimension[width=180,height=29]]
Sun 1/30 20:50:37.834 [ActiveRender-0023a50010d8@1ddb977c] VideoFrame got registration of a cc UI component: sage.ZCCLabel[loc=java.awt.Point[x=25,y=14] size=java.awt.Dimension[width=206,height=116]]
Sun 1/30 20:50:37.849 [AsyncWatch@70c263a1] VideoFrame got registration of a subtitle UI component: null
Sun 1/30 20:50:37.849 [AsyncWatch@70c263a1] VideoFrame got registration of a cc UI component: null
Sun 1/30 20:50:37.866 [FinalRender-0023a50010d8@51dcbc9d] MiniClient did not succeed with menu hint change to:menuName:Browser - Videos, popupName:null, hasTextInput:false, errcode=1
Sun 1/30 20:50:37.999 [VideoFrame-0023a50010d8@6d171805] getEstimatedBW=131168000 estimatedBWBytes=16396000 estimatedBWTime=1000
Sun 1/30 20:50:37.999 [VideoFrame-0023a50010d8@6d171805] MiniPlayer got an estimate from the UI on bandwidth of 131168Kbps
Sun 1/30 20:50:37.999 [VideoFrame-0023a50010d8@6d171805] MiniPlayer is using Pull mode playback
Sun 1/30 20:50:37.999 [VideoFrame-0023a50010d8@6d171805] openURL0(stv://192.168.99.70/\\KJCUBED\Videos\Videos\DVD\MCU_25 Shang-Chi and the Legend of the Ten Rings (2021).mkv)
Sun 1/30 20:50:38.671 [Fork-OPUS4-111999@6912bf75] ENDING background video thumb preloader thread, ID = 0.4497951568341101
Sun 1/30 20:51:08.007 [TimeoutHandler@4d13b3e8] TIMEOUT occurred - close the socket asynchronously for java.nio.channels.SocketChannel[connected local=/192.168.99.70:31099 remote=/192.168.99.118:58289]
Sun 1/30 20:51:08.007 [VideoFrame-0023a50010d8@6d171805] java.nio.channels.AsynchronousCloseException
Sun 1/30 20:51:08.008 [VideoFrame-0023a50010d8@6d171805] VideoFrame had an error loading the file. It must abort the file load.
Sun 1/30 20:51:08.008 [ReProcessHook@37459d7e] processOptionsMenu optionsMenu=default:BASE-77347|OptionsMenu:ErrorMessage
Sun 1/30 20:51:08.008 [VideoFrame-0023a50010d8@6d171805] Closing down MiniPlayer
Sun 1/30 20:51:08.008 [VideoFrame-0023a50010d8@6d171805] closeDriver0()
Sun 1/30 20:51:08.008 [VideoFrame-0023a50010d8@6d171805] Channel Change Time=1643597468008 NOTE: Not valid if this was not a direct channel change!
Sun 1/30 20:51:08.008 [VideoFrame-0023a50010d8@6d171805] VF processing job null nPlayin=false
Sun 1/30 20:51:08.008 [VideoFrame-0023a50010d8@6d171805] VF thread is now waiting for 0:00:00.000
Anything jump out to anyone?

Is the a file size limit for playback?

Shang-chi_preview 2.mkv is 82.5MB

Shang-chi_preview 3.mkv is 55.1MB

Movie is 10.0GB


192.168.99.70 is the SageTV x64 server
192.168.99.118 is the HD300
__________________
SageTV running on: Win10 21H2
SageTV 9.2.6.976 (64 bit)
Java 1.8.0 311 (64 bit)
OpenDCT 0.5.32 (64 bit)
Clients: HD300 (x2)
HDHR3-CC Prime 20220822 (Comcast CableCard) - 3 Tuners
HDFX-4K Flex 20220822 (OTA) - 4 Tuners
Reply With Quote
  #2  
Old 01-30-2022, 09:33 PM
CptKirk CptKirk is offline
Sage Aficionado
 
Join Date: Sep 2010
Posts: 266
Info on the error "java.nio.channels.AsynchronousCloseException":

https://developer.android.com/refere...CloseException

Quote:
Checked exception received by a thread when another thread closes the channel or the part of the channel upon which it is blocked in an I/O operation.
__________________
SageTV running on: Win10 21H2
SageTV 9.2.6.976 (64 bit)
Java 1.8.0 311 (64 bit)
OpenDCT 0.5.32 (64 bit)
Clients: HD300 (x2)
HDHR3-CC Prime 20220822 (Comcast CableCard) - 3 Tuners
HDFX-4K Flex 20220822 (OTA) - 4 Tuners
Reply With Quote
  #3  
Old 02-12-2022, 11:57 PM
CptKirk CptKirk is offline
Sage Aficionado
 
Join Date: Sep 2010
Posts: 266
Still no luck with this. Just did another of my new Blue-Ray rips and it does not play in SageTV either.

Here's the detection of the MKV file with Josh's plugin:
Code:
Sat 2/12 22:10:10.109 [LibraryImporter@1cf46f51] testFile=DCU_10_Suicide Squad (2021).mkv
Sat 2/12 22:10:10.124 [LibraryImporter@1cf46f51] Using the format detector plugin
Sat 2/12 22:10:10.124 [LibraryImporter@1cf46f51] MediaFormatParserPlugin processing: \\KJCUBED\Videos\Videos\DVD\DCU_10_Suicide Squad (2021).mkv
Sat 2/12 22:10:10.156 [LibraryImporter@1cf46f51] MediaFormatParserPlugin processing complete: \\KJCUBED\Videos\Videos\DVD\DCU_10_Suicide Squad (2021).mkv
Sat 2/12 22:10:10.169 [LibraryImporter@1cf46f51] Added:MediaFile[id=776943 A[776948,776945,"DCU 10: Suicide Squad",0@0212.18:58,132,V] mask=V host=KJCUBED encodedBy= format=MATROSKA 2:12:06 9665 kbps [#0 Video[H.264 23.976025 fps 1920x1080 8:4 progressive id=0]#1 Audio[DOLBYTRUEHD 48000 Hz 8 channels  idx=1 id=0 eng]#2 Audio[AC3 48000 Hz 6 channels 448 kbps idx=2 id=0 eng]#3 Audio[AC3 48000 Hz 6 channels 384 kbps idx=3 id=0 eng]#4 Subpic[PGSSUB id=0 eng]] \\KJCUBED\Videos\Videos\DVD\DCU_10_Suicide Squad (2021).mkv, Seg0[Sat 2/12 18:58:34.127-Sat 2/12 21:10:41.102]] num=24188
Sat 2/12 22:10:10.169 [LibraryImporter@1cf46f51] New Library File MediaFile[id=776943 A[776948,776945,"DCU 10: Suicide Squad",0@0212.18:58,132,V] mask=V host=KJCUBED encodedBy= format=MATROSKA 2:12:06 9665 kbps [#0 Video[H.264 23.976025 fps 1920x1080 8:4 progressive id=0]#1 Audio[DOLBYTRUEHD 48000 Hz 8 channels  idx=1 id=0 eng]#2 Audio[AC3 48000 Hz 6 channels 448 kbps idx=2 id=0 eng]#3 Audio[AC3 48000 Hz 6 channels 384 kbps idx=3 id=0 eng]#4 Subpic[PGSSUB id=0 eng]] \\KJCUBED\Videos\Videos\DVD\DCU_10_Suicide Squad (2021).mkv, Seg0[Sat 2/12 18:58:34.127-Sat 2/12 21:10:41.102]]
Everything looks ok.

Now when I try to play it I just get the spinning SageTV circle for quite a while, then the error, then it kicks me into a live tv channel for some odd reason like I mentioned previously.

Code:
Sat 2/12 22:10:43.634 [AsyncWatch@632fb4aa] VideoFrame.watch(A[776948,776945,"DCU 10: Suicide Squad",0@0212.18:58,132,V])
Sat 2/12 22:10:43.634 [AsyncWatch@632fb4aa] watchThisFile=MediaFile[id=776943 A[776948,776945,"DCU 10: Suicide Squad",0@0212.18:58,132,V] mask=V host=KJCUBED encodedBy= format=MATROSKA 2:12:06 9665 kbps [#0 Video[H.264 23.976025 fps 1920x1080 8:4 progressive id=0]#1 Audio[DOLBYTRUEHD 48000 Hz 8 channels  idx=1 id=0 eng]#2 Audio[AC3 48000 Hz 6 channels 448 kbps idx=2 id=0 eng]#3 Audio[AC3 48000 Hz 6 channels 384 kbps idx=3 id=0 eng]#4 Subpic[PGSSUB id=0 eng]] \\KJCUBED\Videos\Videos\DVD\DCU_10_Suicide Squad (2021).mkv, Seg0[Sat 2/12 18:58:34.127-Sat 2/12 21:10:41.102]]
Sat 2/12 22:10:43.635 [AsyncWatch@632fb4aa] Watch airing is a file & over, do that instead dvd=false
Sat 2/12 22:10:43.636 [AsyncWatch@632fb4aa] Seeker.finishWatch(UIManager:localhost@@0023a50011bf-58dbb42e)
Sat 2/12 22:10:43.636 [AsyncWatch@632fb4aa] VF.submitJob(VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=776943 A[776948,776945,"DCU 10: Suicide Squad",0@0212.18:58,132,V] mask=V host=KJCUBED encodedBy= format=MATROSKA 2:12:06 9665 kbps [#0 Video[H.264 23.976025 fps 1920x1080 8:4 progressive id=0]#1 Audio[DOLBYTRUEHD 48000 Hz 8 channels  idx=1 id=0 eng]#2 Audio[AC3 48000 Hz 6 channels 448 kbps idx=2 id=0 eng]#3 Audio[AC3 48000 Hz 6 channels 384 kbps idx=3 id=0 eng]#4 Subpic[PGSSUB id=0 eng]] \\KJCUBED\Videos\Videos\DVD\DCU_10_Suicide Squad (2021).mkv, Seg0[Sat 2/12 18:58:34.127-Sat 2/12 21:10:41.102]] ifn=null])
Sat 2/12 22:10:43.636 [AsyncWatch@632fb4aa] No Start on Watch
Sat 2/12 22:10:43.636 [VideoFrame-0023a50011bf@591449b8] VF processing job VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=776943 A[776948,776945,"DCU 10: Suicide Squad",0@0212.18:58,132,V] mask=V host=KJCUBED encodedBy= format=MATROSKA 2:12:06 9665 kbps [#0 Video[H.264 23.976025 fps 1920x1080 8:4 progressive id=0]#1 Audio[DOLBYTRUEHD 48000 Hz 8 channels  idx=1 id=0 eng]#2 Audio[AC3 48000 Hz 6 channels 448 kbps idx=2 id=0 eng]#3 Audio[AC3 48000 Hz 6 channels 384 kbps idx=3 id=0 eng]#4 Subpic[PGSSUB id=0 eng]] \\KJCUBED\Videos\Videos\DVD\DCU_10_Suicide Squad (2021).mkv, Seg0[Sat 2/12 18:58:34.127-Sat 2/12 21:10:41.102]] ifn=null] nPlayin=false
Sat 2/12 22:10:43.637 [VideoFrame-0023a50011bf@591449b8] VF processing on UI Thread VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=776943 A[776948,776945,"DCU 10: Suicide Squad",0@0212.18:58,132,V] mask=V host=KJCUBED encodedBy= format=MATROSKA 2:12:06 9665 kbps [#0 Video[H.264 23.976025 fps 1920x1080 8:4 progressive id=0]#1 Audio[DOLBYTRUEHD 48000 Hz 8 channels  idx=1 id=0 eng]#2 Audio[AC3 48000 Hz 6 channels 448 kbps idx=2 id=0 eng]#3 Audio[AC3 48000 Hz 6 channels 384 kbps idx=3 id=0 eng]#4 Subpic[PGSSUB id=0 eng]] \\KJCUBED\Videos\Videos\DVD\DCU_10_Suicide Squad (2021).mkv, Seg0[Sat 2/12 18:58:34.127-Sat 2/12 21:10:41.102]] ifn=null]
Sat 2/12 22:10:43.637 [VideoFrame-0023a50011bf@591449b8] VF processing job VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=776943 A[776948,776945,"DCU 10: Suicide Squad",0@0212.18:58,132,V] mask=V host=KJCUBED encodedBy= format=MATROSKA 2:12:06 9665 kbps [#0 Video[H.264 23.976025 fps 1920x1080 8:4 progressive id=0]#1 Audio[DOLBYTRUEHD 48000 Hz 8 channels  idx=1 id=0 eng]#2 Audio[AC3 48000 Hz 6 channels 448 kbps idx=2 id=0 eng]#3 Audio[AC3 48000 Hz 6 channels 384 kbps idx=3 id=0 eng]#4 Subpic[PGSSUB id=0 eng]] \\KJCUBED\Videos\Videos\DVD\DCU_10_Suicide Squad (2021).mkv, Seg0[Sat 2/12 18:58:34.127-Sat 2/12 21:10:41.102]] ifn=null] nPlayin=false
Sat 2/12 22:10:43.638 [VideoFrame-0023a50011bf@591449b8] VF processing on UI Thread VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=776943 A[776948,776945,"DCU 10: Suicide Squad",0@0212.18:58,132,V] mask=V host=KJCUBED encodedBy= format=MATROSKA 2:12:06 9665 kbps [#0 Video[H.264 23.976025 fps 1920x1080 8:4 progressive id=0]#1 Audio[DOLBYTRUEHD 48000 Hz 8 channels  idx=1 id=0 eng]#2 Audio[AC3 48000 Hz 6 channels 448 kbps idx=2 id=0 eng]#3 Audio[AC3 48000 Hz 6 channels 384 kbps idx=3 id=0 eng]#4 Subpic[PGSSUB id=0 eng]] \\KJCUBED\Videos\Videos\DVD\DCU_10_Suicide Squad (2021).mkv, Seg0[Sat 2/12 18:58:34.127-Sat 2/12 21:10:41.102]] ifn=null]
Sat 2/12 22:10:43.638 [VideoFrame-0023a50011bf@591449b8] VideoFrame creating new media player for file:MediaFile[id=776943 A[776948,776945,"DCU 10: Suicide Squad",0@0212.18:58,132,V] mask=V host=KJCUBED encodedBy= format=MATROSKA 2:12:06 9665 kbps [#0 Video[H.264 23.976025 fps 1920x1080 8:4 progressive id=0]#1 Audio[DOLBYTRUEHD 48000 Hz 8 channels  idx=1 id=0 eng]#2 Audio[AC3 48000 Hz 6 channels 448 kbps idx=2 id=0 eng]#3 Audio[AC3 48000 Hz 6 channels 384 kbps idx=3 id=0 eng]#4 Subpic[PGSSUB id=0 eng]] \\KJCUBED\Videos\Videos\DVD\DCU_10_Suicide Squad (2021).mkv, Seg0[Sat 2/12 18:58:34.127-Sat 2/12 21:10:41.102]]
Sat 2/12 22:10:43.638 [VideoFrame-0023a50011bf@591449b8] VF file=MediaFile[id=776943 A[776948,776945,"DCU 10: Suicide Squad",0@0212.18:58,132,V] mask=V host=KJCUBED encodedBy= format=MATROSKA 2:12:06 9665 kbps [#0 Video[H.264 23.976025 fps 1920x1080 8:4 progressive id=0]#1 Audio[DOLBYTRUEHD 48000 Hz 8 channels  idx=1 id=0 eng]#2 Audio[AC3 48000 Hz 6 channels 448 kbps idx=2 id=0 eng]#3 Audio[AC3 48000 Hz 6 channels 384 kbps idx=3 id=0 eng]#4 Subpic[PGSSUB id=0 eng]] \\KJCUBED\Videos\Videos\DVD\DCU_10_Suicide Squad (2021).mkv, Seg0[Sat 2/12 18:58:34.127-Sat 2/12 21:10:41.102]] targetTime = Sat 2/12 18:58:34.127
Sat 2/12 22:10:43.638 [VideoFrame-0023a50011bf@591449b8] VideoFrame.timeSelected(Sat 2/12 18:58:34.127, true) currFile=MediaFile[id=776943 A[776948,776945,"DCU 10: Suicide Squad",0@0212.18:58,132,V] mask=V host=KJCUBED encodedBy= format=MATROSKA 2:12:06 9665 kbps [#0 Video[H.264 23.976025 fps 1920x1080 8:4 progressive id=0]#1 Audio[DOLBYTRUEHD 48000 Hz 8 channels  idx=1 id=0 eng]#2 Audio[AC3 48000 Hz 6 channels 448 kbps idx=2 id=0 eng]#3 Audio[AC3 48000 Hz 6 channels 384 kbps idx=3 id=0 eng]#4 Subpic[PGSSUB id=0 eng]] \\KJCUBED\Videos\Videos\DVD\DCU_10_Suicide Squad (2021).mkv, Seg0[Sat 2/12 18:58:34.127-Sat 2/12 21:10:41.102]]
Sat 2/12 22:10:43.638 [AsyncWatch@632fb4aa] setUI(sage.PseudoMenu@5a748f88[MediaPlayer OSD]) histIdx=2 uiHistory=[sage.PseudoMenu@1041bd86[Main Menu], sage.PseudoMenu@1336a739[Browser - Videos], sage.PseudoMenu@5a748f88[MediaPlayer OSD]] redo=false performingActivation=null
Sat 2/12 22:10:43.639 [VideoFrame-0023a50011bf@591449b8] initDriver0()
Sat 2/12 22:10:43.639 [VideoFrame-0023a50011bf@591449b8] Issuing MCSR client socket to 0023a50011bf
Sat 2/12 22:10:43.639 [VideoFrame-0023a50011bf@591449b8] MiniPlayer established for 0023a50011bf
Sat 2/12 22:10:43.699 [ActiveRender-0023a50011bf@660565ea] VideoFrame got registration of a subtitle UI component: sage.ZCCLabel[loc=java.awt.Point[x=38,y=110] size=java.awt.Dimension[width=180,height=29]]
Sat 2/12 22:10:43.699 [ActiveRender-0023a50011bf@660565ea] VideoFrame got registration of a cc UI component: sage.ZCCLabel[loc=java.awt.Point[x=25,y=14] size=java.awt.Dimension[width=206,height=116]]
Sat 2/12 22:10:43.741 [FinalRender-0023a50011bf@2a6fceac] MiniClient did not succeed with menu hint change to:menuName:Browser - Videos, popupName:null, hasTextInput:false, errcode=1
Sat 2/12 22:10:43.745 [AsyncWatch@632fb4aa] VideoFrame got registration of a subtitle UI component: null
Sat 2/12 22:10:43.745 [AsyncWatch@632fb4aa] VideoFrame got registration of a cc UI component: null
Sat 2/12 22:10:43.851 [VideoFrame-0023a50011bf@591449b8] getEstimatedBW=0 estimatedBWBytes=0 estimatedBWTime=0
Sat 2/12 22:10:43.852 [VideoFrame-0023a50011bf@591449b8] MiniPlayer was not able to get a bandwidth estimate from the UI system, sending data to get its own estimate...
Sat 2/12 22:10:43.858 [VideoFrame-0023a50011bf@591449b8] Bandwidth test base=1 base*2=4 BW=131168000
Sat 2/12 22:10:43.858 [VideoFrame-0023a50011bf@591449b8] MiniPlayer got an estimate from the UI on bandwidth of 131168Kbps
Sat 2/12 22:10:43.858 [VideoFrame-0023a50011bf@591449b8] MiniPlayer is using Pull mode playback
Sat 2/12 22:10:43.858 [VideoFrame-0023a50011bf@591449b8] openURL0(stv://192.168.99.70/\\KJCUBED\Videos\Videos\DVD\DCU_10_Suicide Squad (2021).mkv)
Sat 2/12 22:10:44.081 [Fork-OPUS4-111999@1cf46f51] ENDING background video thumb preloader thread, ID = 0.21638629382274588
Sat 2/12 22:10:44.592 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 751 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:10:45.344 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 1503 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:10:46.097 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 2256 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:10:46.850 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 3009 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:10:47.612 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 3771 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:10:48.365 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 4524 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:10:49.129 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 5288 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:10:49.892 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 6051 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:10:50.645 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 6804 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:10:51.409 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 7568 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:10:52.174 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 8333 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:10:52.936 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 9095 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:10:53.689 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 9848 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:10:54.441 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 10600 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:10:55.204 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 11363 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:10:55.957 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 12116 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:10:56.709 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 12868 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:10:57.472 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 13631 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:10:58.225 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 14384 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:10:58.977 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 15136 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:10:59.728 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 15887 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:11:00.493 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 16652 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:11:01.246 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 17405 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:11:01.996 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 18155 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:11:02.747 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 18906 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:11:03.498 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 19657 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:11:04.248 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 20407 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:11:05.001 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 21160 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:11:05.764 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 21923 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:11:06.516 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 22675 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:11:07.268 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 23427 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:11:08.033 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 24192 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:11:08.796 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 24955 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:11:09.559 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 25718 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:11:10.323 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 26482 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:11:11.085 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 27244 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:11:11.850 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 28009 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:11:12.600 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 28759 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:11:13.364 [AWTThreadWatcher-0023a50011bf@5fb8066a] EventThread-0023a50011bf Hang Detected - hang time = 29523 UILocker=Thread[ActiveRender-0023a50011bf,2,main]
Sat 2/12 22:11:13.859 [TimeoutHandler@7f556b50] TIMEOUT occurred - close the socket asynchronously for java.nio.channels.SocketChannel[connected local=/192.168.99.70:31099 remote=/192.168.99.160:37609]
Sat 2/12 22:11:13.859 [VideoFrame-0023a50011bf@591449b8] java.nio.channels.AsynchronousCloseException
Sat 2/12 22:11:13.860 [VideoFrame-0023a50011bf@591449b8] VideoFrame had an error loading the file. It must abort the file load.
Sat 2/12 22:11:13.860 [ReProcessHook@35abe47d] processOptionsMenu optionsMenu=default:BASE-77347|OptionsMenu:ErrorMessage
Sat 2/12 22:11:13.861 [VideoFrame-0023a50011bf@591449b8] Closing down MiniPlayer
It is the same error that I saw with my other Blue-ray.

Quote:
Sat 2/12 22:11:13.859 [TimeoutHandler@7f556b50] TIMEOUT occurred - close the socket asynchronously for java.nio.channels.SocketChannel[connected local=/192.168.99.70:31099 remote=/192.168.99.160:37609]
Sat 2/12 22:11:13.859 [VideoFrame-0023a50011bf@591449b8] java.nio.channels.AsynchronousCloseException
Sat 2/12 22:11:13.860 [VideoFrame-0023a50011bf@591449b8] VideoFrame had an error loading the file. It must abort the file load.
I have always ripped my DVD's to MP4 H.264. I just started trying Blue-ray and have to rip to MKV H.264 so that I can get the Blue-ray subtitles.

Could it possibly be the audio tracks I am using?

In Handbrake this is what I selected for the audio stream to use for the first audio track. I am using the best/highest quality soundtrack:

Shang-Chi: English (DTS-HD MA) (7.1 ch), Codec DTS-HD Passthru
Suicide Squad: English (TrueHD) (7.1 ch), Codec DTS-HD Passthru

I am wondering if I need to use just the AC3, 5.1 ch soundtrack instead.

I found that I can play them on the SageTV client on the server that you can setup to use the LAV video and LAV audio decoders. Since you cannot set the video and audio decoders on the HD300 that could be where the problem is at. I've got ShangChi transcoding in Handbrake to a new MKV with AC3 audio to see how that goes.

Did some more searching and found references to the HD300 firmware and DTS Audio.

On my HD300's I am currently using the last firmware 20110506-0.

It was mentioned that HD300 firmware 20110124-2 has the DTS and TrueHD audio working. So I will probably flash one back and give that a try as well.
__________________
SageTV running on: Win10 21H2
SageTV 9.2.6.976 (64 bit)
Java 1.8.0 311 (64 bit)
OpenDCT 0.5.32 (64 bit)
Clients: HD300 (x2)
HDHR3-CC Prime 20220822 (Comcast CableCard) - 3 Tuners
HDFX-4K Flex 20220822 (OTA) - 4 Tuners
Reply With Quote
  #4  
Old 02-13-2022, 12:20 PM
graywolf's Avatar
graywolf graywolf is offline
Sage Icon
 
Join Date: Oct 2009
Location: NC
Posts: 1,370
Quote:
I have always ripped my DVD's to MP4 H.264. I just started trying Blue-ray and have to rip to MKV H.264 so that I can get the Blue-ray subtitles.
How many subtitles?
And which languages?
I've seen issues like you described for some that had many subtitles.

As and experiment, try ripping without any subtitles and/or just english.
See if the issue is with the subtitles. Haven't seen PGSSUB type before.
Reply With Quote
  #5  
Old 02-16-2022, 12:23 PM
CptKirk CptKirk is offline
Sage Aficionado
 
Join Date: Sep 2010
Posts: 266
Been doing a lot more debug work over the last few days.

Dropped the whole 37GB blueray rip folder of Shang-Chi into my SageTV movies folder.

My rip had English audio and English subtitles selected, had 4 audio tracks (DTS-HD MA 7.1, DTS 5.1, 2 Ch and 2 Ch) and 3 subtitles tracks (EN, EN Directors, EN Forced).

On the HD300 when I go to Video-DVD/BD I am able to play the Shang-Chi BD with no problems. Went through all audio tracks and all subtitles tracks. All play fine.

Quote:
-------------------------
Side note

I have two HD300's, both of them on the last firmware 20110506-0. As noted in a number of forum posts, I did have to go back to firmware 20110124-2 in order for DTS-HD MA and Dobly TrueHD to work.

On my upstairs HD300 connected directly to a TV via HDMI I had to set the HD300 audio output to Digital Bitstream, since the TV does not support HDMI 1.3.

On my downstairs HD300 connected directly to an Onkyo receiver via HDMI I had to set the HD300 audio output to HDMI 1.3 HD Audio Bitstream.

Before I changed back to 20110124-2 the movie would play but there would be no audio
-------------------------

So I know the HD300 has no problem with the size of the BD file (the .m2ts file is 34.7GB) and also no problem with the audio or subtitle tracks.

It is only once I use Handbrake to transcode it down to a 10GB MKV file. Which, when I try to play it gives the time out error.

Updated my Handbrake for 1.3.3 (which was what I have been using for a long time with DVDs) to the latest 1.5.1 hoping that it would fix it. No luck there.

Have an AMD Ryzen 5950x 16 core / 32 threads so a whole movie transcode on ultrafast was only taking 11 minutes. I was doing so many different tests I finally just changed Handbrake to do the first 3 chapters which was only about 1 minute.


All of the short 3 chapter clips actually played. When play started though there was a few seconds of delay before the clip would start.

Finally wanted to find out what was happening on the HD300 and found the FAQ debug post by Andy (https://forums.sagetv.com/forums/sho...1&postcount=18)

Did both the debug on and Windows File Server on as directed in the debug setup. Was not able to get it so I could browse the HD300 from my windows machine but could telnet (putty) into it to get to the log files.

After a hard power off/on of the HD300 I once again tried to play the full movie MKV file and, of course, it played with no problems. Head scratching started here. Not quite hair pulling out yet, but getting there...

Once I start the play it does take about 15 seconds after selecting Watch Now before it actually starts playing the movie. Before it was during this long wait that it would time out.


Back to the HD300, turned OFF debug and turned OFF file server.

- Full movie MKV file - no play, timeout

Back to the HD300, turned OFF debug and turned ON file server.

- Full movie MKV file - no play, timeout

Back to the HD300, turned ON debug and turned OFF file server.

- Full movie MKV file - PLAYS

Back to the HD300, turned ON debug and turned ON file server.

- Full movie MKV file - PLAYS


So as long as debug is turned ON in the HD300 my Full movie MKV file will play, with the longish pause before play starts. NOTE: if playing the full uncompress BD as a recognized BD by SageTV there is no long pause at the beginning of watching. It starts playing immediately.

So just going to leave my HD300's with that setup for now.

Wish we had the source for the HD300 firmware...


Have another different issue in regards to subtitles, but will create a new post specific to that topic.
__________________
SageTV running on: Win10 21H2
SageTV 9.2.6.976 (64 bit)
Java 1.8.0 311 (64 bit)
OpenDCT 0.5.32 (64 bit)
Clients: HD300 (x2)
HDHR3-CC Prime 20220822 (Comcast CableCard) - 3 Tuners
HDFX-4K Flex 20220822 (OTA) - 4 Tuners
Reply With Quote
  #6  
Old 02-18-2022, 03:06 PM
phelme's Avatar
phelme phelme is offline
Sage Icon
 
Join Date: Dec 2006
Posts: 1,143
Did you try the AC3 conversion? that's where I would start. I use AC3 passthrough (mostly 5.1 content from cable and DirecTV) when running my overnight Handbrake stuff (via Mediashrink).
Reply With Quote
  #7  
Old 02-19-2022, 08:52 AM
CptKirk CptKirk is offline
Sage Aficionado
 
Join Date: Sep 2010
Posts: 266
Do you mean to only use AC3 as a sound track in the transcoded mkv file?

Right now when I do a transcode (I do want the best sound for my home theater system), I would put the best audio track as the first/primary audio track.

DTS HD-MA 7.1 as Handbrake DTS-HD Passthru
DTS 5.1 as Handbrake DTS Passthru
DTS 5.1 as Handbrake AC3 Dolby Pro Logic II
__________________
SageTV running on: Win10 21H2
SageTV 9.2.6.976 (64 bit)
Java 1.8.0 311 (64 bit)
OpenDCT 0.5.32 (64 bit)
Clients: HD300 (x2)
HDHR3-CC Prime 20220822 (Comcast CableCard) - 3 Tuners
HDFX-4K Flex 20220822 (OTA) - 4 Tuners
Reply With Quote
  #8  
Old 02-22-2022, 11:57 AM
phelme's Avatar
phelme phelme is offline
Sage Icon
 
Join Date: Dec 2006
Posts: 1,143
Quote:
Originally Posted by CptKirk View Post
Do you mean to only use AC3 as a sound track in the transcoded mkv file?
yep. worth a try. you could just convert one manually and see what happens.
Reply With Quote
  #9  
Old 02-22-2022, 02:28 PM
CptKirk CptKirk is offline
Sage Aficionado
 
Join Date: Sep 2010
Posts: 266
I removed these two on another Handbrake test:

Quote:
DTS HD-MA 7.1 as Handbrake DTS-HD Passthru
DTS 5.1 as Handbrake DTS Passthru
And only kept this AC3 one:

Quote:
DTS 5.1 as Handbrake AC3 Dolby Pro Logic II
On average the DTS passthru ones take about 16 seconds to start playing.

AC3 only one takes about 8 seconds to start playing.

So it is a little better.
__________________
SageTV running on: Win10 21H2
SageTV 9.2.6.976 (64 bit)
Java 1.8.0 311 (64 bit)
OpenDCT 0.5.32 (64 bit)
Clients: HD300 (x2)
HDHR3-CC Prime 20220822 (Comcast CableCard) - 3 Tuners
HDFX-4K Flex 20220822 (OTA) - 4 Tuners
Reply With Quote
  #10  
Old 02-25-2022, 11:07 AM
MattHelm MattHelm is offline
Sage Icon
 
Join Date: Jun 2005
Location: Chicago, IL
Posts: 1,209
I have been following this thread a bit, as I have been having a lot of issues with playback of some of my files also. I have always used Handbrake as my encoding tool, when converting DVDs, and also some "other" files. I've never done any Blu-Ray, as I buy these for movies I want to see at HD.

Anyway, I've been having a lot of issues with playback of files, and discovered that it was the subtitles that cause the issue. Mainly SSA subtitles with lots of fonts. If I convert to SRT or the SSA subtitles are simple, they work fine.

Also, I found out after converting a bunch of SSA to SRT, then when using Handbrake to add the SRT to a video, it converts it back to a SSA!!! When I use mkvtoolkit to add the SRT to MKV, it works fine.

Anyone know why the fonts/SSA are causing an issue? Memory? Change of code? ??? Suggestions for more testing? I'm not a programmer, so can't look at the code, but I do know a little bit about video files and willing to try things.

BTW, MediaInfo is your friend, please download a copy. mkvtookit also.
__________________
Server #1= AMD A10-5800, 8G RAM, F2A85-M PRO, 12TB, HDHomerun Prime, HDHR, Colossus (Playback - HD-200)
Server #2= AMD X2 3800+, 2G RAM, M2NPV-VM, 2TB, 3x HDHR OTA (Playback - HD-200)
Reply With Quote
  #11  
Old 02-25-2022, 09:03 PM
CptKirk CptKirk is offline
Sage Aficionado
 
Join Date: Sep 2010
Posts: 266
Bingo, I tried to use SRT as well but was still seeing the same problems. I did not use MediaInfo to look at the MKV to notice that the SRT was changed by Handbrake.

I just used the MKVToolNix GUI to unselect the PGS subtitles and added SRT subtitles instead. The resulting file started playing immediately.

I am going to start a new how-to post on adding SRT to a Blueray rip.

New post: Adding SRT subtitles to a Blueray rip
__________________
SageTV running on: Win10 21H2
SageTV 9.2.6.976 (64 bit)
Java 1.8.0 311 (64 bit)
OpenDCT 0.5.32 (64 bit)
Clients: HD300 (x2)
HDHR3-CC Prime 20220822 (Comcast CableCard) - 3 Tuners
HDFX-4K Flex 20220822 (OTA) - 4 Tuners

Last edited by CptKirk; 02-25-2022 at 09:38 PM.
Reply With Quote
Reply


Currently Active Users Viewing This Thread: 1 (0 members and 1 guests)
 
Thread Tools Search this Thread
Search this Thread:

Advanced Search
Display Modes

Posting Rules
You may not post new threads
You may not post replies
You may not post attachments
You may not edit your posts

BB code is On
Smilies are On
[IMG] code is On
HTML code is Off

Forum Jump

Similar Threads
Thread Thread Starter Forum Replies Last Post
Problem playing MKV file on HD100 AzJazz SageTV Media Extender 4 08-01-2010 01:17 PM
Problem Playing Two Ripped DVD's at Same Time jsonnabend Hardware Support 5 06-29-2009 11:42 AM
Playing back ripped DVD's with the MVP, how do YOU do it? PGPfan SageTV Media Extender 22 07-13-2006 10:12 AM
Problem playing WMA file bmcraig SageTV Software 2 07-02-2006 07:55 AM
Playing ripped DVD's PLEASE HELP!!! Tony414 SageTV Customizations 5 02-08-2005 05:58 PM


All times are GMT -6. The time now is 03:06 PM.


Powered by vBulletin® Version 3.8.11
Copyright ©2000 - 2022, vBulletin Solutions Inc.
Copyright 2003-2005 SageTV, LLC. All rights reserved.