search

jellyfin / jellyfin-mpv-shim

MPV Cast Client for Jellyfin
Other
1.57k stars 93 forks source link

Some keyboard shortcuts don't work without an internet connection #257

Open iyzana opened 2 years ago

iyzana commented 2 years ago

Description

I have a jellyfin instance and jellyfin-mpv-shim running on the same computer. Most times this computer has an internet connection, but sometimes my modem crashes and I don't have an outgoing internet connection. Whenever that happens jellyfin and jellyfin-mpv-shim keep working, but - a bit strangely - most of mpvs keyboard shortcuts stop working. Not all. p, i and o still work, but f, <space> or q don't.

My wild uninformed guess would be, that the update check to github blocks a thread that is used for input processing.

To Reproduce

  1. Get into a state where jellyfin and jellyfin-mpv-shim can't reach the internet (e.g. disconnect the outgoing router cable)
  2. Start playback of a video to jellyfin-mpv-shim
  3. Try to pause using the spacebar

Expected behavior The video pauses

Desktop (please complete the following information):

Error Messages

Logs ``` 2022-04-26 18:30:34,552 [ INFO] conf: Loaded settings from json: /home/me/.config/jellyfin-mpv-shim/conf.json 2022-04-26 18:30:34,610 [ INFO] player: Using libmpv1 playback backend. 2022-04-26 18:30:34,628 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.client: JellyfinClient initializing... 2022-04-26 18:30:34,628 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.configuration: Configuration initializing... 2022-04-26 18:30:34,628 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.configuration: Begin http constructor. 2022-04-26 18:30:34,628 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.ws_client: WSClient initializing... 2022-04-26 18:30:34,628 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.connection_manager: ConnectionManager initializing... 2022-04-26 18:30:34,628 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.credentials: Credentials initializing... 2022-04-26 18:30:34,628 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.configuration: Begin app constructor. 2022-04-26 18:30:34,628 [ INFO] JELLYFIN.jellyfin_apiclient_python.connection_manager: Begin connect 2022-04-26 18:30:34,628 [ INFO] JELLYFIN.jellyfin_apiclient_python.connection_manager: Begin getAvailableServers 2022-04-26 18:30:34,628 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.credentials: credentialsupdated 2022-04-26 18:30:34,629 [ INFO] JELLYFIN.jellyfin_apiclient_python.connection_manager: connect has 1 servers 2022-04-26 18:30:34,629 [ INFO] JELLYFIN.jellyfin_apiclient_python.connection_manager: begin connectToServer 2022-04-26 18:30:34,629 [ INFO] JELLYFIN.jellyfin_apiclient_python.api: Sending get request to system/info/public 2022-04-26 18:30:34,629 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.api: 5 2022-04-26 18:30:34,629 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.api: {'Accept': 'application/json', 'Content-type': 'application/x-www-form-urlencoded; charset=UTF-8', 'X-Application': 'Jellyfin MPV Shim/2.0.1', 'Accept-Charset': 'UTF-8,*', 'Accept-encoding': 'gzip', 'User-Agent': 'Jellyfin-MPV-Shim/2.0.1', 'x-emby-authorization': 'MediaBrowser Client=Jellyfin MPV Shim, Device=pc, DeviceId=bef57e4f-8252-4309-97da-e18fea9a6526, Version=2.0.1'} 2022-04-26 18:30:34,631 [ DEBUG] urllib3.connectionpool: Starting new HTTPS connection (1): jellyfin.local:8920 Process STrayProcess-1: Traceback (most recent call last): File "/usr/lib/python3.10/multiprocessing/process.py", line 315, in _bootstrap self.run() File "/home/me/.local/lib/python3.10/site-packages/jellyfin_mpv_shim/gui_mgr.py", line 439, in run from pystray import Icon, MenuItem, Menu ModuleNotFoundError: No module named 'pystray' 2022-04-26 18:30:34,653 [ DEBUG] urllib3.connectionpool: https://jellyfin.local:8920 "GET /system/info/public HTTP/1.1" 200 None 2022-04-26 18:30:34,654 [ INFO] JELLYFIN.jellyfin_apiclient_python.connection_manager: calling onSuccessfulConnection with server pc 2022-04-26 18:30:34,654 [ INFO] JELLYFIN.jellyfin_apiclient_python.api: Sending get request to system/info 2022-04-26 18:30:34,654 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.api: 5 2022-04-26 18:30:34,654 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.api: {'Accept': 'application/json', 'Content-type': 'application/x-www-form-urlencoded; charset=UTF-8', 'X-Application': 'Jellyfin MPV Shim/2.0.1', 'Accept-Charset': 'UTF-8,*', 'Accept-encoding': 'gzip', 'User-Agent': 'Jellyfin-MPV-Shim/2.0.1', 'x-emby-authorization': 'MediaBrowser Client=Jellyfin MPV Shim, Device=pc, DeviceId=bef57e4f-8252-4309-97da-e18fea9a6526, Version=2.0.1', 'X-MediaBrowser-Token': 'REDACTED'} 2022-04-26 18:30:34,655 [ DEBUG] urllib3.connectionpool: Starting new HTTPS connection (1): jellyfin.local:8920 2022-04-26 18:30:34,666 [ DEBUG] urllib3.connectionpool: https://jellyfin.local:8920 "GET /system/info HTTP/1.1" 200 None 2022-04-26 18:30:34,668 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.credentials: credentialsupdated 2022-04-26 18:30:34,668 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.connection_manager: resolving connect with result: {'Servers': "[{'address': 'https://jellyfin.local:8920', 'Name': 'pc', 'Id': '2cff12abeaca4db1929a0228ddb62091', 'DateLastAccessed': '2022-04-26T18:30:34Z', 'UserId': '5f40482ebff24b08ac64ff15d688adb6', 'AccessToken': 'REDACTED', 'Users': [{'Id': '5f40482ebff24b08ac64ff15d688adb6', 'IsSignedInOffline': True}], 'uuid': '049cef0d-3009-416a-b77b-950ce6bb8187', 'username': 'me', 'connected': True}]", 'State': 3} 2022-04-26 18:30:34,668 [ INFO] JELLYFIN.jellyfin_apiclient_python.client: User is authenticated. 2022-04-26 18:30:34,669 [ DEBUG] urllib3.util.retry: Converted retries value: 3 -> 'Retry(total=3, connect=None, read=None, redirect=None, status=None)' 2022-04-26 18:30:34,669 [ DEBUG] urllib3.util.retry: Converted retries value: 3 -> 'Retry(total=3, connect=None, read=None, redirect=None, status=None)' 2022-04-26 18:30:34,669 [ INFO] JELLYFIN.jellyfin_apiclient_python.ws_client: Websocket url: wss://jellyfin.local:8920/socket?api_key=REDACTED&device_id=bef57e4f-8252-4309-97da-e18fea9a6526 2022-04-26 18:30:34,670 [ DEBUG] urllib3.connectionpool: Starting new HTTPS connection (1): jellyfin.local:8920 2022-04-26 18:30:34,682 [ INFO] JELLYFIN.jellyfin_apiclient_python.ws_client: --->[ websocket ] 2022-04-26 18:30:34,682 [ DEBUG] event_handler: Unhandled Event WebSocketConnect: None 2022-04-26 18:30:34,855 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.ws_client: ForceKeepAlive received from server. 2022-04-26 18:30:34,855 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.ws_client: KeepAlive received from server. 2022-04-26 18:30:35,096 [ DEBUG] urllib3.connectionpool: https://jellyfin.local:8920 "POST /Sessions/Capabilities/Full HTTP/1.1" 204 0 2022-04-26 18:30:39,460 [ DEBUG] event_handler: Handled Event Play: {'ItemIds': ['a2e297420da6222e06c6b4b7a07c3fb9', '761ae45851dc13c2ccc8473618051518', '96e7f2fb52cc7e684b0fa0b720b04c8e', '4ff024759405514299ace194987d3781', 'c6e6872c95a6c7e6a9ec6c28828b5c4b', '792ed72354504280dbdacbd324f8dc1f', '17c8a2ddb966485b3d13940780ca7b38', '079fefe194a9372a008ce032a6d01b1a', 'd6bb9b8bf4f4aad5b949a54f6bf6243a', 'fd70f3f3e0634095afc079f424aa6a97', '0a973f19bb914027556010df4ff33691', '8716d8bdf4a0eac1153e2e50c363ac1d'], 'PlayCommand': 'PlayNow', 'ControllingUserId': '5f40482ebff24b08ac64ff15d688adb6', 'ServerId': '2cff12abeaca4db1929a0228ddb62091'} 2022-04-26 18:30:39,471 [ DEBUG] urllib3.connectionpool: https://jellyfin.local:8920 "GET /Users/5f40482ebff24b08ac64ff15d688adb6/Items/a2e297420da6222e06c6b4b7a07c3fb9 HTTP/1.1" 200 None 2022-04-26 18:30:39,475 [ DEBUG] event_handler: EventHandler::playMedia 2022-04-26 18:30:39,475 [ DEBUG] media: Bandwidth: local=True, bitrate=None, force=False 2022-04-26 18:30:39,488 [ DEBUG] urllib3.connectionpool: https://jellyfin.local:8920 "POST /Items/a2e297420da6222e06c6b4b7a07c3fb9/PlaybackInfo HTTP/1.1" 200 None 2022-04-26 18:30:39,490 [ DEBUG] media: Using direct url. 2022-04-26 18:30:39,555 [ INFO] mpv: cplayer: (+) Video --vid=1 (*) (h264 1920x1080 23.976fps) 2022-04-26 18:30:39,555 [ INFO] mpv: cplayer: (+) Audio --aid=1 --alang=jpn (*) (aac 2ch 44100Hz) 2022-04-26 18:30:39,555 [ INFO] mpv: cplayer: (+) Subs --sid=1 --slang=eng (*) (ass) 2022-04-26 18:30:39,614 [ DEBUG] player: Finished waiting for media duration. 2022-04-26 18:30:39,659 [ INFO] mpv: cplayer: AO: [pulse] 44100Hz stereo 2ch float 2022-04-26 18:30:39,660 [ INFO] mpv: cplayer: VO: [gpu] 1920x1080 yuv420p 2022-04-26 18:30:39,682 [ DEBUG] player: PlayerManager::play selecting audio stream index=1 2022-04-26 18:30:39,682 [ INFO] mpv: cplayer: Track switched: 2022-04-26 18:30:39,682 [ DEBUG] player: PlayerManager::play selecting subtitle stream index=2 2022-04-26 18:30:39,683 [ INFO] mpv: cplayer: (+) Video --vid=1 (*) (h264 1920x1080 23.976fps) 2022-04-26 18:30:39,683 [ INFO] mpv: cplayer: (+) Audio --aid=1 --alang=jpn (*) (aac 2ch 44100Hz) 2022-04-26 18:30:39,683 [ INFO] mpv: cplayer: (+) Subs --sid=1 --slang=eng (*) (ass) 2022-04-26 18:30:39,683 [ INFO] mpv: cplayer: Track switched: 2022-04-26 18:30:39,683 [ INFO] mpv: cplayer: (+) Video --vid=1 (*) (h264 1920x1080 23.976fps) 2022-04-26 18:30:39,683 [ INFO] mpv: cplayer: (+) Audio --aid=1 --alang=jpn (*) (aac 2ch 44100Hz) 2022-04-26 18:30:39,686 [ INFO] mpv: cplayer: (+) Subs --sid=1 --slang=eng (*) (ass) 2022-04-26 18:30:41,258 [ DEBUG] urllib3.connectionpool: https://jellyfin.local:8920 "POST /Sessions/Playing HTTP/1.1" 204 0 2022-04-26 18:30:41,260 [ INFO] update_check: Checking for updates... 2022-04-26 18:30:41,266 [ DEBUG] urllib3.connectionpool: Starting new HTTPS connection (1): github.com:443 2022-04-26 18:30:47,460 [ DEBUG] urllib3.connectionpool: https://jellyfin.local:8920 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0 < I'm pressing keyboard shortcuts here > 2022-04-26 18:30:53,713 [ DEBUG] urllib3.connectionpool: https://jellyfin.local:8920 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0 2022-04-26 18:30:59,956 [ DEBUG] urllib3.connectionpool: https://jellyfin.local:8920 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0 2022-04-26 18:31:06,191 [ DEBUG] urllib3.connectionpool: https://jellyfin.local:8920 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0 2022-04-26 18:31:12,929 [ DEBUG] urllib3.connectionpool: https://jellyfin.local:8920 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0 2022-04-26 18:31:19,056 [ DEBUG] urllib3.connectionpool: https://jellyfin.local:8920 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0 2022-04-26 18:31:25,316 [ DEBUG] urllib3.connectionpool: https://jellyfin.local:8920 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0 2022-04-26 18:31:31,536 [ DEBUG] urllib3.connectionpool: https://jellyfin.local:8920 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0 2022-04-26 18:31:37,998 [ DEBUG] urllib3.connectionpool: https://jellyfin.local:8920 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0 2022-04-26 18:31:44,267 [ DEBUG] urllib3.connectionpool: https://jellyfin.local:8920 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0 2022-04-26 18:31:50,411 [ DEBUG] urllib3.connectionpool: https://jellyfin.local:8920 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0 ^C 2022-04-26 18:31:51,333 [ INFO] root: Stopping services... 2022-04-26 18:31:56,655 [ DEBUG] urllib3.connectionpool: https://jellyfin.local:8920 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0 < jellyfin-mpv-shim refuses to stop after the first Ctrl-C > 2022-04-26 18:32:02,883 [ DEBUG] urllib3.connectionpool: https://jellyfin.local:8920 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0 2022-04-26 18:32:09,152 [ DEBUG] urllib3.connectionpool: https://jellyfin.local:8920 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0 2022-04-26 18:32:15,772 [ DEBUG] urllib3.connectionpool: https://jellyfin.local:8920 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0 2022-04-26 18:32:21,341 [ DEBUG] urllib3.connectionpool: https://jellyfin.local:8920 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0 ^C ```
iwalton3 commented 2 years ago

