-- Logs begin at Thu 2024-07-25 12:57:55 UTC, end at Fri 2024-07-26 19:22:33 UTC. --
Jul 26 19:21:01 volumioak systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart.
Jul 26 19:21:01 volumioak systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 7.
Jul 26 19:21:01 volumioak systemd[1]: Stopped Volspotconnect2 Daemon.
Jul 26 19:21:01 volumioak systemd[1]: Started Volspotconnect2 Daemon.
Jul 26 19:21:01 volumioak volumio[21877]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31
Jul 26 19:21:01 volumioak volumio[21877]: Reading Config from "/tmp/volspotify.toml"
Jul 26 19:21:01 volumioak volumio[21877]: [Vollibrespot] : Using Alsa backend with device: volumio
Jul 26 19:21:01 volumioak volumio[21877]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" }
Jul 26 19:21:01 volumioak wpa_supplicant[933]: wlan0: Failed to initiate sched scan
Jul 26 19:21:07 volumioak wpa_supplicant[933]: wlan0: Failed to initiate sched scan
Jul 26 19:21:11 volumioak volumio[21877]: [Vollibrespot] : Connecting to AP "ap-gew1.spotify.com:443"
Jul 26 19:21:12 volumioak volumio[1086]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 26 19:21:12 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Jul 26 19:21:12 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 26 19:21:12 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jul 26 19:21:12 volumioak wpa_supplicant[933]: wlan0: Failed to initiate sched scan
Jul 26 19:21:12 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 26 19:21:12 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 26 19:21:12 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 26 19:21:12 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 26 19:21:12 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 26 19:21:12 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 26 19:21:12 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 26 19:21:12 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Jul 26 19:21:12 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jul 26 19:21:18 volumioak wpa_supplicant[933]: wlan0: Failed to initiate sched scan
Jul 26 19:21:22 volumioak volumio[21877]: thread 'main' panicked at 'Authentication failed with reason: BadCredentials', /build/cache/git/checkouts/librespot-6f197fd632ef9380/08d8bcc/core/src/connection/mod.rs:93:21
Jul 26 19:21:22 volumioak volumio[21877]: stack backtrace:
Jul 26 19:21:22 volumioak volumio[21877]: 0: 0x968444 - std::backtrace_rs::backtrace::libunwind::trace::h40a4eff66330a36d
Jul 26 19:21:22 volumioak volumio[21877]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5
Jul 26 19:21:22 volumioak volumio[21877]: 1: 0x968444 - std::backtrace_rs::backtrace::trace_unsynchronized::hbce01963451b0cd5
Jul 26 19:21:22 volumioak volumio[21877]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
Jul 26 19:21:22 volumioak volumio[21877]: 2: 0x968444 - std::sys_common::backtrace::_print_fmt::h95da650d09c7e00b
Jul 26 19:21:22 volumioak volumio[21877]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:66:5
Jul 26 19:21:22 volumioak volumio[21877]: 3: 0x968444 - ::fmt::h33b23b1d14f668ff
Jul 26 19:21:22 volumioak volumio[21877]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:45:22
Jul 26 19:21:22 volumioak volumio[21877]: 4: 0x9910dc - core::fmt::write::h6320fb0e6ac90e58
Jul 26 19:21:22 volumioak volumio[21877]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/fmt/mod.rs:1190:17
Jul 26 19:21:22 volumioak volumio[21877]: 5: 0x9604c4 - std::io::Write::write_fmt::h33b25d4810ca481f
Jul 26 19:21:22 volumioak volumio[21877]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/io/mod.rs:1657:15
Jul 26 19:21:22 volumioak volumio[21877]: 6: 0x96aef4 - std::sys_common::backtrace::_print::h7e61c5be69c715ef
Jul 26 19:21:22 volumioak volumio[21877]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:48:5
Jul 26 19:21:22 volumioak volumio[21877]: 7: 0x96aef4 - std::sys_common::backtrace::print::h3cee176d7c8dab8b
Jul 26 19:21:22 volumioak volumio[21877]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:35:9
Jul 26 19:21:22 volumioak volumio[21877]: 8: 0x96aef4 - std::panicking::default_hook::{{closure}}::h2d0211dd2e97dc43
Jul 26 19:21:22 volumioak volumio[21877]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:295:22
Jul 26 19:21:22 volumioak volumio[21877]: 9: 0x96ab14 - std::panicking::default_hook::hcbdb3b7c40dca30c
Jul 26 19:21:22 volumioak volumio[21877]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:314:9
Jul 26 19:21:22 volumioak volumio[21877]: 10: 0x96b694 - std::panicking::rust_panic_with_hook::h4ce49e7a343dc12b
Jul 26 19:21:22 volumioak volumio[21877]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:698:17
Jul 26 19:21:22 volumioak volumio[21877]: 11: 0x96b304 - std::panicking::begin_panic_handler::{{closure}}::h4961100fae529fe9
Jul 26 19:21:22 volumioak volumio[21877]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:588:13
Jul 26 19:21:22 volumioak volumio[21877]: 12: 0x9689c4 - std::sys_common::backtrace::__rust_end_short_backtrace::hf2e68e62c7a80f1f
Jul 26 19:21:22 volumioak volumio[21877]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:138:18
Jul 26 19:21:22 volumioak volumio[21877]: 13: 0x96b098 - rust_begin_unwind
Jul 26 19:21:22 volumioak volumio[21877]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:584:5
Jul 26 19:21:22 volumioak volumio[21877]: 14: 0x44e6f4 - core::panicking::panic_fmt::h84c42730e4a50809
Jul 26 19:21:22 volumioak volumio[21877]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/panicking.rs:143:14
Jul 26 19:21:22 volumioak volumio[21877]: 15: 0x63a930 - futures::future::chain::Chain::poll::hb08394d341f2da5e
Jul 26 19:21:22 volumioak volumio[21877]: 16: 0x6b8d4c - as futures::future::Future>::poll::h0222f8b810b74ccb
Jul 26 19:21:22 volumioak volumio[21877]: 17: 0x63b53c - futures::future::chain::Chain::poll::hd3215a5f3268adbc
Jul 26 19:21:22 volumioak volumio[21877]: 18: 0x6b15f0 - as futures::future::Future>::poll::hc28eaa01d8d9029a
Jul 26 19:21:22 volumioak volumio[21877]: 19: 0x475b34 - ::poll::h5fd9e3bcdeb25ad9
Jul 26 19:21:22 volumioak volumio[21877]: 20: 0x4933dc - futures::task_impl::std::set::h8f754e80bd562d0a
Jul 26 19:21:22 volumioak volumio[21877]: 21: 0x4aa42c - std::thread::local::LocalKey::with::h71cfa1e374fcc0a0
Jul 26 19:21:22 volumioak volumio[21877]: 22: 0x48f99c - tokio_current_thread::Entered::block_on::hde55cdf28eabe6d5
Jul 26 19:21:22 volumioak volumio[21877]: 23: 0x4aa6f0 - std::thread::local::LocalKey::with::hedba3cfe41326627
Jul 26 19:21:22 volumioak volumio[21877]: 24: 0x492880 - tokio::runtime::current_thread::runtime::Runtime::block_on::h60d5b89560100ed8
Jul 26 19:21:22 volumioak volumio[21877]: 25: 0x478eb0 - vollibrespot::main::h35555355ed947dd1
Jul 26 19:21:22 volumioak volumio[21877]: 26: 0x498c50 - std::sys_common::backtrace::__rust_begin_short_backtrace::hef626a10d324c12a
Jul 26 19:21:22 volumioak volumio[21877]: 27: 0x4be52c - std::rt::lang_start::{{closure}}::hd80188e4bcac5072
Jul 26 19:21:22 volumioak volumio[21877]: 28: 0x967b28 - core::ops::function::impls:: for &F>::call_once::h0567da839a080232
Jul 26 19:21:22 volumioak volumio[21877]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/ops/function.rs:259:13
Jul 26 19:21:22 volumioak volumio[21877]: 29: 0x967b28 - std::panicking::try::do_call::hdf194554a41aa3cc
Jul 26 19:21:22 volumioak volumio[21877]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40
Jul 26 19:21:22 volumioak volumio[21877]: 30: 0x967b28 - std::panicking::try::hbf4b7be9f9ffa5f8
Jul 26 19:21:22 volumioak volumio[21877]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19
Jul 26 19:21:22 volumioak volumio[21877]: 31: 0x967b28 - std::panic::catch_unwind::h45f392a39f2fe48c
Jul 26 19:21:22 volumioak volumio[21877]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14
Jul 26 19:21:22 volumioak volumio[21877]: 32: 0x967b28 - std::rt::lang_start_internal::{{closure}}::hd772cb03c2060671
Jul 26 19:21:22 volumioak volumio[21877]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/rt.rs:128:48
Jul 26 19:21:22 volumioak volumio[21877]: 33: 0x967b28 - std::panicking::try::do_call::hd126f715b519ff2a
Jul 26 19:21:22 volumioak volumio[21877]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40
Jul 26 19:21:22 volumioak volumio[21877]: 34: 0x967b28 - std::panicking::try::h80b7148ce71893dc
Jul 26 19:21:22 volumioak volumio[21877]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19
Jul 26 19:21:22 volumioak volumio[21877]: 35: 0x967b28 - std::panic::catch_unwind::h1562f0b2e8a9cb0d
Jul 26 19:21:22 volumioak volumio[21877]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14
Jul 26 19:21:22 volumioak volumio[21877]: 36: 0x967b28 - std::rt::lang_start_internal::h3daa586a0b835507
Jul 26 19:21:22 volumioak volumio[21877]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/rt.rs:128:20
Jul 26 19:21:22 volumioak volumio[21877]: 37: 0x47ae80 - main
Jul 26 19:21:22 volumioak volumio[21877]: 38: 0x76c51768 - __libc_start_main
Jul 26 19:21:22 volumioak systemd[1]: volspotconnect.service: Main process exited, code=exited, status=101/n/a
Jul 26 19:21:22 volumioak systemd[1]: volspotconnect.service: Failed with result 'exit-code'.
Jul 26 19:21:23 volumioak wpa_supplicant[933]: wlan0: Failed to initiate sched scan
Jul 26 19:21:25 volumioak systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart.
Jul 26 19:21:25 volumioak systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 8.
Jul 26 19:21:25 volumioak systemd[1]: Stopped Volspotconnect2 Daemon.
Jul 26 19:21:25 volumioak systemd[1]: Started Volspotconnect2 Daemon.
Jul 26 19:21:25 volumioak volumio[21929]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31
Jul 26 19:21:25 volumioak volumio[21929]: Reading Config from "/tmp/volspotify.toml"
Jul 26 19:21:25 volumioak volumio[21929]: [Vollibrespot] : Using Alsa backend with device: volumio
Jul 26 19:21:25 volumioak volumio[21929]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" }
Jul 26 19:21:27 volumioak volumio[1086]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 26 19:21:27 volumioak volumio[1086]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 26 19:21:27 volumioak volumio[1086]: info: Retrieving Cloud Streaming UI
Jul 26 19:21:27 volumioak volumio[1086]: info: Getting Tidal Cloud Configuration
Jul 26 19:21:27 volumioak volumio[1086]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 26 19:21:27 volumioak volumio[1086]: info: Getting Qobuz Cloud Configuration
Jul 26 19:21:27 volumioak volumio[1086]: info: Asking plugin for UI Config
Jul 26 19:21:27 volumioak volumio[1086]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 26 19:21:27 volumioak volumio[1086]: info: Getting Spotify Cloud Configuration
Jul 26 19:21:27 volumioak volumio[1086]: info: Asking plugin for UI Config
Jul 26 19:21:27 volumioak volumio[1086]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 26 19:21:27 volumioak volumio[1086]: info: Saving Spotify Acccount
Jul 26 19:21:27 volumioak volumio[1086]: info: Got Tidal Cloud Configuration
Jul 26 19:21:27 volumioak volumio[1086]: info: Got it
Jul 26 19:21:27 volumioak volumio[1086]: info: Got it
Jul 26 19:21:27 volumioak volumio[1086]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Jul 26 19:21:27 volumioak volumio[1086]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 26 19:21:27 volumioak volumio[1086]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Jul 26 19:21:27 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jul 26 19:21:27 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jul 26 19:21:27 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jul 26 19:21:27 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Jul 26 19:21:27 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 26 19:21:27 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 26 19:21:27 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 26 19:21:27 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 26 19:21:27 volumioak volumio[1086]: info: CoreCommandRouter::volumioGetBrowseSources
Jul 26 19:21:27 volumioak volumio[1086]: info: CoreCommandRouter::volumioGetBrowseSources
Jul 26 19:21:27 volumioak volumio[1086]: info: CoreCommandRouter::volumioGetBrowseSources
Jul 26 19:21:27 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 26 19:21:28 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Jul 26 19:21:29 volumioak wpa_supplicant[933]: wlan0: Failed to initiate sched scan
Jul 26 19:21:31 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 26 19:21:34 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Jul 26 19:21:34 volumioak volumio[1086]: verbose: ControllerMpd::sendMpdCommand rescan
Jul 26 19:21:34 volumioak volumio[1086]: verbose: ControllerMpd::sendMpdCommand status
Jul 26 19:21:34 volumioak volumio[1086]: info:
Jul 26 19:21:34 volumioak volumio[1086]: ---------------------------- MPD announces state update: update
Jul 26 19:21:34 volumioak volumio[1086]: info: sendMpdCommand rescan took 4 milliseconds
Jul 26 19:21:34 volumioak volumio[1086]: info: ControllerMpd::getState
Jul 26 19:21:34 volumioak volumio[1086]: verbose: ControllerMpd::sendMpdCommand status
Jul 26 19:21:34 volumioak volumio[1086]: info: sendMpdCommand status took 3 milliseconds
Jul 26 19:21:34 volumioak volumio[1086]: info: sendMpdCommand status took 1 milliseconds
Jul 26 19:21:34 volumioak volumio[1086]: verbose: ControllerMpd::parseState
Jul 26 19:21:34 volumioak volumio[1086]: info: Command Router : Notfying DB Updatetrue
Jul 26 19:21:34 volumioak volumio[1086]: info: CoreCommandRouter::Close All Modals sent
Jul 26 19:21:34 volumioak volumio[1086]: verbose: ControllerMpd::parseState
Jul 26 19:21:34 volumioak volumio[1086]: info: ControllerMpd::pushState
Jul 26 19:21:34 volumioak volumio[1086]: info: CoreCommandRouter::servicePushState
Jul 26 19:21:34 volumioak volumio[1086]: info: CoreStateMachine::pushState
Jul 26 19:21:34 volumioak volumio[1086]: info: CorePlayQueue::getTrack 3
Jul 26 19:21:34 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 26 19:21:34 volumioak volumio[1086]: info: CoreCommandRouter::volumioPushState
Jul 26 19:21:34 volumioak volumio[1086]: info: CorePlayQueue::getTrack 3
Jul 26 19:21:34 volumioak volumio[1086]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jul 26 19:21:34 volumioak volumio[1086]: verbose: CURRENT POSITION 3
Jul 26 19:21:34 volumioak volumio[1086]: info: CoreStateMachine::syncState stateService stop
Jul 26 19:21:34 volumioak volumio[1086]: info: CoreStateMachine::syncState currentStatus stop
Jul 26 19:21:34 volumioak volumio[1086]: info: CoreStateMachine::pushState
Jul 26 19:21:34 volumioak volumio[1086]: info: CorePlayQueue::getTrack 3
Jul 26 19:21:34 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 26 19:21:34 volumioak volumio[1086]: info: CoreCommandRouter::volumioPushState
Jul 26 19:21:34 volumioak volumio[1086]: info: No code
Jul 26 19:21:34 volumioak volumio[1086]: info: CoreStateMachine::pushState
Jul 26 19:21:34 volumioak volumio[1086]: info: CorePlayQueue::getTrack 3
Jul 26 19:21:34 volumioak volumio[1086]: info: CoreCommandRouter::volumioPushState
Jul 26 19:21:34 volumioak volumio[1086]: info: ------------------------------ 89ms
Jul 26 19:21:34 volumioak volumio[1086]: verbose: ControllerMpd::sendMpdCommand status
Jul 26 19:21:34 volumioak volumio[1086]: info:
Jul 26 19:21:34 volumioak volumio[1086]: ---------------------------- MPD announces state update: update
Jul 26 19:21:34 volumioak volumio[1086]: info: ControllerMpd::getState
Jul 26 19:21:34 volumioak volumio[1086]: verbose: ControllerMpd::sendMpdCommand status
Jul 26 19:21:34 volumioak volumio[1086]: info: sendMpdCommand status took 6 milliseconds
Jul 26 19:21:34 volumioak volumio[1086]: info: sendMpdCommand status took 5 milliseconds
Jul 26 19:21:34 volumioak volumio[1086]: verbose: ControllerMpd::parseState
Jul 26 19:21:34 volumioak volumio[1086]: info: Command Router : Notfying DB Updatefalse
Jul 26 19:21:34 volumioak volumio[1086]: info: CoreCommandRouter::Close All Modals sent
Jul 26 19:21:34 volumioak volumio[1086]: verbose: ControllerMpd::parseState
Jul 26 19:21:34 volumioak volumio[1086]: info: ControllerMpd::pushState
Jul 26 19:21:34 volumioak volumio[1086]: info: CoreCommandRouter::servicePushState
Jul 26 19:21:34 volumioak volumio[1086]: info: CoreStateMachine::pushState
Jul 26 19:21:34 volumioak volumio[1086]: info: CorePlayQueue::getTrack 3
Jul 26 19:21:34 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 26 19:21:34 volumioak volumio[1086]: info: CoreCommandRouter::volumioPushState
Jul 26 19:21:34 volumioak volumio[1086]: info: CorePlayQueue::getTrack 3
Jul 26 19:21:34 volumioak volumio[1086]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jul 26 19:21:34 volumioak volumio[1086]: verbose: CURRENT POSITION 3
Jul 26 19:21:34 volumioak volumio[1086]: info: CoreStateMachine::syncState stateService stop
Jul 26 19:21:34 volumioak volumio[1086]: info: CoreStateMachine::syncState currentStatus stop
Jul 26 19:21:34 volumioak volumio[1086]: info: CoreStateMachine::pushState
Jul 26 19:21:34 volumioak volumio[1086]: info: CorePlayQueue::getTrack 3
Jul 26 19:21:34 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 26 19:21:34 volumioak volumio[1086]: info: CoreCommandRouter::volumioPushState
Jul 26 19:21:34 volumioak volumio[1086]: info: No code
Jul 26 19:21:34 volumioak volumio[1086]: info: CoreStateMachine::pushState
Jul 26 19:21:34 volumioak volumio[1086]: info: CorePlayQueue::getTrack 3
Jul 26 19:21:34 volumioak volumio[1086]: info: CoreCommandRouter::volumioPushState
Jul 26 19:21:34 volumioak volumio[1086]: info: ------------------------------ 56ms
Jul 26 19:21:35 volumioak wpa_supplicant[933]: wlan0: Failed to initiate sched scan
Jul 26 19:21:35 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 26 19:21:36 volumioak volumio[21929]: [Vollibrespot] : Connecting to AP "ap-gew1.spotify.com:443"
Jul 26 19:21:39 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 26 19:21:40 volumioak wpa_supplicant[933]: wlan0: Failed to initiate sched scan
Jul 26 19:21:43 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 26 19:21:46 volumioak wpa_supplicant[933]: wlan0: Failed to initiate sched scan
Jul 26 19:21:47 volumioak volumio[21929]: thread 'main' panicked at 'Authentication failed with reason: BadCredentials', /build/cache/git/checkouts/librespot-6f197fd632ef9380/08d8bcc/core/src/connection/mod.rs:93:21
Jul 26 19:21:47 volumioak volumio[21929]: stack backtrace:
Jul 26 19:21:47 volumioak volumio[21929]: 0: 0xa58444 - std::backtrace_rs::backtrace::libunwind::trace::h40a4eff66330a36d
Jul 26 19:21:47 volumioak volumio[21929]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5
Jul 26 19:21:47 volumioak volumio[21929]: 1: 0xa58444 - std::backtrace_rs::backtrace::trace_unsynchronized::hbce01963451b0cd5
Jul 26 19:21:47 volumioak volumio[21929]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
Jul 26 19:21:47 volumioak volumio[21929]: 2: 0xa58444 - std::sys_common::backtrace::_print_fmt::h95da650d09c7e00b
Jul 26 19:21:47 volumioak volumio[21929]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:66:5
Jul 26 19:21:47 volumioak volumio[21929]: 3: 0xa58444 - ::fmt::h33b23b1d14f668ff
Jul 26 19:21:47 volumioak volumio[21929]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:45:22
Jul 26 19:21:47 volumioak volumio[21929]: 4: 0xa810dc - core::fmt::write::h6320fb0e6ac90e58
Jul 26 19:21:47 volumioak volumio[21929]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/fmt/mod.rs:1190:17
Jul 26 19:21:47 volumioak volumio[21929]: 5: 0xa504c4 - std::io::Write::write_fmt::h33b25d4810ca481f
Jul 26 19:21:47 volumioak volumio[21929]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/io/mod.rs:1657:15
Jul 26 19:21:47 volumioak volumio[21929]: 6: 0xa5aef4 - std::sys_common::backtrace::_print::h7e61c5be69c715ef
Jul 26 19:21:47 volumioak volumio[21929]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:48:5
Jul 26 19:21:47 volumioak volumio[21929]: 7: 0xa5aef4 - std::sys_common::backtrace::print::h3cee176d7c8dab8b
Jul 26 19:21:47 volumioak volumio[21929]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:35:9
Jul 26 19:21:47 volumioak volumio[21929]: 8: 0xa5aef4 - std::panicking::default_hook::{{closure}}::h2d0211dd2e97dc43
Jul 26 19:21:47 volumioak volumio[21929]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:295:22
Jul 26 19:21:47 volumioak volumio[21929]: 9: 0xa5ab14 - std::panicking::default_hook::hcbdb3b7c40dca30c
Jul 26 19:21:47 volumioak volumio[21929]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:314:9
Jul 26 19:21:47 volumioak volumio[21929]: 10: 0xa5b694 - std::panicking::rust_panic_with_hook::h4ce49e7a343dc12b
Jul 26 19:21:47 volumioak volumio[21929]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:698:17
Jul 26 19:21:47 volumioak volumio[21929]: 11: 0xa5b304 - std::panicking::begin_panic_handler::{{closure}}::h4961100fae529fe9
Jul 26 19:21:47 volumioak volumio[21929]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:588:13
Jul 26 19:21:47 volumioak volumio[21929]: 12: 0xa589c4 - std::sys_common::backtrace::__rust_end_short_backtrace::hf2e68e62c7a80f1f
Jul 26 19:21:47 volumioak volumio[21929]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:138:18
Jul 26 19:21:47 volumioak volumio[21929]: 13: 0xa5b098 - rust_begin_unwind
Jul 26 19:21:47 volumioak volumio[21929]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:584:5
Jul 26 19:21:47 volumioak volumio[21929]: 14: 0x53e6f4 - core::panicking::panic_fmt::h84c42730e4a50809
Jul 26 19:21:47 volumioak volumio[21929]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/panicking.rs:143:14
Jul 26 19:21:47 volumioak volumio[21929]: 15: 0x72a930 - futures::future::chain::Chain::poll::hb08394d341f2da5e
Jul 26 19:21:47 volumioak volumio[21929]: 16: 0x7a8d4c - as futures::future::Future>::poll::h0222f8b810b74ccb
Jul 26 19:21:47 volumioak volumio[21929]: 17: 0x72b53c - futures::future::chain::Chain::poll::hd3215a5f3268adbc
Jul 26 19:21:47 volumioak volumio[21929]: 18: 0x7a15f0 - as futures::future::Future>::poll::hc28eaa01d8d9029a
Jul 26 19:21:47 volumioak volumio[21929]: 19: 0x565b34 - ::poll::h5fd9e3bcdeb25ad9
Jul 26 19:21:47 volumioak volumio[21929]: 20: 0x5833dc - futures::task_impl::std::set::h8f754e80bd562d0a
Jul 26 19:21:47 volumioak volumio[21929]: 21: 0x59a42c - std::thread::local::LocalKey::with::h71cfa1e374fcc0a0
Jul 26 19:21:47 volumioak volumio[21929]: 22: 0x57f99c - tokio_current_thread::Entered::block_on::hde55cdf28eabe6d5
Jul 26 19:21:47 volumioak volumio[21929]: 23: 0x59a6f0 - std::thread::local::LocalKey::with::hedba3cfe41326627
Jul 26 19:21:47 volumioak volumio[21929]: 24: 0x582880 - tokio::runtime::current_thread::runtime::Runtime::block_on::h60d5b89560100ed8
Jul 26 19:21:47 volumioak volumio[21929]: 25: 0x568eb0 - vollibrespot::main::h35555355ed947dd1
Jul 26 19:21:47 volumioak volumio[21929]: 26: 0x588c50 - std::sys_common::backtrace::__rust_begin_short_backtrace::hef626a10d324c12a
Jul 26 19:21:47 volumioak volumio[21929]: 27: 0x5ae52c - std::rt::lang_start::{{closure}}::hd80188e4bcac5072
Jul 26 19:21:47 volumioak volumio[21929]: 28: 0xa57b28 - core::ops::function::impls:: for &F>::call_once::h0567da839a080232
Jul 26 19:21:47 volumioak volumio[21929]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/ops/function.rs:259:13
Jul 26 19:21:47 volumioak volumio[21929]: 29: 0xa57b28 - std::panicking::try::do_call::hdf194554a41aa3cc
Jul 26 19:21:47 volumioak volumio[21929]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40
Jul 26 19:21:47 volumioak volumio[21929]: 30: 0xa57b28 - std::panicking::try::hbf4b7be9f9ffa5f8
Jul 26 19:21:47 volumioak volumio[21929]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19
Jul 26 19:21:47 volumioak volumio[21929]: 31: 0xa57b28 - std::panic::catch_unwind::h45f392a39f2fe48c
Jul 26 19:21:47 volumioak volumio[21929]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14
Jul 26 19:21:47 volumioak volumio[21929]: 32: 0xa57b28 - std::rt::lang_start_internal::{{closure}}::hd772cb03c2060671
Jul 26 19:21:47 volumioak volumio[21929]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/rt.rs:128:48
Jul 26 19:21:47 volumioak volumio[21929]: 33: 0xa57b28 - std::panicking::try::do_call::hd126f715b519ff2a
Jul 26 19:21:47 volumioak volumio[21929]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40
Jul 26 19:21:47 volumioak volumio[21929]: 34: 0xa57b28 - std::panicking::try::h80b7148ce71893dc
Jul 26 19:21:47 volumioak volumio[21929]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19
Jul 26 19:21:47 volumioak volumio[21929]: 35: 0xa57b28 - std::panic::catch_unwind::h1562f0b2e8a9cb0d
Jul 26 19:21:47 volumioak volumio[21929]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14
Jul 26 19:21:47 volumioak volumio[21929]: 36: 0xa57b28 - std::rt::lang_start_internal::h3daa586a0b835507
Jul 26 19:21:47 volumioak volumio[21929]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/rt.rs:128:20
Jul 26 19:21:47 volumioak volumio[21929]: 37: 0x56ae80 - main
Jul 26 19:21:47 volumioak volumio[21929]: 38: 0x76c6e768 - __libc_start_main
Jul 26 19:21:47 volumioak systemd[1]: volspotconnect.service: Main process exited, code=exited, status=101/n/a
Jul 26 19:21:47 volumioak systemd[1]: volspotconnect.service: Failed with result 'exit-code'.
Jul 26 19:21:47 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 26 19:21:49 volumioak systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart.
Jul 26 19:21:49 volumioak systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 9.
Jul 26 19:21:49 volumioak systemd[1]: Stopped Volspotconnect2 Daemon.
Jul 26 19:21:49 volumioak systemd[1]: Started Volspotconnect2 Daemon.
Jul 26 19:21:49 volumioak volumio[21941]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31
Jul 26 19:21:49 volumioak volumio[21941]: Reading Config from "/tmp/volspotify.toml"
Jul 26 19:21:49 volumioak volumio[21941]: [Vollibrespot] : Using Alsa backend with device: volumio
Jul 26 19:21:49 volumioak volumio[21941]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" }
Jul 26 19:21:49 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb
Jul 26 19:21:49 volumioak volumio[1086]: verbose: ControllerMpd::sendMpdCommand update
Jul 26 19:21:49 volumioak volumio[1086]: verbose: ControllerMpd::sendMpdCommand status
Jul 26 19:21:49 volumioak volumio[1086]: info:
Jul 26 19:21:49 volumioak volumio[1086]: ---------------------------- MPD announces state update: update
Jul 26 19:21:49 volumioak volumio[1086]: info: sendMpdCommand update took 4 milliseconds
Jul 26 19:21:49 volumioak volumio[1086]: info: ControllerMpd::getState
Jul 26 19:21:49 volumioak volumio[1086]: verbose: ControllerMpd::sendMpdCommand status
Jul 26 19:21:49 volumioak volumio[1086]: verbose: ControllerMpd::sendMpdCommand status
Jul 26 19:21:49 volumioak volumio[1086]: info:
Jul 26 19:21:49 volumioak volumio[1086]: ---------------------------- MPD announces state update: update
Jul 26 19:21:49 volumioak volumio[1086]: info: ControllerMpd::getState
Jul 26 19:21:49 volumioak volumio[1086]: verbose: ControllerMpd::sendMpdCommand status
Jul 26 19:21:49 volumioak volumio[1086]: info: sendMpdCommand status took 7 milliseconds
Jul 26 19:21:49 volumioak volumio[1086]: info: sendMpdCommand status took 5 milliseconds
Jul 26 19:21:49 volumioak volumio[1086]: verbose: ControllerMpd::parseState
Jul 26 19:21:49 volumioak volumio[1086]: info: Command Router : Notfying DB Updatefalse
Jul 26 19:21:49 volumioak volumio[1086]: info: CoreCommandRouter::Close All Modals sent
Jul 26 19:21:49 volumioak volumio[1086]: verbose: ControllerMpd::parseState
Jul 26 19:21:49 volumioak volumio[1086]: info: ControllerMpd::pushState
Jul 26 19:21:49 volumioak volumio[1086]: info: CoreCommandRouter::servicePushState
Jul 26 19:21:49 volumioak volumio[1086]: info: CoreStateMachine::pushState
Jul 26 19:21:49 volumioak volumio[1086]: info: CorePlayQueue::getTrack 3
Jul 26 19:21:49 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 26 19:21:49 volumioak volumio[1086]: info: CoreCommandRouter::volumioPushState
Jul 26 19:21:49 volumioak volumio[1086]: info: CorePlayQueue::getTrack 3
Jul 26 19:21:49 volumioak volumio[1086]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jul 26 19:21:49 volumioak volumio[1086]: verbose: CURRENT POSITION 3
Jul 26 19:21:49 volumioak volumio[1086]: info: CoreStateMachine::syncState stateService stop
Jul 26 19:21:49 volumioak volumio[1086]: info: CoreStateMachine::syncState currentStatus stop
Jul 26 19:21:49 volumioak volumio[1086]: info: CoreStateMachine::pushState
Jul 26 19:21:49 volumioak volumio[1086]: info: CorePlayQueue::getTrack 3
Jul 26 19:21:49 volumioak volumio[1086]: info: CoreCommandRouter::volumioPushState
Jul 26 19:21:49 volumioak volumio[1086]: info: No code
Jul 26 19:21:49 volumioak volumio[1086]: info: CoreStateMachine::pushState
Jul 26 19:21:49 volumioak volumio[1086]: info: CorePlayQueue::getTrack 3
Jul 26 19:21:49 volumioak volumio[1086]: info: CoreCommandRouter::volumioPushState
Jul 26 19:21:49 volumioak volumio[1086]: info: ------------------------------ 63ms
Jul 26 19:21:49 volumioak volumio[1086]: info: sendMpdCommand status took 60 milliseconds
Jul 26 19:21:49 volumioak volumio[1086]: info: sendMpdCommand status took 59 milliseconds
Jul 26 19:21:49 volumioak volumio[1086]: verbose: ControllerMpd::parseState
Jul 26 19:21:49 volumioak volumio[1086]: info: Command Router : Notfying DB Updatefalse
Jul 26 19:21:49 volumioak volumio[1086]: info: CoreCommandRouter::Close All Modals sent
Jul 26 19:21:49 volumioak volumio[1086]: verbose: ControllerMpd::parseState
Jul 26 19:21:49 volumioak volumio[1086]: info: ControllerMpd::pushState
Jul 26 19:21:49 volumioak volumio[1086]: info: CoreCommandRouter::servicePushState
Jul 26 19:21:49 volumioak volumio[1086]: info: CoreStateMachine::pushState
Jul 26 19:21:49 volumioak volumio[1086]: info: CorePlayQueue::getTrack 3
Jul 26 19:21:49 volumioak volumio[1086]: info: CoreCommandRouter::volumioPushState
Jul 26 19:21:49 volumioak volumio[1086]: info: CorePlayQueue::getTrack 3
Jul 26 19:21:49 volumioak volumio[1086]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jul 26 19:21:49 volumioak volumio[1086]: verbose: CURRENT POSITION 3
Jul 26 19:21:49 volumioak volumio[1086]: info: CoreStateMachine::syncState stateService stop
Jul 26 19:21:49 volumioak volumio[1086]: info: CoreStateMachine::syncState currentStatus stop
Jul 26 19:21:49 volumioak volumio[1086]: info: CoreStateMachine::pushState
Jul 26 19:21:49 volumioak volumio[1086]: info: CorePlayQueue::getTrack 3
Jul 26 19:21:49 volumioak volumio[1086]: info: CoreCommandRouter::volumioPushState
Jul 26 19:21:49 volumioak volumio[1086]: info: No code
Jul 26 19:21:49 volumioak volumio[1086]: info: CoreStateMachine::pushState
Jul 26 19:21:49 volumioak volumio[1086]: info: CorePlayQueue::getTrack 3
Jul 26 19:21:49 volumioak volumio[1086]: info: CoreCommandRouter::volumioPushState
Jul 26 19:21:49 volumioak volumio[1086]: info: ------------------------------ 111ms
Jul 26 19:21:51 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 26 19:21:51 volumioak wpa_supplicant[933]: wlan0: Failed to initiate sched scan
Jul 26 19:21:55 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 26 19:21:57 volumioak wpa_supplicant[933]: wlan0: Failed to initiate sched scan
Jul 26 19:21:59 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 26 19:22:00 volumioak volumio[21941]: [Vollibrespot] : Connecting to AP "ap-gew1.spotify.com:443"
Jul 26 19:22:03 volumioak wpa_supplicant[933]: wlan0: Failed to initiate sched scan
Jul 26 19:22:03 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 26 19:22:07 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 26 19:22:08 volumioak wpa_supplicant[933]: wlan0: Failed to initiate sched scan
Jul 26 19:22:11 volumioak volumio[21941]: thread 'main' panicked at 'Authentication failed with reason: BadCredentials', /build/cache/git/checkouts/librespot-6f197fd632ef9380/08d8bcc/core/src/connection/mod.rs:93:21
Jul 26 19:22:11 volumioak volumio[21941]: stack backtrace:
Jul 26 19:22:11 volumioak volumio[21941]: 0: 0xa08444 - std::backtrace_rs::backtrace::libunwind::trace::h40a4eff66330a36d
Jul 26 19:22:11 volumioak volumio[21941]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5
Jul 26 19:22:11 volumioak volumio[21941]: 1: 0xa08444 - std::backtrace_rs::backtrace::trace_unsynchronized::hbce01963451b0cd5
Jul 26 19:22:11 volumioak volumio[21941]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
Jul 26 19:22:11 volumioak volumio[21941]: 2: 0xa08444 - std::sys_common::backtrace::_print_fmt::h95da650d09c7e00b
Jul 26 19:22:11 volumioak volumio[21941]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:66:5
Jul 26 19:22:11 volumioak volumio[21941]: 3: 0xa08444 - ::fmt::h33b23b1d14f668ff
Jul 26 19:22:11 volumioak volumio[21941]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:45:22
Jul 26 19:22:11 volumioak volumio[21941]: 4: 0xa310dc - core::fmt::write::h6320fb0e6ac90e58
Jul 26 19:22:11 volumioak volumio[21941]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/fmt/mod.rs:1190:17
Jul 26 19:22:11 volumioak volumio[21941]: 5: 0xa004c4 - std::io::Write::write_fmt::h33b25d4810ca481f
Jul 26 19:22:11 volumioak volumio[21941]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/io/mod.rs:1657:15
Jul 26 19:22:11 volumioak volumio[21941]: 6: 0xa0aef4 - std::sys_common::backtrace::_print::h7e61c5be69c715ef
Jul 26 19:22:11 volumioak volumio[21941]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:48:5
Jul 26 19:22:11 volumioak volumio[21941]: 7: 0xa0aef4 - std::sys_common::backtrace::print::h3cee176d7c8dab8b
Jul 26 19:22:11 volumioak volumio[21941]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:35:9
Jul 26 19:22:11 volumioak volumio[21941]: 8: 0xa0aef4 - std::panicking::default_hook::{{closure}}::h2d0211dd2e97dc43
Jul 26 19:22:11 volumioak volumio[21941]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:295:22
Jul 26 19:22:11 volumioak volumio[21941]: 9: 0xa0ab14 - std::panicking::default_hook::hcbdb3b7c40dca30c
Jul 26 19:22:11 volumioak volumio[21941]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:314:9
Jul 26 19:22:11 volumioak volumio[21941]: 10: 0xa0b694 - std::panicking::rust_panic_with_hook::h4ce49e7a343dc12b
Jul 26 19:22:11 volumioak volumio[21941]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:698:17
Jul 26 19:22:11 volumioak volumio[21941]: 11: 0xa0b304 - std::panicking::begin_panic_handler::{{closure}}::h4961100fae529fe9
Jul 26 19:22:11 volumioak volumio[21941]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:588:13
Jul 26 19:22:11 volumioak volumio[21941]: 12: 0xa089c4 - std::sys_common::backtrace::__rust_end_short_backtrace::hf2e68e62c7a80f1f
Jul 26 19:22:11 volumioak volumio[21941]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/sys_common/backtrace.rs:138:18
Jul 26 19:22:11 volumioak volumio[21941]: 13: 0xa0b098 - rust_begin_unwind
Jul 26 19:22:11 volumioak volumio[21941]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:584:5
Jul 26 19:22:11 volumioak volumio[21941]: 14: 0x4ee6f4 - core::panicking::panic_fmt::h84c42730e4a50809
Jul 26 19:22:11 volumioak volumio[21941]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/panicking.rs:143:14
Jul 26 19:22:11 volumioak volumio[21941]: 15: 0x6da930 - futures::future::chain::Chain::poll::hb08394d341f2da5e
Jul 26 19:22:11 volumioak volumio[21941]: 16: 0x758d4c - as futures::future::Future>::poll::h0222f8b810b74ccb
Jul 26 19:22:11 volumioak volumio[21941]: 17: 0x6db53c - futures::future::chain::Chain::poll::hd3215a5f3268adbc
Jul 26 19:22:11 volumioak volumio[21941]: 18: 0x7515f0 - as futures::future::Future>::poll::hc28eaa01d8d9029a
Jul 26 19:22:11 volumioak volumio[21941]: 19: 0x515b34 - ::poll::h5fd9e3bcdeb25ad9
Jul 26 19:22:11 volumioak volumio[21941]: 20: 0x5333dc - futures::task_impl::std::set::h8f754e80bd562d0a
Jul 26 19:22:11 volumioak volumio[21941]: 21: 0x54a42c - std::thread::local::LocalKey::with::h71cfa1e374fcc0a0
Jul 26 19:22:11 volumioak volumio[21941]: 22: 0x52f99c - tokio_current_thread::Entered::block_on::hde55cdf28eabe6d5
Jul 26 19:22:11 volumioak volumio[21941]: 23: 0x54a6f0 - std::thread::local::LocalKey::with::hedba3cfe41326627
Jul 26 19:22:11 volumioak volumio[21941]: 24: 0x532880 - tokio::runtime::current_thread::runtime::Runtime::block_on::h60d5b89560100ed8
Jul 26 19:22:11 volumioak volumio[21941]: 25: 0x518eb0 - vollibrespot::main::h35555355ed947dd1
Jul 26 19:22:11 volumioak volumio[21941]: 26: 0x538c50 - std::sys_common::backtrace::__rust_begin_short_backtrace::hef626a10d324c12a
Jul 26 19:22:11 volumioak volumio[21941]: 27: 0x55e52c - std::rt::lang_start::{{closure}}::hd80188e4bcac5072
Jul 26 19:22:11 volumioak volumio[21941]: 28: 0xa07b28 - core::ops::function::impls:: for &F>::call_once::h0567da839a080232
Jul 26 19:22:11 volumioak volumio[21941]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/core/src/ops/function.rs:259:13
Jul 26 19:22:11 volumioak volumio[21941]: 29: 0xa07b28 - std::panicking::try::do_call::hdf194554a41aa3cc
Jul 26 19:22:11 volumioak volumio[21941]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40
Jul 26 19:22:11 volumioak volumio[21941]: 30: 0xa07b28 - std::panicking::try::hbf4b7be9f9ffa5f8
Jul 26 19:22:11 volumioak volumio[21941]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19
Jul 26 19:22:11 volumioak volumio[21941]: 31: 0xa07b28 - std::panic::catch_unwind::h45f392a39f2fe48c
Jul 26 19:22:11 volumioak volumio[21941]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14
Jul 26 19:22:11 volumioak volumio[21941]: 32: 0xa07b28 - std::rt::lang_start_internal::{{closure}}::hd772cb03c2060671
Jul 26 19:22:11 volumioak volumio[21941]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/rt.rs:128:48
Jul 26 19:22:11 volumioak volumio[21941]: 33: 0xa07b28 - std::panicking::try::do_call::hd126f715b519ff2a
Jul 26 19:22:11 volumioak volumio[21941]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:492:40
Jul 26 19:22:11 volumioak volumio[21941]: 34: 0xa07b28 - std::panicking::try::h80b7148ce71893dc
Jul 26 19:22:11 volumioak volumio[21941]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panicking.rs:456:19
Jul 26 19:22:11 volumioak volumio[21941]: 35: 0xa07b28 - std::panic::catch_unwind::h1562f0b2e8a9cb0d
Jul 26 19:22:11 volumioak volumio[21941]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/panic.rs:137:14
Jul 26 19:22:11 volumioak volumio[21941]: 36: 0xa07b28 - std::rt::lang_start_internal::h3daa586a0b835507
Jul 26 19:22:11 volumioak volumio[21941]: at /rustc/7737e0b5c4103216d6fd8cf941b7ab9bdbaace7c/library/std/src/rt.rs:128:20
Jul 26 19:22:11 volumioak volumio[21941]: 37: 0x51ae80 - main
Jul 26 19:22:11 volumioak volumio[21941]: 38: 0x76c48768 - __libc_start_main
Jul 26 19:22:11 volumioak systemd[1]: volspotconnect.service: Main process exited, code=exited, status=101/n/a
Jul 26 19:22:11 volumioak systemd[1]: volspotconnect.service: Failed with result 'exit-code'.
Jul 26 19:22:11 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 26 19:22:12 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Jul 26 19:22:12 volumioak volumio[1086]: verbose: ControllerMpd::sendMpdCommand rescan
Jul 26 19:22:12 volumioak volumio[1086]: verbose: ControllerMpd::sendMpdCommand status
Jul 26 19:22:12 volumioak volumio[1086]: info:
Jul 26 19:22:12 volumioak volumio[1086]: ---------------------------- MPD announces state update: update
Jul 26 19:22:12 volumioak volumio[1086]: info: sendMpdCommand rescan took 4 milliseconds
Jul 26 19:22:12 volumioak volumio[1086]: info: ControllerMpd::getState
Jul 26 19:22:12 volumioak volumio[1086]: verbose: ControllerMpd::sendMpdCommand status
Jul 26 19:22:12 volumioak volumio[1086]: verbose: ControllerMpd::sendMpdCommand status
Jul 26 19:22:12 volumioak volumio[1086]: info:
Jul 26 19:22:12 volumioak volumio[1086]: ---------------------------- MPD announces state update: update
Jul 26 19:22:12 volumioak volumio[1086]: info: ControllerMpd::getState
Jul 26 19:22:12 volumioak volumio[1086]: verbose: ControllerMpd::sendMpdCommand status
Jul 26 19:22:12 volumioak volumio[1086]: info: sendMpdCommand status took 4 milliseconds
Jul 26 19:22:12 volumioak volumio[1086]: info: sendMpdCommand status took 3 milliseconds
Jul 26 19:22:12 volumioak volumio[1086]: verbose: ControllerMpd::parseState
Jul 26 19:22:12 volumioak volumio[1086]: info: Command Router : Notfying DB Updatefalse
Jul 26 19:22:12 volumioak volumio[1086]: info: CoreCommandRouter::Close All Modals sent
Jul 26 19:22:12 volumioak volumio[1086]: verbose: ControllerMpd::parseState
Jul 26 19:22:12 volumioak volumio[1086]: info: ControllerMpd::pushState
Jul 26 19:22:12 volumioak volumio[1086]: info: CoreCommandRouter::servicePushState
Jul 26 19:22:12 volumioak volumio[1086]: info: CoreStateMachine::pushState
Jul 26 19:22:12 volumioak volumio[1086]: info: CorePlayQueue::getTrack 3
Jul 26 19:22:12 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 26 19:22:12 volumioak volumio[1086]: info: CoreCommandRouter::volumioPushState
Jul 26 19:22:12 volumioak volumio[1086]: info: CorePlayQueue::getTrack 3
Jul 26 19:22:12 volumioak volumio[1086]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jul 26 19:22:12 volumioak volumio[1086]: verbose: CURRENT POSITION 3
Jul 26 19:22:12 volumioak volumio[1086]: info: CoreStateMachine::syncState stateService stop
Jul 26 19:22:12 volumioak volumio[1086]: info: CoreStateMachine::syncState currentStatus stop
Jul 26 19:22:12 volumioak volumio[1086]: info: CoreStateMachine::pushState
Jul 26 19:22:12 volumioak volumio[1086]: info: CorePlayQueue::getTrack 3
Jul 26 19:22:12 volumioak volumio[1086]: info: CoreCommandRouter::volumioPushState
Jul 26 19:22:12 volumioak volumio[1086]: info: No code
Jul 26 19:22:12 volumioak volumio[1086]: info: CoreStateMachine::pushState
Jul 26 19:22:12 volumioak volumio[1086]: info: CorePlayQueue::getTrack 3
Jul 26 19:22:12 volumioak volumio[1086]: info: CoreCommandRouter::volumioPushState
Jul 26 19:22:12 volumioak volumio[1086]: info: ------------------------------ 79ms
Jul 26 19:22:12 volumioak volumio[1086]: info: sendMpdCommand status took 78 milliseconds
Jul 26 19:22:12 volumioak volumio[1086]: info: sendMpdCommand status took 77 milliseconds
Jul 26 19:22:12 volumioak volumio[1086]: verbose: ControllerMpd::parseState
Jul 26 19:22:12 volumioak volumio[1086]: info: Command Router : Notfying DB Updatefalse
Jul 26 19:22:12 volumioak volumio[1086]: info: CoreCommandRouter::Close All Modals sent
Jul 26 19:22:12 volumioak volumio[1086]: verbose: ControllerMpd::parseState
Jul 26 19:22:12 volumioak volumio[1086]: info: ControllerMpd::pushState
Jul 26 19:22:12 volumioak volumio[1086]: info: CoreCommandRouter::servicePushState
Jul 26 19:22:12 volumioak volumio[1086]: info: CoreStateMachine::pushState
Jul 26 19:22:12 volumioak volumio[1086]: info: CorePlayQueue::getTrack 3
Jul 26 19:22:12 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 26 19:22:12 volumioak volumio[1086]: info: CoreCommandRouter::volumioPushState
Jul 26 19:22:12 volumioak volumio[1086]: info: CorePlayQueue::getTrack 3
Jul 26 19:22:12 volumioak volumio[1086]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jul 26 19:22:12 volumioak volumio[1086]: verbose: CURRENT POSITION 3
Jul 26 19:22:12 volumioak volumio[1086]: info: CoreStateMachine::syncState stateService stop
Jul 26 19:22:12 volumioak volumio[1086]: info: CoreStateMachine::syncState currentStatus stop
Jul 26 19:22:12 volumioak volumio[1086]: info: CoreStateMachine::pushState
Jul 26 19:22:12 volumioak volumio[1086]: info: CorePlayQueue::getTrack 3
Jul 26 19:22:12 volumioak volumio[1086]: info: CoreCommandRouter::volumioPushState
Jul 26 19:22:12 volumioak volumio[1086]: info: No code
Jul 26 19:22:12 volumioak volumio[1086]: info: CoreStateMachine::pushState
Jul 26 19:22:12 volumioak volumio[1086]: info: CorePlayQueue::getTrack 3
Jul 26 19:22:12 volumioak volumio[1086]: info: CoreCommandRouter::volumioPushState
Jul 26 19:22:12 volumioak volumio[1086]: info: ------------------------------ 123ms
Jul 26 19:22:13 volumioak systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart.
Jul 26 19:22:13 volumioak systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 10.
Jul 26 19:22:13 volumioak systemd[1]: Stopped Volspotconnect2 Daemon.
Jul 26 19:22:13 volumioak systemd[1]: Started Volspotconnect2 Daemon.
Jul 26 19:22:13 volumioak volumio[21959]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31
Jul 26 19:22:13 volumioak volumio[21959]: Reading Config from "/tmp/volspotify.toml"
Jul 26 19:22:13 volumioak volumio[21959]: [Vollibrespot] : Using Alsa backend with device: volumio
Jul 26 19:22:13 volumioak volumio[21959]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" }
Jul 26 19:22:14 volumioak wpa_supplicant[933]: wlan0: Failed to initiate sched scan
Jul 26 19:22:15 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 26 19:22:19 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 26 19:22:20 volumioak wpa_supplicant[933]: wlan0: Failed to initiate sched scan
Jul 26 19:22:23 volumioak volumio[21959]: [Vollibrespot] : Connecting to AP "ap-gew1.spotify.com:443"
Jul 26 19:22:23 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 26 19:22:25 volumioak wpa_supplicant[933]: wlan0: Failed to initiate sched scan
Jul 26 19:22:27 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 26 19:22:31 volumioak wpa_supplicant[933]: wlan0: Failed to initiate sched scan
Jul 26 19:22:31 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Jul 26 19:22:32 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Jul 26 19:22:32 volumioak volumio[1086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
Jul 26 19:22:32 volumioak volumio[1086]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 26 19:22:32 volumioak volumio[1086]: Error: getaddrinfo -3007
Jul 26 19:22:32 volumioak volumio[1086]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11)
Jul 26 19:22:32 volumioak volumio[1086]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10)
Jul 26 19:22:32 volumioak volumio[1086]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) {
Jul 26 19:22:32 volumioak volumio[1086]: code: -3007,
Jul 26 19:22:32 volumioak volumio[1086]: errno: -3007,
Jul 26 19:22:32 volumioak volumio[1086]: syscall: 'getaddrinfo'
Jul 26 19:22:32 volumioak volumio[1086]: }
Jul 26 19:22:32 volumioak volumio[1086]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 26 19:22:33 volumioak sudo[22019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-26 19:21
Jul 26 19:22:33 volumioak sudo[22019]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST"
VOLUMIO_VERSION="3.703"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"