search

jhjdekker98 / plugin.audio.spotifyd-client

A simple KODI client wrapper for SpotifyD
GNU General Public License v3.0
3 stars 2 forks source link

can't connect #1

Open theovermaze opened 1 year ago

theovermaze commented 1 year ago

Hi. I just tested your addon on a Vero4k+ with osmc 2022.10-1. Results:

Compilation of SpotifyD failed with the following error:

osmc@osmc-vero4k:~/spotifyd$ cargo build --release
warning: unused manifest key: package.rust-version
    Updating crates.io index
  Downloaded proc-macro-error v1.0.4
  Downloaded adler v1.0.2
  Downloaded semver v0.9.0
  Downloaded cipher v0.2.5
  Downloaded cc v1.0.73
  Downloaded chrono v0.4.22
  Downloaded clap v2.34.0
  Downloaded cfg-if v0.1.10
  Downloaded thiserror-impl v1.0.36
  Downloaded semver-parser v0.7.0
  Downloaded scopeguard v1.1.0
  Downloaded itoa v1.0.3
  Downloaded indexmap v1.9.1
error: failed to parse manifest at `/home/osmc/.cargo/registry/src/github.com-1285ae84e5963aae/indexmap-1.9.1/Cargo.toml`

Caused by:
  failed to parse the `edition` key

Caused by:
  this version of Cargo is older than the `2021` edition, and only supports `2015` and `2018` editions.

So i just downloaded spotifyd-linux-armhf-default.tar.gz for the spotifyd file.

Addon installed successfully in kodi. After chmod+x of /.kodi/addons/plugin.audio.spotifyd-client/resources/lib/spotifyd/spotifyd i could see the device "JeroenMediaServer" on the Spotify Android App. But it just says "connecting" for some time and the stops.

Client ID and Client Secret is configured.

spotifyd.conf:

[global]
# A command that gets executed in your shell after each song changes.
on_song_change_hook = "echo 1 > /tmp/songChange.tmp"

# The name that gets displayed under the connect tab on
# official clients. Spaces are not allowed!
device_name = "JeroenMediaServer"

# If set to true, enables volume normalisation between songs.
volume_normalisation = true

# The normalisation pregain that is applied for each song.
normalisation_pregain = -5

# The displayed device type in Spotify clients.
# Can be unknown, computer, tablet, smartphone, speaker, t_v,
# a_v_r (Audio/Video Receiver), s_t_b (Set-Top Box), and audio_dongle.
device_type = "a_v_r"

Is there something i could try?

jhjdekker98 commented 1 year ago

I've seen the issue before - I don't remember off the top of my head what the cause is but I'm looking into it. This is also a reminder to myself to make the name of the spotify connect speaker configurable :)

jhjdekker98 commented 1 year ago

@theovermaze There might be an issue with either the sound being sent to the incorrect audio device, or the audio device being busy (in the case of ALSA, pulse is a separate feature flag). Could you give me the output of the following commands?

  1. aplay -l
  2. pacmd list-sinks | grep -e 'name:' -e 'index:'
  3. cat ~/.kodi/addons/plugin.audio.spotifyd-client/songs.log (note: feel free to redact the authentication in the log)
  4. cat ~/.kodi/addons/plugin.audio.spotifyd-client/error.log
  5. cat ~/.kodi/temp/kodi.log
theovermaze commented 1 year ago

Here is the output. Thanks for the help!

1.

osmc@osmc-vero4k:~$ aplay -l
**** List of PLAYBACK Hardware Devices ****
card 0: AMLMESONAUDIO [AML-MESONAUDIO], device 0: I2S T9015-audio-hifi-0 []
  Subdevices: 1/1
  Subdevice #0: subdevice #0
card 0: AMLMESONAUDIO [AML-MESONAUDIO], device 1: SPDIF dit-hifi-1 []
  Subdevices: 1/1
  Subdevice #0: subdevice #0
card 0: AMLMESONAUDIO [AML-MESONAUDIO], device 2: PCM pcm2bt-pcm-2 []
  Subdevices: 1/1
  Subdevice #0: subdevice #0

2.

osmc@osmc-vero4k:~$ pacmd list-sinks | grep -e 'name:' -e 'index:'
-bash: pacmd: command not found

So no PulseAudio? 3.

osmc@osmc-vero4k:~$ cat ~/.kodi/addons/plugin.audio.spotifyd-client/songs.log
Loading config from "/home/osmc/.kodi/addons/plugin.audio.spotifyd-client/resources/spotifyd.conf"
No proxy specified
Using software volume controller.
Connecting to AP "ap.spotify.com:443"
Authenticated as "username removed from log" !
Country: "AT"
Using Alsa sink with format: S16
Running "echo 1 > /tmp/songChange.tmp" using "/bin/bash" with environment variables {"VOLUME": "65535", "PLAYER_EVENT": "volumeset"}

4.

osmc@osmc-vero4k:~$ cat ~/.kodi/addons/plugin.audio.spotifyd-client/error.log
cat: /home/osmc/.kodi/addons/plugin.audio.spotifyd-client/error.log: No such file or directory

5.

osmc@osmc-vero4k:~$ cat ~/.kodi/temp/kodi.log
2023-01-23 15:52:39.397 T:2754     INFO <general>: -----------------------------------------------------------------------
2023-01-23 15:52:39.397 T:2754     INFO <general>: Starting Kodi (19.4). Platform: Linux ARM 32-bit
2023-01-23 15:52:39.397 T:2754     INFO <general>: Using Release Kodi x32 build (version for Vero)
2023-01-23 15:52:39.397 T:2754     INFO <general>: Kodi compiled 2022-11-05 by GCC 10.2.1 for Linux ARM 32-bit version 5.10.106 (330346)
2023-01-23 15:52:39.397 T:2754     INFO <general>: Running on OSMC Vero 4K / Vero 4K + with Open Source Media Center 2022.10-1, kernel: Linux ARM 32-bit version 4.9.269-16-osmc
2023-01-23 15:52:39.414 T:2754     INFO <general>: FFmpeg version/source: 4.3.2-Kodi
2023-01-23 15:52:39.414 T:2754     INFO <general>: 4 CPU cores available
2023-01-23 15:52:39.414 T:2754     INFO <general>: ARM Features: Neon disabled
2023-01-23 15:52:39.414 T:2754     INFO <general>: special://xbmc/ is mapped to: /usr/share/kodi
2023-01-23 15:52:39.414 T:2754     INFO <general>: special://xbmcbin/ is mapped to: /usr/lib/kodi
2023-01-23 15:52:39.414 T:2754     INFO <general>: special://xbmcbinaddons/ is mapped to: /usr/lib/kodi/addons
2023-01-23 15:52:39.414 T:2754     INFO <general>: special://masterprofile/ is mapped to: /home/osmc/.kodi/userdata
2023-01-23 15:52:39.414 T:2754     INFO <general>: special://envhome/ is mapped to: /home/osmc
2023-01-23 15:52:39.414 T:2754     INFO <general>: special://home/ is mapped to: /home/osmc/.kodi
2023-01-23 15:52:39.414 T:2754     INFO <general>: special://temp/ is mapped to: /home/osmc/.kodi/temp
2023-01-23 15:52:39.414 T:2754     INFO <general>: special://logpath/ is mapped to: /home/osmc/.kodi/temp
2023-01-23 15:52:39.414 T:2754     INFO <general>: The executable running is: /usr/lib/kodi/kodi.bin
2023-01-23 15:52:39.414 T:2754     INFO <general>: Local hostname: osmc-vero4k
2023-01-23 15:52:39.414 T:2754     INFO <general>: Log File is located: /home/osmc/.kodi/temp/kodi.log
2023-01-23 15:52:39.416 T:2754     INFO <general>: -----------------------------------------------------------------------
2023-01-23 15:52:39.416 T:2754     INFO <general>: loading settings
2023-01-23 15:52:39.420 T:2754     INFO <general>: special://profile/ is mapped to: special://masterprofile/
2023-01-23 15:52:39.456 T:2754     INFO <general>: Loaded settings file from special://xbmc/system/advancedsettings.xml
2023-01-23 15:52:39.458 T:2754     INFO <general>: Contents of special://xbmc/system/advancedsettings.xml are...
                                                   <?xml version="1.0" encoding="UTF-8" ?>
                                                   <!-- Do not modify! These are OSMC Optimised Settings for your device  !-->
                                                   <!-- If you wish to override any of these values, then create a file in /home/osmc/.kodi/userdata/advancedsettings.xml !-->
                                                   <!-- It will override these settings, and your settings will be preserved across OSMC updates !-->
                                                   <advancedsettings version="1.0">
                                                     <imageres>540</imageres>
                                                     <fanartres>720</fanartres>
                                                     <splash>false</splash>
                                                     <handlemounting>0</handlemounting>
                                                     <samba>
                                                       <clienttimeout>30</clienttimeout>
                                                     </samba>
                                                     <cache>
                                                       <buffermode>1</buffermode>
                                                       <memorysize>524880000</memorysize>
                                                       <readfactor>5.0</readfactor>
                                                     </cache>
                                                     <cputempcommand>/bin/sed -e &apos;s/\([0-9]*\)[0-9]\{3\}.*/\1 C/&apos; /sys/class/thermal/thermal_zone0/temp</cputempcommand>
                                                     <gputempcommand>/bin/sed -e &apos;s/\([0-9]*\)[0-9]\{3\}.*/\1 C/&apos; /sys/class/thermal/thermal_zone0/temp</gputempcommand>
                                                     <gamesgeneral>
                                                       <enable>true</enable>
                                                     </gamesgeneral>
                                                     <smartredraw>true</smartredraw>
                                                     <videoscreen>
                                                       <screen>0</screen>
                                                     </videoscreen>
                                                   </advancedsettings>

