jellyfin / jellyfin-androidtv

Android TV Client for Jellyfin
https://jellyfin.org
GNU General Public License v2.0
2.48k stars 422 forks source link

[Issue]: Sometimes playback stops and resume does not work (possible Android TV issue) #2897

Open rayburgemeestre opened 1 year ago

rayburgemeestre commented 1 year ago

Describe the bug

Accidentally reported bug here originally, now 2 weeks later I realize it was against the wrong repo. And I still have this issue, seemlingly out of nothing, log messages appear:

[2023-07-15 17:17:26.912 +02:00] [INF] Playback stopped reported by app "Android TV" "0.15.11" playing "Spider-Man: Far from Home". Stopped at "481292" ms
[2023-07-15 17:17:27.006 +02:00] [INF] User policy for "jellyfin". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True
[2023-07-15 17:17:27.006 +02:00] [INF] StreamBuilder.BuildVideoItem( Profile="AndroidTV-libVLC", Path="/jellyfin/movies/Spider-Man.Far.from.Home.2019.1080p.BluRay.H264.AAC-LAMA[TGx]/Spider-Man.Far.from.Home.2019.1080p.BluRay.H264.AAC-LAMA.mp4", AudioStreamIndex=null, SubtitleStreamIndex=null ) => ( PlayMethod=DirectPlay, TranscodeReason=0 ) "media:/videos/ddde302c-169d-770c-7edf-4a0fad68497e/stream.mov?MediaSourceId=ddde302c169d770c7edf4a0fad68497e&Static=true&VideoCodec=h264&AudioCodec=aac&AudioStreamIndex=2&api_key=<token>&Tag=956afba0aeff5ed6477265507b51003f"
[2023-07-15 17:17:27.013 +02:00] [INF] User policy for "jellyfin". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True
[2023-07-15 17:17:27.013 +02:00] [INF] StreamBuilder.BuildVideoItem( Profile="AndroidTV-libVLC", Path="/jellyfin/movies/Spider-Man.Far.from.Home.2019.1080p.BluRay.H264.AAC-LAMA[TGx]/Spider-Man.Far.from.Home.2019.1080p.BluRay.H264.AAC-LAMA.mp4", AudioStreamIndex=null, SubtitleStreamIndex=null ) => ( PlayMethod=DirectPlay, TranscodeReason=0 ) "media:/videos/ddde302c-169d-770c-7edf-4a0fad68497e/stream.mov?MediaSourceId=ddde302c169d770c7edf4a0fad68497e&Static=true&VideoCodec=h264&AudioCodec=aac&AudioStreamIndex=2&api_key=<token>&Tag=956afba0aeff5ed6477265507b51003f"
[2023-07-15 17:17:27.114 +02:00] [INF] User policy for "jellyfin". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True
[2023-07-15 17:17:27.114 +02:00] [INF] StreamBuilder.BuildVideoItem( Profile="AndroidTV-ExoPlayer", Path="/jellyfin/movies/Spider-Man.Far.from.Home.2019.1080p.BluRay.H264.AAC-LAMA[TGx]/Spider-Man.Far.from.Home.2019.1080p.BluRay.H264.AAC-LAMA.mp4", AudioStreamIndex=null, SubtitleStreamIndex=null ) => ( PlayMethod=DirectPlay, TranscodeReason=0 ) "media:/videos/ddde302c-169d-770c-7edf-4a0fad68497e/stream.mov?MediaSourceId=ddde302c169d770c7edf4a0fad68497e&Static=true&VideoCodec=h264&AudioCodec=aac&AudioStreamIndex=2&api_key=<token>&Tag=956afba0aeff5ed6477265507b51003f"
[2023-07-15 17:17:27.122 +02:00] [INF] User policy for "jellyfin". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True
[2023-07-15 17:17:27.123 +02:00] [INF] StreamBuilder.BuildVideoItem( Profile="AndroidTV-ExoPlayer", Path="/jellyfin/movies/Spider-Man.Far.from.Home.2019.1080p.BluRay.H264.AAC-LAMA[TGx]/Spider-Man.Far.from.Home.2019.1080p.BluRay.H264.AAC-LAMA.mp4", AudioStreamIndex=null, SubtitleStreamIndex=null ) => ( PlayMethod=DirectPlay, TranscodeReason=0 ) "media:/videos/ddde302c-169d-770c-7edf-4a0fad68497e/stream.mov?MediaSourceId=ddde302c169d770c7edf4a0fad68497e&Static=true&VideoCodec=h264&AudioCodec=aac&AudioStreamIndex=2&api_key=<token>&Tag=956afba0aeff5ed6477265507b51003f"
[2023-07-15 17:17:27.798 +02:00] [INF] Playback stopped reported by app "Android TV" "0.15.11" playing "Spider-Man: Far from Home". Stopped at "0" ms
[2023-07-15 17:17:28.068 +02:00] [INF] Playback stopped reported by app "Android TV" "0.15.11" playing "Spider-Man: Far from Home". Stopped at "0" ms

