search

jellyfin / jellyfin-androidtv

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

Video playback gets reset to the beginning of the video #4145

Open jparenas opened 1 week ago

jparenas commented 1 week ago

Describe the bug

  1. Either start playback for a video or scrub to a different frame while a video is playing.
  2. The video playback gets reset to the beginning of the video.

So far this only occurs for the videos of a single series, trying out other series scrubbing and resuming playback works fine. If I force a transcode for the video (by selecting the worst bitrate available) then scrubbing works again. I have seen the same issue in two different TVs (one running Android TV, one using a Google TV streaming device).

Attached as the logs are also the logs I captured with adb logcat, which might be relevant as I saw these logs come up whenever I scrubbed and hit the issue.

Logs

11-02 12:19:19.904  2904  2925 E audio_hal: [primary_usb_resume:1167] usb not start, [0,0x0], sink_devices:0x40000
11-02 12:19:21.529  2904  2925 E audio_hal: [primary_usb_pause:1132] usb not start, [0,0x0], sink_devices:0x40000
11-02 12:19:21.703  2899  7225 E ResolverController: No valid NAT64 prefix (100, <unspecified>/0)
11-02 12:19:21.725  2899  7226 E ResolverController: No valid NAT64 prefix (100, <unspecified>/0)
11-02 12:19:31.559  2904  3925 E audio_hal: [primary_usb_stop:1073] usb not start, [0,0x0]
11-02 12:19:31.561  2904  2925 E audio_hal: [primary_usb_stop:1073] usb not start, [0,0x0]
11-02 12:19:31.588  3026  3927 E MtkOmxCore: free_inst_handle dlclose(0x67539e9f), free(0xe7a33004)
11-02 12:19:31.626  2934  3604 E HISMW@dataoperator: 
11-02 12:19:31.626  2934  3604 E HISMW@dataoperator: [FACSET] read startaddr: 0x390.
11-02 12:19:31.626  2934  3604 E HISMW@dataoperator: 
11-02 12:19:31.628  2934  3604 E HISMW@videoctrl: 
11-02 12:19:31.628  2934  3604 E HISMW@videoctrl: [LBL] get low blue light type error: 0, level: 0.
11-02 12:19:31.628  2934  3604 E HISMW@videoctrl: 
11-02 12:19:31.628  2934  3604 E HISMW@videoctrl: 
11-02 12:19:31.628  2934  3604 E HISMW@videoctrl: [LBL] get low blue light type error: 0, level: 0.
11-02 12:19:31.628  2934  3604 E HISMW@videoctrl: 
11-02 12:19:31.630  2934  3604 E HISMW@video    : 
11-02 12:19:31.630  2934  3604 E HISMW@video    : [CHECK RETURN] UpdateEnhancedViewingAngleEnabler:4831  VideoCtrl input: 0, return failed: -1.
11-02 12:19:31.630  2934  3604 E HISMW@video    : 
11-02 12:19:31.636  3026  3927 E MtkOmxCore: comp_index(8), path(libMtkOmxVdec.so)
11-02 12:19:31.640  2947 31412 E libc    : Access denied finding property "vendor.mtk.grm.hwbinder.verbose.log"
11-02 12:19:31.641  2947 31412 E libc    : Access denied finding property "vendor.mtk.grm.verbose.log"
11-02 12:19:31.651  3026  3927 E MtkOmxVdec: 0xe7a33000: OMX_GoogleAndroidIndexAllocateNativeHandle: invalid port index(1)
11-02 12:19:31.651  3026  3927 E OMXNodeInstance: setParameter(0xe7a33004:MTK.DECODER.AVC, OMX.google.android.index.allocateNativeHandle(0x7f00010b): Output:1 en=0) ERROR: BadParameter(0x80001005)
11-02 12:19:31.651 26750  7244 E ACodec  : [OMX.MTK.VIDEO.DECODER.AVC] setPortMode on output to DynamicANWBuffer failed w/ err -1010
11-02 12:19:31.651  3026  4320 E OMXNodeInstance: getParameter(0xe7a33004:MTK.DECODER.AVC, ??(0x6f600011)) ERROR: UnsupportedIndex(0x8000101a)
11-02 12:19:31.651  3026  4320 E MtkOmxVdec: 0xe7a33000: OMX_GoogleAndroidIndexAllocateNativeHandle: invalid port index(1)
11-02 12:19:31.651  3026  4320 E OMXNodeInstance: setParameter(0xe7a33004:MTK.DECODER.AVC, OMX.google.android.index.allocateNativeHandle(0x7f00010b): Output:1 en=0) ERROR: BadParameter(0x80001005)
11-02 12:19:31.652  3026  4320 E OMXNodeInstance: setConfig(0xe7a33004:MTK.DECODER.AVC, ConfigPriority(0x6f800002)) ERROR: UnsupportedIndex(0x8000101a)
11-02 12:19:31.653  3026  4320 E MtkOmxVdec: bRequestingDataSpace is not supported
11-02 12:19:31.653  3026  4320 E OMXNodeInstance: getConfig(0xe7a33004:MTK.DECODER.AVC, ??(0x7f00010d)) ERROR: UnsupportedSetting(0x80001019)
11-02 12:19:31.680  2913  2913 E /vendor/bin/hw/android.hardware.graphics.allocator@2.0-service: Failed to get IAshmemDeviceService.
11-02 12:19:31.703  2913  2913 E /vendor/bin/hw/android.hardware.graphics.allocator@2.0-service: Failed to get IAshmemDeviceService.
11-02 12:19:31.725  3026  4320 E MtkOmxVdec: bRequestingDataSpace is not supported
11-02 12:19:31.725  3026  4320 E OMXNodeInstance: getConfig(0xe7a33004:MTK.DECODER.AVC, ??(0x7f00010d)) ERROR: UnsupportedSetting(0x80001019)
11-02 12:19:31.733  3026  4320 E MtkOmxVdec: bRequestingDataSpace is not supported
11-02 12:19:31.733  3026  4320 E OMXNodeInstance: getConfig(0xe7a33004:MTK.DECODER.AVC, ??(0x7f00010d)) ERROR: UnsupportedSetting(0x80001019)
11-02 12:19:31.853  2934  3604 E HISMW@dataoperator: 
11-02 12:19:31.853  2934  3604 E HISMW@dataoperator: [FACSET] read startaddr: 0x390.
11-02 12:19:31.853  2934  3604 E HISMW@dataoperator: 
11-02 12:19:31.855  2934  3604 E HISMW@videoctrl: 
11-02 12:19:31.855  2934  3604 E HISMW@videoctrl: [LBL] get low blue light type error: 0, level: 0.
11-02 12:19:31.855  2934  3604 E HISMW@videoctrl: 
11-02 12:19:31.856  2934  3604 E HISMW@videoctrl: 
11-02 12:19:31.856  2934  3604 E HISMW@videoctrl: [LBL] get low blue light type error: 0, level: 0.
11-02 12:19:31.856  2934  3604 E HISMW@videoctrl: 
11-02 12:19:31.857  2934  3604 E HISMW@video    : 
11-02 12:19:31.857  2934  3604 E HISMW@video    : [CHECK RETURN] UpdateEnhancedViewingAngleEnabler:4831  VideoCtrl input: 0, return failed: -1.
11-02 12:19:31.857  2934  3604 E HISMW@video    : 
11-02 12:19:31.911  2904  3925 E /vendor/bin/hw/android.hardware.audio@2.0-service-mediatek: Failed to get IAshmemDeviceService.
11-02 12:19:31.912  2904  3925 E /vendor/bin/hw/android.hardware.audio@2.0-service-mediatek: Failed to get IAshmemDeviceService.
11-02 12:19:31.919  2947 28071 E libc    : Access denied finding property "vendor.mtk.grm.hwbinder.verbose.log"
11-02 12:19:31.920  2947 28071 E libc    : Access denied finding property "vendor.mtk.grm.verbose.log"
11-02 12:19:31.922  2899  7256 E ResolverController: No valid NAT64 prefix (100, <unspecified>/0)
11-02 12:19:32.008  2934 21632 E HISMW@dataoperator: 
11-02 12:19:32.009  2934 21632 E HISMW@dataoperator: [FACSET] read startaddr: 0x390.
11-02 12:19:32.009  2934 21632 E HISMW@dataoperator: 
11-02 12:19:34.044  2904  2927 E audio_hal: [primary_usb_pause:1132] usb not start, [0,0x0], sink_devices:0x40000

