Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

librespot failed with newest test version of libreelec on RPI4 #5038

Closed
elschman opened this issue Jan 25, 2021 · 20 comments · Fixed by #5166
Closed

librespot failed with newest test version of libreelec on RPI4 #5038

elschman opened this issue Jan 25, 2021 · 20 comments · Fixed by #5166

Comments

@elschman
Copy link

logs are at http://ix.io/2NjV

If I choose librespot via spotify at my mobile to play a song it jumps over to the next song till the playlist end is reached without playing anz kind of song

@elschman
Copy link
Author

2021-01-25 23:15:04.268 T:943 INFO : Librespot: [2021-01-25T22:15:04Z INFO librespot_connect::spirc] Fetching autoplay context uri
2021-01-25 23:15:04.302 T:943 INFO : Librespot: [2021-01-25T22:15:04Z INFO librespot_connect::spirc] Autoplay uri resolved to <"spotify:station:album:7DcHWOXFDrfWLhAp02FMQp">
2021-01-25 23:15:04.374 T:943 INFO : Librespot: [2021-01-25T22:15:04Z INFO librespot_playback::player] Loading with Spotify URI spotify:track:79yOuInT3K0iBU4pcNf26N
2021-01-25 23:15:04.490 T:943 INFO : Librespot: thread '' panicked at 'attempted to zero-initialize type vorbisfile_sys::ov_callbacks, which is invalid', /rustc/e1884a8e3c3e813aada8254edfa120e85bf5ffca/library/core/src/mem/mod.rs:623:9
2021-01-25 23:15:04.584 T:943 INFO : Librespot: suspended sink 1
2021-01-25 23:15:04.584 T:943 INFO : Librespot: event panic 1/3
2021-01-25 23:15:04.584 T:943 INFO : Librespot: 0: 0x901934 -
2021-01-25 23:15:04.584 T:943 INFO : Librespot: 1: 0x92a818 -
2021-01-25 23:15:04.584 T:943 INFO : Librespot: 2: 0x8f995c -
2021-01-25 23:15:04.584 T:943 INFO : Librespot: 3: 0x9045cc -
2021-01-25 23:15:04.584 T:943 INFO : Librespot: 4: 0x9041d0 -
2021-01-25 23:15:04.584 T:943 INFO : Librespot: 5: 0x904de0 -
2021-01-25 23:15:04.584 T:943 INFO : Librespot: 6: 0x904908 -
2021-01-25 23:15:04.584 T:943 INFO : Librespot: 7: 0x901ed4 -
2021-01-25 23:15:04.584 T:943 INFO : Librespot: 8: 0x904888 -
2021-01-25 23:15:04.584 T:943 INFO : Librespot: 9: 0x9271f4 -
2021-01-25 23:15:04.584 T:943 INFO : Librespot: 10: 0x927150 -
2021-01-25 23:15:04.584 T:943 INFO : Librespot: 11: 0x5b87b4 -
2021-01-25 23:15:04.584 T:943 INFO : Librespot: 12: 0x5c4bdc -
2021-01-25 23:15:04.584 T:943 INFO : Librespot: 13: 0x5c32fc -
2021-01-25 23:15:04.585 T:943 INFO : Librespot: 14: 0x90b82c -
2021-01-25 23:15:04.585 T:943 INFO : Librespot: [2021-01-25T22:15:04Z WARN librespot_playback::player] Unable to load <SpotifyId { id: 312455127656784245021068882369821925381, audio_type: Track }>
2021-01-25 23:15:04.585 T:943 INFO : Librespot: Skipping to next track
2021-01-25 23:15:04.585 T:943 INFO : Librespot: [2021-01-25T22:15:04Z INFO librespot_connect::spirc] Resolved 50 tracks from <"spotify:album:7DcHWOXFDrfWLhAp02FMQp">
2021-01-25 23:15:04.649 T:943 INFO : Librespot: suspended sink 1
2021-01-25 23:15:04.650 T:943 INFO : Librespot: librespot stopped
2021-01-25 23:15:04.692 T:943 INFO : Librespot: librespot started
2021-01-25 23:15:04.699 T:943 INFO : Librespot: [2021-01-25T22:15:04Z INFO librespot] librespot 819404a (2021-01-16). Built on 2021-01-16. Build ID: K7eOWhqX
2021-01-25 23:15:04.730 T:943 INFO : Librespot: *** WARNING *** The program 'librespot' uses the Apple Bonjour compatibility layer of Avahi.
2021-01-25 23:15:04.730 T:943 INFO : Librespot: *** WARNING *** Please fix your application to use the native API of Avahi!
2021-01-25 23:15:04.730 T:943 INFO : Librespot: *** WARNING *** For more information see http://0pointer.de/blog/projects/avahi-compat.html
2021-01-25 23:15:04.803 T:943 INFO : Librespot: [2021-01-25T22:15:04Z INFO librespot_core::session] Connecting to AP "gew1-accesspoint-e-6f5c.ap.spotify.com:4070"
2021-01-25 23:15:05.026 T:943 INFO : Librespot: [2021-01-25T22:15:05Z INFO librespot_core::session] Authenticated as "7wrank501ok1pu5oqtcghyfp2" !
2021-01-25 23:15:05.027 T:943 INFO : Librespot: [2021-01-25T22:15:05Z INFO librespot_core::session] Country: "DE"
2021-01-25 23:15:05.027 T:943 INFO : Librespot: country=DE

