jellyfin-kodi
jellyfin-kodi copied to clipboard
jellyfin
Next Episode - Playback not working with `Default select action`= `Show Information`
Describe the bug
Using the "Next Episode" feature is not working if you have changed the Default select action in Kodi from the default Play to Show Information. The Information Window/Screen opens up but pressing play will generate a playback error.
I also noticed that there is a difference in the information being displayed:
Next Episode:
Normal Library:
To Reproduce
- Got to Kodi Settings -> Library -> Videos and set
Default select actiontoShow information - Open Addon and browse to your TV Library -> Next Episodes
- Try to playback an episode
- Playback Error
Expected behavior
Episdoe should play back fine like it does if the Defaul select action is set to Play.
Logs
2022-09-12 15:33:26.370 T:2879 INFO <general>: VideoPlayer::OpenFile:
2022-09-12 15:33:26.372 T:4253 INFO <general>: Creating InputStream
2022-09-12 15:33:26.374 T:4253 INFO <general>: msg: libdvdnav: Using dvdnav version 6.0.0
2022-09-12 15:33:26.376 T:4253 INFO <general>: msg: libdvdread: Can't stat
2022-09-12 15:33:26.379 T:4253 INFO <general>: msg: libdvdread: Could not open
2022-09-12 15:33:26.379 T:4253 ERROR <general>: Error on dvdnav_open
2022-09-12 15:33:26.380 T:4253 ERROR <general>: CVideoPlayer::OpenInputStream - error opening []
2022-09-12 15:33:26.380 T:4253 INFO <general>: CVideoPlayer::OnExit()
2022-09-12 15:33:26.499 T:2993 ERROR <general>: EXCEPTION: XBMC is not playing any file
2022-09-12 15:33:26.514 T:2879 INFO <general>: Skipped 1 duplicate messages..
2022-09-12 15:33:26.514 T:2879 INFO <general>: CVideoPlayer::CloseFile()
2022-09-12 15:33:26.514 T:2879 INFO <general>: VideoPlayer: waiting for threads to exit
2022-09-12 15:33:26.514 T:2879 INFO <general>: VideoPlayer: finished waiting
2022-09-12 15:33:26.522 T:4256 INFO <general>: initializing python engine.
2022-09-12 15:33:26.609 T:2993 INFO <general>: JELLYFIN.jellyfin_kodi.monitor -> DEBUG::jellyfin_kodi/monitor.py:91 [ xbmc: Player.OnPlay ] {
"item": {
"id": 1505,
"type": "episode"
},
"player": {
"playerid": 1,
"speed": 1
}
}
2022-09-12 15:33:26.617 T:2993 INFO <general>: JELLYFIN.jellyfin_kodi.objects.actions -> INFO::jellyfin_kodi/objects/actions.py:762 [ play ] kodi_id: 1505 media: episode
2022-09-12 15:33:26.638 T:2993 INFO <general>: JELLYFIN.jellyfin_kodi.database -> DEBUG::jellyfin_kodi/database/__init__.py:60 --->[ database: jellyfin ] 3588662776
2022-09-12 15:33:26.656 T:2993 INFO <general>: JELLYFIN.jellyfin_kodi.database -> DEBUG::jellyfin_kodi/database/__init__.py:172 ---<[ database: jellyfin ] 3588662776
2022-09-12 15:33:26.658 T:2993 ERROR <general>: EXCEPTION: XBMC is not playing any file
2022-09-12 15:33:26.681 T:2993 INFO <general>: JELLYFIN.jellyfin_kodi.objects.actions -> ERROR::jellyfin_kodi/objects/actions.py:778 XBMC is not playing any file
Traceback (most recent call last):
File "jellyfin_kodi/player.py", line 58, in onPlayBackStarted
current_file = self.getPlayingFile()
RuntimeError: XBMC is not playing any file
During handling of the above exception, another exception occurred:
Traceback (most recent call last):
File "jellyfin_kodi/objects/actions.py", line 776, in on_play
file = player.getPlayingFile()
RuntimeError: XBMC is not playing any file
2022-09-12 15:33:26.689 T:2993 INFO <general>: JELLYFIN.jellyfin_kodi.helper.utils -> DEBUG::jellyfin_kodi/helper/utils.py:56 --[ window clear: jellyfin_play ]
2022-09-12 15:33:26.698 T:2993 INFO <general>: JELLYFIN.jellyfin_kodi.player -> INFO::jellyfin_kodi/player.py:377 --<[ playback ]
2022-09-12 15:33:27.525 T:2993 ERROR <general>: EXCEPTION: XBMC is not playing any file
2022-09-12 15:33:30.367 T:4256 INFO <general>: Skipped 2 duplicate messages..
2022-09-12 15:33:30.367 T:4256 INFO <general>: JELLYFIN.__main__ -> DEBUG::default.py:18 --->[ default ]
2022-09-12 15:33:30.376 T:4256 INFO <general>: JELLYFIN.jellyfin_kodi.jellyfin.client -> DEBUG::jellyfin_kodi/jellyfin/client.py:35 JellyfinClient initializing...
2022-09-12 15:33:30.384 T:4256 INFO <general>: JELLYFIN.jellyfin_kodi.jellyfin.configuration -> DEBUG::jellyfin_kodi/jellyfin/configuration.py:25 Configuration initializing...
2022-09-12 15:33:30.394 T:4256 INFO <general>: JELLYFIN.jellyfin_kodi.jellyfin.configuration -> DEBUG::jellyfin_kodi/jellyfin/configuration.py:50 Begin http constructor.
2022-09-12 15:33:30.403 T:4256 INFO <general>: JELLYFIN.jellyfin_kodi.jellyfin.ws_client -> DEBUG::jellyfin_kodi/jellyfin/ws_client.py:34 WSClient initializing...
2022-09-12 15:33:30.413 T:4256 INFO <general>: JELLYFIN.jellyfin_kodi.jellyfin.connection_manager -> DEBUG::jellyfin_kodi/jellyfin/connection_manager.py:39 ConnectionManager initializing...
2022-09-12 15:33:30.422 T:4256 INFO <general>: JELLYFIN.jellyfin_kodi.jellyfin.credentials -> DEBUG::jellyfin_kodi/jellyfin/credentials.py:23 Credentials initializing...
2022-09-12 15:33:30.431 T:4256 INFO <general>: JELLYFIN -> INFO::jellyfin_kodi/jellyfin/__init__.py:98 ---[ START JELLYFINCLIENT ]---
2022-09-12 15:33:30.444 T:4256 INFO <general>: JELLYFIN.jellyfin_kodi.entrypoint.default -> INFO::jellyfin_kodi/entrypoint/default.py:72 path: ?id=3e840160b2d8a553d88213a62925f0fa&mode=nextepisodes&limit=25 params: {
"id": "3e840160b2d8a553d88213a62925f0fa",
"mode": "nextepisodes",
"limit": "25"
}
2022-09-12 15:33:30.455 T:4256 INFO <general>: JELLYFIN.jellyfin_kodi.database -> DEBUG::jellyfin_kodi/database/__init__.py:60 --->[ database: jellyfin ] 3481936040
2022-09-12 15:33:30.465 T:4256 INFO <general>: JELLYFIN.jellyfin_kodi.database -> DEBUG::jellyfin_kodi/database/__init__.py:172 ---<[ database: jellyfin ] 3481936040
2022-09-12 15:33:30.540 T:2993 ERROR <general>: EXCEPTION: XBMC is not playing any file
2022-09-12 15:33:30.818 T:4256 INFO <general>: JELLYFIN.__main__ -> INFO::default.py:25 ---<[ default ]
2022-09-12 15:33:30.819 T:4256 INFO <general>: CPythonInvoker(36, /home/osmc/.kodi/addons/plugin.video.jellyfin/default.py): script successfully run
2022-09-12 15:33:31.032 T:4256 INFO <general>: Python interpreter stopped
2022-09-12 15:33:31.549 T:2993 INFO <general>: JELLYFIN.jellyfin_kodi.player -> INFO::jellyfin_kodi/player.py:72 Cancel playback report
These logs are the addons debug output when selecting play of the information screen of a "next episodes" entry.
System:
- OS: Linux x64/arm (OSMC, Manjaro, CoreELEC)
- Jellyfin Version: 10.8.4
- Kodi Version: 19.4
- Addon Version: 0.7.8+py3
- Playback Mode: Addon and Native
you should enable debug settings in the plugin settings for more verbose logs.
How much of a difference is the network overhead? I can't imagine HTTP adding much overhead over nfs, if any.
I have to admit that i never really tested this before going "native". When i first got my Vero4K i read a lot of setup guides that advised of using NFS with fstab mount for the media files as SMB and especially mounts using kodi itself could cause issues for larger bitrate files. I just kept this philosophy in mind when i setup kodi with jellyfin....
I have another kodi setup in the bedroom and even tho its not a Vero4K it using the same soc and also has only 100Mbit networking. I will switch to addon mode on this device and test a few of my larger files to see if it makes a difference.
But i will also enable debugging in the addon to get more detailed logs later.
I updated the orignal post and issue name as its not related to the playback mode (native / addon ) but relates to a default kodi setting.
As i can reproduce this bug on multiple system using native and addon mode the issue label can be removed again.
It has nothing to do with the default action setting. It fails even when default action is set to play and you choose "show info" from the context menu. Kodi appears to have changed something in the last 18 months (since I fixed this last year in #484) and it's now completely failing before it's even reaching the entrypoint of the addon.