Have you tried disabling the update check in the config file?

iyzana commented 2 years ago

I just disabled it and can confirm that its the update check that causes the bug. I also noticed that the keyboard shortcuts start working again after the request to github.com times out after two minutes.

iwalton3 commented 2 years ago

times out after two minutes

So this is supposed to time out after 3 seconds, but I realized it was making three requests. The new push to master should only make one.

iwalton3 commented 2 years ago

This should be fixed once I post a new release. Please re-open after upgrading and re-testing if it is still present.

iyzana commented 2 years ago

I assume version 2.1.0 is the new release you mentioned. If so this problem still persists, although the timeout seems to be 15 seconds now. My issue is not about the duration of the timeout though, but that the keyboard shortcuts do not work in that time.

I can't reopen the ticket myself.

Updated logs ``` 2022-06-18 12:44:35,706 [ INFO] conf: Loaded settings from json: /home/me/.config/jellyfin-mpv-shim/conf.json 2022-06-18 12:44:35,761 [ INFO] player: Using libmpv1 playback backend. 2022-06-18 12:44:35,778 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.client: JellyfinClient initializing... 2022-06-18 12:44:35,778 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.configuration: Configuration initializing... 2022-06-18 12:44:35,778 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.configuration: Begin http constructor. 2022-06-18 12:44:35,778 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.ws_client: WSClient initializing... 2022-06-18 12:44:35,778 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.connection_manager: ConnectionManager initializing... 2022-06-18 12:44:35,778 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.credentials: Credentials initializing... 2022-06-18 12:44:35,778 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.configuration: Begin app constructor. 2022-06-18 12:44:35,778 [ INFO] JELLYFIN.jellyfin_apiclient_python.connection_manager: Begin connect 2022-06-18 12:44:35,778 [ INFO] JELLYFIN.jellyfin_apiclient_python.connection_manager: Begin getAvailableServers 2022-06-18 12:44:35,778 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.credentials: credentialsupdated 2022-06-18 12:44:35,778 [ INFO] JELLYFIN.jellyfin_apiclient_python.connection_manager: connect has 1 servers 2022-06-18 12:44:35,779 [ INFO] JELLYFIN.jellyfin_apiclient_python.connection_manager: begin connectToServer 2022-06-18 12:44:35,779 [ INFO] JELLYFIN.jellyfin_apiclient_python.api: Sending get request to system/info/public 2022-06-18 12:44:35,779 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.api: 5 2022-06-18 12:44:35,779 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.api: {'Accept': 'application/json', 'Content-type': 'application/x-www-form-urlencoded; charset=UTF-8', 'X-Application': 'Jellyfin MPV Shim/2.1.0', 'Accept-Charset': 'UTF-8,*', 'Accept-encoding': 'gzip', 'User-Agent': 'Jellyfin-MPV-Shim/2.1.0', 'x-emby-authorization': 'MediaBrowser Client=Jellyfin MPV Shim, Device=pc, DeviceId=bef57e4f-8252-4309-97da-e18fea9a6526, Version=2.1.0'} 2022-06-18 12:44:35,781 [ DEBUG] urllib3.connectionpool: Starting new HTTPS connection (1): jellyfin.me.lan:8920 Process STrayProcess-1: Traceback (most recent call last): File "/usr/lib/python3.10/multiprocessing/process.py", line 315, in _bootstrap self.run() File "/home/me/.local/lib/python3.10/site-packages/jellyfin_mpv_shim/gui_mgr.py", line 439, in run from pystray import Icon, MenuItem, Menu ModuleNotFoundError: No module named 'pystray' 2022-06-18 12:44:35,817 [ DEBUG] urllib3.connectionpool: https://jellyfin.me.lan:8920 "GET /system/info/public HTTP/1.1" 200 None 2022-06-18 12:44:35,818 [ INFO] JELLYFIN.jellyfin_apiclient_python.connection_manager: calling onSuccessfulConnection with server pc 2022-06-18 12:44:35,818 [ INFO] JELLYFIN.jellyfin_apiclient_python.api: Sending get request to system/info 2022-06-18 12:44:35,818 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.api: 5 2022-06-18 12:44:35,818 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.api: {'Accept': 'application/json', 'Content-type': 'application/x-www-form-urlencoded; charset=UTF-8', 'X-Application': 'Jellyfin MPV Shim/2.1.0', 'Accept-Charset': 'UTF-8,*', 'Accept-encoding': 'gzip', 'User-Agent': 'Jellyfin-MPV-Shim/2.1.0', 'x-emby-authorization': 'MediaBrowser Client=Jellyfin MPV Shim, Device=pc, DeviceId=bef57e4f-8252-4309-97da-e18fea9a6526, Version=2.1.0', 'X-MediaBrowser-Token': 'REDACTED'} 2022-06-18 12:44:35,819 [ DEBUG] urllib3.connectionpool: Starting new HTTPS connection (1): jellyfin.me.lan:8920 2022-06-18 12:44:35,951 [ DEBUG] urllib3.connectionpool: https://jellyfin.me.lan:8920 "GET /system/info HTTP/1.1" 200 None 2022-06-18 12:44:35,961 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.credentials: credentialsupdated 2022-06-18 12:44:35,961 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.connection_manager: resolving connect with result: {'Servers': "[{'address': 'https://jellyfin.me.lan:8920', 'Name': 'pc', 'Id': '2cff12abeaca4db1929a0228ddb62091', 'DateLastAccessed': '2022-06-18T12:44:35Z', 'UserId': '5f40482ebff24b08ac64ff15d688adb6', 'AccessToken': 'REDACTED', 'Users': [{'Id': '5f40482ebff24b08ac64ff15d688adb6', 'IsSignedInOffline': True}], 'uuid': '32ce4c90-879d-437e-8c1a-962d5d70ef14', 'username': 'me', 'connected': True}]", 'State': 3} 2022-06-18 12:44:35,961 [ INFO] JELLYFIN.jellyfin_apiclient_python.client: User is authenticated. 2022-06-18 12:44:35,962 [ DEBUG] urllib3.util.retry: Converted retries value: 3 -> 'Retry(total=3, connect=None, read=None, redirect=None, status=None)' 2022-06-18 12:44:35,962 [ DEBUG] urllib3.util.retry: Converted retries value: 3 -> 'Retry(total=3, connect=None, read=None, redirect=None, status=None)' 2022-06-18 12:44:35,963 [ INFO] JELLYFIN.jellyfin_apiclient_python.ws_client: Websocket url: wss://jellyfin.me.lan:8920/socket?api_key=REDACTED&device_id=bef57e4f-8252-4309-97da-e18fea9a6526 2022-06-18 12:44:35,968 [ DEBUG] urllib3.connectionpool: Starting new HTTPS connection (1): jellyfin.me.lan:8920 2022-06-18 12:44:36,013 [ INFO] JELLYFIN.jellyfin_apiclient_python.ws_client: --->[ websocket ] 2022-06-18 12:44:36,013 [ DEBUG] event_handler: Unhandled Event WebSocketConnect: None 2022-06-18 12:44:36,114 [ DEBUG] urllib3.connectionpool: https://jellyfin.me.lan:8920 "POST /Sessions/Capabilities/Full HTTP/1.1" 204 0 2022-06-18 12:44:36,220 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.ws_client: ForceKeepAlive received from server. 2022-06-18 12:44:36,221 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.ws_client: KeepAlive received from server. 2022-06-18 12:44:40,683 [ DEBUG] event_handler: Handled Event Play: {'ItemIds': ['4bb6b12f5e9252fa7cdbb39a5374a6c9', 'd419cfd6ada748f2607ab8806fbdacdc', 'cc43709b60aeadaddec59277a2526830', 'd1448f620ed5ea91e620f89f4434558b', '63086ef209eca99510cc36bb0c8c0b49', '274d24d289a7f6005936d00a6e78dced', 'a4b874c942952ec3c569d0b1002fa35f', '5fe2781ef6b2fc2e45cc81750c5b8199', '7d3d4099fcdb5f103384fe12b6ee8ad7', '29685c7cbe6be94d6be49d8065d7ac4c', 'de83bf71201e786df02e9c21a0a39c8c', '5aac22512eda3007e16971670f943ae8', '7e163ba5ae28df8529b80dde680b8c25', 'd6575d2c566bfb14aa36523ae5e63cb3', '510f9987cd1afe43a9402edd886eda93', '2f7bed850be1b2bcf37dd51aef06b6b6', '185edd06fc8f528a529b0457fbe8c3e5', 'e4474febba0033c6d66e224628c19651', '12d559f5c8527bd331a710e6c51b5709', '3ce374706491b7d47737711b658f212f', '0faf1db5224b88489a27c0e1f3d087c1', '4c4904ece13972093067d6936d4af1f8', '03a9f2fe6ff7bed0b79d841c666bff53', '7b72af7225cd1986b44247c4ec76a32a', 'a201b22851993c21e0d02319cae8b0a1', 'f72383ed2e40cd3d05cf677bec5d9dde', '744bf454f797d58b5fe611705d7fd53c', 'ece05fc6155d3df75542de02c85d74f3', '3ec8ef356d56bfe0118cc4f8f8863a12', 'dd11c931316fc94b70aec25bd0bdd8c6', 'bf4226608ddf8f65dce3f7901af0dcdd', '1ca75d92fa0ed86e5f1cc164bcccd026', 'f2b26a1e3fd64e7da2230a874d0a6c4c', 'b352d1346049b84cbc01c138614cbb0c', 'bd1612140939e3909bd46aa8192627cc', 'd864dc67bbec3760121968cd9b571a39', 'a831b3b76753654d1361bbd33ea03879', '134516195e431190e5a490a6d36d0afc', 'f02e2b0321b44eef491be67d8ab22e79', 'af79f6a3f9b3aeb9e48318a559a29e03', 'c1883f3e5707117b2faca3fe571d7d86', 'dd4f869726a1ca3d20590bf40de02045', 'e74db0e47443d23e8a967be5d595239a', '6968800e2387d7b90790d0db9b84238c', '2a7475eb00e46ef54f69eb7fa8140cf5', '6de169a057f2f3fddf651ddfdedd55cb', 'c2fae94f47ed7c53301ba4b5979539f1', '9c2ccf16e2d8abde58da26afd69a127f', 'b9c31959307194f6706a3ca329849778', '984c0b1ce2e613ca95329c23f6fe1b83', '01bb330bf04871b6b276d13fde8fce3e', '4a109b9815affe1c401fded5a243fcd0', '6873ccac13b71d9517c25e91e812c803', '5ac77b46b4ef1197b02bc4aa22f34d47', '6de7bb4f1dd55d70fcfc3cef64d3f5a8', 'ba8846f7c3f0a57e290b4920263b424a', 'adc564dc2545145e8c7a10477fd64a6d', '42888e3ad5bfb21d7a0137d93cb2b53b', '3b701c69d2dde12269761266ffc87a4c', '493f1f564e956fbf4418fc38cbd3be06', '323100cb1d171ac737de833e90071faf', '27b62839eb56eec79715f8dc96e2c456', 'db1540c4968a9a9efcf79cc39114f615', 'aec4ed18190a76cd52b5695b20d74ee2', 'fd1716711cd0faa8a2cce6bdca423ef0', '6e6d82befa12118c5745ad3108a396db', '89ad12136d91241344148a3c1c721ab5', 'a8868c4534c448a5e37f599e8b1d8d63', '24048188f7c427f8061f1ae8f9573fbc', '0b1fa0477692d37cc13a07056d31c657', '5655388fef5ae2c64c1f08ef0be255ff', '695934347a6fad8523aadf2ccf3bcee7', '32e928f228e44e1c92351edb73a54a15', 'acb372664f9fda9ca22a9487164193fc', '0e207c5fcc480a63e1465e2b0f036c23', '145217b93541ad58a888cf34199c4942', 'cf7f7a9ce45ea0abd94d55193b9a7c73', 'f8245fd042b575daa2d01fc8ea52dc5f', '6b9f41cd96d88f56ebe9c3580fa45974', 'c5f8c3ab5e2d1eabcfa009d7b25037b1', '5814eec534be18604d1156830a454bb7', 'b145a3d20cb5de7dd8473b8f02184784'], 'PlayCommand': 'PlayNow', 'ControllingUserId': '5f40482ebff24b08ac64ff15d688adb6', 'ServerId': '2cff12abeaca4db1929a0228ddb62091'} 2022-06-18 12:44:40,688 [ DEBUG] urllib3.connectionpool: https://jellyfin.me.lan:8920 "GET /Users/5f40482ebff24b08ac64ff15d688adb6/Items/4bb6b12f5e9252fa7cdbb39a5374a6c9 HTTP/1.1" 200 None 2022-06-18 12:44:40,694 [ DEBUG] event_handler: EventHandler::playMedia 2022-06-18 12:44:40,694 [ DEBUG] media: Bandwidth: local=True, bitrate=None, force=False 2022-06-18 12:44:40,703 [ DEBUG] urllib3.connectionpool: https://jellyfin.me.lan:8920 "POST /Items/4bb6b12f5e9252fa7cdbb39a5374a6c9/PlaybackInfo HTTP/1.1" 200 None 2022-06-18 12:44:40,704 [ DEBUG] media: Using direct url. 2022-06-18 12:44:40,774 [ INFO] mpv: cplayer: (+) Video --vid=1 (mpeg2video 720x576 25.000fps) 2022-06-18 12:44:40,774 [ INFO] mpv: cplayer: (+) Audio --aid=1 --alang=eng (*) 'Surround 5.1' (ac3 6ch 48000Hz) 2022-06-18 12:44:40,774 [ INFO] mpv: cplayer: Audio --aid=2 --alang=ger 'Surround 5.1' (ac3 6ch 48000Hz) 2022-06-18 12:44:40,774 [ INFO] mpv: cplayer: Audio --aid=3 --alang=spa 'Surround 5.1' (ac3 6ch 48000Hz) 2022-06-18 12:44:40,774 [ INFO] mpv: cplayer: Audio --aid=4 --alang=eng 'Stereo' (ac3 2ch 48000Hz) 2022-06-18 12:44:40,774 [ INFO] mpv: cplayer: (+) Subs --sid=1 --slang=eng (*) (dvd_subtitle) 2022-06-18 12:44:40,774 [ INFO] mpv: cplayer: Subs --sid=2 --slang=ger (dvd_subtitle) 2022-06-18 12:44:40,774 [ INFO] mpv: cplayer: Subs --sid=3 --slang=fin (dvd_subtitle) 2022-06-18 12:44:40,829 [ DEBUG] player: Finished waiting for media duration. 2022-06-18 12:44:40,845 [ INFO] mpv: cplayer: AO: [pulse] 48000Hz 5.1(side) 6ch float 2022-06-18 12:44:40,847 [ INFO] mpv: cplayer: VO: [gpu] 720x576 => 1024x576 yuv420p 2022-06-18 12:44:40,870 [ DEBUG] player: PlayerManager::play selecting audio stream index=1 2022-06-18 12:44:40,871 [ DEBUG] player: PlayerManager::play selecting subtitle stream index=5 2022-06-18 12:44:40,871 [ INFO] mpv: cplayer: Track switched: 2022-06-18 12:44:40,872 [ INFO] mpv: cplayer: (+) Video --vid=1 (mpeg2video 720x576 25.000fps) 2022-06-18 12:44:40,872 [ INFO] mpv: cplayer: (+) Audio --aid=1 --alang=eng (*) 'Surround 5.1' (ac3 6ch 48000Hz) 2022-06-18 12:44:40,872 [ INFO] mpv: cplayer: Audio --aid=2 --alang=ger 'Surround 5.1' (ac3 6ch 48000Hz) 2022-06-18 12:44:40,872 [ INFO] mpv: cplayer: Audio --aid=3 --alang=spa 'Surround 5.1' (ac3 6ch 48000Hz) 2022-06-18 12:44:40,874 [ INFO] mpv: cplayer: Audio --aid=4 --alang=eng 'Stereo' (ac3 2ch 48000Hz) 2022-06-18 12:44:40,874 [ INFO] mpv: cplayer: (+) Subs --sid=1 --slang=eng (*) (dvd_subtitle) 2022-06-18 12:44:40,874 [ INFO] mpv: cplayer: Subs --sid=2 --slang=ger (dvd_subtitle) 2022-06-18 12:44:40,874 [ INFO] mpv: cplayer: Subs --sid=3 --slang=fin (dvd_subtitle) 2022-06-18 12:44:40,874 [ INFO] mpv: cplayer: Track switched: 2022-06-18 12:44:40,875 [ INFO] mpv: cplayer: (+) Video --vid=1 (mpeg2video 720x576 25.000fps) 2022-06-18 12:44:40,875 [ INFO] mpv: cplayer: (+) Audio --aid=1 --alang=eng (*) 'Surround 5.1' (ac3 6ch 48000Hz) 2022-06-18 12:44:40,875 [ INFO] mpv: cplayer: Audio --aid=2 --alang=ger 'Surround 5.1' (ac3 6ch 48000Hz) 2022-06-18 12:44:40,875 [ INFO] mpv: cplayer: Audio --aid=3 --alang=spa 'Surround 5.1' (ac3 6ch 48000Hz) 2022-06-18 12:44:40,875 [ INFO] mpv: cplayer: Audio --aid=4 --alang=eng 'Stereo' (ac3 2ch 48000Hz) 2022-06-18 12:44:40,875 [ INFO] mpv: cplayer: (+) Subs --sid=1 --slang=eng (*) (dvd_subtitle) 2022-06-18 12:44:40,876 [ INFO] mpv: cplayer: Subs --sid=2 --slang=ger (dvd_subtitle) 2022-06-18 12:44:40,877 [ INFO] mpv: cplayer: Subs --sid=3 --slang=fin (dvd_subtitle) 2022-06-18 12:44:42,271 [ DEBUG] urllib3.connectionpool: https://jellyfin.me.lan:8920 "POST /Sessions/Playing HTTP/1.1" 204 0 2022-06-18 12:44:42,271 [ INFO] update_check: Checking for updates... 2022-06-18 12:44:42,272 [ DEBUG] urllib3.connectionpool: Starting new HTTPS connection (1): github.com:443 2022-06-18 12:44:43,721 [ DEBUG] urllib3.connectionpool: https://jellyfin.me.lan:8920 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0 2022-06-18 12:44:50,441 [ DEBUG] urllib3.connectionpool: https://jellyfin.me.lan:8920 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0 2022-06-18 12:44:56,878 [ DEBUG] urllib3.connectionpool: https://jellyfin.me.lan:8920 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0 2022-06-18 12:44:57,392 [ ERROR] update_check: Could not check for updates. Traceback (most recent call last): File "/usr/lib/python3.10/site-packages/urllib3/connection.py", line 174, in _new_conn conn = connection.create_connection( File "/usr/lib/python3.10/site-packages/urllib3/util/connection.py", line 72, in create_connection for res in socket.getaddrinfo(host, port, family, socket.SOCK_STREAM): File "/usr/lib/python3.10/socket.py", line 955, in getaddrinfo for res in _socket.getaddrinfo(host, port, family, type, proto, flags): socket.gaierror: [Errno -2] Name or service not known During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/usr/lib/python3.10/site-packages/urllib3/connectionpool.py", line 703, in urlopen httplib_response = self._make_request( File "/usr/lib/python3.10/site-packages/urllib3/connectionpool.py", line 386, in _make_request self._validate_conn(conn) File "/usr/lib/python3.10/site-packages/urllib3/connectionpool.py", line 1040, in _validate_conn conn.connect() File "/usr/lib/python3.10/site-packages/urllib3/connection.py", line 358, in connect self.sock = conn = self._new_conn() File "/usr/lib/python3.10/site-packages/urllib3/connection.py", line 186, in _new_conn raise NewConnectionError( urllib3.exceptions.NewConnectionError: : Failed to establish a new connection: [Errno -2] Name or service not known During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/usr/lib/python3.10/site-packages/requests/adapters.py", line 440, in send resp = conn.urlopen( File "/usr/lib/python3.10/site-packages/urllib3/connectionpool.py", line 785, in urlopen retries = retries.increment( File "/usr/lib/python3.10/site-packages/urllib3/util/retry.py", line 592, in increment raise MaxRetryError(_pool, url, error or ResponseError(cause)) urllib3.exceptions.MaxRetryError: HTTPSConnectionPool(host='github.com', port=443): Max retries exceeded with url: /jellyfin/jellyfin-mpv-shim/releases/latest (Caused by NewConnectionError(': Failed to establish a new connection: [Errno -2] Name or service not known')) During handling of the above exception, another exception occurred: Traceback (most recent call last): File "/home/me/.local/lib/python3.10/site-packages/jellyfin_mpv_shim/update_check.py", line 35, in _check_updates response = requests.get( File "/usr/lib/python3.10/site-packages/requests/api.py", line 75, in get return request('get', url, params=params, **kwargs) File "/usr/lib/python3.10/site-packages/requests/api.py", line 61, in request return session.request(method=method, url=url, **kwargs) File "/usr/lib/python3.10/site-packages/requests/sessions.py", line 529, in request resp = self.send(prep, **send_kwargs) File "/usr/lib/python3.10/site-packages/requests/sessions.py", line 645, in send r = adapter.send(request, **kwargs) File "/usr/lib/python3.10/site-packages/requests/adapters.py", line 519, in send raise ConnectionError(e, request=request) requests.exceptions.ConnectionError: HTTPSConnectionPool(host='github.com', port=443): Max retries exceeded with url: /jellyfin/jellyfin-mpv-shim/releases/latest (Caused by NewConnectionError(': Failed to establish a new connection: [Errno -2] Name or service not known')) 2022-06-18 12:44:58,739 [ DEBUG] urllib3.connectionpool: https://jellyfin.me.lan:8920 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0 2022-06-18 12:44:58,740 [ DEBUG] event_handler: Unhandled Event UserDataChanged: {'UserId': '5f40482ebff24b08ac64ff15d688adb6', 'UserDataList': [{'PlaybackPositionTicks': 0, 'PlayCount': 4, 'IsFavorite': False, 'LastPlayedDate': '2022-06-18T10:44:41.040148Z', 'Played': False, 'Key': '72449006021', 'ItemId': '4bb6b12f5e9252fa7cdbb39a5374a6c9'}, {'UnplayedItemCount': 2, 'PlaybackPositionTicks': 0, 'PlayCount': 0, 'IsFavorite': False, 'Played': False, 'Key': '72449006', 'ItemId': '1429692f8b5fb658207ad9640c047a43'}], 'ServerId': '2cff12abeaca4db1929a0228ddb62091'} 2022-06-18 12:45:00,829 [ DEBUG] player: PlayerManager::stop stopping playback of 2022-06-18 12:45:02,048 [ DEBUG] urllib3.connectionpool: https://jellyfin.me.lan:8920 "POST /Sessions/Playing/Stopped HTTP/1.1" 204 0 2022-06-18 12:45:02,049 [ INFO] mpv: cplayer: 2022-06-18 12:45:02,480 [ DEBUG] event_handler: Unhandled Event UserDataChanged: {'UserId': '5f40482ebff24b08ac64ff15d688adb6', 'UserDataList': [{'PlaybackPositionTicks': 0, 'PlayCount': 4, 'IsFavorite': False, 'LastPlayedDate': '2022-06-18T10:44:41.040148Z', 'Played': False, 'Key': '72449006021', 'ItemId': '4bb6b12f5e9252fa7cdbb39a5374a6c9'}, {'UnplayedItemCount': 2, 'PlaybackPositionTicks': 0, 'PlayCount': 0, 'IsFavorite': False, 'Played': False, 'Key': '72449006', 'ItemId': '1429692f8b5fb658207ad9640c047a43'}], 'ServerId': '2cff12abeaca4db1929a0228ddb62091'} 2022-06-18 12:45:06,222 [ DEBUG] JELLYFIN.jellyfin_apiclient_python.ws_client: KeepAlive received from server. ^C 2022-06-18 12:45:22,365 [ INFO] root: Stopping services... --<[ session/140061102449392 ] 2022-06-18 12:45:27,546 [ INFO] Jellyfin.jellyfin_apiclient_python.http: --<[ session/140061102449392 ] 2022-06-18 12:45:27,548 [ INFO] JELLYFIN.jellyfin_apiclient_python.ws_client: ---<[ websocket ] ```
iyzana commented 2 years ago

Just tested version 2.2.0 as well, the bug is still there and the timeout seems to be 2 minutes again.