@heitbaum
Copy link
Contributor

Could you please try with the latest 126 addon version and the current nightly release, there have been quite a few changes since the matrix release 2021-01-17 that you have been running.

@elschman
Copy link
Author

There is currently no RPI4 librespot addon version 126 available under https://test.libreelec.tv/addons/9.80.9/

@CvH
Copy link
Member

CvH commented Feb 15, 2021

pls try again

@elschman
Copy link
Author

different Error but same result.. doesnt work

2021-02-15 23:38:02.367 T:926 INFO : Librespot: [2021-02-15T22:38:02Z INFO librespot_connect::spirc] Fetching autoplay context uri
2021-02-15 23:38:02.401 T:926 INFO : Librespot: [2021-02-15T22:38:02Z WARN librespot_connect::spirc] No autoplay_uri found
2021-02-15 23:38:02.401 T:926 INFO : Librespot: [2021-02-15T22:38:02Z ERROR librespot_connect::spirc] AutoplayError: MercuryError
2021-02-15 23:38:02.473 T:926 INFO : Librespot: [2021-02-15T22:38:02Z INFO librespot_playback::player] Loading with Spotify URI spotify:track:4yqtwO7MQIIXqoiRBPHAgR
2021-02-15 23:38:02.628 T:926 INFO : Librespot: thread '' panicked at 'attempted to zero-initialize type vorbisfile_sys::ov_callbacks, which is invalid', /rustc/cb75ad5db02783e8b0222fee363c5f63f7e2cf5b/library/core/src/mem/mod.rs:623:9
2021-02-15 23:38:02.712 T:926 INFO : Librespot: suspended sink 1
2021-02-15 23:38:02.712 T:926 INFO : Librespot: event panic 2/3
2021-02-15 23:38:02.712 T:926 INFO : Librespot: 0: 0x8db908 -
2021-02-15 23:38:02.712 T:926 INFO : Librespot: 1: 0x905eb0 -
2021-02-15 23:38:02.712 T:926 INFO : Librespot: 2: 0x8d34cc -
2021-02-15 23:38:02.712 T:926 INFO : Librespot: 3: 0x8de130 -
2021-02-15 23:38:02.713 T:926 INFO : Librespot: 4: 0x8ddb5c -
2021-02-15 23:38:02.713 T:926 INFO : Librespot: 5: 0x8de944 -
2021-02-15 23:38:02.713 T:926 INFO : Librespot: 6: 0x8de46c -
2021-02-15 23:38:02.713 T:926 INFO : Librespot: 7: 0x8dbe84 -
2021-02-15 23:38:02.713 T:926 INFO : Librespot: 8: 0x8de3ec -
2021-02-15 23:38:02.713 T:926 INFO : Librespot: 9: 0x9028e0 -
2021-02-15 23:38:02.713 T:926 INFO : Librespot: 10: 0x90283c -
2021-02-15 23:38:02.713 T:926 INFO : Librespot: 11: 0x5988b0 -
2021-02-15 23:38:02.713 T:926 INFO : Librespot: 12: 0x5a5de4 -
2021-02-15 23:38:02.713 T:926 INFO : Librespot: 13: 0x5a3304 -
2021-02-15 23:38:02.713 T:926 INFO : Librespot: 14: 0x8e4f64 -
2021-02-15 23:38:02.713 T:926 INFO : Librespot: [2021-02-15T22:38:02Z WARN librespot_playback::player] Unable to load <SpotifyId { id: 198948220676562962479203615179475644189, audio_type: Track }>
2021-02-15 23:38:02.713 T:926 INFO : Librespot: Skipping to next track
2021-02-15 23:38:02.713 T:926 INFO : Librespot: [2021-02-15T22:38:02Z INFO librespot_playback::player] Loading with Spotify URI spotify:track:0DMSXhLnI1tat6UBtnZU7o
2021-02-15 23:38:02.789 T:926 INFO : Librespot: suspended sink 1
2021-02-15 23:38:02.790 T:926 INFO : Librespot: librespot stopped
2021-02-15 23:38:02.826 T:926 INFO : Librespot: librespot started
2021-02-15 23:38:02.833 T:926 INFO : Librespot: [2021-02-15T22:38:02Z INFO librespot] librespot 96636fc (2021-02-14). Built on 2021-02-14. Build ID: vZtigsgf
2021-02-15 23:38:02.863 T:926 INFO : Librespot: *** WARNING *** The program 'librespot' uses the Apple Bonjour compatibility layer of Avahi.
2021-02-15 23:38:02.863 T:926 INFO : Librespot: *** WARNING *** Please fix your application to use the native API of Avahi!
2021-02-15 23:38:02.863 T:926 INFO : Librespot: *** WARNING *** For more information see http://0pointer.de/blog/projects/avahi-compat.html
2021-02-15 23:38:02.942 T:926 INFO : Librespot: [2021-02-15T22:38:02Z INFO librespot_core::session] Connecting to AP "gew1-accesspoint-e-jnqn.ap.spotify.com:4070"
2021-02-15 23:38:03.166 T:926 INFO : Librespot: [2021-02-15T22:38:03Z INFO librespot_core::session] Authenticated as "7wrank501ok1pu5oqtcghyfp2" !
2021-02-15 23:38:03.167 T:926 INFO : Librespot: [2021-02-15T22:38:03Z INFO librespot_core::session] Country: "DE"
2021-02-15 23:38:03.167 T:926 INFO : Librespot: country=DE
2021-02-15 23:38:37.134 T:735 INFO : Loading skin file: SettingsCategory.xml, load type: KEEP_IN_MEMORY
2021-02-15 23:38:46.354 T:926 INFO : Librespot: [2021-02-15T22:38:46Z INFO librespot_connect::spirc] Fetching autoplay context uri
2021-02-15 23:38:46.391 T:926 INFO : Librespot: [2021-02-15T22:38:46Z WARN librespot_connect::spirc] No autoplay_uri found
2021-02-15 23:38:46.391 T:926 INFO : Librespot: [2021-02-15T22:38:46Z ERROR librespot_connect::spirc] AutoplayError: MercuryError
2021-02-15 23:38:46.391 T:926 INFO : Librespot: [2021-02-15T22:38:46Z INFO librespot_playback::player] Loading with Spotify URI spotify:track:0DMSXhLnI1tat6UBtnZU7o
2021-02-15 23:38:46.524 T:926 INFO : Librespot: thread '' panicked at 'attempted to zero-initialize type vorbisfile_sys::ov_callbacks, which is invalid', /rustc/cb75ad5db02783e8b0222fee363c5f63f7e2cf5b/library/core/src/mem/mod.rs:623:9
2021-02-15 23:38:46.619 T:926 INFO : Librespot: suspended sink 1
2021-02-15 23:38:46.619 T:926 INFO : Librespot: event panic 3/3
2021-02-15 23:38:46.620 T:926 INFO : Librespot: 0: 0x85b908 -
2021-02-15 23:38:46.620 T:926 INFO : Librespot: 1: 0x885eb0 -
2021-02-15 23:38:46.620 T:926 INFO : Librespot: 2: 0x8534cc -
2021-02-15 23:38:46.620 T:926 INFO : Librespot: 3: 0x85e130 -
2021-02-15 23:38:46.620 T:926 INFO : Librespot: 4: 0x85db5c -
2021-02-15 23:38:46.620 T:926 INFO : Librespot: 5: 0x85e944 -
2021-02-15 23:38:46.620 T:926 INFO : Librespot: 6: 0x85e46c -
2021-02-15 23:38:46.620 T:926 INFO : Librespot: 7: 0x85be84 -
2021-02-15 23:38:46.620 T:926 INFO : Librespot: 8: 0x85e3ec -
2021-02-15 23:38:46.620 T:926 INFO : Librespot: 9: 0x8828e0 -
2021-02-15 23:38:46.621 T:926 INFO : Librespot: 10: 0x88283c -
2021-02-15 23:38:46.621 T:926 INFO : Librespot: 11: 0x5188b0 -
2021-02-15 23:38:46.621 T:926 INFO : Librespot: 12: 0x525de4 -
2021-02-15 23:38:46.621 T:926 INFO : Librespot: 13: 0x523304 -
2021-02-15 23:38:46.621 T:926 INFO : Librespot: 14: 0x864f64 -
2021-02-15 23:38:46.621 T:926 INFO : Librespot: [2021-02-15T22:38:46Z WARN librespot_playback::player] Unable to load <SpotifyId { id: 28027944546689918179307309925007082194, audio_type: Track }>
2021-02-15 23:38:46.621 T:926 INFO : Librespot: Skipping to next track
2021-02-15 23:38:46.681 T:926 INFO : Librespot: suspended sink 1
2021-02-15 23:38:46.681 T:926 INFO : Librespot: librespot stopped
2021-02-15 23:38:46.681 T:926 INFO : Librespot: librespot thread stopped
2021-02-15 23:38:46.708 T:765 INFO : Librespot: librespot died
2021-02-15 23:38:46.816 T:765 INFO : Librespot: unloaded module-rtp-send destination_ip=127.0.0.1 port=24642 source=librespot.monitor
2021-02-15 23:38:46.873 T:765 INFO : Librespot: unloaded module-null-sink sink_name=librespot
2021-02-15 23:38:46.873 T:765 INFO : Librespot: monitor stopped
2021-02-15 23:38:46.875 T:765 INFO : CPythonInvoker(5, /storage/.kodi/addons/service.librespot/default.py): script successfully run
2021-02-15 23:38:46.880 T:740 WARNING : Pulseaudio module module-allow-passthrough not loaded - opening PT devices might fail
2021-02-15 23:38:46.881 T:740 INFO : Found 2 Lists of Devices
2021-02-15 23:38:46.881 T:740 INFO : Enumerated PULSE devices:
2021-02-15 23:38:46.881 T:740 INFO : Device 1
2021-02-15 23:38:46.881 T:740 INFO : m_deviceName : Default
2021-02-15 23:38:46.881 T:740 INFO : m_displayName : Default
2021-02-15 23:38:46.881 T:740 INFO : m_displayNameExtra: Bluetooth Audio (PULSEAUDIO)
2021-02-15 23:38:46.881 T:740 INFO : m_deviceType : AE_DEVTYPE_PCM
2021-02-15 23:38:46.881 T:740 INFO : m_channels : FL, FR
2021-02-15 23:38:46.881 T:740 INFO : m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000,176400,192000,384000
2021-02-15 23:38:46.881 T:740 INFO : m_dataFormats : AE_FMT_U8,AE_FMT_S16NE,AE_FMT_S24NE3,AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_FLOAT
2021-02-15 23:38:46.881 T:740 INFO : m_streamTypes : No passthrough capabilities
2021-02-15 23:38:46.884 T:740 WARNING : Pulseaudio module module-allow-passthrough not loaded - opening PT devices might fail
2021-02-15 23:38:46.885 T:740 INFO : Found 2 Lists of Devices
2021-02-15 23:38:46.885 T:740 INFO : Enumerated PULSE devices:
2021-02-15 23:38:46.885 T:740 INFO : Device 1
2021-02-15 23:38:46.885 T:740 INFO : m_deviceName : Default
2021-02-15 23:38:46.885 T:740 INFO : m_displayName : Default
2021-02-15 23:38:46.885 T:740 INFO : m_displayNameExtra: Bluetooth Audio (PULSEAUDIO)
2021-02-15 23:38:46.885 T:740 INFO : m_deviceType : AE_DEVTYPE_PCM
2021-02-15 23:38:46.885 T:740 INFO : m_channels : FL, FR
2021-02-15 23:38:46.885 T:740 INFO : m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000,176400,192000,384000
2021-02-15 23:38:46.885 T:740 INFO : m_dataFormats : AE_FMT_U8,AE_FMT_S16NE,AE_FMT_S24NE3,AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_FLOAT
2021-02-15 23:38:46.885 T:740 INFO : m_streamTypes : No passthrough capabilities
2021-02-15 23:38:47.223 T:765 INFO : Python interpreter stopped