Why it stopped in the first place is a mystery to me, just after a few minutes of playing a movie, suddenly it stops, and I check my terminal and I see the above log lines have appeared..

Nobody is pressing pause, etc., it just stops by itself. I'm running on an nvidia shield, and the app updated to the latest version in the meantime (does so automatically)

It wouldn't be too bad if I have to press play again, but for some reason it resets to "Stopped at 0 ms" as can be seen in the logs..

Logs

See above.

Application version

0.5.11

Where did you install the app from?

Google Play

Device information

Nvidia shield pro 2017

Android version

Android tv 11

Jellyfin server version

10.8.9

darkmod83 commented 11 months ago

Hello, I've the same problem on Android TV (Sony Bravia) It's the same problem with native player or external player like MX Player. The main difference with you, when i stop my movie then restart, it starts again from the beginning. I can't use the play bare to get back to a specific point in the film, it restarts if i move it...

jellyfin-bot commented 7 months ago

This issue has gone 120 days without comment. To avoid abandoned issues, it will be closed in 21 days if there are no new comments.

If you're the original submitter of this issue, please comment confirming if this issue still affects you in the latest release or master branch, or close the issue if it has been fixed. If you're another user also affected by this bug, please comment confirming so. Either action will remove the stale label.

This bot exists to prevent issues from becoming stale and forgotten. Jellyfin is always moving forward, and bugs are often fixed as side effects of other changes. We therefore ask that bug report authors remain vigilant about their issues to ensure they are closed if fixed, or re-confirmed - perhaps with fresh logs or reproduction examples - regularly. If you have any questions you can reach us on Matrix or Social Media.

SteveDinn commented 7 months ago

Checking in with this issue because I just started experiencing it today. I'm on v0.16.0-beta.5 on a CCwGTV. It seems like playback lasts nearly 10 minutes before just stopping. My logs look identical as far as I can tell.

[23:29:13] [INF] [158] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app Android TV 0.16.0-beta.5 playing [Video Title]. Stopped at 598032 ms
[23:29:14] [INF] [156] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Playback stop tracker found, processing stop : 6c3b9cc4f5fe39c08a9007367e3ee28b8bb96e19-f262f7f8350f47ac8257ac2c324ea392-266e44232ff507c570345dd106a973bc
[23:29:14] [INF] [156] Jellyfin.Plugin.PlaybackReporting.Data.PlaybackTracker: PlaybackTracker : Adding Stop Event : 11/29/2023 23:29:14
[23:29:14] [INF] [156] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Saving playback tracking activity in DB

I'll try and collect some server debug logs to see if there is anything else worth sharing.

SteveDinn commented 7 months ago

Not much more info in the server debug logs:

