All media falling back to transcoder on Nvidia Shield

techdiver · March 5, 2021, 10:23pm

Server Version#: 1.22.0.4145
Player Version#: 8.13.2.23227

Starting today I’ve noticed severe issue with plex on shield. The shield would force transcode everything and once I force it to play original quality it works fine for a few minutes but then hangs again.

Then tonight I was trying to watch a Dolby Vision or HDR title and it would fail back to transcoding also.

I uninstalled and reinstalled the app on the shield and it seemed to fic the issue and the titles started up fine but then reverted to the same issue.

I enabled logging on the shield and below is what I see:

03-05 21:48:28.225  i: [OneApp] User can execute command without restrictions because they are entitled.
03-05 21:48:28.226  i: [PlaybackManager] Preparing for Aquaman
03-05 21:48:28.226  i: [DefaultPlaybackManager] Passthrough is enabled.
03-05 21:48:28.235  i: [DefaultPlaybackManager] No codecs being downloaded.
03-05 21:48:28.235  i: [PlayQueues] Creating delayed remote PQ.
03-05 21:48:28.247  i: [MediaBrowserAudioService] onCreate
03-05 21:48:28.249  i: [PlayerService] onCreate
03-05 21:48:28.249  i: [ConnectivityManager] Device is under Wifi
03-05 21:48:28.250  i: [Player] Changing to use ExoPlayer for playback.
03-05 21:48:28.277  i: [MemoryOptimisationBehaviour] Reducing memory cache.
03-05 21:48:28.282  i: [CurrentItemMetadataBehaviour] Fetching current item
03-05 21:48:28.284  i: [MediaSessionHelper] Starting media session with tag: video
03-05 21:48:28.285  i: Fetching [method:GET] https://192.168.1.2:32400/library/metadata/254880?includeChapters=1&includeLoudnessRamps=1&includeMarkers=1&includeRelated=1&X-Plex-Token=...f_zy
03-05 21:48:28.285  i: [MediaSessionHelper] Creating media session with tag: video
03-05 21:48:28.297  i: [MediaSessionBehaviour] Updating metadata for video, thumb: false
03-05 21:48:28.306  i: [InteractionBehaviour] Slept, reason: Startup.
03-05 21:48:28.306  i: [VideoAwakeBehaviour] Keep screen awake has been requested disabled for VideoAwakeBehaviour.
03-05 21:48:28.307  i: [DisplayBehaviour] New ExoPlayerEngine detected, enabling: false.
03-05 21:48:28.307  i: [Player][ExoPlayer] Using PlayQueueMediaSource
03-05 21:48:28.324  i: [MediaSessionHelper] Releasing media session with tag: video
03-05 21:48:28.325  i: [MediaSessionHelper] Starting media session with tag: music
03-05 21:48:28.342  i: [MediaSessionHelper] Creating media session with tag: music
03-05 21:48:28.349  i: [MediaCodecVideoSyncRenderer] Setting allow dummy surface: false
03-05 21:48:28.358  i: [ExoPlayer][EventLogger] playWhenReady [eventTime=0.07, mediaPos=0.00, window=0, true, USER_REQUEST]
03-05 21:48:28.361  i: [ExoPlayer][EventLogger] seekStarted [eventTime=0.07, mediaPos=0.00, window=0]
03-05 21:48:28.362  i: [ExoPlayer][EventLogger] positionDiscontinuity [eventTime=0.07, mediaPos=1739.76, window=0, SEEK]
03-05 21:48:28.363  i: [Player][ExoPlayer] onPositionDiscontinuity, Reason: 1 Period Transition: false
03-05 21:48:28.363  i: [ExoPlayer][EventLogger] timeline [eventTime=0.08, mediaPos=1739.76, window=0, periodCount=1, windowCount=1, reason=PLAYLIST_CHANGED
03-05 21:48:28.364  i: [ExoPlayer][EventLogger]   period [?]
03-05 21:48:28.364  i: [ExoPlayer][EventLogger]   window [?, false, true]
03-05 21:48:28.365  i: [ExoPlayer][EventLogger] ]
03-05 21:48:28.365  i: [Player][ExoPlayer] onTimelineChanged (Position: 0 ms, Duration: 0 ms)
03-05 21:48:28.365  i: [ExoPlayer][EventLogger] mediaItem [eventTime=0.08, mediaPos=1739.76, window=0, reason=PLAYLIST_CHANGED]
03-05 21:48:28.365  i: [ExoPlayer][EventLogger] state [eventTime=0.08, mediaPos=1739.76, window=0, BUFFERING]
03-05 21:48:28.365  i: [MediaDecisionEngine] Starting media decision for: Aquaman (part index 0)
03-05 21:48:28.366  i: [MediaDecisionEngine] Transcode server selected: Eggy's Server
03-05 21:48:28.366  i: Fetching [method:GET] http://127.0.0.1:32500/library/metadata/254880
03-05 21:48:28.370  i: Creating PlayerActivity.
03-05 21:48:28.373  i: [Activity] Resuming the application, attempting to download item and children.
03-05 21:48:28.373  i: [Boot] PlayerActivity took 4ms to run create behaviours.
03-05 21:48:28.373  i: [PlayerActivity] Creating fragment
03-05 21:48:28.374  i: [Player][DimensionsLayout] Resizing: 100 x 100
03-05 21:48:28.377  i: [DisplayBehaviour] Activity has been changed, searching for available modes.
03-05 21:48:28.378  i: [DisplayBehaviour] Current mode detected as 3840x2160 @ 23.9760Hz (2).
03-05 21:48:28.380  i: [PictureInPictureBehaviour] Picture-in-picture is available and can be used.
03-05 21:48:28.380  i: [HttpServer] /127.0.0.1:49760 - GET /library/metadata/254880
03-05 21:48:28.383  i: [ConnectivityManager] Device is under Wifi
03-05 21:48:28.383  e: [Sync] Error forwarding request http://127.0.0.1:32500/library/metadata/254880 to nano server.
03-05 21:48:28.384  e: Error fetching http://127.0.0.1:32500/library/metadata/254880:
Failure: 500 Internal Server Error

