Hello, I can’t make Volumio connect 2 plugin work. I’m a casual user, please help me to solve.
Here is the log:
Starting Live Log...
[/lib/systemd/system/mpd.service:20] Unknown lvalue 'ProtectKernelModules' in section 'Service'
[/lib/systemd/system/mpd.service:23] Unknown lvalue 'RestrictNamespaces' in section 'Service'
Configuration file /lib/systemd/system/spop.service is marked executable. Please remove executable permission bits. Proceeding anyway.
Configuration file /lib/systemd/system/spop.service is marked world-writable. Please remove world writability permission bits. Proceeding anyway.
pam_unix(sudo:session): session closed for user root
info: enable SSH service success
[Vollibrespot] : couldn't parse packet from V4(192.168.1.21:5353): query type 65 is invalid
info: CALLMETHOD: system_controller system enableLiveLog true
info: CoreCommandRouter::executeOnPlugin: system , enableLiveLog
info: Launching a new LiveLog session
[Vollibrespot] : couldn't parse packet from V4(192.168.1.24:5353): query type 65 is invalid
[Vollibrespot] : couldn't parse packet from V4(192.168.1.24:5353): query type 65 is invalid
[Vollibrespot] : Connecting to AP "ap-gew1.spotify.com:443"
[Vollibrespot] : Authenticated as "tosnfprvlkz5vb1c952ohtong" !
[Vollibrespot] : Setting up new mixer: card:hw:2 mixer:SoftMaster index:0
[Vollibrespot] : Alsa min-db is not SND_CTL_TLV_DB_GAIN_MUTE!!
[Vollibrespot] : Alsa Mixer info min: 0 (MilliBel(0)[dB]) -- max: 99 (MilliBel(0)[dB]) HW: false
[Vollibrespot] : Using Alsa linear volume
[Vollibrespot] : Alsa min-db is not SND_CTL_TLV_DB_GAIN_MUTE!!
[Vollibrespot] : Using alsa sink
[Vollibrespot] : Country: "TR"
[Vollibrespot] : Metadata pipe established
[Vollibrespot] : Event: Volume { volume_to_mixer: 55704 }
[SpotifyConnect] 84.99885557335774
[SpotifyConnect] Volume: Spotify:84.99885557335774 Volumio: 85
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: [ASDebug] CurState: pause PrevState: stop
[Vollibrespot] : Fetching autoplay context uri
[Vollibrespot] : Event: SessionActive { became_active_at: 1640255899248 }
[Vollibrespot] : SessionActive!
[Vollibrespot] : Event: PlaybackStarted { track_id: SpotifyId { id: 36487117577567051530074209399358329921, audio_type: Track } }
[Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 36487117577567051530074209399358329921, audio_type: Track } }
[SpotifyConnect] A connect session has begun
[SpotifyConnect] Device palyback is active!
info: CoreCommandRouter::volumioGetState
[SpotifyConnect] Currently active: volspotconnect2
[SpotifyConnect] Not requsting volumioStop on our own service
[SpotifyConnect] Vollibrespot Active
info: CoreCommandRouter::volumioGetState
[SpotifyConnect] Currently active: volspotconnect2
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioGetState
[SpotifyConnect] Currently active: volspotconnect2
[SpotifyConnect] Pushing new state :: true
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: [ASDebug] CurState: pause PrevState: stop
info: [ASDebug] CurState: pause PrevState: stop
[Vollibrespot] : error 403 for uri hm://keymaster/token/authenticated?client_id=4ced2e7c73484127be5d36015752eb43&scope=streaming,user-read-playback-state,user-modify-playback-state,user-read-currently-playing,user-read-private
[Vollibrespot] : Error: MercuryError
thread 'main' panicked at 'cannot poll Map twice', /build/cache/registry/src/github.com-1ecc6299db9ec823/futures-0.1.29/src/future/map.rs:35:29
stack backtrace:
[Vollibrespot] : Loading with Spotify URI
0: 0xa4e33c - backtrace::backtrace::libunwind::trace::hae21a072c81e5842
at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.46/src/backtrace/libunwind.rs:86
1: 0xa4e33c - backtrace::backtrace::trace_unsynchronized::h0f9b260087e46e47
at /cargo/registry/src/github.com-1ecc6299db9ec823/backtrace-0.3.46/src/backtrace/mod.rs:66
2: 0xa4e33c - std::sys_common::backtrace::_print_fmt::hbf1a59173a7860c3
at src/libstd/sys_common/backtrace.rs:78
3: 0xa4e33c - ::fmt::he1a5d6f378e506c4
at src/libstd/sys_common/backtrace.rs:59
4: 0xa6ed5c - core::fmt::write::hb37ae5a5e0b70623
at src/libcore/fmt/mod.rs:1076
5: 0xa47c64 - std::io::Write::write_fmt::ha24bb3f5a858327b
at src/libstd/io/mod.rs:1537
6: 0xa50974 - std::sys_common::backtrace::_print::h47b03aa1342833e3
at src/libstd/sys_common/backtrace.rs:62
7: 0xa50974 - std::sys_common::backtrace::print::h2217cbc390250439
at src/libstd/sys_common/backtrace.rs:49
8: 0xa50974 - std::panicking::default_hook::{{closure}}::h179f5229ea1c8e30
at src/libstd/panicking.rs:198
9: 0xa50640 - std::panicking::default_hook::h46ab82039cbc65eb
at src/libstd/panicking.rs:217
10: 0xa51054 - std::panicking::rust_panic_with_hook::h7326c48419bc7c33
at src/libstd/panicking.rs:526
11: 0xa50c54 - rust_begin_unwind
at src/libstd/panicking.rs:437
12: 0xa6c594 - core::panicking::panic_fmt::ha292e19d5ae716ed
at src/libcore/panicking.rs:85
13: 0xa6c370 - core::option::expect_failed::he9e39f8f5ba60ecb
at src/libcore/option.rs:1261
14: 0x742bf8 - as futures::future::Future>::poll::h3d56b212ca27d9e4
15: 0x5f83a4 - ::poll::ha2e91a6b75c719f3
16: 0x56eca4 - ::poll::hc5e7d2d1b7dbef13
17: 0x536844 - futures::task_impl::std::set::h8f081cf0436110c9
18: 0x54a41c - std::thread::local::LocalKey::with::h711a13323aafc45a
19: 0x526a50 - tokio_current_thread::Entered
::block_on::h339073902a399eb7
20: 0x54ae00 - std::thread::local::LocalKey::with::hff64c13ccfec5327
21: 0x55720c - tokio_reactor::with_default::h7ef12e65cb103d2f
22: 0x52a9f8 - tokio::runtime::current_thread::runtime::Runtime::block_on::h043f136d6b8cf48f
23: 0x5702c8 - vollibrespot::main::h02a0d49d4cc5eaa6
volspotconnect2.service: main process exited, code=exited, status=101/n/a
Unit volspotconnect2.service entered failed state.
[SpotifyConnect] Device palyback is inactive
[SpotifyConnect] Device Session is_active: true
[SpotifyConnect] Sink released
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
24: 0x557f18 - std::rt::lang_start::{{closure}}::h279cd2b7929fdba7
25: 0xa51404 - std::rt::lang_start_internal::{{closure}}::he93bfc404849b78a
at src/libstd/rt.rs:52
26: 0xa51404 - std::panicking::try::do_call::h6e9e98f4078affb0
at src/libstd/panicking.rs:348
27: 0xa51404 - std::panicking::try::h2e68d4f7f799a6df
at src/libstd/panicking.rs:325
28: 0xa51404 - std::panic::catch_unwind::h8880a4c07cc66391
at src/libstd/panic.rs:394
29: 0xa51404 - std::rt::lang_start_internal::hf4ae2140248bf16b
at src/libstd/rt.rs:51
30: 0x570d84 - main
31: 0x76d20678 - __libc_start_main
[Vollibrespot] : EventSender disconnected
info: [ASDebug] CurState: pause PrevState: stop
volspotconnect2.service holdoff time over, scheduling restart.
Stopping Volspotconnect2 Daemon...
Starting Volspotconnect2 Daemon...
Started Volspotconnect2 Daemon.
vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07
Reading Config from "volspotify.toml"
[Vollibrespot] : Using Alsa backend with device: softvolume
[Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" }
[Vollibrespot] : couldn't parse packet from V4(192.168.1.24:5353): query type 65 is invalid
[Vollibrespot] : couldn't parse packet from V4(192.168.1.21:5353): query type 65 is invalid
[Vollibrespot] : couldn't parse packet from V4(192.168.1.24:5353): query type 65 is invalid
[Vollibrespot] : couldn't parse packet from V4(192.168.1.24:5353): query type 65 is invalid
[Vollibrespot] : couldn't parse packet from V4(192.168.1.24:5353): query type 65 is invalid
[Vollibrespot] : couldn't parse packet from V4(192.168.1.24:5353): query type 65 is invalid
[Vollibrespot] : couldn't parse packet from V4(192.168.1.24:5353): query type 65 is invalid
[Vollibrespot] : couldn't parse packet from V4(192.168.1.24:5353): query type 65 is invalid