@elschman
Copy link
Author

My audio device is the AVR connected via HDMI

@heitbaum
Copy link
Contributor

heitbaum commented Feb 21, 2021

I have done a build of librespot 0.1.5 (127) for you to test. I don’t have a premium account - so can’t do any more than a validation test.

PROJECT=RPi ARCH=arm DEVICE=RPi4 s/create_addon librespot

test addon can be downloaded - https://github.com/heitbaum/LibreELEC.tv/blob/librespot-bin/service.librespot-9.80.9.127.zip

@heitbaum
Copy link
Contributor

@elschman
Copy link
Author

elschman commented Feb 22, 2021 via email

@heitbaum
Copy link
Contributor

Just a pastekodi please.

is the error still attempted to zero-initialize type vorbisfile_sys::ov_callbacks, which is invalid

As I this the following may have identified the vorbis error

RustAudio/lewton#89
tomaka/vorbis-rs#19

@elschman
Copy link
Author

elschman commented Feb 23, 2021 via email

@heitbaum
Copy link
Contributor

yup same bug. Let me read into rust first first about patching crates before I volunteer to try and patch this 👍

2021-02-23 07:45:34.364 T:4495 INFO : Librespot: thread '' panicked at 'attempted to zero-initialize type vorbisfile_sys::ov_callbacks, which is invalid', /rustc/cb75ad5db02783e8b0222fee363c5f63f7e2cf5b/library/core/src/mem/mod.rs:623:9