FFmpeg logs

No response

Media info of the file

ffprobe version 6.1.1-3ubuntu5 Copyright (c) 2007-2023 the FFmpeg developers
  built with gcc 13 (Ubuntu 13.2.0-23ubuntu3)
  configuration: --prefix=/usr --extra-version=3ubuntu5 --toolchain=hardened --libdir=/usr/lib/x86_64-linux-gnu --incdir=/usr/include/x86_64-linux-gnu --arch=amd64 --enable-gpl --disable-stripping --disable-omx --enable-gnutls --enable-libaom --enable-libass --enable-libbs2b --enable-libcaca --enable-libcdio --enable-libcodec2 --enable-libdav1d --enable-libflite --enable-libfontconfig --enable-libfreetype --enable-libfribidi --enable-libglslang --enable-libgme --enable-libgsm --enable-libharfbuzz --enable-libmp3lame --enable-libmysofa --enable-libopenjpeg --enable-libopenmpt --enable-libopus --enable-librubberband --enable-libshine --enable-libsnappy --enable-libsoxr --enable-libspeex --enable-libtheora --enable-libtwolame --enable-libvidstab --enable-libvorbis --enable-libvpx --enable-libwebp --enable-libx265 --enable-libxml2 --enable-libxvid --enable-libzimg --enable-openal --enable-opencl --enable-opengl --disable-sndio --enable-libvpl --disable-libmfx --enable-libdc1394 --enable-libdrm --enable-libiec61883 --enable-chromaprint --enable-frei0r --enable-ladspa --enable-libbluray --enable-libjack --enable-libpulse --enable-librabbitmq --enable-librist --enable-libsrt --enable-libssh --enable-libsvtav1 --enable-libx264 --enable-libzmq --enable-libzvbi --enable-lv2 --enable-sdl2 --enable-libplacebo --enable-librav1e --enable-pocketsphinx --enable-librsvg --enable-libjxl --enable-shared
  libavutil      58. 29.100 / 58. 29.100
  libavcodec     60. 31.102 / 60. 31.102
  libavformat    60. 16.100 / 60. 16.100
  libavdevice    60.  3.100 / 60.  3.100
  libavfilter     9. 12.100 /  9. 12.100
  libswscale      7.  5.100 /  7.  5.100
  libswresample   4. 12.100 /  4. 12.100
  libpostproc    57.  3.100 / 57.  3.100
