croneter / PlexKodiConnect

Plex integration in Kodi done right
GNU General Public License v2.0
1.16k stars 77 forks source link

Plex sees the media, but cannot play it #1992

Open icemanxbe opened 1 year ago

icemanxbe commented 1 year ago

When trying to open an episode/file it says 'one or more items failed to play'.

log entry:

2023-09-17 09:18:06.754 T:101096 INFO : VideoPlayer::OpenFile: plugin://plugin.video.plexkodiconnect.tvshows/67856/?mode=play&plex_id=68735&plex_type=episode&filename=S03E02 - One Piece - Witch of Cocoyashi Village! Arlong's Female Leader! HDTV-1080p.mkv 2023-09-17 09:18:06.756 T:101404 INFO : PLEX.tvshows: ADD episode plex_id: 118808 - It's an Ill Wind That Blows Nobody Good 2023-09-17 09:18:06.763 T:107484 INFO : Creating InputStream 2023-09-17 09:18:06.767 T:107484 ERROR : CCurlFile::Open failed with code 404 for http://192.168.0.160:32400/library/parts/258524/963966600/?Accept=%2A%2F%2A&Content-Type=application%2Fx-www-form-urlencoded&Accept-Language=en&X-Plex-Device=MacOSX&X-Plex-Model=23.0.0&X-Plex-Device-Name=Kodi+ice.local&X-Plex-Platform=Generic&X-Plex-Platform-Version=1.0.0&X-Plex-Product=PlexKodiConnect&X-Plex-Version=3.7.1&X-Plex-Client-Identifier=29d77d4a-8f51-410d-b95c-99e07d766f2f&X-Plex-Provides=client%2Ccontroller%2Cplayer%2Cpubsub-player&X-Plex-Protocol=1.0&Cache-Control=no-cache&X-Plex-Token=

2023-09-17 09:18:06.771 T:107484 ERROR : Skipped 1 duplicate messages.. 2023-09-17 09:18:06.771 T:107484 ERROR : CFileCache::Open - <http://192.168.0.160:32400/library/parts/258524/963966600/?Accept=%2A%2F%2A&Content-Type=application%2Fx-www-form-urlencoded&Accept-Language=en&X-Plex-Device=MacOSX&X-Plex-Model=23.0.0&X-Plex-Device-Name=Kodi+ice.local&X-Plex-Platform=Generic&X-Plex-Platform-Version=1.0.0&X-Plex-Product=PlexKodiConnect&X-Plex-Version=3.7.1&X-Plex-Client-Identifier=29d77d4a-8f51-410d-b95c-99e07d766f2f&X-Plex-Provides=client%2Ccontroller%2Cplayer%2Cpubsub-player&X-Plex-Protocol=1.0&Cache-Control=no-cache&X-Plex-Token= failed to open 2023-09-17 09:18:06.772 T:107484 ERROR : CVideoPlayer::OpenInputStream - error opening [plugin://plugin.video.plexkodiconnect.tvshows/67856/?mode=play&plex_id=68735&plex_type=episode&filename=S03E02 - One Piece - Witch of Cocoyashi Village! Arlong's Female Leader! HDTV-1080p.mkv] 2023-09-17 09:18:06.772 T:107484 INFO : CVideoPlayer::OnExit() 2023-09-17 09:18:06.775 T:107426 INFO : Deleting settings information for files plugin://plugin.video.plexkodiconnect.tvshows/67856/?mode=play&plex_id=68735&plex_type=episode&filename=S03E02 - One Piece - Witch of Cocoyashi Village! Arlong's Female Leader! HDTV-1080p.mkv

The file exists, obviously. And it show up and syncs to the library. But i can't get any type of media to actually play.

PadelzZ commented 1 year ago

Also happening to me, haven't changed anything. So i'm not sure if there was an update of Kodi or PKC. Few days ago everything worked just fine and since last night when i wanted to watch something, none of my media starts to play.

In kodi if i browse straight to the share, i can play the video but not when PKC has to start it.

I already did a clean install of everything and problem still persist.

icemanxbe commented 1 year ago

Also happening to me, haven't changed anything. So i'm not sure if there was an update of Kodi or PKC. Few days ago everything worked just fine and since last night when i wanted to watch something, none of my media starts to play.

In kodi if i browse straight to the share, i can play the video but not when PKC has to start it.

I already did a clean install of everything and problem still persist.

Exactly thesame issue. Reinstalled everything twice even. Following the link in the debug log shows a 404 not found error, but all other devices using plex have no issues playing any media. So im also confused if its plex or the addon related.