@NofanTasi
Copy link

same here on CoreELEC
Librespot: thread '' panicked at 'attempted to zero-initialize type vorbisfile_sys::ov_callbacks, which is invalid', /rustc/cb75ad5db02783e8b0222fee363c5f63f7e2cf5b/library/core/src/mem/mod.rs:623:9

@heitbaum
Copy link
Contributor

heitbaum commented Mar 25, 2021

#5166 updated and New RPi4 test build available at https://github.com/heitbaum/LibreELEC.tv/blob/librespot-bin2/service.librespot-9.80.11.127.zip

@elschman
@NofanTasi

PROJECT=RPi ARCH=arm DEVICE=RPi4 scripts/create_addon librespot

please test and let me know.

@heitbaum
Copy link
Contributor

X86 test addon.zip @
https://github.com/heitbaum/LibreELEC.tv/blob/librespot-bin2/service.librespot-9.80.11.127.x86.zip

@elschman
Copy link
Author

elschman commented Mar 26, 2021 via email

@jmbreuer
Copy link
Contributor

X86 test addon.zip @
https://github.com/heitbaum/LibreELEC.tv/blob/librespot-bin2/service.librespot-9.80.11.127.x86.zip

Not available (anymore), any place to get a testing build for the time being?

@jmbreuer
Copy link
Contributor