2023-01-23 15:52:39.459 T:2754     INFO <general>: No settings file to load (special://masterprofile/advancedsettings.xml)
2023-01-23 15:52:39.460 T:2754     INFO <general>: Default Video Player: VideoPlayer
2023-01-23 15:52:39.460 T:2754     INFO <general>: Default Audio Player: paplayer
2023-01-23 15:52:39.460 T:2754     INFO <general>: Disabled debug logging due to GUI setting. Level 0.
2023-01-23 15:52:39.460 T:2754     INFO <general>: Log level changed to "INFO"
2023-01-23 15:52:39.460 T:2754     INFO <general>: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml
2023-01-23 15:52:39.583 T:2754     INFO <general>: creating subdirectories
2023-01-23 15:52:39.584 T:2754     INFO <general>: userdata folder: special://masterprofile/
2023-01-23 15:52:39.584 T:2754     INFO <general>: recording folder:
2023-01-23 15:52:39.584 T:2754     INFO <general>: screenshots folder:
2023-01-23 15:52:39.593 T:2754     INFO <general>: Running database version Addons33
2023-01-23 15:52:40.352 T:2754     INFO <general>: CAddonMgr::FindAddons: audiodecoder.2sf v19.0.4 installed
2023-01-23 15:52:40.352 T:2754     INFO <general>: CAddonMgr::FindAddons: audiodecoder.asap v19.0.2 installed
2023-01-23 15:52:40.353 T:2754     INFO <general>: CAddonMgr::FindAddons: audiodecoder.dumb v19.0.3 installed
2023-01-23 15:52:40.353 T:2754     INFO <general>: CAddonMgr::FindAddons: audiodecoder.gme v19.0.3 installed
2023-01-23 15:52:40.353 T:2754     INFO <general>: CAddonMgr::FindAddons: audiodecoder.gsf v19.0.2 installed
2023-01-23 15:52:40.353 T:2754     INFO <general>: CAddonMgr::FindAddons: audiodecoder.hvl v19.0.2 installed
2023-01-23 15:52:40.354 T:2754     INFO <general>: CAddonMgr::FindAddons: audiodecoder.modplug v19.0.2 installed
2023-01-23 15:52:40.354 T:2754     INFO <general>: CAddonMgr::FindAddons: audiodecoder.ncsf v19.0.2 installed
2023-01-23 15:52:40.354 T:2754     INFO <general>: CAddonMgr::FindAddons: audiodecoder.nosefart v19.0.2 installed
2023-01-23 15:52:40.354 T:2754     INFO <general>: CAddonMgr::FindAddons: audiodecoder.openmpt v19.0.1 installed
2023-01-23 15:52:40.355 T:2754     INFO <general>: CAddonMgr::FindAddons: audiodecoder.organya v19.0.2 installed
2023-01-23 15:52:40.355 T:2754     INFO <general>: CAddonMgr::FindAddons: audiodecoder.qsf v19.0.1 installed
2023-01-23 15:52:40.355 T:2754     INFO <general>: CAddonMgr::FindAddons: audiodecoder.sacd v19.0.2 installed
2023-01-23 15:52:40.356 T:2754     INFO <general>: CAddonMgr::FindAddons: audiodecoder.sidplay v19.0.1 installed
2023-01-23 15:52:40.356 T:2754     INFO <general>: CAddonMgr::FindAddons: audiodecoder.snesapu v19.0.2 installed
2023-01-23 15:52:40.356 T:2754     INFO <general>: CAddonMgr::FindAddons: audiodecoder.ssf v19.0.2 installed
2023-01-23 15:52:40.356 T:2754     INFO <general>: CAddonMgr::FindAddons: audiodecoder.stsound v19.0.1 installed
2023-01-23 15:52:40.356 T:2754     INFO <general>: CAddonMgr::FindAddons: audiodecoder.timidity v19.0.2 installed
2023-01-23 15:52:40.357 T:2754     INFO <general>: CAddonMgr::FindAddons: audiodecoder.upse v19.0.1 installed
2023-01-23 15:52:40.357 T:2754     INFO <general>: CAddonMgr::FindAddons: audiodecoder.vgmstream v19.0.0 installed
2023-01-23 15:52:40.358 T:2754     INFO <general>: CAddonMgr::FindAddons: audiodecoder.wsr v19.0.2 installed
2023-01-23 15:52:40.358 T:2754     INFO <general>: CAddonMgr::FindAddons: audioencoder.flac v19.0.1 installed
2023-01-23 15:52:40.358 T:2754     INFO <general>: CAddonMgr::FindAddons: audioencoder.kodi.builtin.aac v1.0.2 installed
2023-01-23 15:52:40.358 T:2754     INFO <general>: CAddonMgr::FindAddons: audioencoder.kodi.builtin.wma v1.0.2 installed
2023-01-23 15:52:40.359 T:2754     INFO <general>: CAddonMgr::FindAddons: audioencoder.lame v19.1.2 installed
2023-01-23 15:52:40.359 T:2754     INFO <general>: CAddonMgr::FindAddons: audioencoder.vorbis v19.0.1 installed
2023-01-23 15:52:40.359 T:2754     INFO <general>: CAddonMgr::FindAddons: audioencoder.wav v19.0.1 installed
2023-01-23 15:52:40.359 T:2754     INFO <general>: CAddonMgr::FindAddons: game.controller.default v1.0.35 installed
2023-01-23 15:52:40.360 T:2754     INFO <general>: CAddonMgr::FindAddons: game.controller.snes v1.0.34 installed
2023-01-23 15:52:40.360 T:2754     INFO <general>: CAddonMgr::FindAddons: game.libretro v19.0.3 installed
2023-01-23 15:52:40.360 T:2754     INFO <general>: CAddonMgr::FindAddons: game.libretro.2048 v1.0.0.129 installed
2023-01-23 15:52:40.360 T:2754     INFO <general>: CAddonMgr::FindAddons: imagedecoder.heif v19.0.0 installed
2023-01-23 15:52:40.361 T:2754     INFO <general>: CAddonMgr::FindAddons: imagedecoder.mpo v19.0.0 installed
2023-01-23 15:52:40.361 T:2754     INFO <general>: CAddonMgr::FindAddons: imagedecoder.raw v19.0.0 installed
2023-01-23 15:52:40.361 T:2754     INFO <general>: CAddonMgr::FindAddons: inputstream.adaptive v19.0.7 installed
2023-01-23 15:52:40.361 T:2754     INFO <general>: CAddonMgr::FindAddons: inputstream.ffmpegdirect v19.0.3 installed
2023-01-23 15:52:40.362 T:2754     INFO <general>: CAddonMgr::FindAddons: inputstream.rtmp v19.0.1 installed
2023-01-23 15:52:40.362 T:2754     INFO <general>: CAddonMgr::FindAddons: kodi.binary.global.audioengine v1.1.1 installed
2023-01-23 15:52:40.362 T:2754     INFO <general>: CAddonMgr::FindAddons: kodi.binary.global.filesystem v1.1.6 installed
2023-01-23 15:52:40.362 T:2754     INFO <general>: CAddonMgr::FindAddons: kodi.binary.global.general v1.0.5 installed
2023-01-23 15:52:40.363 T:2754     INFO <general>: CAddonMgr::FindAddons: kodi.binary.global.gui v5.15.0 installed
2023-01-23 15:52:40.363 T:2754     INFO <general>: CAddonMgr::FindAddons: kodi.binary.global.main v1.3.0 installed
2023-01-23 15:52:40.363 T:2754     INFO <general>: CAddonMgr::FindAddons: kodi.binary.global.network v1.0.4 installed
2023-01-23 15:52:40.363 T:2754     INFO <general>: CAddonMgr::FindAddons: kodi.binary.global.tools v1.0.4 installed
2023-01-23 15:52:40.364 T:2754     INFO <general>: CAddonMgr::FindAddons: kodi.binary.instance.audiodecoder v3.0.0 installed
2023-01-23 15:52:40.364 T:2754     INFO <general>: CAddonMgr::FindAddons: kodi.binary.instance.audioencoder v2.1.0 installed
2023-01-23 15:52:40.364 T:2754     INFO <general>: CAddonMgr::FindAddons: kodi.binary.instance.game v2.1.1 installed
2023-01-23 15:52:40.365 T:2754     INFO <general>: CAddonMgr::FindAddons: kodi.binary.instance.imagedecoder v2.1.1 installed
2023-01-23 15:52:40.365 T:2754     INFO <general>: CAddonMgr::FindAddons: kodi.binary.instance.inputstream v3.0.1 installed
2023-01-23 15:52:40.365 T:2754     INFO <general>: CAddonMgr::FindAddons: kodi.binary.instance.peripheral v2.0.0 installed
2023-01-23 15:52:40.365 T:2754     INFO <general>: CAddonMgr::FindAddons: kodi.binary.instance.pvr v7.1.0 installed
2023-01-23 15:52:40.366 T:2754     INFO <general>: CAddonMgr::FindAddons: kodi.binary.instance.screensaver v2.1.0 installed
2023-01-23 15:52:40.366 T:2754     INFO <general>: CAddonMgr::FindAddons: kodi.binary.instance.vfs v3.0.0 installed
2023-01-23 15:52:40.366 T:2754     INFO <general>: CAddonMgr::FindAddons: kodi.binary.instance.videocodec v2.0.2 installed
2023-01-23 15:52:40.366 T:2754     INFO <general>: CAddonMgr::FindAddons: kodi.binary.instance.visualization v3.0.0 installed
2023-01-23 15:52:40.367 T:2754     INFO <general>: CAddonMgr::FindAddons: kodi.resource v1.0.0 installed
2023-01-23 15:52:40.367 T:2754     INFO <general>: CAddonMgr::FindAddons: metadata.album.universal v3.1.9 installed
2023-01-23 15:52:40.368 T:2754     INFO <general>: CAddonMgr::FindAddons: metadata.artists.universal v4.3.10 installed
2023-01-23 15:52:40.368 T:2754     INFO <general>: CAddonMgr::FindAddons: metadata.common.allmusic.com v3.2.2 installed
2023-01-23 15:52:40.368 T:2754     INFO <general>: CAddonMgr::FindAddons: metadata.common.fanart.tv v3.6.4 installed
2023-01-23 15:52:40.369 T:2754     INFO <general>: CAddonMgr::FindAddons: metadata.common.imdb.com v3.2.7 installed
2023-01-23 15:52:40.369 T:2754     INFO <general>: CAddonMgr::FindAddons: metadata.common.musicbrainz.org v2.2.4 installed
2023-01-23 15:52:40.369 T:2754     INFO <general>: CAddonMgr::FindAddons: metadata.common.theaudiodb.com v2.0.3 installed
2023-01-23 15:52:40.370 T:2754     INFO <general>: CAddonMgr::FindAddons: metadata.common.themoviedb.org v3.2.18 installed
2023-01-23 15:52:40.370 T:2754     INFO <general>: CAddonMgr::FindAddons: metadata.generic.albums v1.0.14 installed
2023-01-23 15:52:40.370 T:2754     INFO <general>: CAddonMgr::FindAddons: metadata.generic.artists v1.0.14 installed
2023-01-23 15:52:40.370 T:2754     INFO <general>: CAddonMgr::FindAddons: metadata.local v1.0.1 installed
2023-01-23 15:52:40.371 T:2754     INFO <general>: CAddonMgr::FindAddons: metadata.themoviedb.org v5.2.6 installed
2023-01-23 15:52:40.371 T:2754     INFO <general>: CAddonMgr::FindAddons: metadata.themoviedb.org.python v2.0.0 installed
2023-01-23 15:52:40.371 T:2754     INFO <general>: CAddonMgr::FindAddons: metadata.tvdb.com v3.2.8 installed
2023-01-23 15:52:40.371 T:2754     INFO <general>: CAddonMgr::FindAddons: metadata.tvshows.themoviedb.org v3.5.14 installed
2023-01-23 15:52:40.372 T:2754     INFO <general>: CAddonMgr::FindAddons: metadata.tvshows.themoviedb.org.python v1.4.18 installed
2023-01-23 15:52:40.372 T:2754     INFO <general>: CAddonMgr::FindAddons: peripheral.joystick v19.0.3 installed
2023-01-23 15:52:40.372 T:2754     INFO <general>: CAddonMgr::FindAddons: peripheral.xarcade v19.0.4 installed
2023-01-23 15:52:40.372 T:2754     INFO <general>: CAddonMgr::FindAddons: plugin.audio.spotifyd-client v0.3.1 installed
2023-01-23 15:52:40.373 T:2754     INFO <general>: CAddonMgr::FindAddons: plugin.program.autocompletion v2.1.2 installed
2023-01-23 15:52:40.373 T:2754     INFO <general>: CAddonMgr::FindAddons: plugin.video.orftvthek v0.12.7+matrix.1 installed
2023-01-23 15:52:40.373 T:2754     INFO <general>: CAddonMgr::FindAddons: plugin.video.youtube v6.8.24+matrix.1 installed
2023-01-23 15:52:40.373 T:2754     INFO <general>: CAddonMgr::FindAddons: plugin.video.zappntv v1.3.5+matrix.1 installed
2023-01-23 15:52:40.374 T:2754     INFO <general>: CAddonMgr::FindAddons: plugin.video.zdf_de_2016 v1.0.18 installed
2023-01-23 15:52:40.374 T:2754     INFO <general>: CAddonMgr::FindAddons: pvr.argustv v19.2.1 installed
2023-01-23 15:52:40.374 T:2754     INFO <general>: CAddonMgr::FindAddons: pvr.dvblink v19.0.1 installed
2023-01-23 15:52:40.374 T:2754     INFO <general>: CAddonMgr::FindAddons: pvr.dvbviewer v19.1.0 installed
2023-01-23 15:52:40.375 T:2754     INFO <general>: CAddonMgr::FindAddons: pvr.filmon v19.0.1 installed
2023-01-23 15:52:40.375 T:2754     INFO <general>: CAddonMgr::FindAddons: pvr.freebox v19.0.0 installed
2023-01-23 15:52:40.375 T:2754     INFO <general>: CAddonMgr::FindAddons: pvr.hdhomerun v19.1.0 installed
2023-01-23 15:52:40.375 T:2754     INFO <general>: CAddonMgr::FindAddons: pvr.hts v19.0.6 installed
2023-01-23 15:52:40.376 T:2754     INFO <general>: CAddonMgr::FindAddons: pvr.iptvsimple v19.2.2 installed
2023-01-23 15:52:40.376 T:2754     INFO <general>: CAddonMgr::FindAddons: pvr.mediaportal.tvserver v19.0.2 installed
2023-01-23 15:52:40.376 T:2754     INFO <general>: CAddonMgr::FindAddons: pvr.mythtv v19.0.11 installed
2023-01-23 15:52:40.376 T:2754     INFO <general>: CAddonMgr::FindAddons: pvr.nextpvr v19.0.4 installed
2023-01-23 15:52:40.377 T:2754     INFO <general>: CAddonMgr::FindAddons: pvr.njoy v19.0.1 installed
2023-01-23 15:52:40.377 T:2754     INFO <general>: CAddonMgr::FindAddons: pvr.octonet v19.0.0 installed
2023-01-23 15:52:40.377 T:2754     INFO <general>: CAddonMgr::FindAddons: pvr.pctv v19.0.1 installed
2023-01-23 15:52:40.378 T:2754     INFO <general>: CAddonMgr::FindAddons: pvr.sledovanitv.cz v4.5.1 installed
2023-01-23 15:52:40.378 T:2754     INFO <general>: CAddonMgr::FindAddons: pvr.stalker v19.0.4 installed
2023-01-23 15:52:40.378 T:2754     INFO <general>: CAddonMgr::FindAddons: pvr.teleboy v19.8.12 installed
2023-01-23 15:52:40.378 T:2754     INFO <general>: CAddonMgr::FindAddons: pvr.vbox v19.0.0 installed
2023-01-23 15:52:40.379 T:2754     INFO <general>: CAddonMgr::FindAddons: pvr.vdr.vnsi v19.0.5 installed
2023-01-23 15:52:40.379 T:2754     INFO <general>: CAddonMgr::FindAddons: pvr.vuplus v19.0.0 installed
2023-01-23 15:52:40.379 T:2754     INFO <general>: CAddonMgr::FindAddons: pvr.waipu v19.3.1 installed
2023-01-23 15:52:40.380 T:2754     INFO <general>: CAddonMgr::FindAddons: pvr.wmc v19.0.2 installed
2023-01-23 15:52:40.380 T:2754     INFO <general>: CAddonMgr::FindAddons: pvr.zattoo v19.7.16 installed
2023-01-23 15:52:40.380 T:2754     INFO <general>: CAddonMgr::FindAddons: repository.kodi.yatse.tv v1.1.0 installed
2023-01-23 15:52:40.380 T:2754     INFO <general>: CAddonMgr::FindAddons: repository.kodinerds v7.0.1.2 installed
2023-01-23 15:52:40.381 T:2754     INFO <general>: CAddonMgr::FindAddons: repository.xbmc.org v9.9.11 installed
2023-01-23 15:52:40.381 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.images.recordlabels.white v0.0.7 installed
2023-01-23 15:52:40.381 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.images.studios.white v0.0.30 installed
2023-01-23 15:52:40.381 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.images.weathericons.default v1.1.9 installed
2023-01-23 15:52:40.382 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.af_za v999.999.999 installed
2023-01-23 15:52:40.382 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.am_et v999.999.999 installed
2023-01-23 15:52:40.382 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.ar_sa v999.999.999 installed
2023-01-23 15:52:40.382 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.ast_es v999.999.999 installed
2023-01-23 15:52:40.383 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.az_az v999.999.999 installed
2023-01-23 15:52:40.383 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.be_by v999.999.999 installed
2023-01-23 15:52:40.383 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.bg_bg v999.999.999 installed
2023-01-23 15:52:40.383 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.bs_ba v999.999.999 installed
2023-01-23 15:52:40.384 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.ca_es v999.999.999 installed
2023-01-23 15:52:40.384 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.cs_cz v999.999.999 installed
2023-01-23 15:52:40.384 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.cy_gb v999.999.999 installed
2023-01-23 15:52:40.385 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.da_dk v999.999.999 installed
2023-01-23 15:52:40.385 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.de_de v999.999.999 installed
2023-01-23 15:52:40.385 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.el_gr v999.999.999 installed
2023-01-23 15:52:40.385 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.en_au v999.999.999 installed
2023-01-23 15:52:40.386 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.en_gb v999.999.999 installed
2023-01-23 15:52:40.386 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.en_nz v999.999.999 installed
2023-01-23 15:52:40.386 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.en_us v999.999.999 installed
2023-01-23 15:52:40.387 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.eo v999.999.999 installed
2023-01-23 15:52:40.387 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.es_ar v999.999.999 installed
2023-01-23 15:52:40.388 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.es_es v999.999.999 installed
2023-01-23 15:52:40.388 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.es_mx v999.999.999 installed
2023-01-23 15:52:40.388 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.et_ee v999.999.999 installed
2023-01-23 15:52:40.388 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.eu_es v999.999.999 installed
2023-01-23 15:52:40.389 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.fa_af v999.999.999 installed
2023-01-23 15:52:40.389 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.fa_ir v999.999.999 installed
2023-01-23 15:52:40.389 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.fi_fi v999.999.999 installed
2023-01-23 15:52:40.389 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.fil v999.999.999 installed
2023-01-23 15:52:40.390 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.fo_fo v999.999.999 installed
2023-01-23 15:52:40.390 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.fr_ca v999.999.999 installed
2023-01-23 15:52:40.390 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.fr_fr v999.999.999 installed
2023-01-23 15:52:40.390 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.gl_es v999.999.999 installed
2023-01-23 15:52:40.391 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.he_il v999.999.999 installed
2023-01-23 15:52:40.391 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.hi_in v999.999.999 installed
2023-01-23 15:52:40.391 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.hr_hr v999.999.999 installed
2023-01-23 15:52:40.391 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.hu_hu v999.999.999 installed
2023-01-23 15:52:40.392 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.hy_am v999.999.999 installed
2023-01-23 15:52:40.392 T:2870     INFO <general>: Loading special://xbmc/system/Lircmap.xml
2023-01-23 15:52:40.392 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.id_id v999.999.999 installed
2023-01-23 15:52:40.393 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.is_is v999.999.999 installed
2023-01-23 15:52:40.393 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.it_it v999.999.999 installed
2023-01-23 15:52:40.393 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.ja_jp v999.999.999 installed
2023-01-23 15:52:40.394 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.kn_in v999.999.999 installed
2023-01-23 15:52:40.394 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.ko_kr v999.999.999 installed
2023-01-23 15:52:40.394 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.lt_lt v999.999.999 installed
2023-01-23 15:52:40.395 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.lv_lv v999.999.999 installed
2023-01-23 15:52:40.395 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.mi v999.999.999 installed
2023-01-23 15:52:40.395 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.mk_mk v999.999.999 installed
2023-01-23 15:52:40.396 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.ml_in v999.999.999 installed
2023-01-23 15:52:40.396 T:2870     INFO <general>: * Adding remote mapping for device 'mceusb'
2023-01-23 15:52:40.396 T:2870     INFO <general>: * Adding remote mapping for device 'XboxDVDDongle'
2023-01-23 15:52:40.396 T:2870     INFO <general>: * Adding remote mapping for device 'Microsoft_Xbox'
2023-01-23 15:52:40.396 T:2870     INFO <general>: * Adding remote mapping for device 'PinnacleSysPCTVRemote'
2023-01-23 15:52:40.396 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.mn_mn v999.999.999 installed
2023-01-23 15:52:40.396 T:2870     INFO <general>: * Adding remote mapping for device 'anysee'
2023-01-23 15:52:40.396 T:2870     INFO <general>: * Adding remote mapping for device 'iMON-PAD'
2023-01-23 15:52:40.396 T:2870     INFO <general>: * Adding remote mapping for device 'Antec_Veris_RM200'
2023-01-23 15:52:40.396 T:2870     INFO <general>: * Adding remote mapping for device 'MCE_via_iMON'
2023-01-23 15:52:40.397 T:2870     INFO <general>: * Adding remote mapping for device 'TwinHanRemote'
2023-01-23 15:52:40.397 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.ms_my v999.999.999 installed
2023-01-23 15:52:40.397 T:2870     INFO <general>: * Adding remote mapping for device 'linux-input-layer'
2023-01-23 15:52:40.397 T:2870     INFO <general>: * Linking remote mapping for 'linux-input-layer' to 'cx23885_remote'
2023-01-23 15:52:40.397 T:2870     INFO <general>: * Adding remote mapping for device 'mediacenter'
2023-01-23 15:52:40.397 T:2870     INFO <general>: * Adding remote mapping for device 'devinput'
2023-01-23 15:52:40.397 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.mt_mt v999.999.999 installed
2023-01-23 15:52:40.397 T:2870     INFO <general>: * Adding remote mapping for device 'devinput-32'
2023-01-23 15:52:40.397 T:2870     INFO <general>: * Adding remote mapping for device 'devinput-64'
2023-01-23 15:52:40.397 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.my_mm v999.999.999 installed
2023-01-23 15:52:40.398 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.nb_no v999.999.999 installed
2023-01-23 15:52:40.398 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.nl_nl v999.999.999 installed
2023-01-23 15:52:40.399 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.os_os v999.999.999 installed
2023-01-23 15:52:40.399 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.pl_pl v999.999.999 installed
2023-01-23 15:52:40.399 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.pt_br v999.999.999 installed
2023-01-23 15:52:40.399 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.pt_pt v999.999.999 installed
2023-01-23 15:52:40.400 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.ro_ro v999.999.999 installed
2023-01-23 15:52:40.400 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.ru_ru v999.999.999 installed
2023-01-23 15:52:40.400 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.si_lk v999.999.999 installed
2023-01-23 15:52:40.401 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.sk_sk v999.999.999 installed
2023-01-23 15:52:40.401 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.sl_si v999.999.999 installed
2023-01-23 15:52:40.401 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.sq_al v999.999.999 installed
2023-01-23 15:52:40.401 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.sr_rs v999.999.999 installed
2023-01-23 15:52:40.402 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.sr_rs@latin v999.999.999 installed
2023-01-23 15:52:40.402 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.sv_se v999.999.999 installed
2023-01-23 15:52:40.402 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.szl v999.999.999 installed
2023-01-23 15:52:40.402 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.ta_in v999.999.999 installed
2023-01-23 15:52:40.403 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.te_in v999.999.999 installed
2023-01-23 15:52:40.403 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.tg_tj v999.999.999 installed
2023-01-23 15:52:40.403 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.th_th v999.999.999 installed
2023-01-23 15:52:40.403 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.uk_ua v999.999.999 installed
2023-01-23 15:52:40.404 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.uz_uz v999.999.999 installed
2023-01-23 15:52:40.404 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.vi_vn v999.999.999 installed
2023-01-23 15:52:40.404 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.zh_cn v999.999.999 installed
2023-01-23 15:52:40.405 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.language.zh_tw v999.999.999 installed
2023-01-23 15:52:40.405 T:2754     INFO <general>: CAddonMgr::FindAddons: resource.uisounds.kodi v1.0.1 installed
2023-01-23 15:52:40.405 T:2754     INFO <general>: CAddonMgr::FindAddons: screensaver.asteroids v19.0.1 installed
2023-01-23 15:52:40.406 T:2754     INFO <general>: CAddonMgr::FindAddons: screensaver.asterwave v19.0.1 installed
2023-01-23 15:52:40.406 T:2754     INFO <general>: CAddonMgr::FindAddons: screensaver.biogenesis v19.0.1 installed
2023-01-23 15:52:40.406 T:2754     INFO <general>: CAddonMgr::FindAddons: screensaver.cpblobs v19.0.1 installed
2023-01-23 15:52:40.407 T:2754     INFO <general>: CAddonMgr::FindAddons: screensaver.greynetic v19.0.1 installed
2023-01-23 15:52:40.407 T:2754     INFO <general>: CAddonMgr::FindAddons: screensaver.matrixtrails v19.0.1 installed
2023-01-23 15:52:40.407 T:2754     INFO <general>: CAddonMgr::FindAddons: screensaver.pingpong v19.0.1 installed
2023-01-23 15:52:40.407 T:2754     INFO <general>: CAddonMgr::FindAddons: screensaver.pyro v19.0.1 installed
2023-01-23 15:52:40.408 T:2754     INFO <general>: CAddonMgr::FindAddons: screensaver.shadertoy v19.0.1 installed
2023-01-23 15:52:40.408 T:2754     INFO <general>: CAddonMgr::FindAddons: screensaver.xbmc.builtin.black v1.0.34 installed
2023-01-23 15:52:40.408 T:2754     INFO <general>: CAddonMgr::FindAddons: screensaver.xbmc.builtin.dim v1.0.64 installed
2023-01-23 15:52:40.409 T:2754     INFO <general>: CAddonMgr::FindAddons: script.artistslideshow v3.3.3 installed
2023-01-23 15:52:40.409 T:2754     INFO <general>: CAddonMgr::FindAddons: script.extendedinfo v6.0.1 installed
2023-01-23 15:52:40.409 T:2754     INFO <general>: CAddonMgr::FindAddons: script.favourites v8.1.2 installed
2023-01-23 15:52:40.409 T:2754     INFO <general>: CAddonMgr::FindAddons: script.image.resource.select v3.0.2 installed
2023-01-23 15:52:40.410 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.addon.signals v0.0.6+matrix.1 installed
2023-01-23 15:52:40.410 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.arrow v1.0.3.1 installed
2023-01-23 15:52:40.410 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.autocompletion v2.1.1 installed
2023-01-23 15:52:40.410 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.backports.functools_lru_cache v1.6.1 installed
2023-01-23 15:52:40.411 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.backports.zoneinfo v0.2.1 installed
2023-01-23 15:52:40.411 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.beautifulsoup v3.2.1 installed
2023-01-23 15:52:40.411 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.beautifulsoup4 v4.9.3+matrix.1 installed
2023-01-23 15:52:40.411 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.certifi v2022.9.24 installed
2023-01-23 15:52:40.412 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.chardet v4.0.0+matrix.1 installed
2023-01-23 15:52:40.412 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.cherrypy v12.0.1 installed
2023-01-23 15:52:40.412 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.dateutil v2.8.2 installed
2023-01-23 15:52:40.413 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.defusedxml v0.6.0+matrix.1 installed
2023-01-23 15:52:40.413 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.future v0.18.2+matrix.1 installed
2023-01-23 15:52:40.413 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.html2text v2020.1.16+matrix.2 installed
2023-01-23 15:52:40.413 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.html5lib v1.1.0+matrix.1 installed
2023-01-23 15:52:40.414 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.idna v3.4.0 installed
2023-01-23 15:52:40.414 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.inputstreamhelper v0.5.10+matrix.1 installed
2023-01-23 15:52:40.414 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.kodi-six v0.1.3.1 installed
2023-01-23 15:52:40.415 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.kodi65 v1.2.1 installed
2023-01-23 15:52:40.415 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.kutils v1.3.0 installed
2023-01-23 15:52:40.415 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.libmediathek3 v1.5.0 installed
2023-01-23 15:52:40.415 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.libmediathek4 v1.0.0 installed
2023-01-23 15:52:40.416 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.libzdf v5.0.2 installed
2023-01-23 15:52:40.416 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.metadatautils v1.0.37 installed
2023-01-23 15:52:40.416 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.musicbrainz v0.6.0 installed
2023-01-23 15:52:40.416 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.osmccommon v0.1.0 installed
2023-01-23 15:52:40.417 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.osmcsetting.apfstore v0.1.0 installed
2023-01-23 15:52:40.417 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.osmcsetting.logging v0.1.0 installed
2023-01-23 15:52:40.417 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.osmcsetting.networking v0.1.0 installed
2023-01-23 15:52:40.418 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.osmcsetting.remotes v0.1.0 installed
2023-01-23 15:52:40.418 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.osmcsetting.services v0.1.0 installed
2023-01-23 15:52:40.418 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.osmcsetting.updates v0.1.0 installed
2023-01-23 15:52:40.418 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.pil v5.1.0 installed
2023-01-23 15:52:40.419 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.pycryptodome v3.4.3 installed
2023-01-23 15:52:40.419 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.pyjwt v1.7.1+matrix.2 installed
2023-01-23 15:52:40.419 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.pytz v2021.3.0+matrix.1 installed
2023-01-23 15:52:40.419 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.requests v2.27.1+matrix.1 installed
2023-01-23 15:52:40.420 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.routing v0.2.3+matrix.1 installed
2023-01-23 15:52:40.420 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.simplecache v2.0.2 installed
2023-01-23 15:52:40.420 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.simpleeval v0.9.10 installed
2023-01-23 15:52:40.420 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.simplejson v3.17.0+matrix.2 installed
2023-01-23 15:52:40.421 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.six v1.15.0+matrix.1 installed
2023-01-23 15:52:40.421 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.soupsieve v2.1.0+matrix.1 installed
2023-01-23 15:52:40.421 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.thetvdb v1.0.27 installed
2023-01-23 15:52:40.421 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.trakt v4.4.0+matrix.1 installed
2023-01-23 15:52:40.422 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.typing_extensions v3.7.4.3 installed
2023-01-23 15:52:40.422 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.tzdata v2021.5 installed
2023-01-23 15:52:40.422 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.tzlocal v3.0.0+matrix.2 installed
2023-01-23 15:52:40.422 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.unidecode v1.1.1+matrix.2 installed
2023-01-23 15:52:40.423 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.urllib3 v1.26.13+matrix.1 installed
2023-01-23 15:52:40.423 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.webencodings v0.5.1+matrix.2 installed
2023-01-23 15:52:40.423 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.xmltodict v0.12.0+matrix.2 installed
2023-01-23 15:52:40.424 T:2754     INFO <general>: CAddonMgr::FindAddons: script.module.youtube.dl v21.303.0+matrix.1 installed
2023-01-23 15:52:40.424 T:2754     INFO <general>: CAddonMgr::FindAddons: script.skin.helper.colorpicker v2.0.1 installed
2023-01-23 15:52:40.424 T:2754     INFO <general>: CAddonMgr::FindAddons: script.skin.helper.skinbackup v1.0.19 installed
2023-01-23 15:52:40.425 T:2754     INFO <general>: CAddonMgr::FindAddons: script.skin.helper.widgets v1.0.38 installed
2023-01-23 15:52:40.425 T:2754     INFO <general>: CAddonMgr::FindAddons: script.skin.info.service v1.1.2 installed
2023-01-23 15:52:40.425 T:2754     INFO <general>: CAddonMgr::FindAddons: script.skinshortcuts v2.0.1 installed
2023-01-23 15:52:40.426 T:2754     INFO <general>: CAddonMgr::FindAddons: script.trakt v3.5.0 installed
2023-01-23 15:52:40.426 T:2754     INFO <general>: CAddonMgr::FindAddons: script.yatse.kodi v92.5.15 installed
2023-01-23 15:52:40.426 T:2754     INFO <general>: CAddonMgr::FindAddons: service.library.data.provider v0.4.1 installed
2023-01-23 15:52:40.426 T:2754     INFO <general>: CAddonMgr::FindAddons: service.libraryautoupdate v1.1.0 installed
2023-01-23 15:52:40.427 T:2754     INFO <general>: CAddonMgr::FindAddons: service.osmc.settings v0.1.0 installed
2023-01-23 15:52:40.427 T:2754     INFO <general>: CAddonMgr::FindAddons: service.skin.widgets v0.0.33 installed
2023-01-23 15:52:40.427 T:2754     INFO <general>: CAddonMgr::FindAddons: service.subtitles.divxplanet v0.1.1 installed
2023-01-23 15:52:40.428 T:2754     INFO <general>: CAddonMgr::FindAddons: service.subtitles.opensubtitles v5.1.4 installed
2023-01-23 15:52:40.428 T:2754     INFO <general>: CAddonMgr::FindAddons: service.subtitles.podnapisi v5.4.2 installed
2023-01-23 15:52:40.428 T:2754     INFO <general>: CAddonMgr::FindAddons: service.subtitles.rvm.addic7ed v3.1.8+matrix.1 installed
2023-01-23 15:52:40.428 T:2754     INFO <general>: CAddonMgr::FindAddons: service.subtitles.subscene v1.7.2 installed
2023-01-23 15:52:40.429 T:2754     INFO <general>: CAddonMgr::FindAddons: service.subtitles.subsceneplus v1.2.9 installed
2023-01-23 15:52:40.429 T:2754     INFO <general>: CAddonMgr::FindAddons: service.upnext v1.1.2 installed
2023-01-23 15:52:40.429 T:2754     INFO <general>: CAddonMgr::FindAddons: service.watchdog v0.9.7 installed
2023-01-23 15:52:40.430 T:2754     INFO <general>: CAddonMgr::FindAddons: skin.aeon.nox.silvo v8.0.1 installed
2023-01-23 15:52:40.430 T:2754     INFO <general>: CAddonMgr::FindAddons: skin.confluence v4.7.13 installed
2023-01-23 15:52:40.430 T:2754     INFO <general>: CAddonMgr::FindAddons: skin.estouchy v3.0.6 installed
2023-01-23 15:52:40.430 T:2754     INFO <general>: CAddonMgr::FindAddons: skin.estuary v3.0.5 installed
2023-01-23 15:52:40.431 T:2754     INFO <general>: CAddonMgr::FindAddons: skin.osmc v19.1.3 installed
2023-01-23 15:52:40.431 T:2754     INFO <general>: CAddonMgr::FindAddons: skin.osmc.scope v19.1.3 installed
2023-01-23 15:52:40.431 T:2754     INFO <general>: CAddonMgr::FindAddons: vfs.libarchive v19.2.0 installed
2023-01-23 15:52:40.431 T:2754     INFO <general>: CAddonMgr::FindAddons: vfs.rar v19.0.1 installed
2023-01-23 15:52:40.432 T:2754     INFO <general>: CAddonMgr::FindAddons: vfs.sftp v19.0.1 installed
2023-01-23 15:52:40.432 T:2754     INFO <general>: CAddonMgr::FindAddons: visualization.fishbmc v19.0.1 installed
2023-01-23 15:52:40.432 T:2754     INFO <general>: CAddonMgr::FindAddons: visualization.goom v19.0.2 installed
2023-01-23 15:52:40.432 T:2754     INFO <general>: CAddonMgr::FindAddons: visualization.matrix v19.0.1 installed
2023-01-23 15:52:40.433 T:2754     INFO <general>: CAddonMgr::FindAddons: visualization.pictureit v19.0.1 installed
2023-01-23 15:52:40.433 T:2754     INFO <general>: CAddonMgr::FindAddons: visualization.shadertoy v19.1.2 installed
2023-01-23 15:52:40.433 T:2754     INFO <general>: CAddonMgr::FindAddons: visualization.spectrum v19.0.2 installed
2023-01-23 15:52:40.433 T:2754     INFO <general>: CAddonMgr::FindAddons: visualization.starburst v19.0.1 installed
2023-01-23 15:52:40.434 T:2754     INFO <general>: CAddonMgr::FindAddons: visualization.waveform v19.0.3 installed
2023-01-23 15:52:40.434 T:2754     INFO <general>: CAddonMgr::FindAddons: webinterface.default v19.x-2.4.8 installed
2023-01-23 15:52:40.434 T:2754     INFO <general>: CAddonMgr::FindAddons: xbmc.addon v19.1.0 installed
2023-01-23 15:52:40.434 T:2754     INFO <general>: CAddonMgr::FindAddons: xbmc.core v0.1.0 installed
2023-01-23 15:52:40.435 T:2754     INFO <general>: CAddonMgr::FindAddons: xbmc.gui v5.15.0 installed
2023-01-23 15:52:40.435 T:2754     INFO <general>: CAddonMgr::FindAddons: xbmc.json v12.4.0 installed
2023-01-23 15:52:40.435 T:2754     INFO <general>: CAddonMgr::FindAddons: xbmc.metadata v2.1.0 installed
2023-01-23 15:52:40.435 T:2754     INFO <general>: CAddonMgr::FindAddons: xbmc.python v3.0.0 installed
2023-01-23 15:52:40.436 T:2754     INFO <general>: CAddonMgr::FindAddons: xbmc.webinterface v1.0.0 installed
2023-01-23 15:52:40.483 T:2754     INFO <general>: Selected Logind/UPower as PowerSyscall
2023-01-23 15:52:40.484 T:2754    ERROR <general>: DBus error: org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files
2023-01-23 15:52:40.484 T:2754     INFO <general>: LogindUPowerSyscall - UPower not found, battery information will not be available
2023-01-23 15:52:40.735 T:2880     INFO <general>: CAESinkALSA::EnumerateDevice - device default description
2023-01-23 15:52:40.766 T:2880     INFO <general>: CAESinkALSA - Unable to open device "bluealsa" for playback
2023-01-23 15:52:40.771 T:2880     INFO <general>: CAESinkALSA - Unable to open device "btaudio" for playback
2023-01-23 15:52:40.772 T:2880     INFO <general>: CAESinkALSA::EnumerateDevice - device hdmi:CARD=AMLMESONAUDIO,DEV=0 description AML-MESONAUDIO,
                                                   HDMI Audio Output
2023-01-23 15:52:40.773 T:2880     INFO <general>: Found 1 Lists of Devices
2023-01-23 15:52:40.773 T:2880     INFO <general>: Enumerated ALSA devices:
2023-01-23 15:52:40.773 T:2880     INFO <general>:     Device 1
2023-01-23 15:52:40.773 T:2880     INFO <general>:         m_deviceName      : default
2023-01-23 15:52:40.773 T:2880     INFO <general>:         m_displayName     : Default (AML-MESONAUDIO: HDMI, S/PDIF & analogue)
2023-01-23 15:52:40.773 T:2880     INFO <general>:         m_displayNameExtra:
2023-01-23 15:52:40.773 T:2880     INFO <general>:         m_deviceType      : AE_DEVTYPE_PCM
2023-01-23 15:52:40.773 T:2880     INFO <general>:         m_channels        : FL, FR, UNKNOWN1, LFE, FC, BC, BL, BR, BLOC, BROC
2023-01-23 15:52:40.773 T:2880     INFO <general>:         m_sampleRates     : 32000,44100,48000,64000,88200,96000,176400,192000
2023-01-23 15:52:40.773 T:2880     INFO <general>:         m_dataFormats     : AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE
2023-01-23 15:52:40.773 T:2880     INFO <general>:         m_streamTypes     : No passthrough capabilities
2023-01-23 15:52:40.774 T:2880     INFO <general>:     Device 2
2023-01-23 15:52:40.774 T:2880     INFO <general>:         m_deviceName      : hdmi:CARD=AMLMESONAUDIO,DEV=0
2023-01-23 15:52:40.774 T:2880     INFO <general>:         m_displayName     : AML-MESONAUDIO
2023-01-23 15:52:40.774 T:2880     INFO <general>:         m_displayNameExtra: HDMI
2023-01-23 15:52:40.774 T:2880     INFO <general>:         m_deviceType      : AE_DEVTYPE_HDMI
2023-01-23 15:52:40.774 T:2880     INFO <general>:         m_channels        : FL, FR, BL, BR, FC, LFE, SL, SR
2023-01-23 15:52:40.774 T:2880     INFO <general>:         m_sampleRates     : 32000,44100,48000,88200,96000,176400,192000
2023-01-23 15:52:40.774 T:2880     INFO <general>:         m_dataFormats     : AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_RAW
2023-01-23 15:52:40.774 T:2880     INFO <general>:         m_streamTypes     : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD,STREAM_TYPE_DTSHD_MA,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512,STREAM_TYPE_EAC3,STREAM_TYPE_TRUEHD
2023-01-23 15:52:40.774 T:2881     INFO <general>: CActiveAESink::OpenSink - initialize sink
2023-01-23 15:52:40.774 T:2881     INFO <general>: CAESinkALSA::Initialize - Requested layout: FL, FR
2023-01-23 15:52:40.774 T:2881     INFO <general>: CAESinkALSA::Initialize - set digital_codec 0
2023-01-23 15:52:40.774 T:2881     INFO <general>: CAESinkALSA::Initialize - Attempting to open device "default"
2023-01-23 15:52:40.780 T:2881     INFO <general>: CAESinkALSA::Initialize - Opened device "default"
2023-01-23 15:52:40.780 T:2881     INFO <general>: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
2023-01-23 15:52:40.781 T:2881     INFO <general>: CAESinkALSA::InitializeHW - Using data format AE_FMT_S24NE4
2023-01-23 15:52:40.782 T:2881     INFO <general>: CAESinkALSA::Initialize - speaker layout 0
2023-01-23 15:52:40.825 T:2754     INFO <general>: CKeyboardLayoutManager: loading keyboard layouts from special://xbmc/system/keyboardlayouts...
2023-01-23 15:52:40.997 T:2754    ERROR <general>: AML: no rw on /sys/module/amlvideodri/parameters/freerun_mode
2023-01-23 15:52:40.997 T:2754    ERROR <general>: AML: no rw on /sys/devices/system/cpu/cpu0/cpufreq/scaling_min_freq
2023-01-23 15:52:40.997 T:2754    ERROR <general>: AML: no rw on /sys/devices/system/cpu/cpu0/cpufreq/scaling_max_freq
2023-01-23 15:52:40.997 T:2754    ERROR <general>: AML: no rw on /sys/devices/system/cpu/cpu0/cpufreq/scaling_governor
2023-01-23 15:52:40.997 T:2754    ERROR <general>: AML: no rw on /sys/module/di/parameters/bypass_prog
2023-01-23 15:52:41.112 T:2754     INFO <general>: RetroPlayer[PROCESS]: Registering process control for Amlogic
2023-01-23 15:52:41.112 T:2754     INFO <general>: RetroPlayer[RENDER]: Registering renderer factory for OpenGLES
2023-01-23 15:52:41.116 T:2880     INFO <general>: CAESinkALSA::EnumerateDevice - device default description
2023-01-23 15:52:41.126 T:2754     INFO <general>: No /home/osmc/.kodi/userdata/disp_cap to read
2023-01-23 15:52:41.127 T:2754     INFO <general>: No /home/osmc/.kodi/userdata/vesa_cap to read
2023-01-23 15:52:41.127 T:2754     INFO <general>: Current display setting is 0192001080060.00000pstd
2023-01-23 15:52:41.128 T:2754     INFO <general>: Current output resolution is 0192001080059.94006pstd
2023-01-23 15:52:41.128 T:2754     INFO <general>: Found resolution 720 x 480 with 720 x 480 @ 60.000000 Hz
2023-01-23 15:52:41.128 T:2754     INFO <general>: Fallback resolution at 16 + 0 00480060.00000pstd
2023-01-23 15:52:41.128 T:2754     INFO <general>: Found resolution 720 x 480 with 720 x 480 @ 59.940060 Hz
2023-01-23 15:52:41.128 T:2754     INFO <general>: Found resolution 720 x 576 with 720 x 576 @ 50.000000 Hz
2023-01-23 15:52:41.128 T:2754     INFO <general>: Fallback resolution at 16 + 2 00576050.00000pstd
2023-01-23 15:52:41.128 T:2754     INFO <general>: Found resolution 1280 x 720 with 1280 x 720 @ 50.000000 Hz
2023-01-23 15:52:41.128 T:2754     INFO <general>: Fallback resolution at 16 + 3 00720050.00000pstd
2023-01-23 15:52:41.128 T:2754     INFO <general>: Found resolution 1280 x 720 with 1280 x 720 @ 60.000000 Hz
2023-01-23 15:52:41.128 T:2754     INFO <general>: Fallback resolution at 16 + 4 00720060.00000pstd
2023-01-23 15:52:41.128 T:2754     INFO <general>: Found resolution 1280 x 720 with 1280 x 720 @ 59.940060 Hz
2023-01-23 15:52:41.128 T:2754     INFO <general>: Found resolution 1920 x 1080 with 1920 x 1080 @ 24.000000 Hz
2023-01-23 15:52:41.128 T:2754     INFO <general>: Fallback resolution at 16 + 6 01080024.00000pstd
2023-01-23 15:52:41.128 T:2754     INFO <general>: Found resolution 1920 x 1080 with 1920 x 1080 @ 23.976025 Hz
2023-01-23 15:52:41.128 T:2754     INFO <general>: Found resolution 1920 x 1080 with 1920 x 1080 @ 25.000000 Hz
2023-01-23 15:52:41.128 T:2754     INFO <general>: Fallback resolution at 16 + 8 01080025.00000pstd
2023-01-23 15:52:41.128 T:2754     INFO <general>: Found resolution 1920 x 1080 with 1920 x 1080 @ 30.000000 Hz
2023-01-23 15:52:41.128 T:2754     INFO <general>: Fallback resolution at 16 + 9 01080030.00000pstd
2023-01-23 15:52:41.128 T:2754     INFO <general>: Found resolution 1920 x 1080 with 1920 x 1080 @ 29.970030 Hz
2023-01-23 15:52:41.128 T:2754     INFO <general>: Found resolution 1920 x 1080 with 1920 x 1080 @ 50.000000 Hz
2023-01-23 15:52:41.128 T:2754     INFO <general>: Fallback resolution at 16 + 11 01080050.00000pstd
2023-01-23 15:52:41.128 T:2754     INFO <general>: Found resolution 1920 x 1080 with 1920 x 1080 @ 60.000000 Hz
2023-01-23 15:52:41.128 T:2754     INFO <general>: Current resolution setting found at 16 + 12
2023-01-23 15:52:41.128 T:2754     INFO <general>: Found resolution 1920 x 1080 with 1920 x 1080 @ 59.940060 Hz
2023-01-23 15:52:41.128 T:2754     INFO <general>: Found resolution 640 x 480 with 640 x 480 @ 60.000000 Hz
2023-01-23 15:52:41.128 T:2754     INFO <general>: Found resolution 640 x 480 with 640 x 480 @ 59.940060 Hz
2023-01-23 15:52:41.128 T:2754     INFO <general>: Found resolution 800 x 600 with 800 x 600 @ 60.000000 Hz
2023-01-23 15:52:41.128 T:2754     INFO <general>: Found resolution 800 x 600 with 800 x 600 @ 59.940060 Hz
2023-01-23 15:52:41.128 T:2754     INFO <general>: Found resolution 1024 x 768 with 1024 x 768 @ 60.000000 Hz
2023-01-23 15:52:41.128 T:2754     INFO <general>: Found resolution 1024 x 768 with 1024 x 768 @ 59.940060 Hz
2023-01-23 15:52:41.128 T:2754     INFO <general>: Found resolution 1152 x 864 with 1152 x 864 @ 75.000000 Hz
2023-01-23 15:52:41.128 T:2754     INFO <general>: Found resolution 1280 x 800 with 1280 x 800 @ 60.000000 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 1280 x 800 with 1280 x 800 @ 59.940060 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 1280 x 1024 with 1280 x 1024 @ 60.000000 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 1280 x 1024 with 1280 x 1024 @ 59.940060 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 1440 x 900 with 1440 x 900 @ 60.000000 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 1440 x 900 with 1440 x 900 @ 59.940060 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 1600 x 900 with 1600 x 900 @ 60.000000 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 1600 x 900 with 1600 x 900 @ 59.940060 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 1680 x 1050 with 1680 x 1050 @ 60.000000 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 1680 x 1050 with 1680 x 1050 @ 59.940060 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 640 x 480 with 640 x 480 @ 60.000000 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 640 x 480 with 640 x 480 @ 59.940060 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 800 x 600 with 800 x 600 @ 60.000000 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 800 x 600 with 800 x 600 @ 59.940060 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 1024 x 768 with 1024 x 768 @ 60.000000 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 1024 x 768 with 1024 x 768 @ 59.940060 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 1152 x 864 with 1152 x 864 @ 75.000000 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 1280 x 800 with 1280 x 800 @ 60.000000 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 1280 x 800 with 1280 x 800 @ 59.940060 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 1280 x 1024 with 1280 x 1024 @ 60.000000 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 1280 x 1024 with 1280 x 1024 @ 59.940060 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 1440 x 900 with 1440 x 900 @ 60.000000 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 1440 x 900 with 1440 x 900 @ 59.940060 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 1600 x 900 with 1600 x 900 @ 60.000000 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 1600 x 900 with 1600 x 900 @ 59.940060 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 1680 x 1050 with 1680 x 1050 @ 60.000000 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found resolution 1680 x 1050 with 1680 x 1050 @ 59.940060 Hz
2023-01-23 15:52:41.129 T:2754     INFO <general>: Found 0192001080060.00000pstd at 28, setting to RES_DESKTOP at 16
2023-01-23 15:52:41.129 T:2754     INFO <general>: No /home/osmc/.kodi/userdata/disp_cap_3d to read
2023-01-23 15:52:41.130 T:2754     INFO <general>: Found 3D resolution 1280 x 720 with 1280 x 720 @ 50.000000 (FP)
2023-01-23 15:52:41.130 T:2754     INFO <general>: Found 3D resolution 1280 x 360 with 1280 x 720 @ 50.000000 (TAB)
2023-01-23 15:52:41.130 T:2754     INFO <general>: Found 3D resolution 640 x 720 with 1280 x 720 @ 50.000000 (SBS)
2023-01-23 15:52:41.130 T:2754     INFO <general>: Found 3D resolution 1280 x 720 with 1280 x 720 @ 60.000000 (FP)
2023-01-23 15:52:41.130 T:2754     INFO <general>: Found 3D resolution 1280 x 720 with 1280 x 720 @ 59.940060 (FP)
2023-01-23 15:52:41.130 T:2754     INFO <general>: Found 3D resolution 1280 x 360 with 1280 x 720 @ 60.000000 (TAB)
2023-01-23 15:52:41.130 T:2754     INFO <general>: Found 3D resolution 1280 x 360 with 1280 x 720 @ 59.940060 (TAB)
2023-01-23 15:52:41.130 T:2754     INFO <general>: Found 3D resolution 640 x 720 with 1280 x 720 @ 60.000000 (SBS)
2023-01-23 15:52:41.130 T:2754     INFO <general>: Found 3D resolution 640 x 720 with 1280 x 720 @ 59.940060 (SBS)
2023-01-23 15:52:41.130 T:2754     INFO <general>: Found 3D resolution 1920 x 1080 with 1920 x 1080 @ 24.000000 (FP)
2023-01-23 15:52:41.130 T:2754     INFO <general>: Found 3D resolution 1920 x 1080 with 1920 x 1080 @ 23.976025 (FP)
2023-01-23 15:52:41.130 T:2754     INFO <general>: Found 3D resolution 1920 x 540 with 1920 x 1080 @ 24.000000 (TAB)
2023-01-23 15:52:41.131 T:2754     INFO <general>: Found 3D resolution 1920 x 540 with 1920 x 1080 @ 23.976025 (TAB)
2023-01-23 15:52:41.131 T:2754     INFO <general>: Found 3D resolution 960 x 1080 with 1920 x 1080 @ 24.000000 (SBS)
2023-01-23 15:52:41.131 T:2754     INFO <general>: Found 3D resolution 960 x 1080 with 1920 x 1080 @ 23.976025 (SBS)
2023-01-23 15:52:41.131 T:2754     INFO <general>: Found 3D resolution 1920 x 540 with 1920 x 1080 @ 25.000000 (TAB)
2023-01-23 15:52:41.131 T:2754     INFO <general>: Found 3D resolution 960 x 1080 with 1920 x 1080 @ 25.000000 (SBS)
2023-01-23 15:52:41.131 T:2754     INFO <general>: Found 3D resolution 1920 x 540 with 1920 x 1080 @ 30.000000 (TAB)
2023-01-23 15:52:41.131 T:2754     INFO <general>: Found 3D resolution 1920 x 540 with 1920 x 1080 @ 29.970030 (TAB)
2023-01-23 15:52:41.131 T:2754     INFO <general>: Found 3D resolution 960 x 1080 with 1920 x 1080 @ 30.000000 (SBS)
2023-01-23 15:52:41.131 T:2754     INFO <general>: Found 3D resolution 960 x 1080 with 1920 x 1080 @ 29.970030 (SBS)
2023-01-23 15:52:41.131 T:2754     INFO <general>: Found 3D resolution 1920 x 540 with 1920 x 1080 @ 50.000000 (TAB)
2023-01-23 15:52:41.131 T:2754     INFO <general>: Found 3D resolution 960 x 1080 with 1920 x 1080 @ 50.000000 (SBS)
2023-01-23 15:52:41.131 T:2754     INFO <general>: Found 3D resolution 1920 x 540 with 1920 x 1080 @ 60.000000 (TAB)
2023-01-23 15:52:41.131 T:2754     INFO <general>: Found 3D resolution 1920 x 540 with 1920 x 1080 @ 59.940060 (TAB)
2023-01-23 15:52:41.131 T:2754     INFO <general>: Found 3D resolution 960 x 1080 with 1920 x 1080 @ 60.000000 (SBS)
2023-01-23 15:52:41.131 T:2754     INFO <general>: Found 3D resolution 960 x 1080 with 1920 x 1080 @ 59.940060 (SBS)
2023-01-23 15:52:41.150 T:2880     INFO <general>: CAESinkALSA - Unable to open device "bluealsa" for playback
2023-01-23 15:52:41.151 T:2754     INFO <general>: EGL_VERSION = 1.4 Linux-r7p0-00rel0-db6da91a
2023-01-23 15:52:41.151 T:2754     INFO <general>: EGL_VENDOR = ARM
2023-01-23 15:52:41.151 T:2754     INFO <general>: EGL_EXTENSIONS = EGL_KHR_image EGL_KHR_image_base EGL_KHR_image_pixmap EGL_KHR_gl_texture_2D_image EGL_KHR_gl_texture_cubemap_image EGL_KHR_gl_renderbuffer_image EGL_KHR_reusable_sync EGL_KHR_fence_sync EGL_KHR_lock_surface EGL_KHR_lock_surface2 EGL_EXT_create_context_robustness EGL_ANDROID_blob_cache EGL_KHR_create_context EGL_KHR_partial_update EGL_KHR_create_context_no_error
2023-01-23 15:52:41.151 T:2754     INFO <general>: EGL_CLIENT_EXTENSIONS = EGL_EXT_client_extensions EGL_EXT_platform_base
2023-01-23 15:52:41.152 T:2754     INFO <general>: CApplication::CreateGUI - using the aml windowing system
2023-01-23 15:52:41.153 T:2754     INFO <general>: Checking resolution 16
2023-01-23 15:52:41.155 T:2880     INFO <general>: CAESinkALSA - Unable to open device "btaudio" for playback
2023-01-23 15:52:41.156 T:2880     INFO <general>: CAESinkALSA::EnumerateDevice - device hdmi:CARD=AMLMESONAUDIO,DEV=0 description AML-MESONAUDIO,
                                                   HDMI Audio Output
2023-01-23 15:52:41.157 T:2880     INFO <general>: Found 1 Lists of Devices
2023-01-23 15:52:41.158 T:2880     INFO <general>: Enumerated ALSA devices:
2023-01-23 15:52:41.158 T:2880     INFO <general>:     Device 1
2023-01-23 15:52:41.158 T:2880     INFO <general>:         m_deviceName      : default
2023-01-23 15:52:41.158 T:2880     INFO <general>:         m_displayName     : Default (AML-MESONAUDIO: HDMI, S/PDIF & analogue)
2023-01-23 15:52:41.158 T:2880     INFO <general>:         m_displayNameExtra:
2023-01-23 15:52:41.158 T:2880     INFO <general>:         m_deviceType      : AE_DEVTYPE_PCM
2023-01-23 15:52:41.158 T:2880     INFO <general>:         m_channels        : FL, FR, UNKNOWN1, LFE, FC, BC, BL, BR, BLOC, BROC
2023-01-23 15:52:41.158 T:2880     INFO <general>:         m_sampleRates     : 32000,44100,48000,64000,88200,96000,176400,192000
2023-01-23 15:52:41.158 T:2880     INFO <general>:         m_dataFormats     : AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE
2023-01-23 15:52:41.158 T:2880     INFO <general>:         m_streamTypes     : No passthrough capabilities
2023-01-23 15:52:41.158 T:2880     INFO <general>:     Device 2
2023-01-23 15:52:41.158 T:2880     INFO <general>:         m_deviceName      : hdmi:CARD=AMLMESONAUDIO,DEV=0
2023-01-23 15:52:41.158 T:2880     INFO <general>:         m_displayName     : AML-MESONAUDIO
2023-01-23 15:52:41.158 T:2880     INFO <general>:         m_displayNameExtra: HDMI
2023-01-23 15:52:41.158 T:2880     INFO <general>:         m_deviceType      : AE_DEVTYPE_HDMI
2023-01-23 15:52:41.158 T:2880     INFO <general>:         m_channels        : FL, FR, BL, BR, FC, LFE, SL, SR
2023-01-23 15:52:41.158 T:2880     INFO <general>:         m_sampleRates     : 32000,44100,48000,88200,96000,176400,192000
2023-01-23 15:52:41.158 T:2880     INFO <general>:         m_dataFormats     : AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_RAW
2023-01-23 15:52:41.158 T:2880     INFO <general>:         m_streamTypes     : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD,STREAM_TYPE_DTSHD_MA,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512,STREAM_TYPE_EAC3,STREAM_TYPE_TRUEHD
2023-01-23 15:52:41.159 T:2881     INFO <general>: CActiveAESink::OpenSink - initialize sink
2023-01-23 15:52:41.159 T:2881     INFO <general>: CAESinkALSA::Initialize - Requested layout: FL, FR
2023-01-23 15:52:41.159 T:2881     INFO <general>: CAESinkALSA::Initialize - set digital_codec 0
2023-01-23 15:52:41.159 T:2881     INFO <general>: CAESinkALSA::Initialize - Attempting to open device "default"
2023-01-23 15:52:41.165 T:2881     INFO <general>: CAESinkALSA::Initialize - Opened device "default"
2023-01-23 15:52:41.166 T:2881     INFO <general>: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
2023-01-23 15:52:41.167 T:2881     INFO <general>: CAESinkALSA::InitializeHW - Using data format AE_FMT_S24NE4
2023-01-23 15:52:41.168 T:2881     INFO <general>: CAESinkALSA::Initialize - speaker layout 0
2023-01-23 15:52:41.443 T:2754     INFO <general>: GL_VENDOR = ARM
2023-01-23 15:52:41.443 T:2754     INFO <general>: GL_RENDERER = Mali-450 MP
2023-01-23 15:52:41.443 T:2754     INFO <general>: GL_VERSION = OpenGL ES 2.0
2023-01-23 15:52:41.443 T:2754     INFO <general>: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 1.00
2023-01-23 15:52:41.443 T:2754     INFO <general>: GL_EXTENSIONS = GL_OES_texture_npot GL_OES_vertex_array_object GL_OES_compressed_ETC1_RGB8_texture GL_EXT_compressed_ETC1_RGB8_sub_texture GL_OES_standard_derivatives GL_OES_EGL_image GL_OES_depth24 GL_ARM_rgba8 GL_ARM_mali_shader_binary GL_OES_depth_texture GL_OES_packed_depth_stencil GL_EXT_texture_format_BGRA8888 GL_OES_vertex_half_float GL_EXT_blend_minmax GL_OES_EGL_image_external GL_OES_EGL_sync GL_OES_rgb8_rgba8 GL_EXT_multisampled_render_to_texture GL_EXT_discard_framebuffer GL_OES_get_program_binary GL_ARM_mali_program_binary GL_EXT_shader_texture_lod GL_EXT_robustness GL_OES_depth_texture_cube_map GL_KHR_debug GL_ARM_shader_framebuffer_fetch GL_ARM_shader_framebuffer_fetch_depth_stencil GL_OES_mapbuffer GL_KHR_no_error
2023-01-23 15:52:41.799 T:2754     INFO <general>: GLES: Maximum texture width: 4096
2023-01-23 15:52:41.800 T:2754     INFO <general>: load keymapping
2023-01-23 15:52:41.811 T:2754     INFO <general>: Loading special://xbmc/system/keymaps/appcommand.xml
2023-01-23 15:52:41.812 T:2754     INFO <general>: Loading special://xbmc/system/keymaps/customcontroller.AppleRemote.xml
2023-01-23 15:52:41.815 T:2754     INFO <general>: Loading special://xbmc/system/keymaps/customcontroller.Harmony.xml
2023-01-23 15:52:41.819 T:2754     INFO <general>: Loading special://xbmc/system/keymaps/customcontroller.SiriRemote.xml
2023-01-23 15:52:41.821 T:2754     INFO <general>: Loading special://xbmc/system/keymaps/gamepad.xml
2023-01-23 15:52:41.824 T:2754     INFO <general>: Loading special://xbmc/system/keymaps/hama_mce.xml
2023-01-23 15:52:41.825 T:2754     INFO <general>: Loading special://xbmc/system/keymaps/joystick.xml
2023-01-23 15:52:41.829 T:2754     INFO <general>: Loading special://xbmc/system/keymaps/keyboard.xml
2023-01-23 15:52:41.837 T:2754     INFO <general>: Loading special://xbmc/system/keymaps/mouse.xml
2023-01-23 15:52:41.839 T:2754     INFO <general>: Loading special://xbmc/system/keymaps/osmc_classic.xml
2023-01-23 15:52:41.840 T:2754     INFO <general>: Loading special://xbmc/system/keymaps/remote.xml
2023-01-23 15:52:41.846 T:2754     INFO <general>: Loading special://xbmc/system/keymaps/touchscreen.xml
2023-01-23 15:52:41.850 T:2754     INFO <general>: GUI format 1920x1080, Display 1920x1080 @ 60.00 - Full Screen
2023-01-23 15:52:41.850 T:2754     INFO <general>: CLangInfo: loading resource.language.de_de language information...
2023-01-23 15:52:41.853 T:2754     INFO <general>: global locale set to C
2023-01-23 15:52:41.853 T:2754     INFO <general>: CLangInfo: loading resource.language.de_de language strings...
2023-01-23 15:52:42.845 T:2754     INFO <general>: WaitForNet: Waiting for a network interface to come up (Timeout: 1 s)
2023-01-23 15:52:42.845 T:2754     INFO <general>: WaitForNet: A network interface is up after waiting 0 ms
2023-01-23 15:52:42.848 T:2896     INFO <general>: Running database version Addons33
2023-01-23 15:52:42.850 T:2896     INFO <general>: Running database version ViewModes6
2023-01-23 15:52:42.852 T:2896     INFO <general>: Running database version Textures13
2023-01-23 15:52:42.861 T:2896     INFO <general>: Running database version MyMusic82
2023-01-23 15:52:42.872 T:2896     INFO <general>: Running database version MyVideos119
2023-01-23 15:52:42.875 T:2896     INFO <general>: Running database version TV38
2023-01-23 15:52:42.878 T:2896     INFO <general>: Running database version Epg13
2023-01-23 15:52:42.878 T:2754     INFO <general>: start dvd mediatype detection
2023-01-23 15:52:42.919 T:2754     INFO <general>: Unloaded skin
2023-01-23 15:52:42.924 T:2754     INFO <general>:   load skin from: /usr/share/kodi/addons/skin.osmc/ (version: 19.1.3)
2023-01-23 15:52:42.924 T:2754     INFO <general>:   load fonts for skin...
2023-01-23 15:52:42.930 T:2754     INFO <general>: Loading skin includes from /usr/share/kodi/addons/skin.osmc/xml/Includes.xml
2023-01-23 15:52:43.105 T:2754     INFO <general>: Error loading include file /usr/share/kodi/addons/skin.osmc/xml/Coordinates_Includes_Home.xml: Failed to open file (row: 0, col: 0)
2023-01-23 15:52:43.731 T:2754     INFO <general>: Loading fonts from /usr/share/kodi/addons/skin.osmc/xml/Font.xml
2023-01-23 15:52:43.839 T:2754     INFO <general>:   load new skin...
2023-01-23 15:52:43.839 T:2754     INFO <general>: Loading custom window XMLs from skin path /usr/share/kodi/addons/skin.osmc/xml
2023-01-23 15:52:43.863 T:2754     INFO <general>:   initialize new skin...
2023-01-23 15:52:43.863 T:2754     INFO <general>: Loading skin file: Custom_Cache_Progress.xml, load type: LOAD_ON_GUI_INIT
2023-01-23 15:52:43.880 T:2754     INFO <general>: Loading skin file: Custom_Overlay_Debug.xml, load type: LOAD_ON_GUI_INIT
2023-01-23 15:52:43.921 T:2754     INFO <general>: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT
2023-01-23 15:52:43.926 T:2754     INFO <general>: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT
2023-01-23 15:52:43.931 T:2754     INFO <general>: Loading skin file: Custom_AutoMusicVis.xml, load type: LOAD_ON_GUI_INIT
2023-01-23 15:52:43.932 T:2754     INFO <general>: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT
2023-01-23 15:52:43.933 T:2754     INFO <general>: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT
2023-01-23 15:52:43.938 T:2754     INFO <general>: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT
2023-01-23 15:52:43.945 T:2754     INFO <general>: Loading skin file: DialogNotification.xml, load type: LOAD_ON_GUI_INIT
2023-01-23 15:52:43.949 T:2754     INFO <general>: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT
2023-01-23 15:52:43.954 T:2754     INFO <general>:   skin loaded...
2023-01-23 15:52:43.954 T:2754     INFO <general>: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME
2023-01-23 15:52:43.971 T:2754     INFO <general>: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY
2023-01-23 15:52:44.274 T:2915     INFO <general>: initializing python engine.
2023-01-23 15:52:44.559 T:2754  WARNING <general>: Skipped 1 duplicate messages..
2023-01-23 15:52:44.559 T:2754  WARNING <general>: JSONRPC: Could not parse type "Setting.Details.SettingList"
2023-01-23 15:52:44.560 T:2754     INFO <general>: JSONRPC: Adding type "Setting.Details.SettingList" to list of incomplete definitions (waiting for "Setting.Details.Setting")
2023-01-23 15:52:44.560 T:2754     INFO <general>: JSONRPC: Resolving incomplete types/methods referencing Setting.Details.Setting
2023-01-23 15:52:44.633 T:2754     INFO <general>: JSONRPC v12.4.0: Successfully initialized
2023-01-23 15:52:44.895 T:2754     INFO <general>: AddOnLog: peripheral.joystick: Enabling joystick interface "linux"
2023-01-23 15:52:44.898 T:2754     INFO <general>: Register - new keyboard device registered on application->keyboard: Tastatur (0000:0000)
2023-01-23 15:52:44.899 T:2754     INFO <general>: Register - new mouse device registered on application->mouse: Maus (0000:0000)
2023-01-23 15:52:44.908 T:2754     INFO <general>: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
2023-01-23 15:52:44.910 T:2754     INFO <general>: Loaded playercorefactory configuration
2023-01-23 15:52:44.910 T:2754     INFO <general>: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
2023-01-23 15:52:44.910 T:2754     INFO <general>: special://masterprofile/playercorefactory.xml does not exist. Skipping.
2023-01-23 15:52:44.910 T:2754     INFO <general>: removing tempfiles
2023-01-23 15:52:44.915 T:2923     INFO <general>: initializing python engine.
2023-01-23 15:52:44.954 T:2754     INFO <general>: Skipped 5 duplicate messages..
2023-01-23 15:52:44.954 T:2754     INFO <general>: initialize done
2023-01-23 15:52:44.954 T:2754     INFO <general>: Running the application...
2023-01-23 15:52:44.959 T:2929     INFO <general>: initializing python engine.
2023-01-23 15:52:44.981 T:2754     INFO <general>: starting zeroconf publishing
2023-01-23 15:52:44.981 T:2754     INFO <general>: starting upnp client
2023-01-23 15:52:45.009 T:2754     INFO <general>: starting upnp renderer
2023-01-23 15:52:45.009 T:2920     INFO <general>: Register - new cec device registered on cec->AOCEC: CEC Adapter (0000:0000)
2023-01-23 15:52:45.038 T:2754     INFO <general>: JSONRPC Server: Successfully initialized
2023-01-23 15:52:45.038 T:2944     INFO <general>: ES: Starting UDP Event server on port 9777
2023-01-23 15:52:45.038 T:2944     INFO <general>: UDP: Listening on port 9777 (ipv6 : true)
2023-01-23 15:52:45.040 T:2754     INFO <CWebserver[80]>: Started
2023-01-23 15:52:45.089 T:2754     INFO <general>: AIRPLAY: Cleaning up photoassetcache
2023-01-23 15:52:45.150 T:2754     INFO <general>: AIRPLAY Server: Successfully initialized
2023-01-23 15:52:45.218 T:2754     INFO <general>: GLES: Enabling VSYNC
2023-01-23 15:52:46.339 T:2896     INFO <general>: AddOnLog: pvr.hts: starting PVR client
2023-01-23 15:52:46.351 T:2961    ERROR <general>: AddOnLog: pvr.hts: unable to connect to 127.0.0.1:9982
2023-01-23 15:52:46.824 T:2945     INFO <general>: JSONRPC Server: New connection added
2023-01-23 15:52:46.853 T:2961    ERROR <general>: AddOnLog: pvr.hts: unable to connect to 127.0.0.1:9982
2023-01-23 15:52:47.366 T:2880     INFO <general>: CAESinkALSA::EnumerateDevice - device default description
2023-01-23 15:52:47.400 T:2880     INFO <general>: CAESinkALSA - Unable to open device "bluealsa" for playback
2023-01-23 15:52:47.406 T:2880     INFO <general>: CAESinkALSA - Unable to open device "btaudio" for playback
2023-01-23 15:52:47.408 T:2880     INFO <general>: CAESinkALSA::EnumerateDevice - device hdmi:CARD=AMLMESONAUDIO,DEV=0 description AML-MESONAUDIO,
                                                   HDMI Audio Output
2023-01-23 15:52:47.410 T:2880     INFO <general>: Found 1 Lists of Devices
2023-01-23 15:52:47.410 T:2880     INFO <general>: Enumerated ALSA devices:
2023-01-23 15:52:47.410 T:2880     INFO <general>:     Device 1
2023-01-23 15:52:47.410 T:2880     INFO <general>:         m_deviceName      : default
2023-01-23 15:52:47.410 T:2880     INFO <general>:         m_displayName     : Default (AML-MESONAUDIO: HDMI, S/PDIF & analogue)
2023-01-23 15:52:47.410 T:2880     INFO <general>:         m_displayNameExtra:
2023-01-23 15:52:47.410 T:2880     INFO <general>:         m_deviceType      : AE_DEVTYPE_PCM
2023-01-23 15:52:47.410 T:2880     INFO <general>:         m_channels        : FL, FR, UNKNOWN1, LFE, FC, BC, BL, BR, BLOC, BROC
2023-01-23 15:52:47.410 T:2880     INFO <general>:         m_sampleRates     : 32000,44100,48000,64000,88200,96000,176400,192000
2023-01-23 15:52:47.410 T:2880     INFO <general>:         m_dataFormats     : AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE
2023-01-23 15:52:47.410 T:2880     INFO <general>:         m_streamTypes     : No passthrough capabilities
2023-01-23 15:52:47.410 T:2880     INFO <general>:     Device 2
2023-01-23 15:52:47.410 T:2880     INFO <general>:         m_deviceName      : hdmi:CARD=AMLMESONAUDIO,DEV=0
2023-01-23 15:52:47.410 T:2880     INFO <general>:         m_displayName     : AML-MESONAUDIO
2023-01-23 15:52:47.410 T:2880     INFO <general>:         m_displayNameExtra: HDMI
2023-01-23 15:52:47.410 T:2880     INFO <general>:         m_deviceType      : AE_DEVTYPE_HDMI
2023-01-23 15:52:47.410 T:2880     INFO <general>:         m_channels        : FL, FR, BL, BR, FC, LFE, SL, SR
2023-01-23 15:52:47.410 T:2880     INFO <general>:         m_sampleRates     : 32000,44100,48000,88200,96000,176400,192000
2023-01-23 15:52:47.410 T:2880     INFO <general>:         m_dataFormats     : AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_RAW
2023-01-23 15:52:47.410 T:2880     INFO <general>:         m_streamTypes     : STREAM_TYPE_AC3,STREAM_TYPE_DTSHD,STREAM_TYPE_DTSHD_MA,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_512,STREAM_TYPE_EAC3,STREAM_TYPE_TRUEHD
2023-01-23 15:52:47.411 T:2881     INFO <general>: CActiveAESink::OpenSink - initialize sink
2023-01-23 15:52:47.411 T:2881     INFO <general>: CAESinkALSA::Initialize - Requested layout: FL, FR
2023-01-23 15:52:47.411 T:2881     INFO <general>: CAESinkALSA::Initialize - set digital_codec 0
2023-01-23 15:52:47.412 T:2881     INFO <general>: CAESinkALSA::Initialize - Attempting to open device "default"
2023-01-23 15:52:47.417 T:2881     INFO <general>: CAESinkALSA::Initialize - Opened device "default"
2023-01-23 15:52:47.418 T:2881     INFO <general>: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
2023-01-23 15:52:47.419 T:2881     INFO <general>: CAESinkALSA::InitializeHW - Using data format AE_FMT_S24NE4
2023-01-23 15:52:47.420 T:2881     INFO <general>: CAESinkALSA::Initialize - speaker layout 0
2023-01-23 15:52:47.713 T:2923     INFO <general>: CPythonInvoker(2, /usr/share/kodi/addons/inputstream.ffmpegdirect/resources/lib/runner.py): script successfully run
2023-01-23 15:52:47.758 T:2923     INFO <general>: Python interpreter stopped
2023-01-23 15:52:49.204 T:2945     INFO <general>: JSONRPC Server: New connection added
2023-01-23 15:52:50.980 T:2971     INFO <general>: AddOnLog: pvr.hts:   Received permissions:
2023-01-23 15:52:50.980 T:2971     INFO <general>: AddOnLog: pvr.hts:   administrator              : 1
2023-01-23 15:52:50.980 T:2971     INFO <general>: AddOnLog: pvr.hts:   HTSP streaming             : 1
2023-01-23 15:52:50.980 T:2971     INFO <general>: AddOnLog: pvr.hts:   HTSP DVR                   : 1
2023-01-23 15:52:50.980 T:2971     INFO <general>: AddOnLog: pvr.hts:   Failed/aborted DVR         : 1
2023-01-23 15:52:50.980 T:2971     INFO <general>: AddOnLog: pvr.hts:   anonymous HTSP only        : 0
2023-01-23 15:52:50.980 T:2971     INFO <general>: AddOnLog: pvr.hts:   global connection limit    : 0
2023-01-23 15:52:50.980 T:2971     INFO <general>: AddOnLog: pvr.hts:   DVR connection limit       : 0
2023-01-23 15:52:50.980 T:2971     INFO <general>: AddOnLog: pvr.hts:   streaming connection limit : 0
2023-01-23 15:52:50.981 T:2971     INFO <general>: AddOnLog: pvr.hts:   Available streaming profiles:
2023-01-23 15:52:50.981 T:2971     INFO <general>: AddOnLog: pvr.hts:   Name: htsp, Comment: HTSP Default Stream Settings
2023-01-23 15:52:50.981 T:2971     INFO <general>: AddOnLog: pvr.hts: Request async EPG (3 days)
2023-01-23 15:52:50.982 T:2971     INFO <general>: AddOnLog: pvr.hts: Async updates requested
2023-01-23 15:52:50.990 T:2896     INFO <general>: PVR Manager: Starting
2023-01-23 15:52:52.163 T:2960     INFO <general>: AddOnLog: pvr.hts: Async updates initialised
2023-01-23 15:52:52.579 T:2924     INFO <general>: CPythonInvoker(3, /home/osmc/.kodi/addons/plugin.audio.spotifyd-client/service.py): script successfully run
2023-01-23 15:52:52.726 T:2924     INFO <general>: Python interpreter stopped
2023-01-23 15:52:53.135 T:2993     INFO <general>: PVR Manager: Started
2023-01-23 15:52:55.604 T:2945     INFO <general>: JSONRPC Server: New connection added
2023-01-23 15:53:04.857 T:2916     INFO <general>: CPythonInvoker(1, /home/osmc/.kodi/addons/script.skinshortcuts/resources/lib/entry_point.py): script successfully run
2023-01-23 15:53:05.076 T:2916     INFO <general>: Python interpreter stopped
2023-01-23 15:53:11.370 T:2915    ERROR <general>: Exception ignored in:
2023-01-23 15:53:11.370 T:2915    ERROR <general>: <Finalize object, dead>
2023-01-23 15:53:11.370 T:2915    ERROR <general>:

2023-01-23 15:53:11.370 T:2915    ERROR <general>: Traceback (most recent call last):

2023-01-23 15:53:11.370 T:2915    ERROR <general>:   File "/usr/lib/python3.9/multiprocessing/util.py", line 224, in __call__

2023-01-23 15:53:11.373 T:2915    ERROR <general>:
2023-01-23 15:53:11.373 T:2915    ERROR <general>: res = self._callback(*self._args, **self._kwargs)
2023-01-23 15:53:11.373 T:2915    ERROR <general>:

2023-01-23 15:53:11.374 T:2915    ERROR <general>:   File "/usr/lib/python3.9/multiprocessing/pool.py", line 692, in _terminate_pool

2023-01-23 15:53:11.382 T:2915    ERROR <general>:
2023-01-23 15:53:11.382 T:2915    ERROR <general>: cls._help_stuff_finish(inqueue, task_handler, len(pool))
2023-01-23 15:53:11.382 T:2915    ERROR <general>:

2023-01-23 15:53:11.383 T:2915    ERROR <general>:   File "/usr/lib/python3.9/multiprocessing/pool.py", line 947, in _help_stuff_finish

2023-01-23 15:53:11.409 T:2915    ERROR <general>:
2023-01-23 15:53:11.409 T:2915    ERROR <general>: inqueue.get(block=False)
2023-01-23 15:53:11.409 T:2915    ERROR <general>:

2023-01-23 15:53:11.409 T:2915    ERROR <general>: _queue
2023-01-23 15:53:11.409 T:2915    ERROR <general>: .
2023-01-23 15:53:11.409 T:2915    ERROR <general>: Empty
2023-01-23 15:53:11.409 T:2915    ERROR <general>: :
2023-01-23 15:53:11.409 T:2915    ERROR <general>:
2023-01-23 15:53:11.409 T:2915    ERROR <general>:

2023-01-23 15:53:11.413 T:2915     INFO <general>: CPythonInvoker(0, /home/osmc/.kodi/addons/plugin.video.zappntv/main.py): script successfully run
2023-01-23 15:53:11.590 T:2915     INFO <general>: Python interpreter stopped
2023-01-23 15:53:43.896 T:2945     INFO <general>: JSONRPC Server: Disconnection detected
2023-01-23 15:53:51.584 T:2944     INFO <general>: ES: Client  from ::ffff:192.168.1.206 timed out
2023-01-23 15:54:39.237 T:2754     INFO <general>: Samba is idle. Closing the remaining connections
jhjdekker98 commented 1 year ago

@theovermaze Seems like Kodi is correctly starting the plugin service and the binary seems to be launching. Is installing pulseaudio an option for you? I think ALSA is only really an option if you have no other software running using the sound card, because the ALSA backend takes over the soundcard completely.

If it is, please;

  1. add the following lines to your spotifyd.conf (within the [global]-section, anywhere will do) -: 
    use_mpris = false
backend = "pulseaudio"
volume_controller = "softvol"
  2. replace the spotifyd binary you're using now with the latest fully-featured armhf spotifyd release
  3. and restart kodi.

I'm not sure that will fix the problem as I don't expect the connection to kick you off with an ALSA backend, but I'm not sure. The problem seems to be related to the spotifyd binary, but I can't reproduce it yet. If this does fix the problem, I'm guessing the root cause is either MPRIS or somehow indeed ALSA.

theovermaze commented 1 year ago

I can't risk my osmc-installation. So no PulseAudio for me :(

jhjdekker98 commented 1 year ago

TODO:

chrisgo67 commented 1 year ago

Maybe this is based on: https://github.com/Spotifyd/spotifyd/issues/1044

chrisgo67 commented 1 year ago

Tried it with the libreelec nightly (Kodi20) as of 20230210. Cannot connect either. Android sees the instance only for some minutes before it disappears.

chrisgo67 commented 1 year ago

Btw. librespot runs fine here.

jhjdekker98 commented 1 year ago

Successfully reproduced on latest LTS LibreElec release for RPi4 as of today (LibreELEC-RPi4.arm-10.0.4). After following the instructions in the readme, I see the Spotify Connect speaker show up in the app. After trying to connect it disappears and doesn't seem to reappear again unless I reboot.

Intererstingly, the spotifyd-full release I used doesn't seem to support the pulseaudio back-end like @chrisgo67 suggested.

LibreELEC:~/.kodi/addons/plugin.audio.spotifyd-client # ./resources/lib/spotifyd/spotifyd --no-daemon --config-path ./resources/spotifyd.conf
Loading config from "./resources/spotifyd.conf"
...
no usable credentials found, enabling discovery
Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" }
The application panicked (crashed).
Message:  Unknown backend: pulseaudio.
Location: src/setup.rs:169
...

Removing pulseaudio from the service and trying to start is seems successful, but when trying to connect the following occurs:

Loading config from "./resources/spotifyd.conf"
...
Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" }
Connecting to AP "ap.spotify.com:443"
Authenticated as "<REDACTED>" !
Country: "NL"
Using Alsa sink with format: S16
Running "echo 1 > /tmp/songChange.tmp" using "/bin/sh" with environment variables {"VOLUME": "65535", "PLAYER_EVENT": "volumeset"}
The application panicked (crashed).
Message:  Failed to initialize DBus connection: D-Bus error: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 (org.freedesktop.DBus.Error.NotSupported)
Location: src/dbus_mpris.rs:169

My previously used spotifyd binary was compiled for amd64, so I cannot use that here on rpi4. Will report back after compiling on Debian with pulseaudio feature flag and reinstalling with that binary.

jhjdekker98 commented 1 year ago

Confirmed to be an issue with the spotifyd binary. Looking into running librespot instead.

jhjdekker98 commented 1 year ago

Seems like Librespot works because it's using the rodio backend by default. Spotifyd can be compiled with the optional rodio audio backend too (https://github.com/Spotifyd/spotifyd/pull/400). Compiled on rpi4b with OSMC 20230124. Compiled spotifyd binary seems to run fine with rodio backend on OSMC.

theovermaze commented 1 year ago

This sounds great! I would like to try. Any tips on how to compile spotifyd with the rodio audio backend?

jhjdekker98 commented 1 year ago

@theovermaze You'd need to install rust through rustup with the correct host architecture (in the case of the rpi4 and I believe the vero box; ARMv7 Linux), then clone the spotifyd git repository and do a cargo build with the (unfortunately undocumented) rodio audio backend feature flag.

I'm running the compilation again because I managed to accidentally delete the build folder. Once that's done and I verify a clean OSMC installation will run spotifyd-client I'll post the binary online somewhere so you can test it out too. If everything works as expected I wanna add some precompiled binaries to this repo and some autodetection in the service for which binary needs to be run.

theovermaze commented 1 year ago

Thank you! Looking forward to testing! concerning the host architecture. output of uname -a on my vero4k+: Linux osmc-vero4k 4.9.269-21-osmc #1 SMP PREEMPT Sat Jan 7 03:47:42 UTC 2023 aarch64 GNU/Linux

jhjdekker98 commented 1 year ago

@theovermaze compiled binary for armv7 available here.

My uname -a output looks similar enough, although I'm running major version 5 of OSMC. I don't think that will cause any issues with the binary though.

Right now running spotifyd directly in OSMC with the rodio audio backend seems to work, but using the plugin it crashes to Player thread panicked! with no other error log. It seems to have something to do with Python's subprocess, because running spotifyd through a test file with os.system works fine. I'm looking further into this.

jhjdekker98 commented 1 year ago

@theovermaze I pushed some fixes to the spotifyd-client-1 branch. Could you check out that branch, install the mentioned armv7 spotifyd binary and package everything in a zip to install on your Vero box?

I haven't tested on a clean installation yet but I'm quite positive everything will work now (aside from some minor GUI bugs). With the diff on that branch, I see the song metadata being pushed to the temporary file and I hear the music from Spotify.

theovermaze commented 1 year ago

just to make sure: the filesize of spotifyd_armv7.tar is 969,62 mb and consists of the folders "build", "deps", "examples", "incremental" and the files spotifyd and spotifyd.d. The whole content must be placed into /resources/lib/spotifyd?

jhjdekker98 commented 1 year ago

just to make sure: the filesize of spotifyd_armv7.tar is 969,62 mb and consists of the folders "build", "deps", "examples", "incremental" and the files spotifyd and spotifyd.d. The whole content must be placed into /resources/lib/spotifyd?

Absolutely correct

theovermaze commented 1 year ago

Here are my testresults: Addon installed fine. chmod +x /.kodi/addons/plugin.audio.spotifyd-client/resources/lib/spotifyd/spotifyd

Starting the addon via kodi shows an error message.

cat ~/.kodi/temp/kodi.log

2023-02-23 20:06:48.602 T:3183    ERROR <general>: EXCEPTION Thrown (PythonToCppException) : -->Python callback/script returned the following error<--
                                                    - NOTE: IGNORING THIS CAN LEAD TO MEMORY LEAKS!
                                                   Error Type: <class 'FileNotFoundError'>
                                                   Error Contents: [Errno 2] No such file or directory: '/tmp/spotifyd-client/songs.log'
                                                   Traceback (most recent call last):
                                                     File "/home/osmc/.kodi/addons/plugin.audio.spotifyd-client/runner.py", line 5, in <module>
                                                       fstd = open(f"/tmp/spotifyd-client/songs.log", "w")
                                                   FileNotFoundError: [Errno 2] No such file or directory: '/tmp/spotifyd-client/songs.log'
                                                   -->End of Python script error report<--

2023-02-23 20:06:48.629 T:3183     INFO <general>: Python interpreter stopped
2023-02-23 20:06:49.752 T:3187    ERROR <general>: Exception in thread
2023-02-23 20:06:49.752 T:3187    ERROR <general>: Thread-1
2023-02-23 20:06:49.752 T:3187    ERROR <general>: :

2023-02-23 20:06:49.752 T:3187    ERROR <general>: Traceback (most recent call last):

2023-02-23 20:06:49.753 T:3187    ERROR <general>:   File "/usr/lib/python3.9/threading.py", line 954, in _bootstrap_inner

2023-02-23 20:06:49.754 T:3187    ERROR <general>:
2023-02-23 20:06:49.754 T:3187    ERROR <general>: self.run()
2023-02-23 20:06:49.754 T:3187    ERROR <general>:

2023-02-23 20:06:49.754 T:3187    ERROR <general>:   File "/usr/lib/python3.9/threading.py", line 892, in run

2023-02-23 20:06:49.756 T:3187    ERROR <general>:
2023-02-23 20:06:49.756 T:3187    ERROR <general>: self._target(*self._args, **self._kwargs)
2023-02-23 20:06:49.756 T:3187    ERROR <general>:

2023-02-23 20:06:49.756 T:3187    ERROR <general>:   File "/home/osmc/.kodi/addons/plugin.audio.spotifyd-client/addon.py", line 62, in updateTrackData

2023-02-23 20:06:49.756 T:3187    ERROR <general>:
2023-02-23 20:06:49.756 T:3187    ERROR <general>: trackData = getTrackData(lastTrackId, accessToken, accessTokenExpire)
2023-02-23 20:06:49.756 T:3187    ERROR <general>:

2023-02-23 20:06:49.756 T:3187    ERROR <general>:   File "/home/osmc/.kodi/addons/plugin.audio.spotifyd-client/addon.py", line 76, in getTrackData

2023-02-23 20:06:49.757 T:3187    ERROR <general>:
2023-02-23 20:06:49.757 T:3187    ERROR <general>: trackId = getTrackId()
2023-02-23 20:06:49.757 T:3187    ERROR <general>:

2023-02-23 20:06:49.757 T:3187    ERROR <general>:   File "/home/osmc/.kodi/addons/plugin.audio.spotifyd-client/addon.py", line 108, in getTrackId

2023-02-23 20:06:49.757 T:3187    ERROR <general>:
2023-02-23 20:06:49.757 T:3187    ERROR <general>: f = open(f'{TMP_PATH}songs.log', 'r', -1, 'utf-8')
2023-02-23 20:06:49.757 T:3187    ERROR <general>:

2023-02-23 20:06:49.758 T:3187    ERROR <general>: FileNotFoundError
2023-02-23 20:06:49.758 T:3187    ERROR <general>: :
2023-02-23 20:06:49.758 T:3187    ERROR <general>: [Errno 2] No such file or directory: '/tmp/spotifyd-client/songs.log'
2023-02-23 20:06:49.758 T:3187    ERROR <general>:

2023-02-23 20:06:49.998 T:2787     INFO <general>: Loading skin file: /home/osmc/.kodi/addons/plugin.audio.spotifyd-client/resources/skins/default/1080i/w_main.xml, load type: LOAD_ON_GUI_INIT
2023-02-23 20:06:50.834 T:3005     INFO <general>: VideoInfoScanner: Starting scan ..
2023-02-23 20:07:20.953 T:3037     INFO <general>: JSONRPC Server: Disconnection detected

After executing spotifyd in /home/osmc/.kodi/addons/plugin.audio.spotifyd-client/resources/lib/spotifyd i see the device in the android app. Connecting is not possible. The app shows "connecting" for a long time.

jhjdekker98 commented 1 year ago

@theovermaze The addon's error message is related to the /tmp/spotifyd-client/-folder not existing. You could temporarily try creating it manually to get around it, I'll push a fix for it in the open PR too.

That doesn't address the issues with spotifyd not launching though. Could you run spotifyd with the following command: /home/osmc/.kodi/addons/plugin.audio.spotifyd-client/resources/lib/spotifyd --no-daemon --config-path /home/osmc/.kodi/addons/plugin.audio.spotifyd-client/resources/spotifyd.conf and try to connect, and give me the console output? Feel free to redact any information from the console output.

theovermaze commented 1 year ago

here is the output:

osmc@osmc-vero4k:/tmp$ /home/osmc/.kodi/addons/plugin.audio.spotifyd-client/resources/lib/spotifyd/spotifyd --no-daemon --config-path /home/osmc/.kodi/addons/plugin.audio.spotifyd-client/resources/spotifyd.conf
Loading config from "/home/osmc/.kodi/addons/plugin.audio.spotifyd-client/resources/spotifyd.conf"
No username specified. Checking username_cmd
No username_cmd specified
No password specified. Checking password_cmd
No password_cmd specified
No proxy specified
Using software volume controller.
no usable credentials found, enabling discovery
Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" }
Connecting to AP "ap.spotify.com:443"
Authenticated as "username_removed" !
Country: "AT"
Using Rodio sink with format S16 and cpal host: ALSA
Using audio device: default
Running "echo 1 > /tmp/songChange.tmp" using "/bin/bash" with environment variables {"PLAYER_EVENT": "volumeset", "VOLUME": "65535"}
The application panicked (crashed).
Message:  Failed to initialize DBus connection: D-Bus error: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 (org.freedesktop.DBus.Error.NotSupported)
Location: src/dbus_mpris.rs:169

Backtrace omitted.
Run with RUST_BACKTRACE=1 environment variable to display it.
Run with RUST_BACKTRACE=full to include source snippets.
jhjdekker98 commented 1 year ago

@theovermaze Weird, the dbus daemon is unable to start - probably because you're accessing the Vero box over SSH. On my OSMC setup (on rpi4) this works fine though, but I've seen the same error before on other installations.

Could you additionally give me the contents of your /home/osmc/.kodi/addons/plugin.audio.spotifyd-client/resources/spotifyd.conf? I wonder if disabling mpris is enough (uncommenting the use_mpris = false line).

theovermaze commented 1 year ago

spotifyd.conf:

[global]
# Uncomment / edit the lines below if using rodio or pulseaudio backend
#use_mpris = false
#backend = "rodio"/"pulseaudio" #<-- pick one, remove the other
#volume_controller = "softvol"

# A command that gets executed in your shell after each song changes.
on_song_change_hook = "echo 1 > /tmp/songChange.tmp"

# The name that gets displayed under the connect tab on
# official clients. Spaces are not allowed!
device_name = "SpotifydClient"

# If set to true, enables volume normalisation between songs.
volume_normalisation = true

# The normalisation pregain that is applied for each song.
normalisation_pregain = -5

# The displayed device type in Spotify clients.
# Can be unknown, computer, tablet, smartphone, speaker, t_v,
# a_v_r (Audio/Video Receiver), s_t_b (Set-Top Box), and audio_dongle.
device_type = "a_v_r"

uncommenting use_mpris = false worked! After this change connection was possible with osmc@osmc-vero4k:/tmp$ /home/osmc/.kodi/addons/plugin.audio.spotifyd-client/resources/lib/spotifyd/spotifyd --no-daemon --config-path /home/osmc/.kodi/addons/plugin.audio.spotifyd-client/resources/spotifyd.conf

But starting the addon with kodi-gui crashes kodi:

2023-02-24 09:26:25.872 T:3623    ERROR <general>: EXCEPTION Thrown (PythonToCppException) : -->Python callback/script returned the following error<--
                                                    - NOTE: IGNORING THIS CAN LEAD TO MEMORY LEAKS!
                                                   Error Type: <class 'FileNotFoundError'>
                                                   Error Contents: [Errno 2] No such file or directory: '/home/osmc/.kodi/addons/plugin.audio.spotifyd-client/resou                              rces/lib/spotifyd/spotifyd --no-daemon --config-path /home/osmc/.kodi/addons/plugin.audio.spotifyd-client/resources/spotifyd.conf'
                                                   Traceback (most recent call last):
                                                     File "/home/osmc/.kodi/addons/plugin.audio.spotifyd-client/runner.py", line 7, in <module>
                                                       subprocess.Popen([f"{addonPath}/resources/lib/spotifyd/spotifyd --no-daemon --config-path {addonPath}/resour                              ces/spotifyd.conf"])
                                                     File "/usr/lib/python3.9/subprocess.py", line 951, in __init__
                                                       self._execute_child(args, executable, preexec_fn, close_fds,
                                                     File "/usr/lib/python3.9/subprocess.py", line 1823, in _execute_child
                                                       raise child_exception_type(errno_num, err_msg, err_filename)
                                                   FileNotFoundError: [Errno 2] No such file or directory: '/home/osmc/.kodi/addons/plugin.audio.spotifyd-client/re                              sources/lib/spotifyd/spotifyd --no-daemon --config-path /home/osmc/.kodi/addons/plugin.audio.spotifyd-client/resources/spotifyd.conf'
                                                   -->End of Python script error report<--
jhjdekker98 commented 1 year ago

@theovermaze Seems like the way I'm retrieving the path to the binary in the new runner.py is not working properly. I've updated it to use the same builtin method as service.py for accessing the plugin folder (which I probably should have done in the first place). Could you pull the latest changes on the spotifyd-client-1-branch and try again?

theovermaze commented 1 year ago

The addon crashes again. Here is the log:

2023-02-27 17:46:05.588 T:3549     INFO <general>: CPythonInvoker(16, /home/osmc/.kodi/addons/plugin.audio.spotifyd-client/addon.py): script successfully run
2023-02-27 17:46:05.755 T:3549     INFO <general>: Python interpreter stopped
2023-02-27 17:46:09.084 T:3626     INFO <general>: initializing python engine.
2023-02-27 17:46:10.354 T:3631  WARNING <general>: Skipped 1 duplicate messages..
2023-02-27 17:46:10.354 T:3631  WARNING <general>: CPythonInvoker(19): Script invoked without an addon. Adding all addon modules installed to python path as fallback. This behaviour will be removed in future version.
2023-02-27 17:46:11.816 T:3631    ERROR <general>: EXCEPTION: No valid addon id could be obtained. None was passed and the script wasn't executed in a normal Kodi manner.
2023-02-27 17:46:12.175 T:3631    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: No valid addon id could be obtained. None was passed and the script wasn't executed in a normal Kodi manner.
                                                   Traceback (most recent call last):
                                                     File "/home/osmc/.kodi/addons/plugin.audio.spotifyd-client/runner.py", line 4, in <module>
                                                       addonPath = xbmcaddon.Addon().getAddonInfo('path')
                                                   RuntimeError: No valid addon id could be obtained. None was passed and the script wasn't executed in a normal Kodi manner.
                                                   -->End of Python script error report<--

2023-02-27 17:46:12.198 T:3631     INFO <general>: Python interpreter stopped
2023-02-27 17:46:13.287 T:3632    ERROR <general>: Exception in thread
2023-02-27 17:46:13.287 T:3632    ERROR <general>: Thread-1
2023-02-27 17:46:13.287 T:3632    ERROR <general>: :

2023-02-27 17:46:13.287 T:3632    ERROR <general>: Traceback (most recent call last):

2023-02-27 17:46:13.288 T:3632    ERROR <general>:   File "/usr/lib/python3.9/threading.py", line 954, in _bootstrap_inner

2023-02-27 17:46:13.289 T:3632    ERROR <general>:
2023-02-27 17:46:13.289 T:3632    ERROR <general>: self.run()
2023-02-27 17:46:13.289 T:3632    ERROR <general>:

2023-02-27 17:46:13.289 T:3632    ERROR <general>:   File "/usr/lib/python3.9/threading.py", line 892, in run

2023-02-27 17:46:13.291 T:3632    ERROR <general>:
2023-02-27 17:46:13.291 T:3632    ERROR <general>: self._target(*self._args, **self._kwargs)
2023-02-27 17:46:13.291 T:3632    ERROR <general>:

2023-02-27 17:46:13.291 T:3632    ERROR <general>:   File "/home/osmc/.kodi/addons/plugin.audio.spotifyd-client/addon.py", line 62, in updateTrackData

2023-02-27 17:46:13.292 T:3632    ERROR <general>:
2023-02-27 17:46:13.292 T:3632    ERROR <general>: trackData = getTrackData(lastTrackId, accessToken, accessTokenExpire)
2023-02-27 17:46:13.292 T:3632    ERROR <general>:

2023-02-27 17:46:13.292 T:3632    ERROR <general>:   File "/home/osmc/.kodi/addons/plugin.audio.spotifyd-client/addon.py", line 76, in getTrackData

2023-02-27 17:46:13.292 T:3632    ERROR <general>:
2023-02-27 17:46:13.292 T:3632    ERROR <general>: trackId = getTrackId()
2023-02-27 17:46:13.292 T:3632    ERROR <general>:

2023-02-27 17:46:13.292 T:3632    ERROR <general>:   File "/home/osmc/.kodi/addons/plugin.audio.spotifyd-client/addon.py", line 108, in getTrackId

2023-02-27 17:46:13.293 T:3632    ERROR <general>:
2023-02-27 17:46:13.293 T:3632    ERROR <general>: f = open(f'{TMP_PATH}songs.log', 'r', -1, 'utf-8')
2023-02-27 17:46:13.293 T:3632    ERROR <general>:

2023-02-27 17:46:13.293 T:3632    ERROR <general>: FileNotFoundError
2023-02-27 17:46:13.293 T:3632    ERROR <general>: :
2023-02-27 17:46:13.293 T:3632    ERROR <general>: [Errno 2] No such file or directory: '/tmp/spotifyd-client/songs.log'
2023-02-27 17:46:13.293 T:3632    ERROR <general>:

2023-02-27 17:46:13.522 T:2856     INFO <general>: Loading skin file: /home/osmc/.kodi/addons/plugin.audio.spotifyd-client/resources/skins/default/1080i/w_main.xml, load type: LOAD_ON_GUI_INIT

Connecting with osmc@osmc-vero4k:/tmp$ /home/osmc/.kodi/addons/plugin.audio.spotifyd-client/resources/lib/spotifyd/spotifyd --no-daemon --config-path /home/osmc/.kodi/addons/plugin.audio.spotifyd-client/resources/spotifyd.conf after uncommenting use_mpris = false works.

/tmp/spotifyd-client/ was created manually.

I always need to chmod+x of /.kodi/addons/plugin.audio.spotifyd-client/resources/lib/spotifyd/spotifyd Is there another file that needs this?

jhjdekker98 commented 1 year ago

Very odd, looking back at the error log from the earlier commit, it looks like the path to both the executable and the config file are correct. For some reason the addon is not executing the executable, even with the correct parameters passed. The path /home/osmc/.kodi/addons/plugin.audio.spotifyd-client/resources/lib/spotifyd/spotifyd exists, since that's also the binary you're able to execute manually. I suspect there may be a permissions issue when running from the addon, but I'm not sure. I'm looking further into this.

jhjdekker98 commented 1 year ago

No fix yet, more information / note to self:

Running spotifyd from service.py seems to fail because of an error that gets thrown when an event should get pushed to spotifyd (main_loop.rs:194). Oddly, running spotifyd through runner.py with kodi-send and RunScript seems to work only if it crashes once and it's immediately ran again. Also, only audio works, no data is written to the songs or error log files. When successfully running through kodi-send, OSMC also keeps spamming the kodi logs with CActiveAESink::OpenSink - no sink was returned. It's starting to look like the rodio backend also isn't able to pipe audio to the ALSA sink if Kodi/OSMC is already running and keeping the audio device busy.

Why running spotifyd manually from SSH (either running the binary directly or executing runner.py with python3) does work, is a mystery to me on top of that.

jhjdekker98 commented 1 year ago

Recompiled with all audio backend features - testing all gives different results, none functional yet. Rodio results in the same error as described before Portaudio results in a similar error, although a bit more verbose in the log Pulseaudio results in the connection event completing and logging successfully, however since OSMC does not seem to support pulseaudio, the logs are immediately spammed full of Could not start audio: Connection refused and Could not write audio: Not connected to PulseAudio lines.

I'm convinced the problem lies somewhere in there. I also feel like it should be possible to get everything to work with the rodio backend, somehow.