plugin.video.viervijfzes icon indicating copy to clipboard operation
plugin.video.viervijfzes copied to clipboard

Playing issues on Android

Open Rubnflsn opened this issue 1 year ago • 3 comments

Describe the bug I can not play any file for a couple weeks on both my android devices (Google TV and Shield). Everything works fine on Mac.

To Reproduce Steps to reproduce the behavior:

  1. Download latest Kodi from play store
  2. Install GoPlay add-on from repo
  3. Add credentials in add-on and try to play any video
  4. A "This video cannot be played" message is displayed

Logs

2023-03-22 20:48:43.587 T:29469   debug <general>: cached image 'special://masterprofile/Thumbnails/7/7620cb87.jpg' size 1280x720
2023-03-22 20:48:44.855 T:28534   debug <general>: Keyboard: scancode: 0x17, sym: 0x0d, unicode: 0x00, modifier: 0x0
2023-03-22 20:48:45.090 T:28534    info <general>: Skipped 1 duplicate messages..
2023-03-22 20:48:45.090 T:28534   debug <general>: HandleKey: return (0xf00d) pressed, window 10025, action is Select
2023-03-22 20:48:45.104 T:28534   debug <general>: OnPlayMedia plugin://plugin.video.viervijfzes/play/catalog/9cc7ea4e-e1d6-4231-ac79-207f522b7bf7/True
2023-03-22 20:48:45.114 T:28534   debug <general>: CScriptRunner: running add-on script GoPlay('plugin://plugin.video.viervijfzes/play/catalog/9cc7ea4e-e1d6-4231-ac79-207f522b7bf7/True', '2', '')
2023-03-22 20:48:45.115 T:28534   debug <general>: GetLanguageInvoker - Reusing LanguageInvokerThread 10 for script /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.viervijfzes/addon_entry.py
2023-03-22 20:48:45.115 T:29289   debug <general>: initializing python engine.
2023-03-22 20:48:45.116 T:29289   debug <general>: CPythonInvoker(10, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.viervijfzes/addon_entry.py): start processing
2023-03-22 20:48:45.116 T:29289   debug <general>: CPythonInvoker(10): adding args:
2023-03-22 20:48:45.116 T:29289   debug <general>: CPythonInvoker(10):  plugin://plugin.video.viervijfzes/play/catalog/9cc7ea4e-e1d6-4231-ac79-207f522b7bf7/True
2023-03-22 20:48:45.116 T:29289   debug <general>: CPythonInvoker(10):  2
2023-03-22 20:48:45.116 T:29289   debug <general>: CPythonInvoker(10):  
2023-03-22 20:48:45.116 T:29289   debug <general>: CPythonInvoker(10):  resume:false
2023-03-22 20:48:45.116 T:29289   debug <general>: CPythonInvoker(10, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.viervijfzes/addon_entry.py): entering source directory /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.viervijfzes
2023-03-22 20:48:45.116 T:29289   debug <general>: CPythonInvoker(10, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.viervijfzes/addon_entry.py): instantiating addon using automatically obtained id of "plugin.video.viervijfzes" dependent on version 3.0.0 of the xbmc.python api
2023-03-22 20:48:45.121 T:29289   debug <general>: [plugin.video.viervijfzes][routing] Dispatching to 'play_catalog', args: {'uuid': '9cc7ea4e-e1d6-4231-ac79-207f522b7bf7', 'islongform': 'True'}
2023-03-22 20:48:45.123 T:29289   debug <CAddonSettings[[email protected]]>: trying to load setting definitions from old format...
2023-03-22 20:48:45.125 T:29289   debug <CSettingsManager>: requested setting (credentials_hash) was not found.
2023-03-22 20:48:45.127 T:29289   debug <CSettingsManager>: requested setting (videoplayer.useomxplayer) was not found.
2023-03-22 20:48:45.130 T:29289   debug <CAddonSettings[[email protected]]>: trying to load setting definitions from old format...
2023-03-22 20:48:45.132 T:29289   debug <CSettingsManager>: requested setting (credentials_hash) was not found.
2023-03-22 20:48:45.132 T:29289   debug <general>: [plugin.video.viervijfzes] [resources.lib.viervijfzes.auth] Got an id token from memory
2023-03-22 20:48:45.136 T:29568    info <general>: Skipped 6 duplicate messages..
2023-03-22 20:48:45.136 T:29568   debug <general>: Thread ScriptObs start, auto delete: false
2023-03-22 20:48:45.143 T:29289   debug <general>: [plugin.video.viervijfzes] [urllib3.connectionpool] Starting new HTTPS connection (1): api.goplay.be:443
2023-03-22 20:48:45.336 T:28534    info <general>: Skipped 6 duplicate messages..
2023-03-22 20:48:45.336 T:28534   debug <general>: ------ Window Init (DialogBusy.xml) ------
2023-03-22 20:48:45.337 T:29289   debug <general>: [plugin.video.viervijfzes] [urllib3.connectionpool] https://api.goplay.be:443 "GET /web/v1/videos/long-form/9cc7ea4e-e1d6-4231-ac79-207f522b7bf7 HTTP/1.1" 200 815
2023-03-22 20:48:45.363 T:29289    info <general>: Skipped 6 duplicate messages..
2023-03-22 20:48:45.363 T:29289   debug <general>: CPythonInvoker(10, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.viervijfzes/addon_entry.py): script successfully run
2023-03-22 20:48:45.378 T:28534   debug <general>: ------ Window Deinit (DialogBusy.xml) ------
2023-03-22 20:48:45.378 T:29568   debug <general>: Thread ScriptObs -1084104256 terminating
2023-03-22 20:48:45.395 T:28534   debug <general>: CPlayerCoreFactory::GetPlayers(https://stream3-vod.cdn1.sbs.prd.telenet-ops.be/geo/SSAI/BIG_BROTHER/S3/E2/10150990398294812/20230206T175428690/BIG_BROTHER_3_2_F0306410.mpd)
2023-03-22 20:48:45.395 T:28534   debug <general>: CPlayerSelectionRule::GetPlayers: considering rule: system rules
2023-03-22 20:48:45.395 T:28534   debug <general>: CPlayerSelectionRule::GetPlayers: matches rule: system rules
2023-03-22 20:48:45.396 T:28534   debug <general>: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp
2023-03-22 20:48:45.396 T:28534   debug <general>: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
2023-03-22 20:48:45.396 T:28534   debug <general>: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
2023-03-22 20:48:45.396 T:28534   debug <general>: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
2023-03-22 20:48:45.396 T:28534   debug <general>: CPlayerSelectionRule::GetPlayers: considering rule: streams
2023-03-22 20:48:45.396 T:28534   debug <general>: CPlayerSelectionRule::GetPlayers: matches rule: streams
2023-03-22 20:48:45.396 T:28534   debug <general>: CPlayerSelectionRule::GetPlayers: considering rule: aacp/sdp
2023-03-22 20:48:45.396 T:28534   debug <general>: CPlayerSelectionRule::GetPlayers: considering rule: mp2
2023-03-22 20:48:45.396 T:28534   debug <general>: CPlayerSelectionRule::GetPlayers: considering rule: dvd
2023-03-22 20:48:45.396 T:28534   debug <general>: CPlayerSelectionRule::GetPlayers: considering rule: discimage
2023-03-22 20:48:45.397 T:28534   debug <general>: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
2023-03-22 20:48:45.397 T:28534   debug <general>: CPlayerSelectionRule::GetPlayers: considering rule: nsv
2023-03-22 20:48:45.397 T:28534   debug <general>: CPlayerSelectionRule::GetPlayers: considering rule: radio
2023-03-22 20:48:45.397 T:28534   debug <general>: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
2023-03-22 20:48:45.397 T:28534   debug <general>: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer)
2023-03-22 20:48:45.397 T:28534   debug <general>: CPlayerCoreFactory::GetPlayers: for video=true, audio=false
2023-03-22 20:48:45.397 T:28534   debug <general>: CPlayerCoreFactory::GetPlayers: for video=true, audio=true
2023-03-22 20:48:45.397 T:28534   debug <general>: CPlayerCoreFactory::GetPlayers: added 1 players
2023-03-22 20:48:45.401 T:28534   debug <general>: Radio UECP (RDS) Processor - new CDVDRadioRDSData
2023-03-22 20:48:45.401 T:28534   debug <general>: Audio ID3 tag processor - new CVideoPlayerAudioID3
2023-03-22 20:48:45.402 T:28534    info <general>: VideoPlayer::OpenFile: plugin://plugin.video.viervijfzes/play/catalog/9cc7ea4e-e1d6-4231-ac79-207f522b7bf7/True
2023-03-22 20:48:45.403 T:29572   debug <general>: Thread VideoPlayer start, auto delete: false
2023-03-22 20:48:45.403 T:29572 warning <general>: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
2023-03-22 20:48:45.403 T:28534   debug <general>: OnPlayBackStarted: CApplication::OnPlayBackStarted
2023-03-22 20:48:45.405 T:29573   debug <general>: Thread BackgroundLoader start, auto delete: false
2023-03-22 20:48:45.409 T:29572    info <general>: Creating InputStream
2023-03-22 20:48:45.413 T:29572   debug <general>: CFileCache::Open - <https://stream3-vod.cdn1.sbs.prd.telenet-ops.be/geo/SSAI/BIG_BROTHER/S3/E2/10150990398294812/20230206T175428690/BIG_BROTHER_3_2_F0306410.mpd> opening
2023-03-22 20:48:45.415 T:29473   debug <general>: Loading settings for plugin://plugin.video.viervijfzes/play/catalog/9cc7ea4e-e1d6-4231-ac79-207f522b7bf7/True
2023-03-22 20:48:45.418 T:29572   debug <general>: CurlFile::Open - <https://stream3-vod.cdn1.sbs.prd.telenet-ops.be/geo/SSAI/BIG_BROTHER/S3/E2/10150990398294812/20230206T175428690/BIG_BROTHER_3_2_F0306410.mpd>
2023-03-22 20:48:45.421 T:28534   debug <general>: CVideoGUIInfo::InitCurrentItem(plugin://plugin.video.viervijfzes/play/catalog/9cc7ea4e-e1d6-4231-ac79-207f522b7bf7/True)
2023-03-22 20:48:45.421 T:28534   debug <general>: CPlayerGUIInfo::InitCurrentItem(plugin://plugin.video.viervijfzes/play/catalog/9cc7ea4e-e1d6-4231-ac79-207f522b7bf7/True)
2023-03-22 20:48:45.443 T:29572   debug <general>: CFileCache::Open - <https://stream3-vod.cdn1.sbs.prd.telenet-ops.be/geo/SSAI/BIG_BROTHER/S3/E2/10150990398294812/20230206T175428690/BIG_BROTHER_3_2_F0306410.mpd> source chunk size is 0, setting cache chunk size to 131072
2023-03-22 20:48:45.443 T:29572   debug <general>: CFileCache::Open - <https://stream3-vod.cdn1.sbs.prd.telenet-ops.be/geo/SSAI/BIG_BROTHER/S3/E2/10150990398294812/20230206T175428690/BIG_BROTHER_3_2_F0306410.mpd> using single memory cache sized 20971520 bytes
2023-03-22 20:48:45.443 T:29574   debug <general>: Thread FileCache start, auto delete: false
2023-03-22 20:48:45.444 T:28547   debug <general>: void CXBMCApp::OnPlayBackStarted()
2023-03-22 20:48:45.450 T:29574   debug <general>: CFileCache::Process - <https://stream3-vod.cdn1.sbs.prd.telenet-ops.be/geo/SSAI/BIG_BROTHER/S3/E2/10150990398294812/20230206T175428690/BIG_BROTHER_3_2_F0306410.mpd> source read hit eof
2023-03-22 20:48:45.460 T:28547   debug <general>: Visible Behind request: false
2023-03-22 20:48:45.474 T:29572    info <general>: Creating Demuxer
2023-03-22 20:48:45.501 T:29572   error <general>: Open - error probing input format, https://stream3-vod.cdn1.sbs.prd.telenet-ops.be/geo/SSAI/BIG_BROTHER/S3/E2/10150990398294812/20230206T175428690/BIG_BROTHER_3_2_F0306410.mpd
2023-03-22 20:48:45.501 T:29572   error <general>: OpenDemuxStream - Error creating demuxer
2023-03-22 20:48:45.501 T:29572    info <general>: CVideoPlayer::OnExit()
2023-03-22 20:48:45.502 T:29574   debug <general>: Thread FileCache -1149873728 terminating
2023-03-22 20:48:45.503 T:29572   debug <general>: Thread VideoPlayer -1122713152 terminating
2023-03-22 20:48:45.514 T:28579   debug <general>: [plugin.video.viervijfzes] [resources.lib.service] KodiPlayer onPlayBackStarted
2023-03-22 20:48:45.514 T:28579   error <general>: EXCEPTION: Kodi is not playing any file
2023-03-22 20:48:45.516 T:28579   error <general>: EXCEPTION Thrown (PythonToCppException) : -->Python callback/script returned the following error<--
                                                    - NOTE: IGNORING THIS CAN LEAD TO MEMORY LEAKS!
                                                   Error Type: <class 'RuntimeError'>
                                                   Error Contents: Kodi is not playing any file
                                                   Traceback (most recent call last):
                                                     File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.viervijfzes/resources/lib/service.py", line 81, in onPlayBackStarted
                                                       self.stream_path = self.getPlayingFile()
                                                                          ^^^^^^^^^^^^^^^^^^^^^
                                                   RuntimeError: Kodi is not playing any file
                                                   -->End of Python script error report<--
                                                   
2023-03-22 20:48:45.514 T:29575   debug <general>: Thread JobWorker start, auto delete: true
2023-03-22 20:48:45.518 T:29473   debug <general>: OnPlayBackStopped: CApplication::OnPlayBackStopped
2023-03-22 20:48:45.532 T:28534   debug <general>: ------ Window Init (DialogBusy.xml) ------
2023-03-22 20:48:45.537 T:28534   debug <general>: ------ Window Init (DialogConfirm.xml) ------
2023-03-22 20:48:45.541 T:29573   debug <general>: Thread BackgroundLoader -986013248 terminating
2023-03-22 20:48:45.541 T:28534    info <general>: CVideoPlayer::CloseFile()
2023-03-22 20:48:45.542 T:28534   debug <general>: DeleteRenderer - deleting renderer
2023-03-22 20:48:45.542 T:28534   debug <general>: LinuxRendererGLES: Cleaning up GLES resources
2023-03-22 20:48:45.542 T:28534   debug <general>: CAndroidUtils: IsHDRDisplay: false
2023-03-22 20:48:45.543 T:28534    info <general>: VideoPlayer: waiting for threads to exit
2023-03-22 20:48:45.543 T:28534    info <general>: VideoPlayer: finished waiting
2023-03-22 20:48:45.544 T:28534   debug <general>: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData
2023-03-22 20:48:45.544 T:28534   debug <general>: Audio ID3 tag processor - delete ~CVideoPlayerAudioID3
2023-03-22 20:48:45.544 T:28547   debug <general>: void CXBMCApp::OnPlayBackStopped()
2023-03-22 20:48:45.557 T:29576   debug <general>: [script.logviewer] "GET /tail?offset=355780 HTTP/1.1" 200 -
2023-03-22 20:48:45.618 T:28579   debug <general>: [plugin.video.viervijfzes] [resources.lib.service] KodiPlayer onPlayBackStopped
2023-03-22 20:48:45.638 T:28579   debug <general>: [plugin.video.viervijfzes] [urllib3.connectionpool] Starting new HTTPS connection (1): stream3-vod.cdn1.sbs.prd.telenet-ops.be:443
2023-03-22 20:48:45.828 T:28579   debug <general>: [plugin.video.viervijfzes] [urllib3.connectionpool] https://stream3-vod.cdn1.sbs.prd.telenet-ops.be:443 "GET /geo/SSAI/BIG_BROTHER/S3/E1/10150990398276812/20230206T175427701/BIG_BROTHER_3_1_F0306730.mpd HTTP/1.1" 200 8650
2023-03-22 20:48:48.561 T:29584   debug <general>: [script.logviewer] "GET /tail?offset=370615 HTTP/1.1" 200 -
2023-03-22 20:48:51.555 T:29587   debug <general>: [script.logviewer] "GET /tail?offset=371312 HTTP/1.1" 200 -
2023-03-22 20:48:54.559 T:29588   debug <general>: [script.logviewer] "GET /tail?offset=371423 HTTP/1.1" 200 -
2023-03-22 20:48:57.556 T:29589   debug <general>: [script.logviewer] "GET /tail?offset=371534 HTTP/1.1" 200 -
2023-03-22 20:49:00.554 T:29590   debug <general>: [script.logviewer] "GET /tail?offset=371645 HTTP/1.1" 200 -
2023-03-22 20:49:03.553 T:29591   debug <general>: [script.logviewer] "GET /tail?offset=371756 HTTP/1.1" 200 -
2023-03-22 20:49:06.549 T:29594   debug <general>: [script.logviewer] "GET /tail?offset=371867 HTTP/1.1" 200 -
2023-03-22 20:49:09.569 T:29595   debug <general>: [script.logviewer] "GET /tail?offset=371978 HTTP/1.1" 200 -

System

  • Addon version: 0.4.10+matrix.1
  • Kodi version: 20.1
  • Inputstream adaptive version: 0.5.10+matrix.1
  • Operating System (Windows / Mac OS / Android / LibreElec / OSMC / ...): Android TV 12.0.0
  • Special Hardware (RPI / Vero4K+ / ...):

Rubnflsn avatar Mar 22 '23 20:03 Rubnflsn