X86 test addon.zip @
https://github.com/heitbaum/LibreELEC.tv/blob/librespot-bin2/service.librespot-9.80.11.127.x86.zip

Not available (anymore), any place to get a testing build for the time being?

... found this:

https://github.com/ldsz/plugin.audio.spotify/releases

Works for me, YMMV.

@heitbaum
Copy link
Contributor

heitbaum commented Mar 31, 2021

X86 test addon.zip @
https://github.com/heitbaum/LibreELEC.tv/blob/librespot-bin2/service.librespot-9.80.11.127.x86.zip

Not available (anymore), any place to get a testing build for the time being?

... found this:

https://github.com/ldsz/plugin.audio.spotify/releases

Works for me, YMMV.

@jmbreuer - I have republished the test version at - it will end up in the LE repo once we resolve a glibc build issue - https://github.com/heitbaum/LibreELEC.tv/blob/dev/service.librespot-9.80.11.127.zip this is x86

@jmbreuer
Copy link
Contributor

X86 test addon.zip @
https://github.com/heitbaum/LibreELEC.tv/blob/librespot-bin2/service.librespot-9.80.11.127.x86.zip

Not available (anymore), any place to get a testing build for the time being?

... found this:
https://github.com/ldsz/plugin.audio.spotify/releases
Works for me, YMMV.

@jmbreuer - I have republished the test version at - it will end up in the LE repo once we resolve a glibc build issue - https://github.com/heitbaum/LibreELEC.tv/blob/dev/service.librespot-9.80.11.127.zip this is x86

Awesome, thanks! This also Works For Me (tm) ;-)

Currently, I actually have both installed with the Spotify Connect part of plugin.audio.spotify disabled (which does not work for me). This allows me to have both Spotify Connect control as well as directly choosing and playing tracks in Kodi. Not yet ideal, but still better than only one or the other.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

Successfully merging a pull request may close this issue.

5 participants