2020-02-20 17:41:25,135 [    INFO] Loaded settings from json: /home/user/.config/jellyfin-mpv-shim/conf.json
2020-02-20 17:41:25,136 [ WARNING] Cannot load GUI. Falling back to command line interface.
Traceback (most recent call last):
  File "/usr/lib/python3.8/site-packages/jellyfin_mpv_shim/mpv_shim.py", line 28, in main
    from .gui_mgr import userInterface
  File "/usr/lib/python3.8/site-packages/jellyfin_mpv_shim/gui_mgr.py", line 1, in <module>
    from pystray import Icon, MenuItem, Menu
ModuleNotFoundError: No module named 'pystray'
2020-02-20 17:41:25,242 [   DEBUG] JellyfinClient initializing...
2020-02-20 17:41:25,242 [   DEBUG] Configuration initializing...
2020-02-20 17:41:25,242 [   DEBUG] Begin http constructor.
2020-02-20 17:41:25,242 [   DEBUG] WSClient initializing...
2020-02-20 17:41:25,242 [   DEBUG] ConnectionManager initializing...
2020-02-20 17:41:25,242 [   DEBUG] Credentials initializing...
2020-02-20 17:41:25,242 [   DEBUG] Begin app constructor.
2020-02-20 17:41:25,242 [    INFO] Begin connect
2020-02-20 17:41:25,242 [    INFO] Begin getAvailableServers
2020-02-20 17:41:25,242 [   DEBUG] MultiGroup      : ('<broadcast>', 7359)
2020-02-20 17:41:25,242 [   DEBUG] Sending UDP Data: b'who is JellyfinServer?'
2020-02-20 17:41:26,244 [    INFO] Found Servers: []
2020-02-20 17:41:26,246 [   DEBUG] credentialsupdated
2020-02-20 17:41:26,246 [    INFO] Begin connectToServers, with 1 servers
2020-02-20 17:41:26,246 [    INFO] begin connectToServer
2020-02-20 17:41:26,246 [    INFO] tryConnect url: http://192.168.0.110:7207/system/info/public
2020-02-20 17:41:26,248 [   DEBUG] Starting new HTTP connection (1): 192.168.0.110:7207
2020-02-20 17:41:26,250 [   DEBUG] http://192.168.0.110:7207 "GET /system/info/public HTTP/1.1" 200 None
2020-02-20 17:41:26,251 [    INFO] calling onSuccessfulConnection with server jellyfin
2020-02-20 17:41:26,252 [   DEBUG] Starting new HTTP connection (1): 192.168.0.110:7207
2020-02-20 17:41:26,258 [   DEBUG] http://192.168.0.110:7207 "GET /System/Info HTTP/1.1" 200 None
2020-02-20 17:41:26,260 [   DEBUG] credentialsupdated
2020-02-20 17:41:26,260 [   DEBUG] resolving connectToServers with result['State']: {'Servers': [{'address': 'http://192.168.0.110:7207', 'Name': 'jellyfin', 'Id': '5aba8232018c4be8af8f0a7701aeb062', 'DateLastAccessed': '2020-02-20T17:41:26Z', 'UserId': 'f6da1d3b3b774c91b8b73b023782a763', 'AccessToken': '22700766f3bf4071b717e709ece53478', 'Users': [{'Id': 'f6da1d3b3b774c91b8b73b023782a763', 'IsSignedInOffline': True}], 'uuid': '5bafca8f-b778-429c-9778-d28ca59a29ce', 'username': 'Ethan', 'connected': True}], 'State': 3}
2020-02-20 17:41:26,260 [    INFO] User is authenticated.
2020-02-20 17:41:26,260 [   DEBUG] Converted retries value: 3 -> Retry(total=3, connect=None, read=None, redirect=None, status=None)
2020-02-20 17:41:26,260 [   DEBUG] Converted retries value: 3 -> Retry(total=3, connect=None, read=None, redirect=None, status=None)
2020-02-20 17:41:26,261 [    INFO] Websocket url: ws://192.168.0.110:7207/socket?api_key=REDACTED&device_id=57bb0094-986f-42a8-ace3-5b15f827eed5
2020-02-20 17:41:26,263 [   DEBUG] Starting new HTTP connection (1): 192.168.0.110:7207
2020-02-20 17:41:26,265 [    INFO] --->[ websocket ]
2020-02-20 17:41:26,265 [   DEBUG] Unhandled Event WebSocketConnect: None
2020-02-20 17:41:26,271 [   DEBUG] http://192.168.0.110:7207 "POST /Sessions/Capabilities/Full HTTP/1.1" 204 0
2020-02-20 17:41:32,051 [   DEBUG] Handled Event Play: {'Id': '50fc34f1bcf96e945cbfbc7689f6f5c7', 'ItemIds': ['e841bd1eb265a20e3d12726327eda1a0', 'f51954164ea123d435c1311e4225ce2d', '472dca66bdc5c24110726c29390ba3b1', '5dfb50753a01b5d292635f32b759e782', '2ccb42dd729ce6582619f574e21aa586', 'c602e7cca9c790bad262c515aac75aae', '7fbee03265eceef18789bec7dc793088', '336bc83a7f07d0efd0f7deda4d511396', 'adf31ac5468c90cbb2114241c1c9bf4e', '3a2cf1c678100eea2f7de585afe86bce', '2f24daa068f33d34b1f661daab78fd9b', '4c7fe638ccea29748b1a64edb05bfe1c', '71c62fd5a60b76ac6283694757dc389e', 'b9ee6b5b724808d233252a7a94575278', 'de1c162a49625db8d74e3f680c709fc3', 'cef351266e944cbf25ed7f227c33ec7e', '9c050cbe2078f4a3fc6862269a8d930a', '378d423d4abfba5766f844061f70655a', '525b3eaba0a03a26426623a4253171d8', '93461548df47bc686debb48d6af2e41f', 'a30e2edef173c5f034317a36ddcf782e', '4e42e7a2c3474e4ea3f994f597721dd4', '46edf3c1ebea771f25fd105773c1e922', '44181574b26fa5c09ef330325cc83e6f'], 'PlayCommand': 'PlayNow', 'ControllingUserId': 'f6da1d3b3b774c91b8b73b023782a763', 'ServerId': '5aba8232018c4be8af8f0a7701aeb062'}
2020-02-20 17:41:32,057 [   DEBUG] http://192.168.0.110:7207 "GET /Users/f6da1d3b3b774c91b8b73b023782a763/Items/e841bd1eb265a20e3d12726327eda1a0 HTTP/1.1" 200 None
2020-02-20 17:41:32,059 [   DEBUG] EventHandler::playMedia <jellyfin_mpv_shim.media.Media object at 0x7f9258a9aaf0>
2020-02-20 17:41:32,064 [   DEBUG] http://192.168.0.110:7207 "POST /Items/e841bd1eb265a20e3d12726327eda1a0/PlaybackInfo HTTP/1.1" 200 None
2020-02-20 17:41:45,420 [   DEBUG] PlayerManager::play selecting audio stream index=2
2020-02-20 17:41:45,424 [   DEBUG] PlayerManager::play selecting subtitle stream index=3
2020-02-20 17:41:45,451 [   DEBUG] http://192.168.0.110:7207 "POST /Sessions/Playing HTTP/1.1" 204 0
2020-02-20 17:41:45,468 [   DEBUG] http://192.168.0.110:7207 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0
2020-02-20 17:41:45,955 [   DEBUG] Unhandled Event UserDataChanged: {'UserId': 'f6da1d3b3b774c91b8b73b023782a763', 'UserDataList': [{'PlaybackPositionTicks': 0, 'PlayCount': 13, 'IsFavorite': False, 'LastPlayedDate': '2020-02-21T01:41:45.4694801Z', 'Played': False, 'Key': '355480001001', 'ItemId': 'e841bd1eb265a20e3d12726327eda1a0'}, {'UnplayedItemCount': 24, 'PlaybackPositionTicks': 0, 'PlayCount': 0, 'IsFavorite': False, 'Played': False, 'Key': '355480001', 'ItemId': 'b90abbc4b4b4efccfe8fdf9442a1e031'}], 'ServerId': '5aba8232018c4be8af8f0a7701aeb062'}
2020-02-20 17:41:48,525 [   DEBUG] Unhandled Event LibraryChanged: {'FoldersAddedTo': [], 'FoldersRemovedFrom': [], 'ItemsAdded': [], 'ItemsRemoved': [], 'ItemsUpdated': ['e2f707ab6d60c6cdfb49caba58d1ec76', '472dca66bdc5c24110726c29390ba3b1', '25f9fe4ede41949177ff6810e2e671fd', 'f51954164ea123d435c1311e4225ce2d', 'fa738bd4d45ecef788df87916d2245ae', '2753ce99c1620b296311cd4e6f8eabd7', 'edeffed2cf8d2db0efb23b5d6900b54e', '7b7abf93309810cd777a87035ac165ea', '27c25eb9fe5c04188a273c0356d1c210', 'ff5ac435d5d492ee3ccee63cf62fe4ea', '2e8d1a28aa29ff5e412a5563a4cec274', 'd28c21e67d3913d52150207f786801cb', '9f0988f7a43dd43cfe44620dcd345ea0', '697681f3cf492122a354dbae71d85abf', '5dfb50753a01b5d292635f32b759e782', 'c602e7cca9c790bad262c515aac75aae', '2ccb42dd729ce6582619f574e21aa586'], 'CollectionFolders': [], 'IsEmpty': False, 'ServerId': '5aba8232018c4be8af8f0a7701aeb062'}
2020-02-20 17:41:50,471 [   DEBUG] http://192.168.0.110:7207 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0
2020-02-20 17:41:55,494 [   DEBUG] http://192.168.0.110:7207 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0
2020-02-20 17:42:00,512 [   DEBUG] http://192.168.0.110:7207 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0
2020-02-20 17:42:05,528 [   DEBUG] http://192.168.0.110:7207 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0
2020-02-20 17:42:10,545 [   DEBUG] http://192.168.0.110:7207 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0
2020-02-20 17:42:15,565 [   DEBUG] http://192.168.0.110:7207 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0
2020-02-20 17:42:20,584 [   DEBUG] http://192.168.0.110:7207 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0
2020-02-20 17:42:25,603 [   DEBUG] http://192.168.0.110:7207 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0
2020-02-20 17:42:30,622 [   DEBUG] http://192.168.0.110:7207 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0
2020-02-20 17:42:35,640 [   DEBUG] http://192.168.0.110:7207 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0
2020-02-20 17:42:40,661 [   DEBUG] http://192.168.0.110:7207 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0
2020-02-20 17:42:45,678 [   DEBUG] http://192.168.0.110:7207 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0
2020-02-20 17:42:50,696 [   DEBUG] http://192.168.0.110:7207 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0
2020-02-20 17:42:55,712 [   DEBUG] http://192.168.0.110:7207 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0
2020-02-20 17:43:00,729 [   DEBUG] http://192.168.0.110:7207 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0
2020-02-20 17:43:05,746 [   DEBUG] http://192.168.0.110:7207 "POST /Sessions/Playing/Progress HTTP/1.1" 204 0
2020-02-20 17:43:08,200 [   DEBUG] PlayerManager::stop stopping playback of <jellyfin_mpv_shim.media.Video object at 0x7f9258a9aac0>
2020-02-20 17:43:08,218 [   DEBUG] http://192.168.0.110:7207 "POST /Sessions/Playing/Stopped HTTP/1.1" 204 0
2020-02-20 17:43:08,723 [   DEBUG] Unhandled Event UserDataChanged: {'UserId': 'f6da1d3b3b774c91b8b73b023782a763', 'UserDataList': [{'PlaybackPositionTicks': 0, 'PlayCount': 13, 'IsFavorite': False, 'LastPlayedDate': '2020-02-21T01:41:45.4694801Z', 'Played': False, 'Key': '355480001001', 'ItemId': 'e841bd1eb265a20e3d12726327eda1a0'}, {'UnplayedItemCount': 24, 'PlaybackPositionTicks': 0, 'PlayCount': 0, 'IsFavorite': False, 'Played': False, 'Key': '355480001', 'ItemId': 'b90abbc4b4b4efccfe8fdf9442a1e031'}], 'ServerId': '5aba8232018c4be8af8f0a7701aeb062'}