03-05 21:48:28.385  i: [CurrentItemMetadataBehaviour] Fetched current item, success: true
03-05 21:48:28.385  i: [MediaDecisionEngine] Analyzing media: 3840x2160 20120kbps (Container: mkv, Video: hevc, Audio: truehd)
03-05 21:48:28.386  e: An exception occurred: java.lang.IllegalArgumentException: Invalid URL port: "0"
03-05 21:48:28.387  e: Stacktrace: java.lang.IllegalArgumentException: Invalid URL port: "0"
	at okhttp3.HttpUrl$Builder.parse$okhttp(SourceFile:34)
	at okhttp3.HttpUrl$Companion.get(SourceFile:1)
	at okhttp3.Request$Builder.url(SourceFile:7)
	at com.plexapp.plex.net.pms.sync.f.x(SourceFile:21)
	at com.plexapp.plex.net.pms.sync.f.w(SourceFile:2)
	at com.plexapp.plex.net.pms.sync.p.H(SourceFile:2)
	at com.plexapp.plex.net.pms.sync.p.t(SourceFile:6)
	at com.plexapp.plex.net.pms.sync.f.o(SourceFile:3)
	at com.plexapp.plex.net.pms.h0.s(SourceFile:8)
	at org.jboss.netty.channel.p0.e(SourceFile:2)
	at org.jboss.netty.channel.DefaultChannelPipeline.v(SourceFile:1)
	at org.jboss.netty.channel.DefaultChannelPipeline$a.b(SourceFile:2)
	at h.a.a.c.c.d.e(SourceFile:7)
	at org.jboss.netty.channel.DefaultChannelPipeline.v(SourceFile:1)
	at org.jboss.netty.channel.DefaultChannelPipeline$a.b(SourceFile:2)
	at h.a.a.c.a.a.h.s(SourceFile:16)
	at org.jboss.netty.channel.p0.e(SourceFile:2)
	at org.jboss.netty.channel.DefaultChannelPipeline.v(SourceFile:1)
	at org.jboss.netty.channel.DefaultChannelPipeline$a.b(SourceFile:2)
	at org.jboss.netty.channel.v.r(SourceFile:1)
	at org.jboss.netty.handler.codec.replay.b.C(SourceFile:8)
	at org.jboss.netty.handler.codec.replay.b.u(SourceFile:11)
	at org.jboss.netty.handler.codec.replay.b.s(SourceFile:9)
	at org.jboss.netty.channel.p0.e(SourceFile:2)
	at org.jboss.netty.channel.DefaultChannelPipeline.v(SourceFile:1)
	at org.jboss.netty.channel.DefaultChannelPipeline.b(SourceFile:3)
	at org.jboss.netty.channel.v.q(SourceFile:1)
	at org.jboss.netty.channel.v.p(SourceFile:1)
	at org.jboss.netty.channel.u0.f.l.i(SourceFile:16)
	at org.jboss.netty.channel.u0.f.l.g(SourceFile:5)
	at org.jboss.netty.channel.u0.f.l.run(SourceFile:13)
	at h.a.a.e.g.run(SourceFile:7)
	at h.a.a.e.k.e$a.run(SourceFile:2)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641)
	at java.lang.Thread.run(Thread.java:764)

