SageTV Community  

Go Back   SageTV Community > SageTV Development and Customizations > SageTV Clients Development

Notices

SageTV Clients Development This forum is for discussions relating to SageTV Open Source Clients Development.

Reply
 
Thread Tools Search this Thread Display Modes
  #681  
Old 06-01-2021, 08:40 PM
ojones ojones is offline
Sage User
 
Join Date: Dec 2005
Posts: 61
Wow - this makes sense (regrettably)! Seems like the best hope here (for seekable playback) is for remuxed push content run through the transcoder in a MKV wrapper. Pull content in a .ts/.ps isn't seekable and the Sage remuxer appears to have issues pushing (per Josh in 2nd post above). Holy grail is getting this to play ball without active transcoding.
__________________
Hyper-V Host @ Dual Processor E5-2643 3.4ghz v4 HexaCore 128gb ram
Sage Server: VM w2016 x64 Guest running 9.2.x
OpenDCT & Plex Server: VM Ubuntu 16.04
Primary Client: VM W10x64 with GPU Passthrough
Reply With Quote
  #682  
Old 06-02-2021, 06:29 AM
nyplayer nyplayer is online now
SageTVaholic
 
Join Date: Sep 2005
Posts: 4,799
Quote:
Originally Posted by jvl711 View Post
To add onto stuckless' comments, which I agree with 100%, there is another caveat here. Android miniclient is telling sage that it does not support .ts/.ps for pull, it tells sage that it supports it for push only. This than makes sage uses its own muxer to process the files instead of sending them raw to the Android client. I have played around with these settings to make it send the files raw "pull", and it does not seem to be able to play it.

In short: ExoPlayer seems to love MKV and is ok at .ps/.ts. So I think that if I get around to adding the remux setting to keep audio and video as is, but place in MKV container, Andriod Client will probably have very little issues with the content.

Josh
You already have MKV Profiles in the miniclient why not just add a simple remux that takes very little CPU and let us test it?
__________________
Windows 10 I3 Dual Core 3.0 Server, SageTV9... OpenDCT with 2 HDHRPrimes and 4 HDHRconnects for a total of 14 Tuners.
Reply With Quote
  #683  
Old 06-02-2021, 07:12 AM
trk2 trk2 is offline
Sage Aficionado
 
Join Date: Jan 2006
Location: Maine
Posts: 480
Quote:
Originally Posted by nyplayer View Post
You already have MKV Profiles in the miniclient why not just add a simple remux that takes very little CPU and let us test it?
Stream copy as ffmpeg calls it. Been looking forward to that feature for a long time.
Reply With Quote
  #684  
Old 06-02-2021, 11:43 AM
nyplayer nyplayer is online now
SageTVaholic
 
Join Date: Sep 2005
Posts: 4,799
Quote:
Originally Posted by trk2 View Post
Stream copy as ffmpeg calls it. Been looking forward to that feature for a long time.
Right now these are my favorites defaults to remux to MKV and Delete original ...

__________________
Windows 10 I3 Dual Core 3.0 Server, SageTV9... OpenDCT with 2 HDHRPrimes and 4 HDHRconnects for a total of 14 Tuners.
Reply With Quote
  #685  
Old 06-02-2021, 01:21 PM
phelme's Avatar
phelme phelme is offline
Sage Icon
 
Join Date: Dec 2006
Posts: 1,127
Quote:
Originally Posted by ojones View Post
Stuckless - As usual you make a lot of sense! I had forgotten about the ExoPlayer grumpiness with bad files. I had assumed OpenDCT would clean that up but maybe its only cleaned up well enough to play not seek. I wonder if ExoPlayer will fully digest the streams provided by SageTVTranscoder once Josh figures out remuxing. Theoretically OpenDCT should already be doing this but I am clearly not an expert!
wonder if this is my problem. I haven't switched to OpenDCT and rather using PrimeNetEncoder because I've had zero playback problems with it and the SageTV HDxxx extenders. But what I'm noticing is that some MPEG2 TS files I play with the MiniClient will often shuttle their timelines back to the beginning of the file or the last play point when seeking. When this happens to save the SO grief I just switch back to the HD300. :/

What's interesting is once I run these same files through a (nightly) SJQ Handbrake conversion to MKV (to save space), they shuttle fine in the MiniClient.
Reply With Quote
  #686  
Old 06-21-2021, 01:21 PM
jvl711's Avatar
jvl711 jvl711 is offline
Sage Fanatic
 
Join Date: Jan 2004
Posts: 803
Version 1.8.1

Hi All,

New version is live in Amazon/Google app stores.

1.8.1 (6/18/2021)
- Updated to ExoPlayer 2.14.0
- Updated FFmpeg extension to 2.14.0
- Some minor bug fixes

Thanks,
Josh
__________________
Projects I am currently maintaining
SageTV Andoid Client
Media Format Parser Plugin
JavaFFmpegLibrary
SageTVTranscoder

If you like the work I am doing and would like to support it you can become a Patreon member.
Reply With Quote
  #687  
Old 06-21-2021, 09:48 PM
tvmaster2's Avatar
tvmaster2 tvmaster2 is offline
SageTVaholic
 
Join Date: Jun 2005
Location: tarana
Posts: 4,122
Quote:
Originally Posted by jvl711 View Post
Hi All,

New version is live in Amazon/Google app stores.

1.8.1 (6/18/2021)
- Updated to ExoPlayer 2.14.0
- Updated FFmpeg extension to 2.14.0
- Some minor bug fixes

Thanks,
Josh
Thanks as always
__________________
Sage 9 server = Gigabyte AMD quad-core - 4 gigs - integrated ATI HD4200 chipset - SSD boot, Hitachi Deskstar show drives. HD-PVR - Colossus - Win7 32 bit. HD200/300ís networked. HDHomerun tuner. "If you've given up on Weird Al, you've given up on life" - Homer Simpson
Reply With Quote
  #688  
Old 06-23-2021, 11:43 PM
gtallan gtallan is offline
Sage User
 
Join Date: Jul 2005
Location: St. Paul, MN
Posts: 45
Quote:
Originally Posted by stuckless View Post
Does this ONLY happen in the Android MiniClient? We ran into a crash/hang some time ago with thumbanils when the thumbnail filename is very long. You thumbnail is 209 characters long and the max filesystem length on Android in 255 characters... I suspect that IF this only happening on Android client, then you are hitting this problem.
Well I'm glad I found this comment - I wondered why my android client seemed to freeze/crash seemingly at random. Trimming some path lengths fixed it. Thanks for the tip!
Reply With Quote
  #689  
Old 06-28-2021, 10:38 AM
nyplayer nyplayer is online now
SageTVaholic
 
Join Date: Sep 2005
Posts: 4,799
Is this Normal ....

Before connecting miniclient ... 574,00 KB

As Soon As I connect 1 Android MiniClient ... 1,649,256
__________________
Windows 10 I3 Dual Core 3.0 Server, SageTV9... OpenDCT with 2 HDHRPrimes and 4 HDHRconnects for a total of 14 Tuners.
Reply With Quote
  #690  
Old 06-28-2021, 10:54 AM
stuckless's Avatar
stuckless stuckless is offline
SageTVaholic
 
Join Date: Oct 2007
Location: London, Ontario, Canada
Posts: 9,711
Quote:
Originally Posted by nyplayer View Post
Is this Normal ....

Before connecting miniclient ... 574,00 KB

As Soon As I connect 1 Android MiniClient ... 1,649,256
It doesn't seem abnormal. The way mini-clients work is that they build their UIs on the server and send them across the wire. Screens take a lot of memory.
Reply With Quote
  #691  
Old 06-28-2021, 11:11 AM
nyplayer nyplayer is online now
SageTVaholic
 
Join Date: Sep 2005
Posts: 4,799
Quote:
Originally Posted by stuckless View Post
It doesn't seem abnormal. The way mini-clients work is that they build their UIs on the server and send them across the wire. Screens take a lot of memory.
Yeah I opened up another Client on my phone and it went up another gig.
__________________
Windows 10 I3 Dual Core 3.0 Server, SageTV9... OpenDCT with 2 HDHRPrimes and 4 HDHRconnects for a total of 14 Tuners.
Reply With Quote
  #692  
Old 06-28-2021, 11:18 AM
hb4 hb4 is offline
Sage Aficionado
 
Join Date: Sep 2008
Location: Seattle, Wa
Posts: 342
FS4K to offsite server:
Not sure if this is specific to my setup, but if the SageTV Service is not running, the FS4K app hangs while trying to connect. The FS4K has to be power cycled to recover. Is this expected?
__________________
Server: Intel i5-11400 @4.4GHz 6 cores Windows10 Pro, Sage 9.2.6.976, Comskip Donators
Capture: Now> Xfinity/TVEverywhere/Channels OpenDCT_0.5.32_x86.
Future> remote HDHR Prime with Firmware version 20150826
Storage: 120gB SSD, 4tB HD on Server
Network: Now> gb LAN; Future> 500Mb Comcast to WAN to 20Mb rural ISP.
Playback: FireStick 4K, miniclient V1.9.3
Tech Level: Hobbyist
Reply With Quote
  #693  
Old 07-04-2021, 07:28 AM
ojones ojones is offline
Sage User
 
Join Date: Dec 2005
Posts: 61
Sage Error Code Using Mini Client

Hi All - Anyone able to make sense of my server logs during (crash pushing to the mini-client)? I've reproduced using 1.8.1 client (Sony Andriod TV and Fire HD7 tablet) and 9.2.4 windows server. Wan link server side is 1gb/s symmetric (verizon) and client side is 200-400mb/s down and 25/s up (cable w 60-75ms minimum ping). I had this working last week (same versions) from a location with 100mb/s verizon connection. Wondering if the flakey cable connection is messing me up or if I am running into a bug of some kind.

Help!

I will have an Nvidia Shield here later this week to retest as I've found that device to be the most robust client. Placeshifter has no issues.