JelleDeMoor commented 1 year ago

Same here, but I can add this happened immediately after updating Plex server to v1.32.7.7484. Sidenote: at the same time, going to my server's IP address and port without extra pointers now results in an XML file error, whereas adding /web/index.html works normal.

PadelzZ commented 1 year ago

Same here, but I can add this happened immediately after updating Plex server to v1.32.7.7484. Sidenote: at the same time, going to my server's IP address and port without extra pointers now results in an XML file error, whereas adding /web/index.html works normal.

I downgraded Plex now to this Version 1.32.6.7468 and straight away my media starts playing again. Fix for now might be to downgrade Plex server

JelleDeMoor commented 1 year ago

A, seems the error is indeed at Plex, and they know about it and are working on it: https://forums.plex.tv/t/pms-1-32-6-hw-transcoding-issues-and-corrections/853757

croneter commented 8 months ago

Is this still an issue? If so, then I need a DEBUG log file: https://github.com/croneter/PlexKodiConnect/wiki/How-to-Report-A-Bug

PadelzZ commented 8 months ago

haven't seen the error anymore after the update of Plex.

Clay-Cui commented 8 months ago

Hello, this issue is still a problem for me. KODI can see the media, can't play it. The log is as below:

2024-01-20 23:19:12.247 T:15553 debug : PLEX.kodimonitor: Method: Info.OnChanged Data: None 2024-01-20 23:19:12.247 T:15553 debug : PLEX.kodimonitor: Method: Player.OnPlay Data: {'item': {'id': 34, 'type': 'movie'}, 'player': {'playerid': 1, 'speed': 1}} 2024-01-20 23:19:12.248 T:15553 debug : PLEX.kodimonitor: Detected position 0 for {'playlistid': 1, 'id': 265, 'version': 1, 'type': 'video', 'selectedItemID': 366, 'selectedItemOffset': 0, 'shuffled': 0, 'repeat': 0, 'kodi_playlist_playback': False, 'pkc_edit': True, 'items': [{'id': 366, 'plex_id': 1616, 'plex_type': 'movie', 'kodi_id': 34, 'kodi_type': 'movie', 'file': '/storage/A092-AB02/Movie/La.La.Land.2016.2160p.BluRay.REMUX.HEVC.DTS-HD.MA.TrueHD.7.1.Atmos-FGT/La.La.Land.2016.2160p.BluRay.REMUX.HEVC.DTS-HD.MA.TrueHD.7.1.Atmos-FGT.mkv', 'guid': 'plex://movie/5d776b59594b2b001e6d764f', 'playmethod': '0', 'playcount': 1, 'resume': True,'offset': 2705.7960000000003, 'force_transcode': False, 'part': 0}]} 2024-01-20 23:19:12.248 T:15553 debug : PLEX.kodimonitor: PKC playqueue item is: {'id': 366, 'plex_id': 1616, 'plex_type': 'movie', 'kodi_id': 34, 'kodi_type': 'movie', 'file': '/storage/A092-AB02/Movie/La.La.Land.2016.2160p.BluRay.REMUX.HEVC.DTS-HD.MA.TrueHD.7.1.Atmos-FGT/La.La.Land.2016.2160p.BluRay.REMUX.HEVC.DTS-HD.MA.TrueHD.7.1.Atmos-FGT.mkv', 'guid': 'plex://movie/5d776b59594b2b001e6d764f', 'playmethod': '0', 'playcount': 1, 'resume': True,'offset': 2705.7960000000003, 'force_transcode': False, 'part': 0} 2024-01-20 23:19:12.249 T:15553 debug : PLEX.kodimonitor: No need to initialize playqueues 2024-01-20 23:19:12.250 T:15553 debug CAddonSettings[0@plugin.video.plexkodiconnect]: trying to load setting definitions from old format... 2024-01-20 23:19:12.258 T:15553 debug : PLEX.kodimonitor: Set the Plex container_key to: /playQueues/265 2024-01-20 23:19:12.258 T:15553 debug : PLEX.kodimonitor: Set the player state: {'type': 'video', 'time': {'hours': 0, 'milliseconds': 0, 'minutes': 0, 'seconds': 0}, 'totaltime': {'hours': 0, 'milliseconds': 0, 'minutes': 0, 'seconds': 0}, 'speed': 1, 'shuffled': False, 'repeat': 'off', 'position': 0, 'playlistid': 1, 'currentvideostream': None, 'currentaudiostream': {}, 'subtitleenabled': True, 'currentsubtitle': {}, 'file': '/storage/A092-AB02/Movie/La.La.Land.2016.2160p.BluRay.REMUX.HEVC.DTS-HD.MA.TrueHD.7.1.Atmos-FGT/La.La.Land.2016.2160p.BluRay.REMUX.HEVC.DTS-HD.MA.TrueHD.7.1.Atmos-FGT.mkv', 'kodi_id': 34, 'kodi_type': 'movie', 'plex_id': 1616, 'plex_type': 'movie', 'container_key': '/playQueues/265', 'volume': 100, 'muted': False, 'playmethod': 0, 'playcount': 1, 'external_player': False, 'markers': [], 'first_credits_marker': None, 'final_credits_marker': None} 2024-01-20 23:19:12.262 T:15505 debug : Visible Behind request: false 2024-01-20 23:19:12.344 T:15633 error : CVideoPlayer::OpenInputStream - error opening [plugin://plugin.video.plexkodiconnect.movies/?mode=play&plex_id=1616&plex_type=movie&filename=La.La.Land.2016.2160p.BluRay.REMUX.HEVC.DTS-HD.MA.TrueHD.7.1.Atmos-FGT.mkv] 2024-01-20 23:19:12.344 T:15633 info : CVideoPlayer::OnExit() 2024-01-20 23:19:12.345 T:15633 debug : Thread VideoPlayer 218709101760 terminating 2024-01-20 23:19:12.350 T:15547 info : Deleting settings information for files plugin://plugin.video.plexkodiconnect.movies/?mode=play&plex_id=1616&plex_type=movie&filename=La.La.Land.2016.2160p.BluRay.REMUX.HEVC.DTS-HD.MA.TrueHD.7.1.Atmos-FGT.mkv 2024-01-20 23:19:12.352 T:15548 debug : OnPlayBackStopped: CApplication::OnPlayBackStopped 2024-01-20 23:19:12.352 T:15502 debug : ------ Window Init (DialogBusy.xml) ------ 2024-01-20 23:19:12.352 T:15505 debug : void CXBMCApp::OnPlayBackStopped() 2024-01-20 23:19:12.356 T:15502 debug : ------ Window Init (DialogConfirm.xml) ------ 2024-01-20 23:19:12.356 T:15502 info : Loading skin file: DialogConfirm.xml, load type: KEEP_IN_MEMORY 2024-01-20 23:19:12.359 T:15553 debug : PLEX.kodimonitor: Method: Player.OnStop Data: {'end': False, 'item': {'id': 34, 'type': 'movie'}} 2024-01-20 23:19:12.360 T:15553 debug : PLEX.kodimonitor: playback_cleanup called. Active players: {1} 2024-01-20 23:19:12.363 T:15553 debug : PLEX.kodimonitor: First credits marker: None 2024-01-20 23:19:12.364 T:15553 debug : PLEX.kodimonitor: Last credits marker: None 2024-01-20 23:19:12.364 T:15553 debug : PLEX.kodimonitor: Using PMS setting LibraryVideoPlayedAtBehaviour=3 2024-01-20 23:19:12.364 T:15553 debug : PLEX.kodimonitor: Kodi advancedsettings: playcountminimumpercent=0.9, ignoresecondsatstart=180, ignorepercentatend=0.08 2024-01-20 23:19:12.364 T:15553 debug : PLEX.kodimonitor: time 0.0, totaltime 1e-06, progress 0.0, MARK_PLAYED_AT 0.9 2024-01-20 23:19:12.365 T:15553 debug : PLEX.kodimonitor: Deduced that video has ended: False 2024-01-20 23:19:12.365 T:15553 debug : PLEX.kodimonitor: Ignoring playback less than 60 seconds 2024-01-20 23:19:12.365 T:15553 debug : PLEX.kodimonitor: Resulting playback progress 0.0 (0.0 of 1e-06 seconds) playcount None 2024-01-20 23:19:12.365 T:15553 debug : PLEX.kodimonitor: Force-reload skin to force Kodi to show in-progress video: False 2024-01-20 23:19:12.386 T:15584 debug : PLEX.kodimonitor: Start cleaning Kodi files table 2024-01-20 23:19:12.387 T:15553 debug : PLEX.kodimonitor: Finished PKC playback cleanup

The server is running on shiled and the newest. Could you help please

croneter commented 8 months ago

@Clay-Cui I need the entire debug log please, see https://github.com/croneter/PlexKodiConnect/wiki/How-to-Report-A-Bug