03-05 21:48:28.388  i: [video] User maximum h264 profile determined: 52
03-05 21:48:28.388  i: [video] Device recommended h264 profile determined: 52
03-05 21:48:28.393  i: [MediaSessionBehaviour] Updating metadata for video, thumb: true
03-05 21:48:28.395  i: Fetching [method:GET] https://plex.tv/api/v2/user/profile?X-Plex-Token=...f_zy
03-05 21:48:28.456  i: [PictureInPictureBehaviour] Picture-in-picture is available and can be used.
03-05 21:48:28.489  i: [MenuSheetHud] Item changed (and fetched), invalidating settings...
03-05 21:48:28.567  i: Resuming PlayerActivity.
03-05 21:48:28.585  i: [ExoPlayer][EventLogger] loading [eventTime=0.32, mediaPos=1739.76, window=0, period=0, true]
03-05 21:48:28.585  i: [SystemUIBehaviour] Hiding the system user-interface.
03-05 21:48:28.609  i: [Player][View] Layout has been measured with a size of 1920 x 1080 (1920 x 1080).
03-05 21:48:28.770  i: [BufferHelper] Assumed Bitrate: 40240, Segment Count: 4715
03-05 21:48:28.770  i: [BufferHelper] Detected memory pressure, reducing segment count to fit available memory: 512
03-05 21:48:28.771  i: [BufferHelper] Segment count: 3276

Further down we see the following:

