-- Logs begin at Sat 2024-05-04 09:54:25 UTC, end at Sat 2024-05-04 09:57:28 UTC. -- May 04 09:56:01 hifi-fasound volumio[1016]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 09:56:01 hifi-fasound volumio[1016]: info: [GPIO_Control] UI Config file /data/plugins/system_controller/gpio_control/UIConfig.json May 04 09:56:09 hifi-fasound volumio[1016]: info: CALLMETHOD: system_controller gpio_control saveConfig [object Object] May 04 09:56:09 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: gpio_control , saveConfig May 04 09:56:09 hifi-fasound volumio[1016]: info: [GPIO_Control] Saving config May 04 09:56:09 hifi-fasound volumio[1016]: info: [GPIO_Control] Reading config and creating GPIOs May 04 09:56:09 hifi-fasound volumio[1016]: info: [GPIO_Control] Will set GPIO 15 On when systemStartup May 04 09:56:09 hifi-fasound volumio[1016]: info: [GPIO_Control] Turning GPIO 15 On (systemStartup) May 04 09:56:09 hifi-fasound volumio[1016]: info: CoreCommandRouter::volumioGetState May 04 09:56:09 hifi-fasound volumio[1016]: info: CorePlayQueue::getTrack 0 May 04 09:56:24 hifi-fasound volumio[1016]: info: Starting Uninstall of plugin music_service - spop May 04 09:56:24 hifi-fasound volumio[1016]: info: Uninstalling plugin spop May 04 09:56:24 hifi-fasound volumio[1016]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify May 04 09:56:24 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 04 09:56:24 hifi-fasound volumio[1016]: [SpotifyConnect] Closing metadata listener May 04 09:56:24 hifi-fasound volumio[1016]: info: Disabling plugin spop May 04 09:56:24 hifi-fasound volumio[1016]: info: Checking if uninstall.sh is present May 04 09:56:24 hifi-fasound sudo[1710]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volspotconnect.service May 04 09:56:24 hifi-fasound volumio[1016]: info: Executing uninstall.sh May 04 09:56:24 hifi-fasound sudo[1710]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 09:56:24 hifi-fasound systemd[1]: Stopping Volspotconnect2 Daemon... May 04 09:56:24 hifi-fasound systemd[1]: Stopped Volspotconnect2 Daemon. May 04 09:56:24 hifi-fasound sudo[1710]: pam_unix(sudo:session): session closed for user root May 04 09:56:24 hifi-fasound volumio[1016]: [SpotifyConnect] Vollibrespot Daemon service stoped! May 04 09:56:24 hifi-fasound sudo[1717]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/spop/uninstall.sh May 04 09:56:24 hifi-fasound sudo[1717]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 09:56:24 hifi-fasound sudo[1717]: pam_unix(sudo:session): session closed for user root May 04 09:56:24 hifi-fasound volumio[1016]: info: Uninstall script completed May 04 09:56:24 hifi-fasound volumio[1016]: info: Removing plugin spop from configuration May 04 09:56:24 hifi-fasound volumio[1016]: info: Successfully removed spop configuration files May 04 09:56:24 hifi-fasound volumio[1016]: info: Plugin folders cleanup May 04 09:56:24 hifi-fasound volumio[1016]: info: Scanning into folder /volumio/app/plugins/ May 04 09:56:24 hifi-fasound volumio[1016]: info: Scanning category audio_interface May 04 09:56:24 hifi-fasound volumio[1016]: info: Scanning category miscellanea May 04 09:56:24 hifi-fasound volumio[1016]: info: Scanning category music_service May 04 09:56:24 hifi-fasound volumio[1016]: info: Scanning category plugins.json May 04 09:56:24 hifi-fasound volumio[1016]: info: Scanning category system_controller May 04 09:56:24 hifi-fasound volumio[1016]: info: Scanning category user_interface May 04 09:56:24 hifi-fasound volumio[1016]: info: Scanning into folder /data/plugins/ May 04 09:56:24 hifi-fasound volumio[1016]: info: Scanning category miscellanea May 04 09:56:24 hifi-fasound volumio[1016]: info: Scanning category music_service May 04 09:56:24 hifi-fasound volumio[1016]: info: Cleaning folder for spop May 04 09:56:24 hifi-fasound volumio[1016]: info: Scanning category system_controller May 04 09:56:24 hifi-fasound volumio[1016]: info: Plugin folders cleanup completed May 04 09:56:24 hifi-fasound volumio[1016]: info: [{"prettyName":"Touch Display","name":"touch_display","category":"miscellanea","version":"1.3.0","icon":"fa-hand-pointer-o","enabled":true,"active":true},{"prettyName":"CD Player","name":"cdplayer","category":"music_service","version":"1.0.0","icon":"fa-music","enabled":true,"active":true},{"prettyName":"GPIO Buttons","name":"gpio-buttons","category":"system_controller","version":"0.8.1","icon":"fa-microchip","enabled":true,"active":true},{"prettyName":"GPIO Control","name":"gpio_control","category":"system_controller","version":"0.0.1","icon":"fa-microchip","enabled":true,"active":true}] May 04 09:56:34 hifi-fasound volumio[1016]: info: Downloading plugin at http://plugins.volumio.org/plugins/volumio/armhf/music_service/spop/spop.zip May 04 09:56:39 hifi-fasound volumio[1016]: info: END DOWNLOAD: http://plugins.volumio.org/plugins/volumio/armhf/music_service/spop/spop.zip May 04 09:56:39 hifi-fasound volumio[1016]: info: Folder /tmp/plugins removed May 04 09:56:40 hifi-fasound volumio[1016]: info: Checking if plugin already exists May 04 09:56:40 hifi-fasound volumio[1016]: info: Rename folder May 04 09:56:40 hifi-fasound volumio[1016]: info: Folder /tmp/downloaded_plugin.zip removed May 04 09:56:40 hifi-fasound volumio[1016]: info: Move to category May 04 09:56:43 hifi-fasound volumio[1016]: info: Checking if install.sh is present May 04 09:56:43 hifi-fasound volumio[1016]: info: Executing install.sh May 04 09:56:43 hifi-fasound sudo[1779]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/spop/install.sh May 04 09:56:43 hifi-fasound sudo[1779]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 09:56:43 hifi-fasound volumio[1016]: info: Writing systemd unit May 04 09:56:43 hifi-fasound sudo[1779]: pam_unix(sudo:session): session closed for user root May 04 09:56:43 hifi-fasound volumio[1016]: info: Setting permissions May 04 09:56:43 hifi-fasound volumio[1016]: info: Writing startconnect unit May 04 09:56:43 hifi-fasound volumio[1016]: Plugin install end detected on script May 04 09:56:43 hifi-fasound volumio[1016]: info: Install script completed May 04 09:56:43 hifi-fasound volumio[1016]: info: Adding reference to registry May 04 09:56:43 hifi-fasound volumio[1016]: info: Done installing plugin. May 04 09:56:43 hifi-fasound volumio[1016]: info: Folder /tmp/plugins removed May 04 09:56:43 hifi-fasound volumio[1016]: info: Folder /tmp/downloaded_plugin.zip removed May 04 09:56:43 hifi-fasound volumio[1016]: info: Folder /data/temp removed May 04 09:56:44 hifi-fasound volumio[1016]: info: Enabling plugin spop May 04 09:56:44 hifi-fasound volumio[1016]: info: Loading plugin "spop"... May 04 09:56:44 hifi-fasound volumio[1016]: info: PLUGIN START: spop May 04 09:56:44 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 04 09:56:44 hifi-fasound volumio[1016]: [SpotifyConnect] Creating VLS config file May 04 09:56:44 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 04 09:56:44 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 04 09:56:44 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 04 09:56:44 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 04 09:56:44 hifi-fasound volumio[1016]: [SpotifyConnect] Starting metadata listener May 04 09:56:44 hifi-fasound sudo[1796]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts May 04 09:56:44 hifi-fasound sudo[1796]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 09:56:44 hifi-fasound sudo[1796]: pam_unix(sudo:session): session closed for user root May 04 09:56:44 hifi-fasound sudo[1800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service May 04 09:56:44 hifi-fasound sudo[1800]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 09:56:44 hifi-fasound systemd[1]: Starting Volspotconnect2 Daemon... May 04 09:56:44 hifi-fasound systemd[1]: Started Volspotconnect2 Daemon. May 04 09:56:44 hifi-fasound volumio[1810]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 May 04 09:56:44 hifi-fasound volumio[1810]: Reading Config from "/tmp/volspotify.toml" May 04 09:56:44 hifi-fasound volumio[1810]: [Vollibrespot] : Using Alsa backend with device: softvolume May 04 09:56:44 hifi-fasound volumio[1810]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } May 04 09:56:44 hifi-fasound sudo[1800]: pam_unix(sudo:session): session closed for user root May 04 09:56:44 hifi-fasound volumio[1016]: [SpotifyConnect] Vollibrespot Daemon service started! May 04 09:56:44 hifi-fasound volumio[1016]: [Metrics] SpotifyConnect: 0s 141.19ms May 04 09:56:44 hifi-fasound volumio[1016]: info: Done. May 04 09:56:47 hifi-fasound volumio[1016]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 09:56:48 hifi-fasound volumio[1016]: info: Checking Spotify Web API May 04 09:56:58 hifi-fasound volumio[1810]: [Vollibrespot] : Connecting to AP "ap-gae2.spotify.com:443" May 04 09:56:58 hifi-fasound volumio[1810]: [Vollibrespot] : Authenticated as "1opqbvca26fsd4g60igcyctv5" ! May 04 09:56:58 hifi-fasound volumio[1810]: [Vollibrespot] : Using alsa sink May 04 09:56:58 hifi-fasound volumio[1810]: [Vollibrespot] : Country: "TW" May 04 09:56:58 hifi-fasound volumio[1810]: [Vollibrespot] : Metadata pipe established May 04 09:56:58 hifi-fasound volumio[1810]: [Vollibrespot] : Event: Volume { volume_to_mixer: 32768 } May 04 09:56:58 hifi-fasound volumio[1016]: [SpotifyConnect] Volume Spotify: 50.000762951094835 Volumio: 50 May 04 09:56:58 hifi-fasound volumio[1810]: [Vollibrespot] : Fetching autoplay context uri May 04 09:56:58 hifi-fasound volumio[1810]: [Vollibrespot] : Event: SessionActive { became_active_at: 1714816618891 } May 04 09:56:58 hifi-fasound volumio[1810]: [Vollibrespot] : SessionActive! May 04 09:56:58 hifi-fasound volumio[1016]: [SpotifyConnect] A connect session has begun May 04 09:56:58 hifi-fasound volumio[1016]: info: Acquiring new spotify session May 04 09:56:58 hifi-fasound volumio[1810]: [Vollibrespot] : Event: PlaybackStarted { track_id: SpotifyId { id: 119970865213098212147211882846637349857, audio_type: Track } } May 04 09:56:58 hifi-fasound volumio[1810]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 119970865213098212147211882846637349857, audio_type: Track } } May 04 09:56:58 hifi-fasound volumio[1016]: info: CoreCommandRouter::volumioStop May 04 09:56:58 hifi-fasound volumio[1016]: info: CoreStateMachine::stop May 04 09:56:58 hifi-fasound volumio[1016]: info: CoreStateMachine::setConsumeUpdateService undefined May 04 09:56:58 hifi-fasound volumio[1016]: verbose: UNSET VOLATILE May 04 09:56:58 hifi-fasound volumio[1016]: info: Checking Spotify Web API May 04 09:56:58 hifi-fasound volumio[1016]: [SpotifyConnect] Vollibrespot Active May 04 09:56:58 hifi-fasound volumio[1016]: info: CoreStateMachine::setConsumeUpdateService undefined May 04 09:56:58 hifi-fasound volumio[1016]: info: [1714816618895] ControllerSpotify::pushState May 04 09:56:58 hifi-fasound volumio[1016]: info: CoreCommandRouter::servicePushState May 04 09:56:58 hifi-fasound volumio[1016]: info: CoreStateMachine::pushState May 04 09:56:58 hifi-fasound volumio[1016]: info: CoreCommandRouter::volumioPushState May 04 09:56:58 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 09:56:58 hifi-fasound volumio[1016]: [SpotifyConnect] Device palyback is active! May 04 09:56:58 hifi-fasound volumio[1810]: [Vollibrespot] : error 403 for uri hm://keymaster/token/authenticated?client_id=ecd10c0393ec4a36bae1661bbbfd2e1d&scope=streaming,user-read-playback-state,user-modify-playback-state,user-read-currently-playing,user-read-private May 04 09:56:58 hifi-fasound volumio[1810]: [Vollibrespot] : Error: MercuryError May 04 09:56:58 hifi-fasound volumio[1810]: thread 'main' panicked at 'cannot poll Map twice', /home/volumio/.cargo/registry/src/github.com-1285ae84e5963aae/futures-0.1.31/src/future/map.rs:35:29 May 04 09:56:58 hifi-fasound volumio[1810]: stack backtrace: May 04 09:56:58 hifi-fasound volumio[1810]: 0: 0x993c40 - std::backtrace_rs::backtrace::libunwind::trace::h9be44abcd6023537 May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5 May 04 09:56:58 hifi-fasound volumio[1810]: 1: 0x993c40 - std::backtrace_rs::backtrace::trace_unsynchronized::he588770997e640ec May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 May 04 09:56:58 hifi-fasound volumio[1810]: 2: 0x993c40 - std::sys_common::backtrace::_print_fmt::h2a5bea2fa6ce9b3d May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:66:5 May 04 09:56:58 hifi-fasound volumio[1810]: 3: 0x993c40 - ::fmt::hf1c91d83d30a63b5 May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:45:22 May 04 09:56:58 hifi-fasound volumio[1810]: 4: 0x9b9d68 - core::fmt::write::he7b81f119cac9e82 May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/fmt/mod.rs:1196:17 May 04 09:56:58 hifi-fasound volumio[1810]: 5: 0x98d5d4 - std::io::Write::write_fmt::hd6a547671801193b May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/io/mod.rs:1654:15 May 04 09:56:58 hifi-fasound volumio[1810]: 6: 0x995728 - std::sys_common::backtrace::_print::hcf4a7819f0b4198f May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:48:5 May 04 09:56:58 hifi-fasound volumio[1810]: 7: 0x995728 - std::sys_common::backtrace::print::hb4deb0b578e6c939 May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:35:9 May 04 09:56:58 hifi-fasound volumio[1810]: 8: 0x995728 - std::panicking::default_hook::{{closure}}::h7d65a85d73ca528f May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:295:22 May 04 09:56:58 hifi-fasound volumio[1810]: 9: 0x99523c - std::panicking::default_hook::h3b931251a9c4b1f6 May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:314:9 May 04 09:56:58 hifi-fasound volumio[1810]: 10: 0x995f44 - std::panicking::rust_panic_with_hook::h52cc4877d8c74a8b May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:698:17 May 04 09:56:58 hifi-fasound volumio[1810]: 11: 0x995c30 - std::panicking::begin_panic_handler::{{closure}}::h7546eed0ba906ec0 May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:588:13 May 04 09:56:58 hifi-fasound volumio[1810]: 12: 0x9941bc - std::sys_common::backtrace::__rust_end_short_backtrace::h32ad68afde8ac292 May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:138:18 May 04 09:56:58 hifi-fasound volumio[1810]: 13: 0x9959ec - rust_begin_unwind May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:584:5 May 04 09:56:58 hifi-fasound volumio[1810]: 14: 0x478e2c - core::panicking::panic_fmt::h43e2baa6a2dcb05a May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/panicking.rs:142:14 May 04 09:56:58 hifi-fasound volumio[1810]: 15: 0x9b6b40 - core::panicking::panic_display::h7abbe07d495b3a32 May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/panicking.rs:72:5 May 04 09:56:58 hifi-fasound volumio[1810]: 16: 0x9b6af0 - core::panicking::panic_str::h61704b1b7d988fea May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/panicking.rs:56:5 May 04 09:56:58 hifi-fasound volumio[1810]: 17: 0x478cb0 - core::option::expect_failed::h3c9740a4df357423 May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/option.rs:1854:5 May 04 09:56:58 hifi-fasound volumio[1810]: 18: 0x6da388 - as futures::future::Future>::poll::h03b0468e31b39462 May 04 09:56:58 hifi-fasound volumio[1810]: 19: 0x569950 - ::poll::h980bb2790cc3c82d May 04 09:56:58 hifi-fasound volumio[1810]: 20: 0x4a2598 - ::poll::h06f390c1cf340695 May 04 09:56:58 hifi-fasound volumio[1810]: 21: 0x4b918c - futures::task_impl::std::set::h917345edbb2d7b17 May 04 09:56:58 hifi-fasound volumio[1810]: 22: 0x4daf24 - std::thread::local::LocalKey::with::hebf033a3f9f19674 May 04 09:56:58 hifi-fasound volumio[1810]: 23: 0x4a9924 - tokio_current_thread::Entered