Input #0, matroska,webm, from [REDACTED]:
  Metadata:
    title           : [REDACTED]
    encoder         : libebml v1.4.2 + libmatroska v1.6.4
    creation_time   : 2021-11-29T17:06:30.000000Z
    IMDB            : [REDACTED]
    TMDB            : [REDACTED]
    TVDB            : [REDACTED]
  Duration: 00:56:45.24, start: 0.000000, bitrate: 8598 kb/s
  Chapters:
    Chapter #0:0: start 0.000000, end 7.007000
      Metadata:
        title           : en:Studio Logo
    Chapter #0:1: start 7.007000, end 114.614000
      Metadata:
        title           : en:Intro
    Chapter #0:2: start 114.614000, end 3327.157000
      Metadata:
        title           : en:[REDACTED]
    Chapter #0:3: start 3327.157000, end 3405.235000
      Metadata:
        title           : en:End Credits
  Stream #0:0(eng): Video: h264 (High), yuv420p(tv, bt709, progressive), 1920x1080 [SAR 1:1 DAR 16:9], 23.98 fps, 23.98 tbr, 1k tbn (default)
    Metadata:
      BPS             : 8211993
      DURATION        : 00:56:45.235000000
      NUMBER_OF_FRAMES: 81644
      NUMBER_OF_BYTES : 3495470958
      _STATISTICS_WRITING_APP: mkvmerge v62.0.0 ('Apollo') 64-bit
      _STATISTICS_WRITING_DATE_UTC: 2021-11-29 17:06:30
      _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES
  Stream #0:1(eng): Audio: ac3, 48000 Hz, 5.1(side), fltp, 384 kb/s (default)
    Metadata:
      BPS             : 384000
      DURATION        : 00:56:45.216000000
      NUMBER_OF_FRAMES: 106413
      NUMBER_OF_BYTES : 163450368
      _STATISTICS_WRITING_APP: mkvmerge v62.0.0 ('Apollo') 64-bit
      _STATISTICS_WRITING_DATE_UTC: 2021-11-29 17:06:30
      _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES
  Stream #0:2(eng): Subtitle: subrip
    Metadata:
      BPS             : 51
      DURATION        : 00:53:28.080000000
      NUMBER_OF_FRAMES: 631
      NUMBER_OF_BYTES : 20827
      _STATISTICS_WRITING_APP: mkvmerge v62.0.0 ('Apollo') 64-bit
      _STATISTICS_WRITING_DATE_UTC: 2021-11-29 17:06:30
      _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES
  Stream #0:3(eng): Subtitle: subrip (hearing impaired)
    Metadata:
      title           : SDH
      BPS             : 54
      DURATION        : 00:55:31.328000000
      NUMBER_OF_FRAMES: 707
      NUMBER_OF_BYTES : 22588
      _STATISTICS_WRITING_APP: mkvmerge v62.0.0 ('Apollo') 64-bit
      _STATISTICS_WRITING_DATE_UTC: 2021-11-29 17:06:30
      _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES
  Stream #0:4(spa): Subtitle: subrip
    Metadata:
      title           : Latin American
      BPS             : 53
      DURATION        : 00:53:40.592000000
      NUMBER_OF_FRAMES: 619
      NUMBER_OF_BYTES : 21488
      _STATISTICS_WRITING_APP: mkvmerge v62.0.0 ('Apollo') 64-bit
      _STATISTICS_WRITING_DATE_UTC: 2021-11-29 17:06:30
      _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES
  Stream #0:5(spa): Subtitle: subrip (hearing impaired)
    Metadata:
      title           : Latin American / SDH
      BPS             : 55
      DURATION        : 00:55:31.411000000
      NUMBER_OF_FRAMES: 693
      NUMBER_OF_BYTES : 23201
      _STATISTICS_WRITING_APP: mkvmerge v62.0.0 ('Apollo') 64-bit
      _STATISTICS_WRITING_DATE_UTC: 2021-11-29 17:06:30
      _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES

Application version

0.17.9-beta.1

Device information

HiSense SmartTV 4K FFM

Android version

Android TV 10

Jellyfin server version

10.10.0

GingerCoffee commented 3 days ago

I started having this today too. I can't tell when it happened but I noticed it after my playback got interrupted by a Google Assistant setup prompt for some reason and then I couldn't skip around by any means in the player. This happened with Season 5 of Community only (which is what I was watching at the time). I haven't been able to replicate it on any other show but all episodes of that season do it.

I have confirmed this also happens on the Android app which doesn't show the blue dot indicating current position for affected episodes. I have also confirmed that it works properly when transcoding is forced. It also works as expected in a web browser. My affected episodes are encoded in h265 so I had to confirm that the browser I was using wasn't just transcoding anyway due to a lack of support.

It seems that this is a bug isolated to Android. I don't have any iOS devices to test, however.