03-05 21:48:30.196  e: [ExoPlayer][EventLogger] playerFailed [eventTime=1.93, mediaPos=1739.76, window=0, period=0
  com.google.android.exoplayer2.ExoPlaybackException: MediaCodecVideoRenderer error, index=1, format=Format(0, null, null, video/dolby-vision, dvhe.07.06, -1, null, [3840, 2160, 23.976025], [-1, -1]), format_supported=NO_EXCEEDS_CAPABILITIES
      at com.google.android.exoplayer2.l0.handleMessage(SourceFile:44)
      at android.os.Handler.dispatchMessage(Handler.java:102)
      at android.os.Looper.loop(Looper.java:193)
      at android.os.HandlerThread.run(HandlerThread.java:65)
  Caused by: com.google.android.exoplayer2.video.MediaCodecVideoDecoderException: Decoder failed: OMX.Nvidia.DOVI.decode
      at com.google.android.exoplayer2.video.m.m(SourceFile:1)
      at com.google.android.exoplayer2.mediacodec.MediaCodecRenderer.render(SourceFile:24)
      at com.google.android.exoplayer2.l0.n(SourceFile:14)
      at com.google.android.exoplayer2.l0.handleMessage(SourceFile:24)
      ... 3 more
  Caused by: java.lang.IllegalStateException
      at android.media.MediaCodec.native_dequeueOutputBuffer(Native Method)
      at android.media.MediaCodec.dequeueOutputBuffer(MediaCodec.java:2940)
      at com.google.android.exoplayer2.mediacodec.q.f(SourceFile:1)
      at com.google.android.exoplayer2.mediacodec.MediaCodecRenderer.drainOutputBuffer(SourceFile:7)
      at com.google.android.exoplayer2.mediacodec.MediaCodecRenderer.render(SourceFile:16)
      ... 5 more
]
03-05 21:48:30.207  e: [Player][ExoPlayer] Playback error detected
03-05 21:48:30.215  i: [FFmpeg] [INFO] [Cache] Terminating thread.
03-05 21:48:30.216  i: [Player][Timeline] Handling player error
03-05 21:48:30.217  i: [Player][Timeline] Playback stopped (error: true)
03-05 21:48:30.217  i: [Player][Timeline] Player error not known by server, reporting original player error (or a playback interrupted one)
03-05 21:48:30.217  i: [Player] Error reported: UnknownError (null)
03-05 21:48:30.218  i: [Player][Timeline] Playback stopped (error: false)
03-05 21:48:30.218  i: [FFmpeg] [INFO] [Cache] Thread has been terminated.
03-05 21:48:30.223  i: [FFmpeg] [INFO] [Cache] Cache has been closed, interrupting AVIO ...
03-05 21:48:30.223  i: [FFmpeg] [INFO] Demuxer pipeline terminated.
03-05 21:48:30.224  i: [FFmpeg] [INFO] [Cache] Close requested, terminating.
03-05 21:48:30.224  i: [FFmpeg] [INFO] Demuxer has been successfully closed.
03-05 21:48:30.225  i: [TranscodeFallbackBehaviour] Detected direct play failed, falling back to transcode (starting: true)
03-05 21:48:30.225  i: [VideoAwakeBehaviour] Keep screen awake has been requested disabled for VideoAwakeBehaviour.
03-05 21:48:30.226  i: [DisplayBehaviour] New ExoPlayerEngine detected, enabling: false.
03-05 21:48:30.226  i: [Player][ExoPlayer] Using PlayQueueMediaSource
03-05 21:48:30.226  i: [Player] Error has been consumed by Transcode Fallback Behaviour and will not continue.
03-05 21:48:30.227  e: An exception occurred: com.google.android.exoplayer2.ExoPlaybackException: MediaCodecVideoRenderer error, index=1, format=Format(0, null, null, video/dolby-vision, dvhe.07.06, -1, null, [3840, 2160, 23.976025], [-1, -1]), format_supported=NO_EXCEEDS_CAPABILITIES
03-05 21:48:30.227  i: [ExoPlayer][EventLogger] loading [eventTime=1.95, mediaPos=1739.76, window=0, period=0, false]
03-05 21:48:30.228  e: Stacktrace: com.google.android.exoplayer2.ExoPlaybackException: MediaCodecVideoRenderer error, index=1, format=Format(0, null, null, video/dolby-vision, dvhe.07.06, -1, null, [3840, 2160, 23.976025], [-1, -1]), format_supported=NO_EXCEEDS_CAPABILITIES
	at com.google.android.exoplayer2.l0.handleMessage(SourceFile:44)
	at android.os.Handler.dispatchMessage(Handler.java:102)
	at android.os.Looper.loop(Looper.java:193)
	at android.os.HandlerThread.run(HandlerThread.java:65)
Caused by: com.google.android.exoplayer2.video.MediaCodecVideoDecoderException: Decoder failed: OMX.Nvidia.DOVI.decode
	at com.google.android.exoplayer2.video.m.m(SourceFile:1)
	at com.google.android.exoplayer2.mediacodec.MediaCodecRenderer.render(SourceFile:24)
	at com.google.android.exoplayer2.l0.n(SourceFile:14)
	at com.google.android.exoplayer2.l0.handleMessage(SourceFile:24)
	... 3 more
Caused by: java.lang.IllegalStateException
	at android.media.MediaCodec.native_dequeueOutputBuffer(Native Method)
	at android.media.MediaCodec.dequeueOutputBuffer(MediaCodec.java:2940)
	at com.google.android.exoplayer2.mediacodec.q.f(SourceFile:1)
	at com.google.android.exoplayer2.mediacodec.MediaCodecRenderer.drainOutputBuffer(SourceFile:7)
	at com.google.android.exoplayer2.mediacodec.MediaCodecRenderer.render(SourceFile:16)
	... 5 more

If I start the movie again from the start it works for a while and then hangs again.