::block_on::h34935ca5acdeef78 May 04 09:56:58 hifi-fasound volumio[1810]: 24: 0x4dabac - std::thread::local::LocalKey::with::hb9ef5b7276039152 May 04 09:56:58 hifi-fasound volumio[1810]: 25: 0x4c9604 - tokio_reactor::with_default::hcd4b2b1df52c6b3d May 04 09:56:58 hifi-fasound volumio[1810]: 26: 0x498da4 - tokio::runtime::current_thread::runtime::Runtime::block_on::hdff564047631f32c May 04 09:56:58 hifi-fasound volumio[1810]: 27: 0x4a39a0 - vollibrespot::main::haa33a046348d736f May 04 09:56:58 hifi-fasound volumio[1810]: 28: 0x4c16fc - std::sys_common::backtrace::__rust_begin_short_backtrace::h434d7d11e1d7d897 May 04 09:56:58 hifi-fasound volumio[1810]: 29: 0x4d9278 - std::rt::lang_start::{{closure}}::h7ee31a2c0e916c10 May 04 09:56:58 hifi-fasound volumio[1810]: 30: 0x986bcc - core::ops::function::impls:: for &F>::call_once::h9368c55e0af27eda May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/ops/function.rs:280:13 May 04 09:56:58 hifi-fasound volumio[1810]: 31: 0x986bcc - std::panicking::try::do_call::h7a5efa020212c0f3 May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:492:40 May 04 09:56:58 hifi-fasound volumio[1810]: 32: 0x986bcc - std::panicking::try::h3145f518af029892 May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:456:19 May 04 09:56:58 hifi-fasound volumio[1810]: 33: 0x986bcc - std::panic::catch_unwind::h876d78503e730edb May 04 09:56:58 hifi-fasound volumio[1016]: [SpotifyConnect] Device palyback is inactive May 04 09:56:58 hifi-fasound volumio[1016]: [SpotifyConnect] Sink released May 04 09:56:58 hifi-fasound volumio[1016]: info: [1714816618974] ControllerSpotify::pushState May 04 09:56:58 hifi-fasound volumio[1016]: info: CoreCommandRouter::servicePushState May 04 09:56:58 hifi-fasound volumio[1016]: info: CoreStateMachine::pushState May 04 09:56:58 hifi-fasound volumio[1016]: info: CoreCommandRouter::volumioPushState May 04 09:56:58 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panic.rs:137:14 May 04 09:56:58 hifi-fasound volumio[1810]: 34: 0x986bcc - std::rt::lang_start_internal::{{closure}}::hfb915b4bce05c29a May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/rt.rs:128:48 May 04 09:56:58 hifi-fasound volumio[1810]: 35: 0x986bcc - std::panicking::try::do_call::h6affa17582fe803e May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:492:40 May 04 09:56:58 hifi-fasound volumio[1810]: 36: 0x986bcc - std::panicking::try::hf3254f9f909f508b May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:456:19 May 04 09:56:58 hifi-fasound volumio[1810]: 37: 0x986bcc - std::panic::catch_unwind::h17abded8b6d92414 May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panic.rs:137:14 May 04 09:56:58 hifi-fasound volumio[1810]: 38: 0x986bcc - std::rt::lang_start_internal::h62925866154f59e6 May 04 09:56:58 hifi-fasound volumio[1810]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/rt.rs:128:20 May 04 09:56:58 hifi-fasound volumio[1810]: 39: 0x4a411c - main May 04 09:56:58 hifi-fasound volumio[1810]: 40: 0xb6c3e678 - __libc_start_main May 04 09:56:58 hifi-fasound volumio[1810]: [Vollibrespot] : EventSender disconnected May 04 09:56:58 hifi-fasound volumio[1016]: info: CorePlayQueue::getTrack 0 May 04 09:56:58 hifi-fasound volumio[1016]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received spop May 04 09:56:59 hifi-fasound volumio[1016]: info: touch_display: Setting screensaver timeout to 0 seconds. May 04 09:56:59 hifi-fasound volumio[1016]: info: touch_display: Setting screensaver timeout to 0 seconds. May 04 09:56:59 hifi-fasound volumio[1016]: info: CoreCommandRouter::volumioGetState May 04 09:56:59 hifi-fasound volumio[1016]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 May 04 09:56:59 hifi-fasound volumio[1016]: info: touch_display: Setting screensaver timeout to 0 seconds. May 04 09:57:01 hifi-fasound systemd[1]: volspotconnect.service holdoff time over, scheduling restart. May 04 09:57:01 hifi-fasound systemd[1]: Stopping Volspotconnect2 Daemon... May 04 09:57:01 hifi-fasound systemd[1]: Starting Volspotconnect2 Daemon... May 04 09:57:01 hifi-fasound systemd[1]: Started Volspotconnect2 Daemon. May 04 09:57:01 hifi-fasound volumio[1867]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 May 04 09:57:01 hifi-fasound volumio[1867]: Reading Config from "/tmp/volspotify.toml" May 04 09:57:01 hifi-fasound volumio[1867]: [Vollibrespot] : Using Alsa backend with device: softvolume May 04 09:57:01 hifi-fasound volumio[1867]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } May 04 09:57:10 hifi-fasound volumio[1016]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 09:57:10 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 04 09:57:10 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 04 09:57:10 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 04 09:57:10 hifi-fasound volumio[1016]: info: Getting Alsa Cards List without I2S DAC May 04 09:57:10 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber May 04 09:57:10 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 04 09:57:10 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 09:57:10 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 09:57:10 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 09:57:10 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 09:57:10 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 09:57:10 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 09:57:10 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 09:57:10 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 04 09:57:10 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 04 09:57:21 hifi-fasound volumio[1016]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] May 04 09:57:21 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions May 04 09:57:21 hifi-fasound volumio[1016]: info: CoreCommandRouter::volumioGetState May 04 09:57:21 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: mpd , saveResampleOptions May 04 09:57:21 hifi-fasound sudo[1943]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 04 09:57:21 hifi-fasound volumio[1016]: info: Restoring Previous Volume level: 80 false true May 04 09:57:21 hifi-fasound volumio[1016]: info: VolumeController::SetAlsaVolume100 May 04 09:57:21 hifi-fasound sudo[1943]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 09:57:21 hifi-fasound volumio[1016]: info: Volume configurations have been set May 04 09:57:21 hifi-fasound volumio[1016]: [SpotifyConnect] Creating VLS config file May 04 09:57:21 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 04 09:57:21 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 04 09:57:21 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 04 09:57:21 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 04 09:57:21 hifi-fasound volumio[1016]: [SpotifyConnect] Creating VLS config file May 04 09:57:21 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 04 09:57:21 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 04 09:57:21 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 04 09:57:21 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 04 09:57:21 hifi-fasound sudo[1946]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 04 09:57:21 hifi-fasound sudo[1946]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 09:57:21 hifi-fasound sudo[1943]: pam_unix(sudo:session): session closed for user root May 04 09:57:21 hifi-fasound systemd[1]: Stopping Music Player Daemon... May 04 09:57:21 hifi-fasound volumio[1016]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 04 09:57:21 hifi-fasound volumio[1016]: info: Updating Volume Controller Parameters: Device: 2 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 5 May 04 09:57:21 hifi-fasound volumio[1016]: info: CoreCommandRouter::getUIConfigOnPlugin May 04 09:57:21 hifi-fasound volumio[1016]: info: CoreStateMachine::pushState May 04 09:57:21 hifi-fasound volumio[1016]: info: CoreCommandRouter::volumioPushState May 04 09:57:21 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 09:57:21 hifi-fasound systemd[1]: Starting Music Player Daemon... May 04 09:57:21 hifi-fasound volumio[1016]: [SpotifyConnect] Restarting Vollibrespot Daemon May 04 09:57:21 hifi-fasound volumio[1016]: [SpotifyConnect] Restarting Vollibrespot Daemon May 04 09:57:21 hifi-fasound sudo[1970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service May 04 09:57:21 hifi-fasound sudo[1970]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 09:57:21 hifi-fasound systemd[1]: Stopping Volspotconnect2 Daemon... May 04 09:57:21 hifi-fasound sudo[1976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service May 04 09:57:21 hifi-fasound systemd[1]: Starting Volspotconnect2 Daemon... May 04 09:57:21 hifi-fasound systemd[1]: Started Volspotconnect2 Daemon. May 04 09:57:21 hifi-fasound sudo[1970]: pam_unix(sudo:session): session closed for user root May 04 09:57:21 hifi-fasound volumio[1016]: info: CoreStateMachine::pushState May 04 09:57:21 hifi-fasound volumio[1016]: info: CoreCommandRouter::volumioPushState May 04 09:57:21 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 09:57:21 hifi-fasound sudo[1976]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 09:57:21 hifi-fasound volumio[1979]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 May 04 09:57:21 hifi-fasound volumio[1979]: Reading Config from "/tmp/volspotify.toml" May 04 09:57:21 hifi-fasound volumio[1979]: [Vollibrespot] : Using Alsa backend with device: softvolume May 04 09:57:21 hifi-fasound volumio[1016]: info: MPD Permissions set May 04 09:57:21 hifi-fasound systemd[1]: Stopping Volspotconnect2 Daemon... May 04 09:57:21 hifi-fasound systemd[1]: Starting Volspotconnect2 Daemon... May 04 09:57:21 hifi-fasound systemd[1]: Started Volspotconnect2 Daemon. May 04 09:57:21 hifi-fasound sudo[1976]: pam_unix(sudo:session): session closed for user root May 04 09:57:22 hifi-fasound volumio[1988]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 May 04 09:57:22 hifi-fasound volumio[1988]: Reading Config from "/tmp/volspotify.toml" May 04 09:57:22 hifi-fasound volumio[1988]: [Vollibrespot] : Using Alsa backend with device: softvolume May 04 09:57:22 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 04 09:57:22 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 04 09:57:22 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 04 09:57:22 hifi-fasound volumio[1016]: info: Getting Alsa Cards List without I2S DAC May 04 09:57:22 hifi-fasound volumio[1988]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } May 04 09:57:22 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber May 04 09:57:22 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 04 09:57:22 hifi-fasound systemd[1]: Started Music Player Daemon. May 04 09:57:22 hifi-fasound sudo[1946]: pam_unix(sudo:session): session closed for user root May 04 09:57:22 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 09:57:22 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 09:57:22 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 09:57:22 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 09:57:22 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 09:57:22 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 09:57:22 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 04 09:57:22 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 04 09:57:22 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 04 09:57:22 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 04 09:57:22 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 04 09:57:22 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 04 09:57:22 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 04 09:57:22 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 04 09:57:22 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 04 09:57:22 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 04 09:57:22 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 04 09:57:22 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 04 09:57:22 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: cdplayer , getMPDConfigString May 04 09:57:22 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 04 09:57:22 hifi-fasound volumio[1016]: [SpotifyConnect] Vollibrespot Daemon service restarted! May 04 09:57:22 hifi-fasound volumio[1016]: [SpotifyConnect] Vollibrespot Daemon service restarted! May 04 09:57:22 hifi-fasound volumio[1016]: error: updateQueue error: null May 04 09:57:22 hifi-fasound volumio[1016]: error: Upnp client error: Error: This socket has been ended by the other party May 04 09:57:26 hifi-fasound volumio[1016]: info: VolumeController::SetAlsaVolume80 May 04 09:57:26 hifi-fasound volumio[1016]: info: CoreStateMachine::pushState May 04 09:57:26 hifi-fasound volumio[1016]: info: CoreCommandRouter::volumioPushState May 04 09:57:26 hifi-fasound volumio[1016]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 04 09:57:28 hifi-fasound volumio[1016]: info: Checking Spotify Web API May 04 09:57:28 hifi-fasound volumio[1016]: info: Checking Spotify Web API May 04 09:57:28 hifi-fasound volumio[1016]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 04 09:57:28 hifi-fasound volumio[1988]: [Vollibrespot] : Connecting to AP "ap-gae2.spotify.com:443" May 04 09:57:28 hifi-fasound volumio[1016]: Error [ERR_SOCKET_DGRAM_NOT_RUNNING]: Not running May 04 09:57:28 hifi-fasound volumio[1016]: at Socket._healthCheck (dgram.js:638:11) May 04 09:57:28 hifi-fasound volumio[1016]: at Socket.send (dgram.js:435:8) May 04 09:57:28 hifi-fasound volumio[1016]: at SpotConnEvents.sendmsg (/data/plugins/music_service/spop/SpotConnController.js:106:21) May 04 09:57:28 hifi-fasound volumio[1016]: at ControllerSpotify.checkWebApi (/data/plugins/music_service/spop/index.js:2318:23) May 04 09:57:28 hifi-fasound volumio[1016]: at Timeout.setTimeout [as _onTimeout] (/data/plugins/music_service/spop/index.js:2651:18) May 04 09:57:28 hifi-fasound volumio[1016]: at ontimeout (timers.js:482:11) May 04 09:57:28 hifi-fasound volumio[1016]: at tryOnTimeout (timers.js:317:5) May 04 09:57:28 hifi-fasound volumio[1016]: at Timer.listOnTimeout (timers.js:277:5) May 04 09:57:28 hifi-fasound volumio[1016]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 04 09:57:28 hifi-fasound volumio[1988]: [Vollibrespot] : Authenticated as "1opqbvca26fsd4g60igcyctv5" ! May 04 09:57:28 hifi-fasound volumio[1988]: [Vollibrespot] : Using alsa sink May 04 09:57:28 hifi-fasound volumio[1988]: [Vollibrespot] : Country: "TW" May 04 09:57:28 hifi-fasound volumio[1988]: [Vollibrespot] : Metadata pipe established May 04 09:57:28 hifi-fasound volumio[1988]: [Vollibrespot] : Event: Volume { volume_to_mixer: 32768 } May 04 09:57:28 hifi-fasound sudo[2027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-04 09:56 May 04 09:57:28 hifi-fasound sudo[2027]: pam_unix(sudo:session): session opened for user root by (uid=0) May 04 09:57:28 hifi-fasound volumio[1988]: [Vollibrespot] : Fetching autoplay context uri May 04 09:57:28 hifi-fasound volumio[1988]: [Vollibrespot] : Event: SessionActive { became_active_at: 1714816648697 } May 04 09:57:28 hifi-fasound volumio[1988]: [Vollibrespot] : SessionActive! May 04 09:57:28 hifi-fasound volumio[1988]: [Vollibrespot] : Event: PlaybackStarted { track_id: SpotifyId { id: 119970865213098212147211882846637349857, audio_type: Track } } May 04 09:57:28 hifi-fasound volumio[1988]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 119970865213098212147211882846637349857, audio_type: Track } } PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021" VOLUMIO_VERSION="2.917" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"