[23:46:47] [DBG] [153] Jellyfin.Api.Helpers.TranscodingJobHelper: PingTranscodingJob PlaySessionId=6d0520c7d3884011b8dcf22f2219a47e isUsedPaused: False
[23:46:48] [DBG] [124] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: CustomAuthentication was successfully authenticated.
[23:46:48] [DBG] [124] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: CustomAuthentication was successfully authenticated.
[23:46:48] [DBG] [126] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: CustomAuthentication was successfully authenticated.
[23:46:48] [DBG] [126] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: CustomAuthentication was successfully authenticated.
[23:46:48] [DBG] [126] Jellyfin.Api.Controllers.PlaystateController: ReportPlaybackStopped PlaySessionId: 6d0520c7d3884011b8dcf22f2219a47e
[23:46:48] [INF] [126] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app Android TV 0.16.0-beta.5 playing [Video Title]. Stopped at 1192500 ms
[23:46:48] [DBG] [119] Jellyfin.Api.Helpers.TranscodingJobHelper: PingTranscodingJob PlaySessionId=6d0520c7d3884011b8dcf22f2219a47e isUsedPaused: False
[23:46:49] [DBG] [124] Jellyfin.Api.Helpers.TranscodingJobHelper: PingTranscodingJob PlaySessionId=6d0520c7d3884011b8dcf22f2219a47e isUsedPaused: False
[23:46:49] [INF] [61] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Playback stop tracker found, processing stop : 6c3b9cc4f5fe39c08a9007367e3ee28b8bb96e19-f262f7f8350f47ac8257ac2c324ea392-266e44232ff507c570345dd106a973bc
[23:46:49] [INF] [61] Jellyfin.Plugin.PlaybackReporting.Data.PlaybackTracker: PlaybackTracker : Adding Stop Event : 11/29/2023 23:46:49
[23:46:49] [DBG] [61] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: ProcessProgress : EventCount(2)Event(11/29/2023 23:36:49,START)Event(11/29/2023 23:46:49,STOP)Diff(600,600)To
tal(600)
[23:46:49] [INF] [61] Jellyfin.Plugin.PlaybackReporting.EventMonitorEntryPoint: Saving playback tracking activity in DB
[23:46:49] [DBG] [66] Jellyfin.Api.Auth.CustomAuthenticationHandler: AuthenticationScheme: CustomAuthentication was successfully authenticated.
Sam-Har-999 commented 4 months ago

Playback just stops, I am sure the remote is not being pressed. I have only seen this when playing Shows. Once stopped proceeds to play the next episode. I go back the episode that stopped displays the correct amount of time played.

Firestick 4K (2nd gen) 8.1.0.3. Jellyfin 0.16.6 downloaded from Amazon