The issue actually happens with 1080p SDR content also, so not just limited to DV. All of these titles having been working flawlessly for months up to now.

techdiver · March 6, 2021, 10:42am

Further to this, other titles are randomly just stopping and the yellwo circle icon appears. When that happens the logs report the following:

03-06 01:42:32.069  i: [PlaybackTimeBehaviour] Time: 1655763 IsStarted: true
03-06 01:42:32.371  i: [ExoPlayer][EventLogger] loading [eventTime=4182.26, mediaPos=1656.72, window=0, period=0, true]
03-06 01:42:32.377  i: [ExoPlayer][EventLogger] loading [eventTime=4182.27, mediaPos=1656.72, window=0, period=0, false]
03-06 01:42:32.821  i: [PlaybackTimeBehaviour] Time: 1656514 IsStarted: true
03-06 01:42:33.321  i: [PlaybackTimeBehaviour] Time: 1657015 IsStarted: true
03-06 01:42:33.488  i: [ExoPlayer][EventLogger] loading [eventTime=4183.38, mediaPos=1657.84, window=0, period=0, true]
03-06 01:42:33.492  i: [ExoPlayer][EventLogger] loading [eventTime=4183.38, mediaPos=1657.84, window=0, period=0, false]
03-06 01:42:34.000  i: [ExoPlayer][EventLogger] loading [eventTime=4183.89, mediaPos=1658.35, window=0, period=0, true]
03-06 01:42:34.009  i: [ExoPlayer][EventLogger] loading [eventTime=4183.90, mediaPos=1658.35, window=0, period=0, false]
03-06 01:42:34.073  i: [PlaybackTimeBehaviour] Time: 1657766 IsStarted: true
03-06 01:42:34.794  i: [ExoPlayer][EventLogger] loading [eventTime=4184.68, mediaPos=1659.14, window=0, period=0, true]
03-06 01:42:34.811  i: [ExoPlayer][EventLogger] loading [eventTime=4184.70, mediaPos=1659.16, window=0, period=0, false]
03-06 01:42:34.823  i: [PlaybackTimeBehaviour] Time: 1658517 IsStarted: true
03-06 01:42:35.324  i: [PlaybackTimeBehaviour] Time: 1659017 IsStarted: true
03-06 01:42:35.459  i: [ExoPlayer][EventLogger] loading [eventTime=4185.35, mediaPos=1659.80, window=0, period=0, true]
03-06 01:42:35.468  i: [ExoPlayer][EventLogger] loading [eventTime=4185.36, mediaPos=1659.81, window=0, period=0, false]
03-06 01:42:35.698  i: [EngineEventManager] onPlaybackPaused
03-06 01:42:35.705  i: [PlaybackTimeBehaviour] Time: 1659399 IsStarted: true
03-06 01:42:35.706  i: [PlaybackTimeBehaviour] Pausing stopwatch
03-06 01:42:35.706  i: [VideoAwakeBehaviour] Keep screen awake has been requested disabled for VideoAwakeBehaviour.
03-06 01:42:35.707  i: [VideoAwakeBehaviour] Disabling screen on
03-06 01:42:35.708  i: [AudioFocusBehaviour] Playback paused
03-06 01:42:35.709  i: Fetching [method:GET] https://192.168.1.2:32400/:/timeline?audioStreamID=881322&bufferedTime=60506&duration=2544160&guid=com.plexapp.agents.thetvdb%3A%2F%2F295760%2F5%2F6%3Flang%3Den&key=%2Flibrary%2Fmetadata%2F254175&playbackTime=1659399&playQueueItemID=104476&ratingKey=254175&state=paused&time=1660046&token=...f_zy&X-Plex-Client-Identifier=6d18cbd80c5b7194-com-plexapp-android&X-Plex-Token=...f_zy
03-06 01:42:35.730  i: [AudioFocusBehaviour] Given up focus.
03-06 01:42:35.731  i: [TranscodeSession] Pausing...
03-06 01:42:35.732  i: [PlayQueueProgressBehaviour] Updating PlayQueueManager state, isPlaying: false
03-06 01:42:35.732  i: [WiFiLockBehaviour] Releasing WiFi lock since playback was paused.
03-06 01:42:35.733  i: [PictureInPictureBehaviour] Picture-in-picture is available and can be used.
03-06 01:42:35.738  i: [ExoPlayer][EventLogger] playWhenReady [eventTime=4185.63, mediaPos=1660.05, window=0, period=0, false, USER_REQUEST]
03-06 01:42:35.740  i: [ExoPlayer][EventLogger] isPlaying [eventTime=4185.63, mediaPos=1660.05, window=0, period=0, false]

