Closed CFTBL closed 1 year ago
I think that particular error is a red herring, and while it's a problem, it's not related to the addon not working. Is there another error?
Also, are you sure 3.0.7 is installed? I can't reproduce this error. Can you provide a full debug log (or a link from the Log Uploader addon)?
OK. I just went back to square one, a blank SD card, and installed IAGL 3.0.7 as follows:
When I attempt to launch a game like pengo.zip in the MAME 2003 Plus list, it fails to launch. I'll turn on debugging in a second, but here's what I see (without debugging turned on) in the kodi log after hitting the Launch button (and it doesn't seem to matter whether or not the game is already in cache) ...
2023-03-21 15:19:20.038 T:2129 info <general>: IAGL: Post processing skipped for pengo.zip, attempting launch
2023-03-21 15:19:20.038 T:2129 error <general>: IAGL: Launcher None is unknown, defauling to RETROPLAYER
2023-03-21 15:19:20.068 T:2129 info <general>: [script.module.infotagger] set_info:
KeyError: genre
2023-03-21 15:19:20.068 T:2129 error <general>: EXCEPTION: argument "publisher" for method "setPublisher" must be unicode or str
2023-03-21 15:19:20.130 T:1178 info <general>: VideoPlayer::OpenFile: /storage/.kodi/userdata/addon_data/plugin.program.iagl/game_cache/pengo.zip
2023-03-21 15:19:20.130 T:2139 info <general>: Creating InputStream
2023-03-21 15:19:20.145 T:2139 info <general>: Creating Demuxer
2023-03-21 15:19:20.176 T:2139 error <general>: Open - error probing input format, /storage/.kodi/userdata/addon_data/plugin.program.iagl/game_cache/pengo.zip
2023-03-21 15:19:20.176 T:2139 error <general>: OpenDemuxStream - Error creating demuxer
2023-03-21 15:19:20.176 T:2139 info <general>: CVideoPlayer::OnExit()
2023-03-21 15:19:20.287 T:1178 info <general>: CVideoPlayer::CloseFile()
2023-03-21 15:19:20.287 T:1178 info <general>: VideoPlayer: waiting for threads to exit
2023-03-21 15:19:20.287 T:1178 info <general>: VideoPlayer: finished waiting
2023-03-21 15:19:25.068 T:2129 error <general>: IAGL: Status of launch is unknown for Pengo, current window id 12002
2023-03-21 15:19:25.104 T:1186 info <general>: CActiveAESink::OpenSink - initialize sink
2023-03-21 15:19:25.104 T:1186 info <general>: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=vc4hdmi0,DEV=0"
2023-03-21 15:19:25.108 T:1186 info <general>: CAESinkALSA::Initialize - Opened device "hdmi:CARD=vc4hdmi0,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00"
2023-03-21 15:19:25.108 T:1186 info <general>: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
2023-03-21 15:19:25.108 T:1186 info <general>: CAESinkALSA::InitializeHW - Using data format AE_FMT_S24NE3
2023-03-21 15:19:25.187 T:2128 error <general>: GetDirectory - Error getting plugin://plugin.program.iagl/game/MAME_2003_Plus_ZachMorris/Pengo+%28set+1+rev+c%29
Here's the kodi log with debugging turned on (again, this is when I click the Launch button to launch pengo.zip, just a game I picked at random, in the MAME 2003 Plus list):
2023-03-21 15:27:17.696 T:2162 debug <general>: ffmpeg[0x4b7cbe8]: [image2] Custom AVIOContext makes no sense and will be ignored with AVFMT_NOFILE format.
2023-03-21 15:27:19.341 T:1183 debug <general>: CLibInputKeyboard::ProcessKey - using delay: 500ms repeat: 33ms
2023-03-21 15:27:19.341 T:2236 debug <general>: Thread Timer start, auto delete: false
2023-03-21 15:27:19.361 T:1178 debug <general>: Keyboard: scancode: 0x1c, sym: 0x0d, unicode: 0x0d, modifier: 0x0
2023-03-21 15:27:19.445 T:2236 debug <general>: Thread Timer 3854557824 terminating
2023-03-21 15:27:19.461 T:1178 debug <general>: Keyboard: scancode: 0x1c, sym: 0x0d, unicode: 0x0d, modifier: 0x0
2023-03-21 15:27:19.461 T:1178 debug <general>: HandleKey: return (0xf00d) pressed, window 13000, action is Select
2023-03-21 15:27:19.462 T:1186 info <general>: CActiveAESink::OpenSink - initialize sink
2023-03-21 15:27:19.462 T:1186 debug <general>: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=vc4hdmi0,DEV=0
2023-03-21 15:27:19.462 T:1186 info <general>: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=vc4hdmi0,DEV=0"
2023-03-21 15:27:19.468 T:1186 info <general>: CAESinkALSA::Initialize - Opened device "hdmi:CARD=vc4hdmi0,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00"
2023-03-21 15:27:19.469 T:1186 info <general>: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
2023-03-21 15:27:19.469 T:1186 info <general>: CAESinkALSA::InitializeHW - Using data format AE_FMT_S24NE3
2023-03-21 15:27:19.469 T:1186 debug <general>: CAESinkALSA::InitializeHW - Request: periodSize 2205, bufferSize 8820
2023-03-21 15:27:19.469 T:1186 debug <general>: CAESinkALSA::InitializeHW - Got: periodSize 2205, bufferSize 8820
2023-03-21 15:27:19.469 T:1186 debug <general>: CAESinkALSA::InitializeHW - Setting timeout to 200 ms
2023-03-21 15:27:19.470 T:1186 debug <general>: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
2023-03-21 15:27:19.470 T:1186 debug <general>: CAESinkALSA::GetChannelLayout - Requested Layout: FL, FR
2023-03-21 15:27:19.470 T:1186 debug <general>: CAESinkALSA::GetChannelLayout - Got Layout: FL, FR (ALSA: FL FR)
2023-03-21 15:27:19.470 T:1186 debug <general>: CActiveAESink::OpenSink - ALSA Initialized:
2023-03-21 15:27:19.470 T:1186 debug <general>: Output Device : vc4-hdmi-0 (vc4hdmi0)
2023-03-21 15:27:19.470 T:1186 debug <general>: Sample Rate : 44100
2023-03-21 15:27:19.470 T:1186 debug <general>: Sample Format : AE_FMT_S24NE3
2023-03-21 15:27:19.470 T:1186 debug <general>: Channel Count : 2
2023-03-21 15:27:19.470 T:1186 debug <general>: Channel Layout: FL, FR
2023-03-21 15:27:19.470 T:1186 debug <general>: Frames : 2205
2023-03-21 15:27:19.470 T:1186 debug <general>: Frame Size : 6
2023-03-21 15:27:19.511 T:1178 debug <general>: ------ Window Deinit (DialogBusy.xml) ------
2023-03-21 15:27:19.562 T:2225 debug <general>: [plugin.program.iagl][routing] Dispatching to 'download_and_launch_game', args: {'game_list_id': 'MAME_2003_Plus_ZachMorris', 'game_id': 'Pengo+%28set+1+rev+c%29'}
2023-03-21 15:27:19.565 T:2225 debug <general>: IAGL: Found game Pengo+%28set+1+rev+c%29 in list MAME_2003_Plus_ZachMorris
2023-03-21 15:27:19.585 T:2225 debug <general>: IAGL: Downloader set to archive.org
2023-03-21 15:27:19.588 T:2225 debug <general>: IAGL: Current game download parameters {'dl_source': 'Archive.org', 'baseurl': 'https://archive.org/download/', 'url': 'MAME_2003-Plus_Reference_Set_2018/roms/pengo.zip', 'downloadpath': 'default', 'url_resolved': 'https://archive.org/download/MAME_2003-Plus_Reference_Set_2018/roms/pengo.zip', 'filename': 'pengo.zip', 'filename_no_ext': 'pengo', 'filename_ext': 'zip', 'post_processor': 'none', 'launcher': 'retroplayer', 'default_addon': 'none', 'ext_launch_cmd': 'None', 'emu_command': None, 'downloadpath_resolved': PosixPath('/storage/.kodi/userdata/addon_data/plugin.program.iagl/game_cache/pengo.zip'), 'matching_existing_files': [PosixPath('/storage/.kodi/userdata/addon_data/plugin.program.iagl/game_cache/pengo.zip')], 'downloader': 'archive_org'}
2023-03-21 15:27:19.588 T:2225 debug <general>: IAGL: Matching files found locally: [PosixPath('/storage/.kodi/userdata/addon_data/plugin.program.iagl/game_cache/pengo.zip')]
2023-03-21 15:27:19.588 T:2225 debug <general>: IAGL: pengo exists locally and will not be re-downloaded
2023-03-21 15:27:19.588 T:2225 debug <general>: IAGL: Post processor set to NONE
2023-03-21 15:27:19.588 T:2225 info <general>: IAGL: Post processing skipped for pengo.zip, attempting launch
2023-03-21 15:27:19.589 T:2225 error <general>: IAGL: Launcher None is unknown, defauling to RETROPLAYER
2023-03-21 15:27:19.589 T:2225 debug <general>: IAGL: Launcher set to RETROPLAYER
2023-03-21 15:27:19.612 T:2225 info <general>: [script.module.infotagger] set_info:
KeyError: genre
2023-03-21 15:27:19.612 T:2225 error <general>: EXCEPTION: argument "publisher" for method "setPublisher" must be unicode or str
2023-03-21 15:27:19.670 T:1178 debug <general>: CPlayerCoreFactory::GetPlayers(/storage/.kodi/userdata/addon_data/plugin.program.iagl/game_cache/pengo.zip)
2023-03-21 15:27:19.670 T:1178 debug <general>: CPlayerSelectionRule::GetPlayers: considering rule: system rules
2023-03-21 15:27:19.670 T:1178 debug <general>: CPlayerSelectionRule::GetPlayers: matches rule: system rules
2023-03-21 15:27:19.670 T:1178 debug <general>: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp
2023-03-21 15:27:19.670 T:1178 debug <general>: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
2023-03-21 15:27:19.670 T:1178 debug <general>: CPlayerSelectionRule::GetPlayers: considering rule: rtmp
2023-03-21 15:27:19.670 T:1178 debug <general>: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
2023-03-21 15:27:19.670 T:1178 debug <general>: CPlayerSelectionRule::GetPlayers: considering rule: streams
2023-03-21 15:27:19.670 T:1178 debug <general>: CPlayerSelectionRule::GetPlayers: considering rule: dvd
2023-03-21 15:27:19.670 T:1178 debug <general>: CPlayerSelectionRule::GetPlayers: considering rule: discimage
2023-03-21 15:27:19.670 T:1178 debug <general>: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
2023-03-21 15:27:19.670 T:1178 debug <general>: CPlayerSelectionRule::GetPlayers: considering rule: nsv
2023-03-21 15:27:19.670 T:1178 debug <general>: CPlayerSelectionRule::GetPlayers: considering rule: radio
2023-03-21 15:27:19.670 T:1178 debug <general>: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
2023-03-21 15:27:19.670 T:1178 debug <general>: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer)
2023-03-21 15:27:19.670 T:1178 debug <general>: CPlayerCoreFactory::GetPlayers: for video=true, audio=false
2023-03-21 15:27:19.670 T:1178 debug <general>: CPlayerCoreFactory::GetPlayers: for video=true, audio=true
2023-03-21 15:27:19.670 T:1178 debug <general>: CPlayerCoreFactory::GetPlayers: added 1 players
2023-03-21 15:27:19.674 T:1178 debug <general>: Radio UECP (RDS) Processor - new CDVDRadioRDSData
2023-03-21 15:27:19.675 T:1178 debug <general>: Audio ID3 tag processor - new CVideoPlayerAudioID3
2023-03-21 15:27:19.675 T:1178 info <general>: VideoPlayer::OpenFile: /storage/.kodi/userdata/addon_data/plugin.program.iagl/game_cache/pengo.zip
2023-03-21 15:27:19.675 T:2237 debug <general>: Thread VideoPlayer start, auto delete: false
2023-03-21 15:27:19.675 T:1178 debug <general>: OnPlayBackStarted: CApplication::OnPlayBackStarted
2023-03-21 15:27:19.675 T:2237 info <general>: Creating InputStream
2023-03-21 15:27:19.686 T:2152 debug <general>: Loading settings for /storage/.kodi/userdata/addon_data/plugin.program.iagl/game_cache/pengo.zip
2023-03-21 15:27:19.688 T:2237 debug <general>: ScanForExternalSubtitles: Searching for subtitles...
2023-03-21 15:27:19.689 T:2237 debug <general>: ScanArchiveForAssociatedItems: Scanning archive /storage/.kodi/userdata/addon_data/plugin.program.iagl/game_cache/pengo.zip
2023-03-21 15:27:19.690 T:2237 debug <general>: ScanForExternalSubtitles: END (total time: 1 ms)
2023-03-21 15:27:19.690 T:2237 info <general>: Creating Demuxer
2023-03-21 15:27:19.718 T:2237 error <general>: Open - error probing input format, /storage/.kodi/userdata/addon_data/plugin.program.iagl/game_cache/pengo.zip
2023-03-21 15:27:19.718 T:2237 error <general>: OpenDemuxStream - Error creating demuxer
2023-03-21 15:27:19.718 T:2237 info <general>: CVideoPlayer::OnExit()
2023-03-21 15:27:19.719 T:2237 debug <general>: Thread VideoPlayer 3328209536 terminating
2023-03-21 15:27:19.723 T:2146 debug <general>: OnPlayBackStopped: CApplication::OnPlayBackStopped
2023-03-21 15:27:19.728 T:1178 debug <general>: CVideoGUIInfo::InitCurrentItem(/storage/.kodi/userdata/addon_data/plugin.program.iagl/game_cache/pengo.zip)
2023-03-21 15:27:19.829 T:1178 debug <general>: ------ Window Init (DialogBusy.xml) ------
2023-03-21 15:27:19.830 T:1178 debug <general>: ------ Window Init (DialogConfirm.xml) ------
2023-03-21 15:27:19.834 T:1178 info <general>: CVideoPlayer::CloseFile()
2023-03-21 15:27:19.834 T:1178 debug <general>: DeleteRenderer - deleting renderer
2023-03-21 15:27:19.834 T:1178 debug <general>: LinuxRendererGLES: Cleaning up GLES resources
2023-03-21 15:27:19.834 T:1178 info <general>: VideoPlayer: waiting for threads to exit
2023-03-21 15:27:19.834 T:1178 info <general>: VideoPlayer: finished waiting
2023-03-21 15:27:19.836 T:1178 debug <general>: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData
2023-03-21 15:27:19.836 T:1178 debug <general>: Audio ID3 tag processor - delete ~CVideoPlayerAudioID3
2023-03-21 15:27:19.848 T:1178 debug <general>: ------ Window Deinit (/storage/.kodi/addons/plugin.program.iagl/resources/skins/Default/1080i/IAGL-infodialog.xml) ------
2023-03-21 15:27:19.851 T:1178 debug <general>: CDRMAtomic::FlipPage - Execute modeset at next commit
2023-03-21 15:27:19.913 T:1806 debug <general>: [plugin.video.youtube] PlaybackMonitor active threads: ||
2023-03-21 15:27:21.745 T:1178 debug <general>: Keyboard: scancode: 0x61, sym: 0x131, unicode: 0x00, modifier: 0xc0
2023-03-21 15:27:21.746 T:1178 debug <general>: HandleKey: ctrl-rightctrl (0x1f0d1) pressed, window 12002, action is
2023-03-21 15:27:22.179 T:1178 debug <general>: Keyboard: scancode: 0x61, sym: 0x131, unicode: 0x00, modifier: 0x0
2023-03-21 15:27:24.612 T:2225 error <general>: IAGL: Status of launch is unknown for Pengo, current window id 12002
2023-03-21 15:27:24.622 T:2225 debug <general>: CPythonInvoker(15, /storage/.kodi/addons/plugin.program.iagl/addon.py): script successfully run
2023-03-21 15:27:24.622 T:2225 debug <general>: onExecutionDone(15, /storage/.kodi/addons/plugin.program.iagl/addon.py)
2023-03-21 15:27:24.648 T:1178 debug <general>: ------ Window Init (DialogNotification.xml) ------
2023-03-21 15:27:24.654 T:2225 debug <general>: .
2023-03-21 15:27:24.764 T:2225 debug <general>: Python interpreter stopped
2023-03-21 15:27:24.764 T:2225 debug <general>: Thread LanguageInvoker 3498046080 terminating
2023-03-21 15:27:24.766 T:2224 error <general>: GetDirectory - Error getting plugin://plugin.program.iagl/game/MAME_2003_Plus_ZachMorris/Pengo+%28set+1+rev+c%29
2023-03-21 15:27:24.766 T:2224 debug <general>: Thread waiting 3352056448 terminating
One more clue. If I uninstall IAGL 3.0.7 and install IAGL 3.0.6 from the plugin.program.iagl-3.0.6 zip file, then repopulate the Mame 2003 Plus list, the game Pengo launches as it should.
Just curious, by any chance was a different version of Python used in 3.07 Vs 3.06? Kinda smells like that kind of problem to me, just knowing that new versions of Python are notorious for breaking things, but I'm totally guessing here.
Tracked down the issue. Seems to be a problem with Kodi's new infotag, so I reverted it to the old method
Version 3.07 of IAGL seems to be broken on LibreELEC-RR on an RPi4. The previous version, 3.06, works fine but in 3.07 no games will launch from any list. When attempting to open a list, or clicking on a game in a list, errors like "EXCEPTION: The parameter "genre" must be either a Tuple or a List" and "EXCEPTION: The parameter "studios" must be either a Tuple or a List" appear in the log. Additional errors appear in the log when I attempt to launch a game.
I've annotated the log, below, to indicate what I was doing in Kodi when errors occured...