"The Case of the Simple Simon". Stopped at "3034871" ms. *** Normal stop at end of episode** [2024-03-18 20:04:52.163 +00:00] [INF] [123] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "Tammy". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-03-18 20:04:52.164 +00:00] [INF] [123] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="AndroidTV-libVLC", Path="/media/Shows/Perry Mason (1957) TVDB/Season 07/Episode S07E25-A4_t02.mkv", AudioStreamIndex=null, SubtitleStreamIndex=null ) => ( PlayMethod=DirectPlay, TranscodeReason=0 ) "media:/videos/b1306a82-3c34-452d-8a6a-7c1665e56e5f/stream.mkv?MediaSourceId=b1306a823c34452d8a6a7c1665e56e5f&Static=true&VideoCodec=mpeg2video&AudioCodec=ac3&AudioStreamIndex=1&SubtitleStreamIndex=2&api_key=&SubtitleMethod=Embed&Tag=d5a11bef0c5ff37ddb11fa1f22418aa5" [2024-03-18 20:04:52.213 +00:00] [INF] [123] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "Tammy". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True [2024-03-18 20:04:52.213 +00:00] [INF] [123] Jellyfin.Api.Helpers.MediaInfoHelper: StreamBuilder.BuildVideoItem( Profile="AndroidTV-ExoPlayer", Path="/media/Shows/Perry Mason (1957) TVDB/Season 07/Episode S07E25-A4_t02.mkv", AudioStreamIndex=null, SubtitleStreamIndex=null ) => ( PlayMethod=Transcode, TranscodeReason=AudioCodecNotSupported, SubtitleCodecNotSupported ) "media:/videos/b1306a82-3c34-452d-8a6a-7c1665e56e5f/master.m3u8?MediaSourceId=b1306a823c34452d8a6a7c1665e56e5f&VideoCodec=hevc,h264&AudioCodec=aac,mp3&AudioStreamIndex=1&SubtitleStreamIndex=2&VideoBitrate=99808000&AudioBitrate=192000&MaxFramerate=29.97003&api_key=&SubtitleMethod=Encode&RequireAvc=false&Tag=d5a11bef0c5ff37ddb11fa1f22418aa5&SegmentContainer=ts&BreakOnNonKeyFrames=False&mpeg2video-level=8&mpeg2video-videobitdepth=8&mpeg2video-profile=main&aac-audiochannels=8&TranscodeReasons=AudioCodecNotSupported,%20SubtitleCodecNotSupported" [2024-03-18 20:27:23.180 +00:00] [INF] [91] Emby.Server.Implementations.Session.SessionManager: Playback stopped reported by app "Android TV" "0.16.6" playing "The Case of the Illicit Illusion". Stopped at "1348906" ms. abnormal stop **** [2024-03-18 20:27:30.813 +00:00] [INF] [189] Jellyfin.Api.Helpers.MediaInfoHelper: User policy for "Tammy". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True

omartulashvili commented 2 months ago

Guys, hi.

I have an identical problem, I believe. The procedure is as follows:

  1. Installed jellyfin on my server on digital ocean
  2. Put movies in the /media/movies folder
  3. Then went to the web version, entered my ip and port where the service is running, specified the settings
  4. When trying to play the film an error pops up