If I check the playback in the server it shows it as being Paused??? There was no such action. I have to end the playback and restart.

Other times I see the following in the logs when it happens:

03-06 10:42:52.249  i: [PlaybackTimeBehaviour] Time: 8342 IsStarted: true
03-06 10:42:52.343  i: [PlaybackTimeBehaviour] Time: 8436 IsStarted: true
03-06 10:42:52.345  i: Fetching [method:GET] https://192.168.1.2:32400/:/timeline?audioStreamID=780803&bufferedTime=115000&duration=5832828&guid=plex%3A%2F%2Fmovie%2F5d776c9b47dd6e001f6ed31c&key=%2Flibrary%2Fmetadata%2F205405&playbackTime=8437&playQueueItemID=104491&ratingKey=205405&state=playing&time=3199785&token=...f_zy&X-Plex-Client-Identifier=6d18cbd80c5b7194-com-plexapp-android&X-Plex-Token=...f_zy
03-06 10:42:52.750  i: [PlaybackTimeBehaviour] Time: 8843 IsStarted: true
03-06 10:42:53.501  i: [PlaybackTimeBehaviour] Time: 9595 IsStarted: true
03-06 10:42:54.002  i: [PlaybackTimeBehaviour] Time: 10095 IsStarted: true
03-06 10:42:54.753  i: [PlaybackTimeBehaviour] Time: 10846 IsStarted: true
03-06 10:42:55.505  i: [PlaybackTimeBehaviour] Time: 11598 IsStarted: true
03-06 10:42:56.006  i: [PlaybackTimeBehaviour] Time: 12099 IsStarted: true
03-06 10:42:56.757  i: [PlaybackTimeBehaviour] Time: 12850 IsStarted: true
03-06 10:42:56.945  i: [Player][View] Configuration has been changed with a size of 1920 x 1080.
03-06 10:42:56.966  i: [Player][DimensionsLayout] Resizing: 1920 x 1038
03-06 10:42:57.222  i: [PlayerUtils] Pause supported, pausing playback.
03-06 10:42:57.222  i: [ActivityLifecycleBehaviour] Pausing playback automatically.
03-06 10:42:57.223  i: [PictureInPictureBehaviour] Picture-in-picture is available and can be used.
03-06 10:42:57.230  i: [EngineEventManager] onPlaybackPaused
03-06 10:42:57.235  i: [PlaybackTimeBehaviour] Time: 13328 IsStarted: true
03-06 10:42:57.235  i: [PlaybackTimeBehaviour] Pausing stopwatch
03-06 10:42:57.236  i: [VideoAwakeBehaviour] Keep screen awake has been requested disabled for VideoAwakeBehaviour.
03-06 10:42:57.237  i: [VideoAwakeBehaviour] Disabling screen on
03-06 10:42:57.237  i: [AudioFocusBehaviour] Playback paused
03-06 10:42:57.238  i: Fetching [method:GET] https://192.168.1.2:32400/:/timeline?audioStreamID=780803&bufferedTime=110077&duration=5832828&guid=plex%3A%2F%2Fmovie%2F5d776c9b47dd6e001f6ed31c&key=%2Flibrary%2Fmetadata%2F205405&playbackTime=13328&playQueueItemID=104491&ratingKey=205405&state=paused&time=3204708&token=...f_zy&X-Plex-Client-Identifier=6d18cbd80c5b7194-com-plexapp-android&X-Plex-Token=...f_zy
03-06 10:42:57.239  i: [AudioFocusBehaviour] Given up focus.
03-06 10:42:57.239  i: [TranscodeSession] Pausing...
03-06 10:42:57.241  i: [PlayQueueProgressBehaviour] Updating PlayQueueManager state, isPlaying: false
03-06 10:42:57.242  i: [WiFiLockBehaviour] Releasing WiFi lock since playback was paused.
03-06 10:42:57.242  i: [PictureInPictureBehaviour] Picture-in-picture is available and can be used.
03-06 10:42:57.247  i: [ExoPlayer][EventLogger] playWhenReady [eventTime=15.58, mediaPos=3204.71, window=0, period=0, false, USER_REQUEST]
03-06 10:42:57.248  i: [ExoPlayer][EventLogger] isPlaying [eventTime=15.58, mediaPos=3204.71, window=0, period=0, false]
03-06 10:42:57.300  i: [ExoPlayer][EventLogger] surfaceSize [eventTime=15.63, mediaPos=3204.71, window=0, period=0, 0, 0]
03-06 10:42:57.468  i: [PlaybackTimeBehaviour] Time: 13329 IsStarted: false
03-06 10:42:57.947  i: [WebSocketApplicationBehaviour] Focus change detected. Focused: false
03-06 10:42:57.949  i: [MetricsSessionApplicationBehaviour] Attaching listener for play queue events.
03-06 10:42:58.538  i: [HdmiCaps] Capabilties changed (AudioCapabilities[maxChannelCount=8, supportedEncodings=[2]])
03-06 10:42:58.539  i: [HdmiCaps] Reporting capabilities changed
03-06 10:42:58.539  i: [DisplayBehaviour] HDMI disconnection detected, waiting 10 seconds to see if it's reconnected
03-06 10:42:59.340  e: [ExoPlayer][EventLogger] audioTrackUnderrun [eventTime=17.67, mediaPos=3204.76, window=0, period=0, 765625, -9223372036854775807, 1006]
03-06 10:42:59.344  i: [ExoPlayer][EventLogger] videoDisabled [eventTime=17.67, mediaPos=3204.76, window=0, period=0]
03-06 10:42:59.344  i: [FF][MediaPeriod] Releasing.
03-06 10:42:59.345  i: [ExoPlayer][EventLogger] audioDisabled [eventTime=17.67, mediaPos=3204.76, window=0, period=0]
03-06 10:42:59.347  i: [FF] Loading canceled (released: true)
03-06 10:42:59.347  i: [FFmpeg] [INFO] Demuxer has been successfully interupted.
03-06 10:42:59.350  e: [ExoPlayer][EventLogger] playerFailed [eventTime=17.68, mediaPos=3204.76, window=0, period=0
  com.google.android.exoplayer2.ExoPlaybackException: MediaCodecAudioRenderer error, index=3, format=Format(1, null, null, audio/true-hd, truehd, 0, english, [-1, -1, -1.0], [8, 48000]), format_supported=YES
      at com.google.android.exoplayer2.l0.handleMessage(SourceFile:44)
      at android.os.Handler.dispatchMessage(Handler.java:102)
      at android.os.Looper.loop(Looper.java:193)
      at android.os.HandlerThread.run(HandlerThread.java:65)
  Caused by: com.google.android.exoplayer2.audio.AudioSink$WriteException: AudioTrack write failed: -6
      at com.google.android.exoplayer2.audio.DefaultAudioSink.k0(SourceFile:28)
      at com.google.android.exoplayer2.audio.DefaultAudioSink.a0(SourceFile:3)
      at com.google.android.exoplayer2.audio.DefaultAudioSink.k(SourceFile:57)
      at com.google.android.exoplayer2.audio.b0.Y(SourceFile:10)
      at com.google.android.exoplayer2.mediacodec.MediaCodecRenderer.a(SourceFile:9)
      at com.google.android.exoplayer2.mediacodec.MediaCodecRenderer.render(SourceFile:11)
      at com.google.android.exoplayer2.l0.n(SourceFile:14)
      at com.google.android.exoplayer2.l0.handleMessage(SourceFile:24)
      ... 3 more
]
03-06 10:42:59.351  e: [Player][ExoPlayer] Playback error detected
03-06 10:42:59.352  i: [Player][Timeline] Handling player error
03-06 10:42:59.352  i: [Player][Timeline] Playback stopped (error: true)
03-06 10:42:59.352  e: An exception occurred: com.google.android.exoplayer2.ExoPlaybackException: MediaCodecAudioRenderer error, index=3, format=Format(1, null, null, audio/true-hd, truehd, 0, english, [-1, -1, -1.0], [8, 48000]), format_supported=YES
03-06 10:42:59.353  e: Stacktrace: com.google.android.exoplayer2.ExoPlaybackException: MediaCodecAudioRenderer error, index=3, format=Format(1, null, null, audio/true-hd, truehd, 0, english, [-1, -1, -1.0], [8, 48000]), format_supported=YES
	at com.google.android.exoplayer2.l0.handleMessage(SourceFile:44)
	at android.os.Handler.dispatchMessage(Handler.java:102)
	at android.os.Looper.loop(Looper.java:193)
	at android.os.HandlerThread.run(HandlerThread.java:65)