Sat 7/3 21:41:40.848 [AsyncWatch@2c8ea885] VideoFrame.watch(A[46929369,46875193,"Beachfront Bargain Hunt: Renovation",67375@0613.13:00,60,T])
Sat 7/3 21:41:40.848 [AsyncWatch@2c8ea885] watchThisFile=MediaFile[id=47047527 A[46929369,46875193,"Beachfront Bargain Hunt: Renovation",67375@0613.13:00,60,T] mask=TV host=Workspace-1 encodedBy=DCT-Ceton InfiniTV Ethernet (00-80-8a-76) Tuner 1 on 192.168.45.60:9000 DIYHD format=MPEG2-TS 0:00:01 12604 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 progressive id=100]#1 Audio[AC3 48000 Hz 6 channels 384 kbps idx=1 id=101 eng]#2 Audio[AC3 48000 Hz 2 channels 192 kbps idx=2 id=102 eng]{ScrapedBy=Phoenix, IMDBID=, SeasonFinal=false, CollectionName=, MediaType=TV, EpisodeCount=0, CollectionOverview=, ScrapedDate=1623607205708, MediaProviderDataID=315689, MediaTitle=Beachfront Bargain Hunt: Renovation, SeriesInfoID=12110823, TagLine=, UserRating=0, DiscNumber=0, CollectionID=0, MediaProviderID=tvdb, TrailerUrl=}] \\workspace-1\tv-rec2\BeachfrontBargainHuntRenovation-S03E11-MakeoverinMathewsVirginia-46929369-0.ts, Seg0[Sun 6/13 13:00:00.004-Sun 6/13 14:00:00.011]]
Sat 7/3 21:41:40.849 [AsyncWatch@2c8ea885] Watch airing is a file & over, do that instead dvd=false
Sat 7/3 21:41:40.850 [AsyncWatch@2c8ea885] Seeker.finishWatch(UIManager:localhost@@475346585341-3ea6b337)
Sat 7/3 21:41:40.850 [AsyncWatch@2c8ea885] VF.submitJob(VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=47047527 A[46929369,46875193,"Beachfront Bargain Hunt: Renovation",67375@0613.13:00,60,T] mask=TV host=Workspace-1 encodedBy=DCT-Ceton InfiniTV Ethernet (00-80-8a-76) Tuner 1 on 192.168.45.60:9000 DIYHD format=MPEG2-TS 0:00:01 12604 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 progressive id=100]#1 Audio[AC3 48000 Hz 6 channels 384 kbps idx=1 id=101 eng]#2 Audio[AC3 48000 Hz 2 channels 192 kbps idx=2 id=102 eng]{ScrapedBy=Phoenix, IMDBID=, SeasonFinal=false, CollectionName=, MediaType=TV, EpisodeCount=0, CollectionOverview=, ScrapedDate=1623607205708, MediaProviderDataID=315689, MediaTitle=Beachfront Bargain Hunt: Renovation, SeriesInfoID=12110823, TagLine=, UserRating=0, DiscNumber=0, CollectionID=0, MediaProviderID=tvdb, TrailerUrl=}] \\workspace-1\tv-rec2\BeachfrontBargainHuntRenovation-S03E11-MakeoverinMathewsVirginia-46929369-0.ts, Seg0[Sun 6/13 13:00:00.004-Sun 6/13 14:00:00.011]] ifn=null])
Sat 7/3 21:41:40.850 [AsyncWatch@2c8ea885] No Start on Watch
Sat 7/3 21:41:40.850 [VideoFrame-475346585341@5f80a9fa] VF processing job VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=47047527 A[46929369,46875193,"Beachfront Bargain Hunt: Renovation",67375@0613.13:00,60,T] mask=TV host=Workspace-1 encodedBy=DCT-Ceton InfiniTV Ethernet (00-80-8a-76) Tuner 1 on 192.168.45.60:9000 DIYHD format=MPEG2-TS 0:00:01 12604 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 progressive id=100]#1 Audio[AC3 48000 Hz 6 channels 384 kbps idx=1 id=101 eng]#2 Audio[AC3 48000 Hz 2 channels 192 kbps idx=2 id=102 eng]{ScrapedBy=Phoenix, IMDBID=, SeasonFinal=false, CollectionName=, MediaType=TV, EpisodeCount=0, CollectionOverview=, ScrapedDate=1623607205708, MediaProviderDataID=315689, MediaTitle=Beachfront Bargain Hunt: Renovation, SeriesInfoID=12110823, TagLine=, UserRating=0, DiscNumber=0, CollectionID=0, MediaProviderID=tvdb, TrailerUrl=}] \\workspace-1\tv-rec2\BeachfrontBargainHuntRenovation-S03E11-MakeoverinMathewsVirginia-46929369-0.ts, Seg0[Sun 6/13 13:00:00.004-Sun 6/13 14:00:00.011]] ifn=null] nPlayin=false
Sat 7/3 21:41:40.851 [VideoFrame-475346585341@5f80a9fa] VF processing on UI Thread VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=47047527 A[46929369,46875193,"Beachfront Bargain Hunt: Renovation",67375@0613.13:00,60,T] mask=TV host=Workspace-1 encodedBy=DCT-Ceton InfiniTV Ethernet (00-80-8a-76) Tuner 1 on 192.168.45.60:9000 DIYHD format=MPEG2-TS 0:00:01 12604 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 progressive id=100]#1 Audio[AC3 48000 Hz 6 channels 384 kbps idx=1 id=101 eng]#2 Audio[AC3 48000 Hz 2 channels 192 kbps idx=2 id=102 eng]{ScrapedBy=Phoenix, IMDBID=, SeasonFinal=false, CollectionName=, MediaType=TV, EpisodeCount=0, CollectionOverview=, ScrapedDate=1623607205708, MediaProviderDataID=315689, MediaTitle=Beachfront Bargain Hunt: Renovation, SeriesInfoID=12110823, TagLine=, UserRating=0, DiscNumber=0, CollectionID=0, MediaProviderID=tvdb, TrailerUrl=}] \\workspace-1\tv-rec2\BeachfrontBargainHuntRenovation-S03E11-MakeoverinMathewsVirginia-46929369-0.ts, Seg0[Sun 6/13 13:00:00.004-Sun 6/13 14:00:00.011]] ifn=null]
Sat 7/3 21:41:40.851 [VideoFrame-475346585341@5f80a9fa] VF processing job VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=47047527 A[46929369,46875193,"Beachfront Bargain Hunt: Renovation",67375@0613.13:00,60,T] mask=TV host=Workspace-1 encodedBy=DCT-Ceton InfiniTV Ethernet (00-80-8a-76) Tuner 1 on 192.168.45.60:9000 DIYHD format=MPEG2-TS 0:00:01 12604 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 progressive id=100]#1 Audio[AC3 48000 Hz 6 channels 384 kbps idx=1 id=101 eng]#2 Audio[AC3 48000 Hz 2 channels 192 kbps idx=2 id=102 eng]{ScrapedBy=Phoenix, IMDBID=, SeasonFinal=false, CollectionName=, MediaType=TV, EpisodeCount=0, CollectionOverview=, ScrapedDate=1623607205708, MediaProviderDataID=315689, MediaTitle=Beachfront Bargain Hunt: Renovation, SeriesInfoID=12110823, TagLine=, UserRating=0, DiscNumber=0, CollectionID=0, MediaProviderID=tvdb, TrailerUrl=}] \\workspace-1\tv-rec2\BeachfrontBargainHuntRenovation-S03E11-MakeoverinMathewsVirginia-46929369-0.ts, Seg0[Sun 6/13 13:00:00.004-Sun 6/13 14:00:00.011]] ifn=null] nPlayin=false
Sat 7/3 21:41:40.851 [VideoFrame-475346585341@5f80a9fa] VF network encoder playback detected: true
Sat 7/3 21:41:40.852 [VideoFrame-475346585341@5f80a9fa] VF processing on UI Thread VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=47047527 A[46929369,46875193,"Beachfront Bargain Hunt: Renovation",67375@0613.13:00,60,T] mask=TV host=Workspace-1 encodedBy=DCT-Ceton InfiniTV Ethernet (00-80-8a-76) Tuner 1 on 192.168.45.60:9000 DIYHD format=MPEG2-TS 0:00:01 12604 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 progressive id=100]#1 Audio[AC3 48000 Hz 6 channels 384 kbps idx=1 id=101 eng]#2 Audio[AC3 48000 Hz 2 channels 192 kbps idx=2 id=102 eng]{ScrapedBy=Phoenix, IMDBID=, SeasonFinal=false, CollectionName=, MediaType=TV, EpisodeCount=0, CollectionOverview=, ScrapedDate=1623607205708, MediaProviderDataID=315689, MediaTitle=Beachfront Bargain Hunt: Renovation, SeriesInfoID=12110823, TagLine=, UserRating=0, DiscNumber=0, CollectionID=0, MediaProviderID=tvdb, TrailerUrl=}] \\workspace-1\tv-rec2\BeachfrontBargainHuntRenovation-S03E11-MakeoverinMathewsVirginia-46929369-0.ts, Seg0[Sun 6/13 13:00:00.004-Sun 6/13 14:00:00.011]] ifn=null]
Sat 7/3 21:41:40.852 [VideoFrame-475346585341@5f80a9fa] VideoFrame creating new media player for file:MediaFile[id=47047527 A[46929369,46875193,"Beachfront Bargain Hunt: Renovation",67375@0613.13:00,60,T] mask=TV host=Workspace-1 encodedBy=DCT-Ceton InfiniTV Ethernet (00-80-8a-76) Tuner 1 on 192.168.45.60:9000 DIYHD format=MPEG2-TS 0:00:01 12604 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 progressive id=100]#1 Audio[AC3 48000 Hz 6 channels 384 kbps idx=1 id=101 eng]#2 Audio[AC3 48000 Hz 2 channels 192 kbps idx=2 id=102 eng]{ScrapedBy=Phoenix, IMDBID=, SeasonFinal=false, CollectionName=, MediaType=TV, EpisodeCount=0, CollectionOverview=, ScrapedDate=1623607205708, MediaProviderDataID=315689, MediaTitle=Beachfront Bargain Hunt: Renovation, SeriesInfoID=12110823, TagLine=, UserRating=0, DiscNumber=0, CollectionID=0, MediaProviderID=tvdb, TrailerUrl=}] \\workspace-1\tv-rec2\BeachfrontBargainHuntRenovation-S03E11-MakeoverinMathewsVirginia-46929369-0.ts, Seg0[Sun 6/13 13:00:00.004-Sun 6/13 14:00:00.011]]
Sat 7/3 21:41:40.853 [VideoFrame-475346585341@5f80a9fa] VF file=MediaFile[id=47047527 A[46929369,46875193,"Beachfront Bargain Hunt: Renovation",67375@0613.13:00,60,T] mask=TV host=Workspace-1 encodedBy=DCT-Ceton InfiniTV Ethernet (00-80-8a-76) Tuner 1 on 192.168.45.60:9000 DIYHD format=MPEG2-TS 0:00:01 12604 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 progressive id=100]#1 Audio[AC3 48000 Hz 6 channels 384 kbps idx=1 id=101 eng]#2 Audio[AC3 48000 Hz 2 channels 192 kbps idx=2 id=102 eng]{ScrapedBy=Phoenix, IMDBID=, SeasonFinal=false, CollectionName=, MediaType=TV, EpisodeCount=0, CollectionOverview=, ScrapedDate=1623607205708, MediaProviderDataID=315689, MediaTitle=Beachfront Bargain Hunt: Renovation, SeriesInfoID=12110823, TagLine=, UserRating=0, DiscNumber=0, CollectionID=0, MediaProviderID=tvdb, TrailerUrl=}] \\workspace-1\tv-rec2\BeachfrontBargainHuntRenovation-S03E11-MakeoverinMathewsVirginia-46929369-0.ts, Seg0[Sun 6/13 13:00:00.004-Sun 6/13 14:00:00.011]] targetTime = Sun 6/13 13:25:24.948
Sat 7/3 21:41:40.853 [VideoFrame-475346585341@5f80a9fa] VideoFrame.timeSelected(Sun 6/13 13:25:24.948, true) currFile=MediaFile[id=47047527 A[46929369,46875193,"Beachfront Bargain Hunt: Renovation",67375@0613.13:00,60,T] mask=TV host=Workspace-1 encodedBy=DCT-Ceton InfiniTV Ethernet (00-80-8a-76) Tuner 1 on 192.168.45.60:9000 DIYHD format=MPEG2-TS 0:00:01 12604 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 progressive id=100]#1 Audio[AC3 48000 Hz 6 channels 384 kbps idx=1 id=101 eng]#2 Audio[AC3 48000 Hz 2 channels 192 kbps idx=2 id=102 eng]{ScrapedBy=Phoenix, IMDBID=, SeasonFinal=false, CollectionName=, MediaType=TV, EpisodeCount=0, CollectionOverview=, ScrapedDate=1623607205708, MediaProviderDataID=315689, MediaTitle=Beachfront Bargain Hunt: Renovation, SeriesInfoID=12110823, TagLine=, UserRating=0, DiscNumber=0, CollectionID=0, MediaProviderID=tvdb, TrailerUrl=}] \\workspace-1\tv-rec2\BeachfrontBargainHuntRenovation-S03E11-MakeoverinMathewsVirginia-46929369-0.ts, Seg0[Sun 6/13 13:00:00.004-Sun 6/13 14:00:00.011]]
Sat 7/3 21:41:40.853 [AsyncWatch@2c8ea885] setUI(sage.PseudoMenu@3bf2e27e[MediaPlayer OSD]) histIdx=2 uiHistory=[sage.PseudoMenu@67ddcdda[Main Menu], sage.PseudoMenu@1dda2188[SageRecordings w/ Optional Preview & AutoCategories], sage.PseudoMenu@3bf2e27e[MediaPlayer OSD]] redo=false performingActivation=null
Sat 7/3 21:41:40.853 [VideoFrame-475346585341@5f80a9fa] initDriver0()
Sat 7/3 21:41:40.853 [VideoFrame-475346585341@5f80a9fa] Issuing MCSR client socket to 475346585341
Sat 7/3 21:41:40.854 [VideoFrame-475346585341@5f80a9fa] MiniPlayer established for 475346585341
Sat 7/3 21:41:40.928 [VideoFrame-475346585341@5f80a9fa] getEstimatedBW=0 estimatedBWBytes=0 estimatedBWTime=0
Sat 7/3 21:41:40.929 [VideoFrame-475346585341@5f80a9fa] MiniPlayer was not able to get a bandwidth estimate from the UI system, sending data to get its own estimate...
Sat 7/3 21:41:41.236 [VideoFrame-475346585341@5f80a9fa] Bandwidth test base=79 base*2=84 BW=1660354
Sat 7/3 21:41:41.237 [VideoFrame-475346585341@5f80a9fa] MiniPlayer got an estimate from the UI on bandwidth of 1660Kbps
Sat 7/3 21:41:41.237 [VideoFrame-475346585341@5f80a9fa] MiniPlayer is using Push mode playback
Sat 7/3 21:41:41.237 [VideoFrame-475346585341@5f80a9fa] MiniPlayer is using the transcoder
Sat 7/3 21:41:41.237 [VideoFrame-475346585341@5f80a9fa] Overriding transcode mode because a fixed format was set by client
Sat 7/3 21:41:41.237 [VideoFrame-475346585341@5f80a9fa] Mpeg2Reader is detecting timestamp boundaries in the file...
Sat 7/3 21:41:41.237 [VideoFrame-475346585341@5f80a9fa] IFrame alignment=false
Sat 7/3 21:41:41.237 [VideoFrame-475346585341@5f80a9fa] Opened MPEG-2 PS file: \\workspace-1\tv-rec2\BeachfrontBargainHuntRenovation-S03E11-MakeoverinMathewsVirginia-46929369-0.ts firstPTS=45000 durationMsec=-1
Sat 7/3 21:41:41.238 [VideoFrame-475346585341@5f80a9fa] openURL0(push
Sat 7/3 21:41:41.314 [VideoFrame-475346585341@5f80a9fa] Switching audio stream to be 0xbd-80 for default AC3
Sat 7/3 21:41:41.314 [VideoFrame-475346585341@5f80a9fa] Setting audio stream for playback to be ID=0xbd80
Sat 7/3 21:41:41.766 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 750 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:41:42.057 [Fork-OPUS4-112742@78671775] ENDING background recording thumb preloader thread, ID = 0.16586097744846318
Sat 7/3 21:41:42.516 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 1501 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:41:43.267 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 2252 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:41:44.017 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 3002 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:41:44.767 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 3752 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:41:45.518 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 4503 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:41:46.269 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 5254 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:41:47.019 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 6004 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:41:47.770 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 6755 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:41:48.521 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 7506 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:41:49.272 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 8257 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:41:50.023 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 9008 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:41:50.773 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 9758 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:41:51.524 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 10509 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:41:52.275 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 11260 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:41:53.026 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 12011 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:41:53.777 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 12762 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:41:54.527 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 13512 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:41:55.278 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 14263 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:41:56.029 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 15014 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:41:56.780 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 15765 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:41:57.530 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 16515 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:41:58.280 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 17265 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:41:59.031 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 18016 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:41:59.782 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 18767 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:42:00.532 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 19517 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:42:01.282 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 20267 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:42:02.033 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 21018 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:42:02.784 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 21769 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:42:03.534 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 22519 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:42:04.285 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 23270 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:42:05.035 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 24020 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:42:05.785 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 24770 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:42:06.536 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 25521 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:42:07.285 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 26270 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:42:08.036 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 27021 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:42:08.787 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 27772 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:42:09.538 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 28523 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:42:10.288 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 29273 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:42:11.039 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 30024 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:42:11.314 [TimeoutHandler@1bb028f] TIMEOUT occurred - close the socket asynchronously for java.nio.channels.SocketChannel[connected local=/192.168.45.59:31099 remote=/192.168.1.77:46007]
Sat 7/3 21:42:11.315 [VideoFrame-475346585341@5f80a9fa] Error with MiniPlayer, closing UI: java.nio.channels.AsynchronousCloseException
Sat 7/3 21:42:11.315 [MCSRReconnect@2c8ea885] Preparing the media player for a reload...
Sat 7/3 21:42:11.316 [VideoFrame-475346585341@5f80a9fa] Sigma video dim=java.awt.Dimension[width=720,height=480]
Sat 7/3 21:42:11.316 [MCSRReconnect@2c8ea885] VF.submitJob(VFJob[ReloadPrepareMF r=0.0 t=0 file=null ifn=null])
Sat 7/3 21:42:11.316 [VideoFrame-475346585341@5f80a9fa] pausePush0()
Sat 7/3 21:42:11.316 [VideoFrame-475346585341@5f80a9fa] Error with MiniPlayer, closing UI: java.nio.channels.ClosedChannelException
Sat 7/3 21:42:11.316 [VideoFrame-475346585341@5f80a9fa] setMute0()
Sat 7/3 21:42:11.317 [VideoFrame-475346585341@5f80a9fa] Error with MiniPlayer, closing UI: java.nio.channels.ClosedChannelException
Sat 7/3 21:42:11.317 [VideoFrame-475346585341@5f80a9fa] Error with MiniPlayer, closing UI: java.nio.channels.ClosedChannelException
Sat 7/3 21:42:11.317 [VideoFrame-475346585341@5f80a9fa] getDuration : 0
Sat 7/3 21:42:11.318 [VideoFrame-475346585341@5f80a9fa] VideoFrame.timeSelected2(Sun 6/13 13:25:24.948, true) currFile=MediaFile[id=47047527 A[46929369,46875193,"Beachfront Bargain Hunt: Renovation",67375@0613.13:00,60,T] mask=TV host=Workspace-1 encodedBy=DCT-Ceton InfiniTV Ethernet (00-80-8a-76) Tuner 1 on 192.168.45.60:9000 DIYHD format=MPEG2-TS 0:00:01 12604 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 progressive id=100]#1 Audio[AC3 48000 Hz 6 channels 384 kbps idx=1 id=101 eng]#2 Audio[AC3 48000 Hz 2 channels 192 kbps idx=2 id=102 eng]{ScrapedBy=Phoenix, IMDBID=, SeasonFinal=false, CollectionName=, MediaType=TV, EpisodeCount=0, CollectionOverview=, ScrapedDate=1623607205708, MediaProviderDataID=315689, MediaTitle=Beachfront Bargain Hunt: Renovation, SeriesInfoID=12110823, TagLine=, UserRating=0, DiscNumber=0, CollectionID=0, MediaProviderID=tvdb, TrailerUrl=}] \\workspace-1\tv-rec2\BeachfrontBargainHuntRenovation-S03E11-MakeoverinMathewsVirginia-46929369-0.ts, Seg0[Sun 6/13 13:00:00.004-Sun 6/13 14:00:00.011]] realDur=0
Sat 7/3 21:42:11.318 [VideoFrame-475346585341@5f80a9fa] seeking numpushbuffers=0 seekTime=1524944
Sat 7/3 21:42:11.318 [VideoFrame-475346585341@5f80a9fa] Using 7 threads for the transcoder
Sat 7/3 21:42:11.464 [MiniUIServer@351de64] MiniUI got connection from java.nio.channels.SocketChannel[connected local=/192.168.45.59:31099 remote=/192.168.1.77:45760]
Sat 7/3 21:42:11.469 [MiniUIServerConnection@552606c6] MiniPlayer is adding to its map:475346585341
Sat 7/3 21:42:11.789 [AWTThreadWatcher-475346585341@12f6dec4] EventThread-475346585341 Hang Detected - hang time = 30774 UILocker=Thread[ActiveRender-475346585341,2,main]
Sat 7/3 21:42:11.812 [VideoFrame-475346585341@5f80a9fa] File Format Parsed3 \\workspace-1\tv-rec2\BeachfrontBargainHuntRenovation-S03E11-MakeoverinMathewsVirginia-46929369-0.ts=MPEG2-TS 0:59:06 18284 kbps [#0 Video[H.264 29.97 fps 1920x1080 16:9 progressive id=100]#1 Audio[AC3 48000 Hz idx=1 id=101 eng]#2 Audio[AC3 48000 Hz 2 channels idx=2 id=102 eng]{Language=eng}]
Sat 7/3 21:42:11.816 [VideoFrame-475346585341@5f80a9fa] flushPush0()
Sat 7/3 21:42:11.817 [VideoFrame-475346585341@5f80a9fa] Error with MiniPlayer, closing UI: java.nio.channels.ClosedChannelException
Sat 7/3 21:42:11.817 [VideoFrame-475346585341@5f80a9fa] Creating new push thread
Sat 7/3 21:42:11.818 [VideoFrame-475346585341@5f80a9fa] playPush0()
Sat 7/3 21:42:11.818 [Pusher@4e5e8d09] Pusher thread is starting
Sat 7/3 21:42:11.818 [Pusher@4e5e8d09] Miniplayer pusher using buffer size of 32768
Sat 7/3 21:42:11.818 [VideoFrame-475346585341@5f80a9fa] Error with MiniPlayer, closing UI: java.nio.channels.ClosedChannelException
Sat 7/3 21:42:11.819 [VideoFrame-475346585341@5f80a9fa] Channel Change Time=1625362931819 NOTE: Not valid if this was not a direct channel change!
Sat 7/3 21:42:11.820 [ActiveRender-475346585341@80ab0b1] VideoFrame got registration of a subtitle UI component: sage.ZCCLabel[loc=java.awt.Point[x=288,y=857] size=java.awt.Dimension[width=1344,height=225]]
Sat 7/3 21:42:11.820 [ActiveRender-475346585341@80ab0b1] VideoFrame got registration of a cc UI component: sage.ZCCLabel[loc=java.awt.Point[x=192,y=112] size=java.awt.Dimension[width=1536,height=902]]
Sat 7/3 21:42:11.826 [ReProcessHook@25380992] Start looking for max channel digits
Sat 7/3 21:42:11.827 [ReProcessHook@25380992] New max channel = 3, from channel 400 on lineup 'Verizon Fios Philadelphia - Digital - Philadelphia (sdepg)'
Sat 7/3 21:42:11.827 [ReProcessHook@25380992] New max channel = 4, from channel 1521 on lineup 'Verizon Fios Philadelphia - Digital - Philadelphia (sdepg)'
Sat 7/3 21:42:11.833 [ReProcessHook@25380992] Done looking for max channel digits; elapsed time: 7
Sat 7/3 21:42:11.833 [Fork-JREkiwi-615771@78671775] Starting Comskip Playback v2.1.3 Thread: Thread[Fork-JREkiwi-615771,5,main], for UI context 475346585341
Sat 7/3 21:42:11.849 [VideoFrame-475346585341@5f80a9fa] VF processing job VFJob[ReloadPrepareMF r=0.0 t=0 file=null ifn=null] nPlayin=true
Sat 7/3 21:42:11.849 [PluginEventQueue@38c8e7a0] [[SageTCPServer]]: Event: PlaybackStarted
Sat 7/3 21:42:11.849 [VideoFrame-475346585341@5f80a9fa] VF processing on UI Thread VFJob[ReloadPrepareMF r=0.0 t=0 file=null ifn=null]
Sat 7/3 21:42:11.849 [PluginEventQueue@38c8e7a0] [[SageTCPServer-Player:9274]]: Playback: Start
Sat 7/3 21:42:11.849 [VideoFrame-475346585341@5f80a9fa] stopPush0()
Sat 7/3 21:42:11.849 [PluginEventQueue@38c8e7a0] [[SageTCPServer-Player:9274]]: [ChangeStates] About to process
Sat 7/3 21:42:11.850 [VideoFrame-475346585341@5f80a9fa] Error with MiniPlayer, closing UI: java.nio.channels.ClosedChannelException
Sat 7/3 21:42:11.850 [VideoFrame-475346585341@5f80a9fa] Closing down MiniPlayer
Sat 7/3 21:42:11.850 [VideoFrame-475346585341@5f80a9fa] closeDriver0()
Sat 7/3 21:42:11.851 [VideoFrame-475346585341@5f80a9fa] VF processing job null nPlayin=false
Sat 7/3 21:42:11.851 [MCSRReconnect@2c8ea885] MediaPlayer is ready for the reload.
Sat 7/3 21:42:11.852 [MCSRReconnect@2c8ea885] MCSR reconnect daemon has started...wait up to 30 seconds for a client reconnect...
Sat 7/3 21:42:11.852 [VideoFrame-475346585341@5f80a9fa] isRec=false rd=3600007 base=0 eos=false
Sat 7/3 21:42:11.852 [VideoFrame-475346585341@5f80a9fa] VF thread is now waiting for 0:00:00.000
Sat 7/3 21:42:41.866 [MCSRReconnect@2c8ea885] MCSR reconnect daemon timed out w/no reconnection, kill the UI!
Sat 7/3 21:42:41.867 [KillUIMgr@25380992] Killing UIMgr UIManager:localhost@@475346585341-3ea6b337
Sat 7/3 21:42:41.867 [KillUIMgr@25380992] Killed UI Timers
Sat 7/3 21:42:41.868 [KillUIMgr@25380992] Updated:Watched[id=47722492 Airing=A[46929369,46875193,"Beachfront Bargain Hunt: Renovation",67375@0613.13:00,60,T], WatchStart=Sun 6/13 13:00:00.004, WatchEnd=Sun 6/13 13:25:24.948, RealStart=Sat 7/3 20:04:02.073, RealEnd=Sat 7/3 21:42:41.867]
Sat 7/3 21:42:41.868 [KillUIMgr@25380992] VF logFileWatch doneAir=A[46929369,46875193,"Beachfront Bargain Hunt: Renovation",67375@0613.13:00,60,T] theTime=Sun 6/13 13:25:24.948 recTime=Sun 6/13 13:00:00.004
Sat 7/3 21:42:41.868 [KillUIMgr@25380992] Closing down MiniPlayer
Sat 7/3 21:42:41.868 [KillUIMgr@25380992] closeDriver0()
Sat 7/3 21:42:41.868 [KillUIMgr@25380992] Seeker.finishWatch(UIManager:localhost@@475346585341-3ea6b337)
Sat 7/3 21:42:41.868 [PluginEventQueue@38c8e7a0] [[SageTCPServer]]: Event: PlaybackStopped
Sat 7/3 21:42:41.868 [Scheduler@66eb408b] Scheduler awoken
Sat 7/3 21:42:41.868 [VideoFrame-475346585341@5f80a9fa] VF processing job null nPlayin=false
Sat 7/3 21:42:41.869 [VideoFrame-475346585341@5f80a9fa] VideoFrame thread is now exiting
Sat 7/3 21:42:41.869 [Seeker@69862a29] Seeker awoken
Sat 7/3 21:42:41.869 [Seeker@69862a29] MemStats: Used=781MB Total=954MB Max=954MB
Sat 7/3 21:42:41.869 [KillUIMgr@25380992] Killed VideoFrame
Sat 7/3 21:42:41.869 [PluginEventQueue@38c8e7a0] [[SageTCPServer-Player:9274]]: Playback: Stop
Sat 7/3 21:42:41.869 [KillUIMgr@25380992] VF.submitJob(VFJob[CloseMF r=0.0 t=0 file=null ifn=null])
Sat 7/3 21:42:41.869 [KillUIMgr@25380992] Seeker.finishWatch(UIManager:localhost@@475346585341-3ea6b337)
__________________
Hyper-V Host @ Dual Processor E5-2643 3.4ghz v4 HexaCore 128gb ram
Sage Server: VM w2016 x64 Guest running 9.2.x
OpenDCT & Plex Server: VM Ubuntu 16.04
Primary Client: VM W10x64 with GPU Passthrough
Reply With Quote
  #694  
Old 07-04-2021, 07:42 AM
ojones ojones is offline
Sage User
 
Join Date: Dec 2005
Posts: 61
Looks like I spoke to soon. Impacts placeshifter as well.

Thanks for any insights!

Sun 7/4 9:33:27.164 [Seeker@69862a29] needFreeSize = 2.025 GB currFreeSize=2286.315421696 GB
Sun 7/4 9:33:27.164 [Seeker@69862a29] Seeker waiting for 56 mins.
Sun 7/4 9:33:27.459 [AWTThreadWatcher-00ff0146afae@6d17eee3] EventThread-00ff0146afae Hang Detected - hang time = 7505 UILocker=Thread[ActiveRender-00ff0146afae,2,main]
Sun 7/4 9:33:28.209 [AWTThreadWatcher-00ff0146afae@6d17eee3] EventThread-00ff0146afae Hang Detected - hang time = 8255 UILocker=Thread[ActiveRender-00ff0146afae,2,main]
Sun 7/4 9:33:28.960 [AWTThreadWatcher-00ff0146afae@6d17eee3] EventThread-00ff0146afae Hang Detected - hang time = 9006 UILocker=Thread[ActiveRender-00ff0146afae,2,main]
Sun 7/4 9:33:29.114 [VideoFrame-00ff0146afae@1e0f18a8] Sigma video dim=java.awt.Dimension[width=1920,height=1080]
Sun 7/4 9:33:29.199 [VideoFrame-00ff0146afae@1e0f18a8] getDuration : 0
Sun 7/4 9:33:29.199 [VideoFrame-00ff0146afae@1e0f18a8] setMute0()
Sun 7/4 9:33:29.290 [VideoFrame-00ff0146afae@1e0f18a8] VideoFrame.timeSelected2(Thu 7/1 20:00:00.007, true) currFile=MediaFile[id=47665851 A[47105309,47099683,"Making It",19613@0701.20:00,60,T] mask=TV host=Workspace-1 encodedBy=DCT-Ceton InfiniTV Ethernet (00-80-8a-76) Tuner 1 on 192.168.45.60:9000 WCAUDT format=MPEG2-TS 0:00:01 9227 kbps [#0 Video[H.264 29.97003 fps 1920x1080 16:9 progressive id=100]#1 Audio[AC3 48000 Hz 6 channels 384 kbps idx=1 id=101 eng]#2 Audio[AC3 48000 Hz 1 channels 96 kbps idx=2 id=102 spa]{ScrapedBy=Phoenix, IMDBID=, SeasonFinal=false, CollectionName=, MediaType=TV, EpisodeCount=0, CollectionOverview=, ScrapedDate=1625187601617, MediaProviderDataID=338260, MediaTitle=Making It, SeriesInfoID=14154367, TagLine=, UserRating=0, DiscNumber=0, CollectionID=0, MediaProviderID=tvdb, TrailerUrl=}] \\workspace-1\tv-rec2\MakingIt-S03E02-RandomCraftsofKindness-47105309-0.ts, Seg0[Thu 7/1 20:00:00.007-Thu 7/1 21:00:00.039]] realDur=0
Sun 7/4 9:33:29.290 [VideoFrame-00ff0146afae@1e0f18a8] playPush0()
Sun 7/4 9:33:29.362 [VideoFrame-00ff0146afae@1e0f18a8] Channel Change Time=1625405609362 NOTE: Not valid if this was not a direct channel change!
Sun 7/4 9:33:29.363 [ActiveRender-00ff0146afae@10e153e8] VideoFrame got registration of a subtitle UI component: sage.ZCCLabel[loc=java.awt.Point[x=237,y=753] size=java.awt.Dimension[width=1110,height=198]]
Sun 7/4 9:33:29.364 [ActiveRender-00ff0146afae@10e153e8] VideoFrame got registration of a cc UI component: sage.ZCCLabel[loc=java.awt.Point[x=158,y=99] size=java.awt.Dimension[width=1268,height=792]]
Sun 7/4 9:33:29.374 [ReProcessHook@552606c6] Start looking for max channel digits
Sun 7/4 9:33:29.374 [ReProcessHook@552606c6] New max channel = 3, from channel 400 on lineup 'Verizon Fios Philadelphia - Digital - Philadelphia (sdepg)'
Sun 7/4 9:33:29.375 [ReProcessHook@552606c6] New max channel = 4, from channel 1521 on lineup 'Verizon Fios Philadelphia - Digital - Philadelphia (sdepg)'
Sun 7/4 9:33:29.382 [ReProcessHook@552606c6] Done looking for max channel digits; elapsed time: 8
Sun 7/4 9:33:29.382 [Fork-JREkiwi-615771@78671775] Starting Comskip Playback v2.1.3 Thread: Thread[Fork-JREkiwi-615771,5,main], for UI context 00ff0146afae
Sun 7/4 9:33:29.389 [VideoFrame-00ff0146afae@1e0f18a8] VF processing job null nPlayin=true
Sun 7/4 9:33:29.389 [PluginEventQueue@38c8e7a0] [[SageTCPServer]]: Event: PlaybackStarted
Sun 7/4 9:33:29.389 [VideoFrame-00ff0146afae@1e0f18a8] isRec=false rd=3600032 base=0 eos=false
Sun 7/4 9:33:29.389 [PluginEventQueue@38c8e7a0] [[SageTCPServer-Player:9266]]: Playback: Start
Sun 7/4 9:33:29.389 [VideoFrame-00ff0146afae@1e0f18a8] VF thread is now waiting for 0:59:59.782
Sun 7/4 9:33:29.389 [PluginEventQueue@38c8e7a0] [[SageTCPServer-Player:9266]]: [ChangeStates] About to process
Sun 7/4 9:33:34.048 [Fork-JREkiwi-615771@78671775] MiniPlayer received an EOS when getting the media time - set the EOS flag
Sun 7/4 9:33:34.049 [VideoFrame-00ff0146afae@1e0f18a8] VF processing job null nPlayin=true
Sun 7/4 9:33:34.049 [VideoFrame-00ff0146afae@1e0f18a8] isRec=false rd=3600032 base=875 eos=true
Sun 7/4 9:33:34.049 [VideoFrame-00ff0146afae@1e0f18a8] VF processing job VFJob[StdComplete r=0.0 t=0 file=null ifn=null] nPlayin=true
Sun 7/4 9:33:34.049 [VideoFrame-00ff0146afae@1e0f18a8] VF processing on UI Thread VFJob[StdComplete r=0.0 t=0 file=null ifn=null]
Sun 7/4 9:33:34.049 [VideoFrame-00ff0146afae@1e0f18a8] MiniPlayer.setPlaybackRate(1.0)
Sun 7/4 9:33:34.050 [VideoFrame-00ff0146afae@1e0f18a8] VF.submitJob(VFJob[Pause r=0.0 t=0 file=null ifn=null])
Sun 7/4 9:33:34.050 [VideoFrame-00ff0146afae@1e0f18a8] VF logFileWatch doneAir=A[47105309,47099683,"Making It",19613@0701.20:00,60,T] theTime=Thu 7/1 20:00:00.882 recTime=Thu 7/1 20:00:00.007
Sun 7/4 9:33:34.050 [PluginEventQueue@38c8e7a0] [[SageTCPServer]]: Event: PlaybackFinished
Sun 7/4 9:33:34.050 [VideoFrame-00ff0146afae@1e0f18a8] VF processing job VFJob[Pause r=0.0 t=0 file=null ifn=null] nPlayin=true
Sun 7/4 9:33:34.050 [PluginEventQueue@38c8e7a0] [[SageTCPServer-Player:9266]]: Playback: Finish
Sun 7/4 9:33:34.050 [VideoFrame-00ff0146afae@1e0f18a8] VF processing on UI Thread VFJob[Pause r=0.0 t=0 file=null ifn=null]
Sun 7/4 9:33:34.050 [VideoFrame-00ff0146afae@1e0f18a8] MiniPlayer.setPlaybackRate(1.0)
Sun 7/4 9:33:34.051 [VideoFrame-00ff0146afae@1e0f18a8] pausePush0()
Sun 7/4 9:33:34.051 [EventRouter-00ff0146afae@7f2b9c87] processUserEvent-UserEvent[back] evtTime=Sun 7/4 9:33:32.731
Sun 7/4 9:33:34.052 [EventRouter-00ff0146afae@7f2b9c87] setUI(sage.PseudoMenu@736dd576[SageRecordings w/ Optional Preview & AutoCategories]) histIdx=1 uiHistory=[sage.PseudoMenu@4d933b54[Main Menu], sage.PseudoMenu@736dd576
__________________
Hyper-V Host @ Dual Processor E5-2643 3.4ghz v4 HexaCore 128gb ram
Sage Server: VM w2016 x64 Guest running 9.2.x
OpenDCT & Plex Server: VM Ubuntu 16.04
Primary Client: VM W10x64 with GPU Passthrough
Reply With Quote
  #695  
Old 07-07-2021, 10:47 PM
hb4 hb4 is offline
Sage Aficionado
 
Join Date: Sep 2008
Location: Seattle, Wa
Posts: 342
I am also experiencing 'hang detected'; seemed to start happening on or near new version of client; before that it was great. FS4K to remote (different city) client.

Code:
Wed 7/7 20:21:51.884 [VideoFrame-545352504a49@14fa335] VF processing on UI Thread VFJob[CloseMF r=0.0 t=0 file=null ifn=null]
Wed 7/7 20:21:51.890 [VideoFrame-545352504a49@14fa335] VF processing job null nPlayin=false
Wed 7/7 20:21:51.897 [VideoFrame-545352504a49@14fa335] VF thread is now waiting for 0:00:00.000
Wed 7/7 20:21:51.903 [EventRouter-545352504a49@1cc8ad3] Seeker.finishWatch(UIManager:localhost@@545352504a49-fa69fa)
Wed 7/7 20:21:51.911 [AsyncWatch@4430d1] VideoFrame.watch(A[7323562,7323508,"The Rachel Maddow Show",64241@0707.18:00,60,T])
Wed 7/7 20:21:51.916 [AsyncWatch@4430d1] watchThisFile=MediaFile[id=7487619 A[7323562,7323508,"The Rachel Maddow Show",64241@0707.18:00,60,T] mask=TV host=Media encodedBy=DCT-HDHomeRun Prime Tuner 13112554-0 on 127.0.0.1:9000 MNBCHD format=MPEG2-TS 0:00:01 2884 kbps [#0 Video[H.264 59.94006 fps 1280x720 16:9 progressive id=0100]#1 Audio[AC3 48000 Hz 6 channels 384 kbps MAIN idx=1 id=0101 eng]#2 Subpic[SRT path=F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.CC1.srt CC1]#3 Subpic[SRT path=F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.CC2.srt CC2]] F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.ts, Seg0[Wed 7/7 18:00:00.009-Wed 7/7 19:00:00.018]]
Wed 7/7 20:21:51.920 [AsyncWatch@4430d1] Watch airing is a file & over, do that instead dvd=false
Wed 7/7 20:21:51.924 [AsyncWatch@4430d1] Seeker.finishWatch(UIManager:localhost@@545352504a49-fa69fa)
Wed 7/7 20:21:51.928 [AsyncWatch@4430d1] VF.submitJob(VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=7487619 A[7323562,7323508,"The Rachel Maddow Show",64241@0707.18:00,60,T] mask=TV host=Media encodedBy=DCT-HDHomeRun Prime Tuner 13112554-0 on 127.0.0.1:9000 MNBCHD format=MPEG2-TS 0:00:01 2884 kbps [#0 Video[H.264 59.94006 fps 1280x720 16:9 progressive id=0100]#1 Audio[AC3 48000 Hz 6 channels 384 kbps MAIN idx=1 id=0101 eng]#2 Subpic[SRT path=F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.CC1.srt CC1]#3 Subpic[SRT path=F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.CC2.srt CC2]] F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.ts, Seg0[Wed 7/7 18:00:00.009-Wed 7/7 19:00:00.018]] ifn=null])
Wed 7/7 20:21:51.932 [VideoFrame-545352504a49@14fa335] VF processing job VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=7487619 A[7323562,7323508,"The Rachel Maddow Show",64241@0707.18:00,60,T] mask=TV host=Media encodedBy=DCT-HDHomeRun Prime Tuner 13112554-0 on 127.0.0.1:9000 MNBCHD format=MPEG2-TS 0:00:01 2884 kbps [#0 Video[H.264 59.94006 fps 1280x720 16:9 progressive id=0100]#1 Audio[AC3 48000 Hz 6 channels 384 kbps MAIN idx=1 id=0101 eng]#2 Subpic[SRT path=F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.CC1.srt CC1]#3 Subpic[SRT path=F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.CC2.srt CC2]] F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.ts, Seg0[Wed 7/7 18:00:00.009-Wed 7/7 19:00:00.018]] ifn=null] nPlayin=false
Wed 7/7 20:21:51.936 [AsyncWatch@4430d1] No Start on Watch
Wed 7/7 20:21:51.940 [VideoFrame-545352504a49@14fa335] VF processing on UI Thread VFJob[WatchMF r=0.0 t=0 file=MediaFile[id=7487619 A[7323562,7323508,"The Rachel Maddow Show",64241@0707.18:00,60,T] mask=TV host=Media encodedBy=DCT-HDHomeRun Prime Tuner 13112554-0 on 127.0.0.1:9000 MNBCHD format=MPEG2-TS 0:00:01 2884 kbps [#0 Video[H.264 59.94006 fps 1280x720 16:9 progressive id=0100]#1 Audio[AC3 48000 Hz 6 channels 384 kbps MAIN idx=1 id=0101 eng]#2 Subpic[SRT path=F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.CC1.srt CC1]#3 Subpic[SRT path=F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.CC2.srt CC2]] F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.ts, Seg0[Wed 7/7 18:00:00.009-Wed 7/7 19:00:00.018]] ifn=null]
Wed 7/7 20:21:51.944 [AsyncWatch@4430d1] Deriving FreeType font face for fonts\DejaVuSansMono size=15 style=0 from=C:\Program Files (x86)\SageTV\SageTV\fonts\DejaVuSansMono.ttf
Wed 7/7 20:21:51.948 [VideoFrame-545352504a49@14fa335] VF processing job VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=7487619 A[7323562,7323508,"The Rachel Maddow Show",64241@0707.18:00,60,T] mask=TV host=Media encodedBy=DCT-HDHomeRun Prime Tuner 13112554-0 on 127.0.0.1:9000 MNBCHD format=MPEG2-TS 0:00:01 2884 kbps [#0 Video[H.264 59.94006 fps 1280x720 16:9 progressive id=0100]#1 Audio[AC3 48000 Hz 6 channels 384 kbps MAIN idx=1 id=0101 eng]#2 Subpic[SRT path=F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.CC1.srt CC1]#3 Subpic[SRT path=F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.CC2.srt CC2]] F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.ts, Seg0[Wed 7/7 18:00:00.009-Wed 7/7 19:00:00.018]] ifn=null] nPlayin=false
Wed 7/7 20:21:51.952 [AsyncWatch@4430d1] Loading new font to cache font=MetaFont[fonts\DejaVuSansMono, size=15, style=0, height=17.0, ascent=14.0, descent=4.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 7/7 20:21:51.955 [VideoFrame-545352504a49@14fa335] VF network encoder playback detected: true
Wed 7/7 20:21:51.959 [VideoFrame-545352504a49@14fa335] VF processing on UI Thread VFJob[LoadMF r=0.0 t=0 file=MediaFile[id=7487619 A[7323562,7323508,"The Rachel Maddow Show",64241@0707.18:00,60,T] mask=TV host=Media encodedBy=DCT-HDHomeRun Prime Tuner 13112554-0 on 127.0.0.1:9000 MNBCHD format=MPEG2-TS 0:00:01 2884 kbps [#0 Video[H.264 59.94006 fps 1280x720 16:9 progressive id=0100]#1 Audio[AC3 48000 Hz 6 channels 384 kbps MAIN idx=1 id=0101 eng]#2 Subpic[SRT path=F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.CC1.srt CC1]#3 Subpic[SRT path=F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.CC2.srt CC2]] F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.ts, Seg0[Wed 7/7 18:00:00.009-Wed 7/7 19:00:00.018]] ifn=null]
Wed 7/7 20:21:51.962 [AsyncWatch@4430d1] setUI(sage.PseudoMenu@1dbe180[MediaPlayer OSD]) histIdx=2 uiHistory=[sage.PseudoMenu@170e26c[SageRecordings w/ Optional Preview & AutoCategories], sage.PseudoMenu@116df64[MediaFileList], sage.PseudoMenu@1dbe180[MediaPlayer OSD]] redo=false performingActivation=null
Wed 7/7 20:21:51.966 [VideoFrame-545352504a49@14fa335] VideoFrame creating new media player for file:MediaFile[id=7487619 A[7323562,7323508,"The Rachel Maddow Show",64241@0707.18:00,60,T] mask=TV host=Media encodedBy=DCT-HDHomeRun Prime Tuner 13112554-0 on 127.0.0.1:9000 MNBCHD format=MPEG2-TS 0:00:01 2884 kbps [#0 Video[H.264 59.94006 fps 1280x720 16:9 progressive id=0100]#1 Audio[AC3 48000 Hz 6 channels 384 kbps MAIN idx=1 id=0101 eng]#2 Subpic[SRT path=F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.CC1.srt CC1]#3 Subpic[SRT path=F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.CC2.srt CC2]] F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.ts, Seg0[Wed 7/7 18:00:00.009-Wed 7/7 19:00:00.018]]
Wed 7/7 20:21:51.969 [VideoFrame-545352504a49@14fa335] JVL - ELSE BLOCK Creating MiniPlayer
Wed 7/7 20:21:51.973 [AsyncWatch@4430d1] Deriving FreeType font face for fonts\DejaVuSansMono size=33 style=0 from=C:\Program Files (x86)\SageTV\SageTV\fonts\DejaVuSansMono.ttf
Wed 7/7 20:21:51.977 [AsyncWatch@4430d1] Loading new font to cache font=MetaFont[fonts\DejaVuSansMono, size=33, style=0, height=38.0, ascent=31.0, descent=8.0, leading=-1.0, class=class sage.FreetypeFont]
Wed 7/7 20:21:51.982 [VideoFrame-545352504a49@14fa335] VF file=MediaFile[id=7487619 A[7323562,7323508,"The Rachel Maddow Show",64241@0707.18:00,60,T] mask=TV host=Media encodedBy=DCT-HDHomeRun Prime Tuner 13112554-0 on 127.0.0.1:9000 MNBCHD format=MPEG2-TS 0:00:01 2884 kbps [#0 Video[H.264 59.94006 fps 1280x720 16:9 progressive id=0100]#1 Audio[AC3 48000 Hz 6 channels 384 kbps MAIN idx=1 id=0101 eng]#2 Subpic[SRT path=F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.CC1.srt CC1]#3 Subpic[SRT path=F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.CC2.srt CC2]] F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.ts, Seg0[Wed 7/7 18:00:00.009-Wed 7/7 19:00:00.018]] targetTime = Wed 7/7 18:00:00.009
Wed 7/7 20:21:51.986 [VideoFrame-545352504a49@14fa335] VideoFrame.timeSelected(Wed 7/7 18:00:00.009, true) currFile=MediaFile[id=7487619 A[7323562,7323508,"The Rachel Maddow Show",64241@0707.18:00,60,T] mask=TV host=Media encodedBy=DCT-HDHomeRun Prime Tuner 13112554-0 on 127.0.0.1:9000 MNBCHD format=MPEG2-TS 0:00:01 2884 kbps [#0 Video[H.264 59.94006 fps 1280x720 16:9 progressive id=0100]#1 Audio[AC3 48000 Hz 6 channels 384 kbps MAIN idx=1 id=0101 eng]#2 Subpic[SRT path=F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.CC1.srt CC1]#3 Subpic[SRT path=F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.CC2.srt CC2]] F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.ts, Seg0[Wed 7/7 18:00:00.009-Wed 7/7 19:00:00.018]]
Wed 7/7 20:21:51.989 [VideoFrame-545352504a49@14fa335] initDriver0()
Wed 7/7 20:21:51.993 [VideoFrame-545352504a49@14fa335] Issuing MCSR client socket to 545352504a49
Wed 7/7 20:21:51.997 [VideoFrame-545352504a49@14fa335] MiniPlayer established for 545352504a49
Wed 7/7 20:21:52.019 [VideoFrame-545352504a49@14fa335] Supported push containers: [MPEG2-TS, MPEG2-PS, MPEG1-PS]
Wed 7/7 20:21:52.023 [VideoFrame-545352504a49@14fa335] ******************************* Investigating PULL/PUSH and supported codecs **********************************
Wed 7/7 20:21:52.026 [VideoFrame-545352504a49@14fa335] Determining if MPEG4_VIDEO is supported clientCanDoMpeg4
Wed 7/7 20:21:52.030 [VideoFrame-545352504a49@14fa335] 	clientCanDoMpeg4: true
Wed 7/7 20:21:52.033 [VideoFrame-545352504a49@14fa335] Determining if the client can do pull. Determined if there is a hostname, and it starts with file://
Wed 7/7 20:21:52.036 [VideoFrame-545352504a49@14fa335] 	Since we are not local, checking to see if container format is suppoted.
Wed 7/7 20:21:52.040 [VideoFrame-545352504a49@14fa335] JVL: PullContainers: [MP3, WMV, AC3, AAC, MATROSKA, QUICKTIME, ASF, FLAC, FLASHVIDEO, WAV, OGG]
Wed 7/7 20:21:52.043 [VideoFrame-545352504a49@14fa335] 		CurrentContainer: MPEG2-TS
Wed 7/7 20:21:52.046 [VideoFrame-545352504a49@14fa335] 		clientDoesPull: false
Wed 7/7 20:21:52.049 [VideoFrame-545352504a49@14fa335] Fixed push format setting from client: container=matroska;videobitrate=2000000;fps=SOURCE;bframes=0;resolution=720;audiocodec=ac3;audiobitrate=128000;audiochannels=2;
Wed 7/7 20:21:52.052 [VideoFrame-545352504a49@14fa335] Fixed push format setting from client: container=matroska;videobitrate=2000000;fps=SOURCE;bframes=0;resolution=720;audiocodec=ac3;audiobitrate=128000;audiochannels=2;
Wed 7/7 20:21:52.056 [VideoFrame-545352504a49@14fa335] Checking bandwidth to the client
Wed 7/7 20:21:52.059 [VideoFrame-545352504a49@14fa335] getEstimatedBW=0 estimatedBWBytes=0 estimatedBWTime=0
Wed 7/7 20:21:52.062 [VideoFrame-545352504a49@14fa335] Bandwidth: 0
Wed 7/7 20:21:52.066 [VideoFrame-545352504a49@14fa335] 	Bandwidth is < 500000 and client can do mpeg4 or httpls
Wed 7/7 20:21:52.069 [VideoFrame-545352504a49@14fa335] MiniPlayer was not able to get a bandwidth estimate from the UI system, sending data to get its own estimate...
Wed 7/7 20:21:52.183 [VideoFrame-545352504a49@14fa335] Bandwidth test base=28 base*2=31 BW=4684571
Wed 7/7 20:21:52.190 [VideoFrame-545352504a49@14fa335] MiniPlayer got an estimate from the UI on bandwidth of 4684Kbps
Wed 7/7 20:21:52.196 [VideoFrame-545352504a49@14fa335] Checking for low bandwidth (local client, MiniClient, supports push MPEG2_TS or MPEG2_PS, less than required bandwidth and MPEG4)
Wed 7/7 20:21:52.203 [VideoFrame-545352504a49@14fa335] 	pureLocal: false
Wed 7/7 20:21:52.209 [VideoFrame-545352504a49@14fa335] 	MiniClient Renderer is not null: true
Wed 7/7 20:21:52.214 [VideoFrame-545352504a49@14fa335] Supported push containers: [MPEG2-TS, MPEG2-PS, MPEG1-PS]
Wed 7/7 20:21:52.218 [VideoFrame-545352504a49@14fa335] 	MPEG2_PS Support: true
Wed 7/7 20:21:52.221 [VideoFrame-545352504a49@14fa335] Supported push containers: [MPEG2-TS, MPEG2-PS, MPEG1-PS]
Wed 7/7 20:21:52.225 [VideoFrame-545352504a49@14fa335] 	MPEG2_TS Support: true
Wed 7/7 20:21:52.228 [VideoFrame-545352504a49@14fa335] 	IsLowBandwidth: false
Wed 7/7 20:21:52.232 [VideoFrame-545352504a49@14fa335] 	clientCanDoMpeg4: true
Wed 7/7 20:21:52.235 [VideoFrame-545352504a49@14fa335] Supported push containers: [MPEG2-TS, MPEG2-PS, MPEG1-PS]
Wed 7/7 20:21:52.238 [VideoFrame-545352504a49@14fa335] Checking for whether we are supporting push/pull
Wed 7/7 20:21:52.242 [VideoFrame-545352504a49@14fa335] 	clientDoesPull: false
Wed 7/7 20:21:52.245 [VideoFrame-545352504a49@14fa335] 	httpls: false
Wed 7/7 20:21:52.248 [VideoFrame-545352504a49@14fa335] 	clientDoesMPEG2Push: true
Wed 7/7 20:21:52.251 [VideoFrame-545352504a49@14fa335] 	clientCanDoMpeg4: true
Wed 7/7 20:21:52.255 [VideoFrame-545352504a49@14fa335] 	IsNOTLowBandwidth: true
Wed 7/7 20:21:52.258 [VideoFrame-545352504a49@14fa335] MiniPlayer is using Push mode playback
Wed 7/7 20:21:52.261 [VideoFrame-545352504a49@14fa335] Looks like it only switches to mpeg4 if it is not a mediaExtender, or low bandwidth....
Wed 7/7 20:21:52.264 [VideoFrame-545352504a49@14fa335] 	mediaExtender: true
Wed 7/7 20:21:52.267 [VideoFrame-545352504a49@14fa335] 	lowBandwidth: false
Wed 7/7 20:21:52.271 [VideoFrame-545352504a49@14fa335] We are a media extender, and we are not low bandwidth....
Wed 7/7 20:21:52.274 [VideoFrame-545352504a49@14fa335] Supported push containers: [MPEG2-TS, MPEG2-PS, MPEG1-PS]
Wed 7/7 20:21:52.277 [VideoFrame-545352504a49@14fa335] 	MPEG2_TS containerOK (I think it wants to just remux into MPEG2_TS: true
Wed 7/7 20:21:52.280 [VideoFrame-545352504a49@14fa335] 	Forcing transcode: false
Wed 7/7 20:21:52.283 [VideoFrame-545352504a49@14fa335] 	Confirming there is video
Wed 7/7 20:21:52.286 [VideoFrame-545352504a49@14fa335] 	Checking to see if video it MPEG2
Wed 7/7 20:21:52.289 [VideoFrame-545352504a49@14fa335] 	Video is not MPEG2 and is a supported codec. Setting video to OK
Wed 7/7 20:21:52.293 [VideoFrame-545352504a49@14fa335] 	Video codec: H.264
Wed 7/7 20:21:52.296 [VideoFrame-545352504a49@14fa335] Checking audio codec
Wed 7/7 20:21:52.299 [VideoFrame-545352504a49@14fa335] 	Has audio
Wed 7/7 20:21:52.302 [VideoFrame-545352504a49@14fa335] 	Audio code is OK
Wed 7/7 20:21:52.306 [VideoFrame-545352504a49@14fa335] 	Audio is not low rate
Wed 7/7 20:21:52.309 [VideoFrame-545352504a49@14fa335] Checking if client can do MPEGHD again....
Wed 7/7 20:21:52.312 [VideoFrame-545352504a49@14fa335] 	Client can do MPEGHD
Wed 7/7 20:21:52.315 [VideoFrame-545352504a49@14fa335] MiniPlayer is using the MPEG2 pusher
Wed 7/7 20:21:52.325 [VideoFrame-545352504a49@14fa335] Mpeg2Reader is detecting timestamp boundaries in the file...
Wed 7/7 20:21:52.329 [VideoFrame-545352504a49@14fa335] IFrame alignment=true
Wed 7/7 20:21:52.332 [VideoFrame-545352504a49@14fa335] Mpeg2Reader about to determine the firstPTS in the file...
Wed 7/7 20:21:52.336 [VideoFrame-545352504a49@14fa335] Mpeg2Reader has found the firstPTS, now determining the duration of the file...
Wed 7/7 20:21:52.345 [VideoFrame-545352504a49@14fa335] Opened MPEG-2 TS file: F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.ts firstPTS=323986352 durationMsec=3599154
Wed 7/7 20:21:52.349 [VideoFrame-545352504a49@14fa335] Mpeg2Reader seeking to pos=0
Wed 7/7 20:21:52.353 [VideoFrame-545352504a49@14fa335] Setting the transcoder format...
Wed 7/7 20:21:52.356 [VideoFrame-545352504a49@14fa335] 	There is a current media file...
Wed 7/7 20:21:52.359 [VideoFrame-545352504a49@14fa335] Not sure exactly what this block is doing.  if the ContainerFormat is not null and serverSideTranscoding, and not use original audio track
Wed 7/7 20:21:52.363 [VideoFrame-545352504a49@14fa335] Calling openURL0: push: f=MPEG2-TS;dur=1838;br=2884000;[bf=vid;f=H.264;index=0;main=yes;tag=0100;fps=59.94006;fpsn=60000;fpsd=1001;ar=1.777778;arn=16;ard=9;w=1280;h=720;][bf=aud;f=AC3;br=384000;index=1;main=yes;tag=0101;sr=48000;ch=6;lang=eng;][bf=sub;f=SRT;lang=CC1;path=F:\\Sage Recordings\\The Rachel Maddow Show - S2021E134 - 7323562-0.CC1.srt;forced=false;][bf=sub;f=SRT;lang=CC2;path=F:\\Sage Recordings\\The Rachel Maddow Show - S2021E134 - 7323562-0.CC2.srt;forced=false;]
Wed 7/7 20:21:52.366 [VideoFrame-545352504a49@14fa335] openURL0(push:f=MPEG2-TS;dur=1838;br=2884000;[bf=vid;f=H.264;index=0;main=yes;tag=0100;fps=59.94006;fpsn=60000;fpsd=1001;ar=1.777778;arn=16;ard=9;w=1280;h=720;][bf=aud;f=AC3;br=384000;index=1;main=yes;tag=0101;sr=48000;ch=6;lang=eng;][bf=sub;f=SRT;lang=CC1;path=F:\\Sage Recordings\\The Rachel Maddow Show - S2021E134 - 7323562-0.CC1.srt;forced=false;][bf=sub;f=SRT;lang=CC2;path=F:\\Sage Recordings\\The Rachel Maddow Show - S2021E134 - 7323562-0.CC2.srt;forced=false;])
Wed 7/7 20:21:52.397 [VideoFrame-545352504a49@14fa335] is ((mediaExtender && pushmode) or hdmediaextend) and not low bandwidth
Wed 7/7 20:21:52.401 [VideoFrame-545352504a49@14fa335] Setting audio stream for playback to be ID=0x101
Wed 7/7 20:21:53.071 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 750 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:21:53.362 [Fork-OPUS4-112742@1e60672] ENDING background recording thumb preloader thread, ID = 0.7385171052730369
Wed 7/7 20:21:53.828 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 1507 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:21:54.584 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 2263 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:21:55.342 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 3021 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:21:56.099 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 3778 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:21:56.856 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 4535 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:21:57.614 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 5293 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:21:58.372 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 6051 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:21:59.129 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 6808 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:21:59.887 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 7566 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:00.644 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 8323 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:01.399 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 9078 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:02.156 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 9835 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:02.913 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 10592 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:03.671 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 11350 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:04.426 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 12105 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:05.181 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 12860 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:05.935 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 13614 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:06.691 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 14370 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:07.445 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 15124 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:08.201 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 15880 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:08.955 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 16634 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:09.714 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 17393 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:10.468 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 18146 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:11.221 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 18900 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:11.974 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 19653 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:12.728 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 20407 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:13.482 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 21161 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:14.236 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 21915 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:14.990 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 22669 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:15.745 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 23424 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:16.500 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 24179 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:17.254 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 24933 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:18.008 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 25687 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:18.763 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 26442 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:19.520 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 27199 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:20.275 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 27954 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:21.032 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 28711 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:21.787 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 29466 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:22.404 [TimeoutHandler@10ce2af] TIMEOUT occurred - close the socket asynchronously for java.nio.channels.SocketChannel[connected local=/192.168.1.195:31099 remote=/69.7.56.242:54054]
Wed 7/7 20:22:22.410 [VideoFrame-545352504a49@14fa335] Error with MiniPlayer, closing UI: java.nio.channels.AsynchronousCloseException
Wed 7/7 20:22:22.415 [MCSRReconnect@4430d1] Preparing the media player for a reload...
Wed 7/7 20:22:22.421 [VideoFrame-545352504a49@14fa335] Sigma video dim=java.awt.Dimension[width=720,height=480]
Wed 7/7 20:22:22.428 [MCSRReconnect@4430d1] VF.submitJob(VFJob[ReloadPrepareMF r=0.0 t=0 file=null ifn=null])
Wed 7/7 20:22:22.435 [VideoFrame-545352504a49@14fa335] pausePush0()
Wed 7/7 20:22:22.446 [VideoFrame-545352504a49@14fa335] Error with MiniPlayer, closing UI: java.nio.channels.ClosedChannelException
Wed 7/7 20:22:22.453 [VideoFrame-545352504a49@14fa335] setMute0()
Wed 7/7 20:22:22.459 [VideoFrame-545352504a49@14fa335] Error with MiniPlayer, closing UI: java.nio.channels.ClosedChannelException
Wed 7/7 20:22:22.464 [VideoFrame-545352504a49@14fa335] Error with MiniPlayer, closing UI: java.nio.channels.ClosedChannelException
Wed 7/7 20:22:22.472 [VideoFrame-545352504a49@14fa335] getDuration : 3599154
Wed 7/7 20:22:22.478 [VideoFrame-545352504a49@14fa335] VideoFrame.timeSelected2(Wed 7/7 18:00:00.009, true) currFile=MediaFile[id=7487619 A[7323562,7323508,"The Rachel Maddow Show",64241@0707.18:00,60,T] mask=TV host=Media encodedBy=DCT-HDHomeRun Prime Tuner 13112554-0 on 127.0.0.1:9000 MNBCHD format=MPEG2-TS 0:00:01 2884 kbps [#0 Video[H.264 59.94006 fps 1280x720 16:9 progressive id=0100]#1 Audio[AC3 48000 Hz 6 channels 384 kbps MAIN idx=1 id=0101 eng]#2 Subpic[SRT path=F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.CC1.srt CC1]#3 Subpic[SRT path=F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.CC2.srt CC2]] F:\Sage Recordings\The Rachel Maddow Show - S2021E134 - 7323562-0.ts, Seg0[Wed 7/7 18:00:00.009-Wed 7/7 19:00:00.018]] realDur=3599154
Wed 7/7 20:22:22.482 [VideoFrame-545352504a49@14fa335] seeking numpushbuffers=0 seekTime=0
Wed 7/7 20:22:22.489 [VideoFrame-545352504a49@14fa335] Mpeg2Reader seeking to pos=0
Wed 7/7 20:22:22.495 [VideoFrame-545352504a49@14fa335] flushPush0()
Wed 7/7 20:22:22.500 [VideoFrame-545352504a49@14fa335] Error with MiniPlayer, closing UI: java.nio.channels.ClosedChannelException
Wed 7/7 20:22:22.513 [VideoFrame-545352504a49@14fa335] Creating new push thread
Wed 7/7 20:22:22.522 [VideoFrame-545352504a49@14fa335] Channel Change Time=1625714542522 NOTE: Not valid if this was not a direct channel change!
Wed 7/7 20:22:22.526 [Pusher@13a174e] Pusher thread is starting
Wed 7/7 20:22:22.535 [Pusher@13a174e] Miniplayer pusher using buffer size of 32768
Wed 7/7 20:22:22.543 [VideoFrame-545352504a49@14fa335] VF processing job VFJob[ReloadPrepareMF r=0.0 t=0 file=null ifn=null] nPlayin=true
Wed 7/7 20:22:22.562 [MiniUIServer@166eb42] MiniUI got connection from java.nio.channels.SocketChannel[connected local=/192.168.1.195:31099 remote=/69.7.56.242:54060]
Wed 7/7 20:22:22.567 [AWTThreadWatcher-545352504a49@1ce8d81] EventThread-545352504a49 Hang Detected - hang time = 30234 UILocker=Thread[ActiveRender-545352504a49,2,main]
Wed 7/7 20:22:22.575 [SRTSubtitleMonitor@1f143f5] ERROR in SRT file; didn't find timecode on line; instead found: 1140 error=java.lang.StringIndexOutOfBoundsException: String index out of range: 5
Wed 7/7 20:22:22.579 [MiniUIServerConnection@4af226] MiniPlayer is adding to its map:545352504a49
Wed 7/7 20:22:22.583 [VideoFrame-545352504a49@14fa335] VF processing on UI Thread VFJob[ReloadPrepareMF r=0.0 t=0 file=null ifn=null]
Wed 7/7 20:22:22.591 [ActiveRender-545352504a49@f2d7e] VideoFrame got registration of a subtitle UI component: sage.ZCCLabel[loc=java.awt.Point[x=288,y=820] size=java.awt.Dimension[width=1344,height=216]]
Wed 7/7 20:22:22.595 [SRTSubtitleMonitor@1f143f5] ERROR in SRT file; didn't find timecode on line; instead found:  error=java.lang.NumberFormatException: For input string: ""
Wed 7/7 20:22:22.600 [SRTSubtitleMonitor@1f143f5] ERROR in SRT file; didn't find timecode on line; instead found: 1141 error=java.lang.StringIndexOutOfBoundsException: String index out of range: 5
Wed 7/7 20:22:22.614 [ActiveRender-545352504a49@f2d7e] VideoFrame got registration of a cc UI component: sage.ZCCLabel[loc=java.awt.Point[x=192,y=108] size=java.awt.Dimension[width=1536,height=864]]
Wed 7/7 20:22:22.627 [VideoFrame-545352504a49@14fa335] stopPush0()
Wed 7/7 20:22:22.632 [VideoFrame-545352504a49@14fa335] Error with MiniPlayer, closing UI: java.nio.channels.ClosedChannelException
Wed 7/7 20:22:22.642 [VideoFrame-545352504a49@14fa335] Closing down MiniPlayer
Wed 7/7 20:22:22.651 [VideoFrame-545352504a49@14fa335] closeDriver0()
Wed 7/7 20:22:22.658 [VideoFrame-545352504a49@14fa335] VF processing job null nPlayin=false
Wed 7/7 20:22:22.665 [MCSRReconnect@4430d1] MediaPlayer is ready for the reload.
Wed 7/7 20:22:22.671 [VideoFrame-545352504a49@14fa335] isRec=false rd=3600009 base=0 eos=false
Wed 7/7 20:22:22.675 [MCSRReconnect@4430d1] MCSR reconnect daemon has started...wait up to 30 seconds for a client reconnect...
Wed 7/7 20:22:22.681 [VideoFrame-545352504a49@14fa335] VF thread is now waiting for 0:00:00.000
__________________
Server: Intel i5-11400 @4.4GHz 6 cores Windows10 Pro, Sage 9.2.6.976, Comskip Donators
Capture: Now> Xfinity/TVEverywhere/Channels OpenDCT_0.5.32_x86.
Future> remote HDHR Prime with Firmware version 20150826
Storage: 120gB SSD, 4tB HD on Server
Network: Now> gb LAN; Future> 500Mb Comcast to WAN to 20Mb rural ISP.
Playback: FireStick 4K, miniclient V1.9.3
Tech Level: Hobbyist
Reply With Quote
  #696  
Old 07-08-2021, 06:06 AM
ojones ojones is offline
Sage User
 
Join Date: Dec 2005
Posts: 61
Any coincidence this is happening for both of us right after the following?

"Setting audio stream for playback to be ID"

How is the latency of your wan link? My downlink leg is via a high latency comcast connection with some packet loss.

Have you been able to reproduce on any other client devices?
__________________
Hyper-V Host @ Dual Processor E5-2643 3.4ghz v4 HexaCore 128gb ram
Sage Server: VM w2016 x64 Guest running 9.2.x
OpenDCT & Plex Server: VM Ubuntu 16.04
Primary Client: VM W10x64 with GPU Passthrough
Reply With Quote
  #697  
Old 07-08-2021, 10:03 AM
stuckless's Avatar
stuckless stuckless is offline
SageTVaholic
 
Join Date: Oct 2007
Location: London, Ontario, Canada
Posts: 9,711
From what I can, this is happening when you are using a client to connect to a remote server. Does this also happen on your local LAN? Does this happen when using Placeshifter, HD300, or ONLY when using the Android app?

I've seen UI hangs a few in my time with SageTV.
1) Base network port on my switch. it worked, but it was dropping packets.
2) Server disks were going to sleep
3) Server is trying to transcode on the fly and can't keep up

Have you upgraded the server, recently? Changed Java?

Does it happen for all videos? or Just some?
Reply With Quote
  #698  
Old 07-08-2021, 11:32 AM
jvl711's Avatar
jvl711 jvl711 is offline
Sage Fanatic
 
Join Date: Jan 2004
Posts: 803
Quote:
Originally Posted by hb4 View Post
I am also experiencing 'hang detected'; seemed to start happening on or near new version of client; before that it was great. FS4K to remote (different city) client.
When you say it is hanging, are you seeing the spinning circle? Does this happening when navigating or when watching video? If you are seeing hang detected in the server logs, I think that is generally a server side issue I think... I also noticed that you are using one of the testing version of Sage.jar. I think there are newer versions than that one that have all of the features in it.

Josh
__________________
Projects I am currently maintaining
SageTV Andoid Client
Media Format Parser Plugin
JavaFFmpegLibrary
SageTVTranscoder

If you like the work I am doing and would like to support it you can become a Patreon member.
Reply With Quote
  #699  
Old 07-08-2021, 11:32 AM
hb4 hb4 is offline
Sage Aficionado
 
Join Date: Sep 2008
Location: Seattle, Wa
Posts: 342
Quote:
Originally Posted by stuckless View Post
From what I can, this is happening when you are using a client to connect to a remote server. Does this also happen on your local LAN? Does this happen when using Placeshifter, HD300, or ONLY when using the Android app?

I've seen UI hangs a few in my time with SageTV.
1) Base network port on my switch. it worked, but it was dropping packets.
2) Server disks were going to sleep
3) Server is trying to transcode on the fly and can't keep up

Have you upgraded the server, recently? Changed Java?

Does it happen for all videos? or Just some?
I've just tested Placeshifter remotely and it hangs as well. I can post a snip from the sagetv_0.txt file if it helps.

It doesn't happen all of the time, but I'm pretty sure that once it happens I can never watch that video again. I'll have to check that.

The only change I made since FS4K was working (perfectly) was to install a new router.

<Update:> As I typed that, I wondered if I'd missed some IP assignments. Searching Sagetvclient_0.txt I discovered...

Code:
Thu 7/8 9:40:52.062 [main@16ec8df] Local IP is 192.168.1.195
Thu 7/8 9:40:52.066 [main@16ec8df] Broadcast IP is 192.168.1.255
Thu 7/8 9:41:13.079 [main@16ec8df] Error establishing server connection to 192.168.123.8 of:java.net.ConnectException: Connection timed out: connect
Thu 7/8 9:41:13.099 [main@16ec8df] Local IP is 192.168.1.195
Thu 7/8 9:41:13.105 [main@16ec8df] Broadcast IP is 192.168.1.255
Thu 7/8 9:41:13.166 [main@16ec8df] Local IP is 192.168.1.195
Thu 7/8 9:41:13.171 [main@16ec8df] Broadcast IP is 192.168.1.255
Thu 7/8 9:41:13.176 [Thread-1@1b41a82] Requested to find MAC address of server at: 192.168.123.8
Thu 7/8 9:41:13.186 [Thread-1@1b41a82] Local IP is 192.168.1.195
Thu 7/8 9:41:16.192 [Thread-1@1b41a82] Requested to find MAC address of server at: 192.168.123.8
Thu 7/8 9:41:16.200 [Thread-1@1b41a82] Local IP is 192.168.1.195
Thu 7/8 9:41:40.816 [PooledThread@1c21418] Error establishing server connection to 192.168.123.8 of:java.net.ConnectException: Connection timed out: connect
Thu 7/8 9:42:16.828 [PooledThread@1c21418] Error establishing server connection to 192.168.123.8 of:java.net.ConnectException: Connection timed out: connect
Turns out I might have, but SagetvClient.properties and Sagetv.properties both seem to have the correct server address. How do I tell java.net to use the correct server? (hoping this will solve my issues).
__________________
Server: Intel i5-11400 @4.4GHz 6 cores Windows10 Pro, Sage 9.2.6.976, Comskip Donators
Capture: Now> Xfinity/TVEverywhere/Channels OpenDCT_0.5.32_x86.
Future> remote HDHR Prime with Firmware version 20150826
Storage: 120gB SSD, 4tB HD on Server
Network: Now> gb LAN; Future> 500Mb Comcast to WAN to 20Mb rural ISP.
Playback: FireStick 4K, miniclient V1.9.3
Tech Level: Hobbyist
Reply With Quote
  #700  
Old 07-08-2021, 11:40 AM
wnjj wnjj is offline
Sage Icon
 
Join Date: Jan 2009
Posts: 1,475
Quote:
Originally Posted by jvl711 View Post
When you say it is hanging, are you seeing the spinning circle? Does this happening when navigating or when watching video? If you are seeing hang detected in the server logs, I think that is generally a server side issue I think... I also noticed that you are using one of the testing version of Sage.jar. I think there are newer versions than that one that have all of the features in it.

Josh
Based upon the logs shown above, it’s hanging when trying to set the audio stream type here:

https://github.com/google/sagetv/blo...yer.java#L3685

Which is called from here:

https://github.com/google/sagetv/blo...yer.java#L1396

I’m not sure if that is a coincidence that happens when something else hangs the system but the 30 seconds of hang triggers a timeout and the exception kicks in there.
__________________
Windows Installer
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
SageTV MiniClient for Android Indiegogo Campaign (Thanks) stuckless SageTV Clients Development 13 10-27-2020 01:49 PM
Android MiniClient 1.4.3 stuckless SageTV Clients Development 20 03-25-2019 10:32 AM
Android MiniClient 1.2.9 stuckless SageTV Clients Development 53 04-16-2018 07:30 AM
Android Miniclient and UK TV rickgillyon SageTV Clients Development 6 12-01-2016 05:58 PM
Android Miniclient on Mi Box Crashing SageTV Server v9 mackb SageTV Clients Development 9 11-27-2016 07:28 PM


All times are GMT -6. The time now is 07:45 AM.


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