[2024-05-13 19:13:34.132 +00:00] [INF] StreamBuilder.BuildVideoItem( Profile="AndroidTV-libVLC", Path="/media/movies/Sluzhanka/Служанка (2016).mkv", AudioStreamIndex=null, SubtitleStreamIndex=null ) => ( PlayMethod=DirectPlay, TranscodeReason=0 ) "media:/videos/0b414135-9c01-cb58-0233-cc319d5d4acc/stream.mkv?MediaSourceId=0b4141359c01cb580233cc319d5d4acc&Static=true&VideoCodec=h264&AudioCodec=ac3&AudioStreamIndex=1&api_key=<token>&SubtitleMethod=Encode&Tag=00ff0c2192c092480c56d7d912e1bb93"
[2024-05-13 19:13:34.352 +00:00] [INF] User policy for "omartulashvili-jellyfin". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True
[2024-05-13 19:13:34.354 +00:00] [INF] StreamBuilder.BuildVideoItem( Profile="AndroidTV-ExoPlayer", Path="/media/movies/Sluzhanka/Служанка (2016).mkv", AudioStreamIndex=null, SubtitleStreamIndex=null ) => ( PlayMethod=DirectPlay, TranscodeReason=0 ) "media:/videos/0b414135-9c01-cb58-0233-cc319d5d4acc/stream.mkv?MediaSourceId=0b4141359c01cb580233cc319d5d4acc&Static=true&VideoCodec=h264&AudioCodec=ac3&AudioStreamIndex=1&api_key=<token>&SubtitleMethod=Encode&Tag=00ff0c2192c092480c56d7d912e1bb93"
[2024-05-13 19:13:35.319 +00:00] [INF] Playback stopped reported by app "Android TV" "0.16.10" playing "Sluzhanka". Stopped at "0" ms
[2024-05-13 19:13:35.391 +00:00] [INF] User policy for "omartulashvili-jellyfin". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True
[2024-05-13 19:13:35.394 +00:00] [INF] StreamBuilder.BuildVideoItem( Profile="AndroidTV-libVLC", Path="/media/movies/Sluzhanka/Служанка (2016).mkv", AudioStreamIndex=null, SubtitleStreamIndex=null ) => ( PlayMethod=DirectPlay, TranscodeReason=0 ) "media:/videos/0b414135-9c01-cb58-0233-cc319d5d4acc/stream.mkv?MediaSourceId=0b4141359c01cb580233cc319d5d4acc&Static=true&VideoCodec=h264&AudioCodec=ac3&AudioStreamIndex=1&api_key=<token>&SubtitleMethod=Encode&Tag=00ff0c2192c092480c56d7d912e1bb93"
[2024-05-13 19:13:35.590 +00:00] [INF] User policy for "omartulashvili-jellyfin". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True
[2024-05-13 19:13:35.593 +00:00] [INF] StreamBuilder.BuildVideoItem( Profile="AndroidTV-ExoPlayer", Path="/media/movies/Sluzhanka/Служанка (2016).mkv", AudioStreamIndex=null, SubtitleStreamIndex=null ) => ( PlayMethod=DirectPlay, TranscodeReason=0 ) "media:/videos/0b414135-9c01-cb58-0233-cc319d5d4acc/stream.mkv?MediaSourceId=0b4141359c01cb580233cc319d5d4acc&Static=true&VideoCodec=h264&AudioCodec=ac3&AudioStreamIndex=1&api_key=<token>&SubtitleMethod=Encode&Tag=00ff0c2192c092480c56d7d912e1bb93"
[2024-05-13 19:13:36.734 +00:00] [INF] Playback stopped reported by app "Android TV" "0.16.10" playing "Sluzhanka". Stopped at "0" ms
[2024-05-13 19:13:36.810 +00:00] [INF] User policy for "omartulashvili-jellyfin". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True
[2024-05-13 19:13:36.813 +00:00] [INF] StreamBuilder.BuildVideoItem( Profile="AndroidTV-libVLC", Path="/media/movies/Sluzhanka/Служанка (2016).mkv", AudioStreamIndex=null, SubtitleStreamIndex=null ) => ( PlayMethod=DirectPlay, TranscodeReason=0 ) "media:/videos/0b414135-9c01-cb58-0233-cc319d5d4acc/stream.mkv?MediaSourceId=0b4141359c01cb580233cc319d5d4acc&Static=true&VideoCodec=h264&AudioCodec=ac3&AudioStreamIndex=1&api_key=<token>&SubtitleMethod=Encode&Tag=00ff0c2192c092480c56d7d912e1bb93"
[2024-05-13 19:13:36.966 +00:00] [INF] User policy for "omartulashvili-jellyfin". EnablePlaybackRemuxing: True EnableVideoPlaybackTranscoding: True EnableAudioPlaybackTranscoding: True
[2024-05-13 19:13:36.967 +00:00] [INF] StreamBuilder.BuildVideoItem( Profile="AndroidTV-ExoPlayer", Path="/media/movies/Sluzhanka/Служанка (2016).mkv", AudioStreamIndex=null, SubtitleStreamIndex=null ) => ( PlayMethod=DirectPlay, TranscodeReason=0 ) "media:/videos/0b414135-9c01-cb58-0233-cc319d5d4acc/stream.mkv?MediaSourceId=0b4141359c01cb580233cc319d5d4acc&Static=true&VideoCodec=h264&AudioCodec=ac3&AudioStreamIndex=1&api_key=<token>&SubtitleMethod=Encode&Tag=00ff0c2192c092480c56d7d912e1bb93"

hitachi TV Jellyfin.Server 10.8.13.0 Jellyfin for Android Tv 24 april 2025