Caused by: com.google.android.exoplayer2.audio.AudioSink$WriteException: AudioTrack write failed: -6
	at com.google.android.exoplayer2.audio.DefaultAudioSink.k0(SourceFile:28)
	at com.google.android.exoplayer2.audio.DefaultAudioSink.a0(SourceFile:3)
	at com.google.android.exoplayer2.audio.DefaultAudioSink.k(SourceFile:57)
	at com.google.android.exoplayer2.audio.b0.Y(SourceFile:10)
	at com.google.android.exoplayer2.mediacodec.MediaCodecRenderer.a(SourceFile:9)
	at com.google.android.exoplayer2.mediacodec.MediaCodecRenderer.render(SourceFile:11)
	at com.google.android.exoplayer2.l0.n(SourceFile:14)
	at com.google.android.exoplayer2.l0.handleMessage(SourceFile:24)
	... 3 more

freddy_uk · March 7, 2021, 12:20pm

Does plex think your playing on a remote device and is therefore transcoding to your settings. To rule that out I would enable “ Treat WAN IP As LAN Bandwidth” and under plex web is the quality set to maximum and direct play/stream enabled.

techdiver · March 7, 2021, 12:42pm

It’s very sporadic. It mostly effects resuming titles. I did see one incidence of it thinking I was external and enforcing the external bitrate. But in general what happens is the DV fails to play bit it does fall back to HDR 10 but transcodes the audio.

Completely random though. Sometimes playing works fine, others or does not.

freddy_uk · March 7, 2021, 2:00pm

The shield seems a pretty cr.py device. I have one and waiting now to see what the new Apple TV is like before buying a shield pro.

techdiver · March 7, 2021, 2:18pm

In fairness it is a good device. It just has issues for me with Dolby Vision. Everything else is bulletproof.

The exoplayer that plex uses can be quite buggy.

freddy_uk · March 7, 2021, 3:06pm

I have lots of issues with 4k stuff, webrips are generally ok but the rest crash back to the user screen about 3 times before eventually playing fault free. I know the pro handles higher bitrate stuff much better than the tube. Before replacing my tube I’m waiting to see what Apple release in the next few weeks.

techdiver · March 7, 2021, 3:18pm

Oh the tube with plex is a disaster. I had the Tube and changed to the pro. No issue with high bitrate. I have a 2017 model too in another room and it’s bullet proof. The Shield has the best codec support of any device. But definitely get the pro version.

system · June 5, 2021, 3:18pm

This topic was automatically closed 90 days after the last reply. New replies are no longer allowed.

Topic		Replies	Views
HW 4k transcoding issue on Nvidia Shield TV Streaming Devices server-windows , android-tv , roku	43	1306	December 27, 2021
Trailers won't start on my Nvidia Shield - Error with audio codec? (more below) Streaming Devices android-tv	85	1389	November 8, 2022
Hardware transcoding issues with PMS 1.24.x and 1.25.x? Any details on what the HW transcoding issues are and is a fix in progress? Plex Media Server server-nvidia-shield	157	5746	November 1, 2022
2160p failure on Nvidia Shield 2019 Streaming Devices android-tv	55	376	December 6, 2020
Video playback issues on Shield TV for all formats Streaming Devices android-tv	19	563	January 17, 2022

All media falling back to transcoder on Nvidia Shield

Related topics