-- Logs begin at Tue 2024-08-27 09:00:39 CEST, end at Wed 2024-09-04 13:53:39 CEST. -- Sep 04 13:52:17 volumio volumio[941]: INFO:librespot_playback::player: Shutting down player thread ... Sep 04 13:52:17 volumio volumio[941]: INFO:librespot_core::session: Connecting to AP "ap2-gew4.spotify.com:4070" Sep 04 13:52:17 volumio volumio[941]: INFO:librespot_core::session: Authenticated as "embohne" ! Sep 04 13:52:17 volumio volumio[941]: INFO:librespot_playback::player: new Player[1] Sep 04 13:52:17 volumio volumio[941]: INFO:librespot_playback::audio_backend::alsa: Using alsa sink Sep 04 13:52:17 volumio volumio[941]: INFO:librespot_core::session: Country: "BE" Sep 04 13:52:17 volumio volumio[941]: INFO:librespot_playback::player: SpCon::kSpPlaybackNotifyBecameActive Sep 04 13:52:17 volumio volumio[941]: INFO:librespot_playback::player: SpCon::token Sep 04 13:52:17 volumio volumio[1005]: info: [SpConDebug] Session is active! Sep 04 13:52:17 volumio volumio[1005]: info: CoreCommandRouter::volumioGetState Sep 04 13:52:17 volumio volumio[1005]: info: CoreStateMachine::getState Sep 04 13:52:17 volumio volumio[1005]: info: [SpConDebug] Currently active:volspotconnect2 Sep 04 13:52:17 volumio volumio[1005]: info: [SpConDebug] SpotConn Active Sep 04 13:52:17 volumio volumio[1005]: info: CoreCommandRouter::volumioGetState Sep 04 13:52:17 volumio volumio[1005]: info: CoreStateMachine::getState Sep 04 13:52:17 volumio volumio[1005]: info: [SpConDebug] Currently active:volspotconnect2 Sep 04 13:52:17 volumio volumio[1005]: info: CoreCommandRouter::servicePushState Sep 04 13:52:17 volumio volumio[1005]: info: CoreStateMachine::syncState Sep 04 13:52:17 volumio volumio[1005]: info: CoreStateMachine::pushState Sep 04 13:52:17 volumio volumio[1005]: info: CoreStateMachine::getState Sep 04 13:52:17 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Sep 04 13:52:17 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 13:52:17 volumio volumio[1005]: info: [SpConDebug] Token: BQDWKDXq-bar6PXHhhgW6YKIten9Fy-Kfya8H-Dbo2-qzbqL0zyIjYTRVdR670YKZLktTZShF0MkVRZoLEzKbRhI_m5aMGy_2ZItXRKlnVHEb1wew31Fu-27YdE7zvGjjHrcA78Mn_9F9Ca_cwClEwAsY1tH-laVKTVGGTbpqlbOEChvi4bpZyA3kMmMe0z5E5EP4_N6vJ3Y-R2eVA Sep 04 13:52:17 volumio sudo[30445]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 04 13:52:17 volumio sudo[30445]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 13:52:17 volumio sudo[30445]: pam_unix(sudo:session): session closed for user root Sep 04 13:52:17 volumio volumio[941]: INFO:librespot_playback::player: SpCon::metadata Sep 04 13:52:17 volumio volumio[1005]: info: [SpConDebug] Pushing metadata::Vollibrespot:true Sep 04 13:52:17 volumio volumio[1005]: info: CoreCommandRouter::servicePushState Sep 04 13:52:17 volumio volumio[1005]: info: CoreStateMachine::syncState Sep 04 13:52:17 volumio volumio[1005]: info: CoreStateMachine::pushState Sep 04 13:52:17 volumio volumio[1005]: info: CoreStateMachine::getState Sep 04 13:52:17 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Sep 04 13:52:17 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 13:52:17 volumio volumio[941]: INFO:librespot_playback::player: Loading track "In The Dead Of Night" with Spotify URI "spotify:track:7s4eOa9D4Qt7o3iRChaVIu" Sep 04 13:52:17 volumio sudo[30455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 04 13:52:17 volumio sudo[30455]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 13:52:18 volumio sudo[30455]: pam_unix(sudo:session): session closed for user root Sep 04 13:52:18 volumio volumio[941]: ERROR:librespot_core::channel: channel error: 2 0 Sep 04 13:52:18 volumio volumio[941]: thread '' panicked at 'called `Result::unwrap()` on an `Err` value: ChannelError', /checkout/src/libcore/result.rs:916:5 Sep 04 13:52:18 volumio volumio[941]: stack backtrace: Sep 04 13:52:18 volumio volumio[941]: 0: 0x93113f - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h280c621ec0336843 Sep 04 13:52:18 volumio volumio[941]: at /checkout/src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Sep 04 13:52:18 volumio volumio[941]: 1: 0x93b49f - std::sys_common::backtrace::print::h5bb167d48668dac9 Sep 04 13:52:18 volumio volumio[941]: at /checkout/src/libstd/sys_common/backtrace.rs:68 Sep 04 13:52:18 volumio volumio[941]: at /checkout/src/libstd/sys_common/backtrace.rs:57 Sep 04 13:52:18 volumio volumio[941]: 2: 0x9299c7 - std::panicking::default_hook::{{closure}}::hccf3b2e1cc48596f Sep 04 13:52:18 volumio volumio[941]: at /checkout/src/libstd/panicking.rs:381 Sep 04 13:52:18 volumio volumio[941]: 3: 0x9294a3 - std::panicking::default_hook::h338b1189515ccc69 Sep 04 13:52:18 volumio volumio[941]: at /checkout/src/libstd/panicking.rs:397 Sep 04 13:52:18 volumio volumio[941]: 4: 0x929e73 - std::panicking::rust_panic_with_hook::h5d950fb4a856fba5 Sep 04 13:52:18 volumio volumio[941]: at /checkout/src/libstd/panicking.rs:577 Sep 04 13:52:18 volumio volumio[941]: 5: 0x929d17 - std::panicking::begin_panic::h7a5157aecf168062 Sep 04 13:52:18 volumio volumio[941]: at /checkout/src/libstd/panicking.rs:538 Sep 04 13:52:18 volumio volumio[941]: 6: 0x929c43 - std::panicking::begin_panic_fmt::hc44606ee40e9a98e Sep 04 13:52:18 volumio volumio[941]: at /checkout/src/libstd/panicking.rs:522 Sep 04 13:52:18 volumio volumio[941]: 7: 0x929beb - rust_begin_unwind Sep 04 13:52:18 volumio volumio[941]: at /checkout/src/libstd/panicking.rs:498 Sep 04 13:52:18 volumio volumio[941]: 8: 0x9930fb - core::panicking::panic_fmt::h68e7715928be641f Sep 04 13:52:18 volumio volumio[941]: at /checkout/src/libcore/panicking.rs:71 Sep 04 13:52:18 volumio volumio[941]: 9: 0x57798b - core::result::unwrap_failed::h3204474b47058be7 Sep 04 13:52:18 volumio volumio[941]: 10: 0x57222b - librespot_playback::player::PlayerInternal::handle_command::hcb355ff3177e6465 Sep 04 13:52:18 volumio volumio[941]: 11: 0x567e47 - librespot_playback::player::PlayerInternal::run::ha5d2a3d448e39c20 Sep 04 13:52:18 volumio volumio[941]: 12: 0x45ecdb - std::sys_common::backtrace::__rust_begin_short_backtrace::h67b399fd939d6424 Sep 04 13:52:18 volumio volumio[941]: 13: 0x47a5d7 - std::panicking::try::do_call::h336d94d8fe284e6e Sep 04 13:52:18 volumio volumio[941]: 14: 0x95099b - __rust_maybe_catch_panic Sep 04 13:52:18 volumio volumio[941]: at /checkout/src/libpanic_unwind/lib.rs:101 Sep 04 13:52:18 volumio volumio[941]: 15: 0x47cf03 - >::call_box::hddd04264772c2c8c Sep 04 13:52:18 volumio volumio[941]: 16: 0x937bd3 - std::sys_common::thread::start_thread::hb77bc064386dd6d6 Sep 04 13:52:18 volumio volumio[941]: at /checkout/src/liballoc/boxed.rs:825 Sep 04 13:52:18 volumio volumio[941]: at /checkout/src/libstd/sys_common/thread.rs:24 Sep 04 13:52:18 volumio volumio[941]: 17: 0x92a4cf - std::sys::unix::thread::Thread::new::thread_start::h9391820a2a22e3af Sep 04 13:52:18 volumio volumio[941]: at /checkout/src/libstd/sys/unix/thread.rs:90 Sep 04 13:53:08 volumio volumio[1005]: info: VolumeController::SetAlsaVolume35 Sep 04 13:53:08 volumio volumio[1005]: info: CoreStateMachine::pushState Sep 04 13:53:08 volumio volumio[1005]: info: CoreStateMachine::getState Sep 04 13:53:08 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Sep 04 13:53:08 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 13:53:08 volumio volumio[1005]: info: Sep 04 13:53:08 volumio volumio[1005]: ---------------------------- MPD announces state update: mixer Sep 04 13:53:08 volumio volumio[1005]: info: ControllerMpd::getState Sep 04 13:53:08 volumio volumio[1005]: info: ControllerMpd::sendMpdCommand status Sep 04 13:53:08 volumio volumio[1005]: info: sending command... Sep 04 13:53:08 volumio sudo[30820]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 04 13:53:08 volumio sudo[30820]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 13:53:08 volumio volumio[1005]: info: parsing response... Sep 04 13:53:08 volumio volumio[1005]: info: ControllerMpd::parseState Sep 04 13:53:08 volumio volumio[1005]: info: ControllerMpd::sendMpdCommand playlistinfo Sep 04 13:53:08 volumio volumio[1005]: info: sending command... Sep 04 13:53:08 volumio sudo[30820]: pam_unix(sudo:session): session closed for user root Sep 04 13:53:08 volumio volumio[1005]: info: parsing response... Sep 04 13:53:08 volumio volumio[1005]: info: ControllerMpd::parseTrackInfo Sep 04 13:53:08 volumio volumio[1005]: info: ControllerMpd::pushState Sep 04 13:53:08 volumio volumio[1005]: info: CoreCommandRouter::servicePushState Sep 04 13:53:08 volumio volumio[1005]: info: CoreStateMachine::syncState Sep 04 13:53:08 volumio volumio[1005]: info: CoreStateMachine::pushState Sep 04 13:53:08 volumio volumio[1005]: info: CoreStateMachine::getState Sep 04 13:53:08 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Sep 04 13:53:08 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 13:53:08 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Sep 04 13:53:08 volumio volumio[1005]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Sep 04 13:53:08 volumio volumio[1005]: info: ------------------------------ 52ms Sep 04 13:53:08 volumio sudo[30829]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 04 13:53:08 volumio sudo[30829]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 13:53:08 volumio sudo[30829]: pam_unix(sudo:session): session closed for user root Sep 04 13:53:08 volumio volumio[1005]: info: VolumeController::SetAlsaVolume65 Sep 04 13:53:08 volumio volumio[1005]: info: CoreStateMachine::pushState Sep 04 13:53:08 volumio volumio[1005]: info: CoreStateMachine::getState Sep 04 13:53:08 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Sep 04 13:53:08 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 13:53:08 volumio volumio[1005]: info: Sep 04 13:53:08 volumio volumio[1005]: ---------------------------- MPD announces state update: mixer Sep 04 13:53:08 volumio volumio[1005]: info: ControllerMpd::getState Sep 04 13:53:08 volumio volumio[1005]: info: ControllerMpd::sendMpdCommand status Sep 04 13:53:08 volumio volumio[1005]: info: sending command... Sep 04 13:53:08 volumio volumio[1005]: info: parsing response... Sep 04 13:53:08 volumio volumio[1005]: info: ControllerMpd::parseState Sep 04 13:53:08 volumio volumio[1005]: info: ControllerMpd::sendMpdCommand playlistinfo Sep 04 13:53:08 volumio volumio[1005]: info: sending command... Sep 04 13:53:08 volumio volumio[1005]: info: parsing response... Sep 04 13:53:08 volumio volumio[1005]: info: ControllerMpd::parseTrackInfo Sep 04 13:53:08 volumio volumio[1005]: info: ControllerMpd::pushState Sep 04 13:53:08 volumio volumio[1005]: info: CoreCommandRouter::servicePushState Sep 04 13:53:08 volumio volumio[1005]: info: CoreStateMachine::syncState Sep 04 13:53:08 volumio volumio[1005]: info: CoreStateMachine::pushState Sep 04 13:53:08 volumio volumio[1005]: info: CoreStateMachine::getState Sep 04 13:53:08 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Sep 04 13:53:08 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 13:53:08 volumio sudo[30839]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 04 13:53:08 volumio sudo[30839]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 13:53:08 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Sep 04 13:53:08 volumio volumio[1005]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Sep 04 13:53:09 volumio volumio[1005]: info: ------------------------------ 37ms Sep 04 13:53:09 volumio sudo[30843]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 04 13:53:09 volumio sudo[30839]: pam_unix(sudo:session): session closed for user root Sep 04 13:53:09 volumio sudo[30843]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 13:53:09 volumio sudo[30843]: pam_unix(sudo:session): session closed for user root Sep 04 13:53:36 volumio volumio[1005]: info: VolumeController::SetAlsaVolume50 Sep 04 13:53:36 volumio volumio[1005]: info: CoreStateMachine::pushState Sep 04 13:53:36 volumio volumio[1005]: info: CoreStateMachine::getState Sep 04 13:53:36 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Sep 04 13:53:36 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 13:53:36 volumio volumio[1005]: info: Sep 04 13:53:36 volumio volumio[1005]: ---------------------------- MPD announces state update: mixer Sep 04 13:53:36 volumio volumio[1005]: info: ControllerMpd::getState Sep 04 13:53:36 volumio volumio[1005]: info: ControllerMpd::sendMpdCommand status Sep 04 13:53:36 volumio volumio[1005]: info: sending command... Sep 04 13:53:36 volumio volumio[1005]: info: parsing response... Sep 04 13:53:36 volumio sudo[31057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 04 13:53:36 volumio volumio[1005]: info: ControllerMpd::parseState Sep 04 13:53:36 volumio volumio[1005]: info: ControllerMpd::sendMpdCommand playlistinfo Sep 04 13:53:36 volumio volumio[1005]: info: sending command... Sep 04 13:53:36 volumio volumio[1005]: info: parsing response... Sep 04 13:53:36 volumio volumio[1005]: info: ControllerMpd::parseTrackInfo Sep 04 13:53:36 volumio volumio[1005]: info: ControllerMpd::pushState Sep 04 13:53:36 volumio volumio[1005]: info: CoreCommandRouter::servicePushState Sep 04 13:53:36 volumio volumio[1005]: info: CoreStateMachine::syncState Sep 04 13:53:36 volumio volumio[1005]: info: CoreStateMachine::pushState Sep 04 13:53:36 volumio volumio[1005]: info: CoreStateMachine::getState Sep 04 13:53:36 volumio volumio[1005]: info: CoreCommandRouter::volumioPushState Sep 04 13:53:36 volumio volumio[1005]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 13:53:36 volumio sudo[31057]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 13:53:36 volumio sudo[31057]: pam_unix(sudo:session): session closed for user root Sep 04 13:53:36 volumio volumio[1005]: info: CorePlayQueue::getTrack 0 Sep 04 13:53:36 volumio volumio[1005]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Sep 04 13:53:36 volumio volumio[1005]: info: ------------------------------ 41ms Sep 04 13:53:36 volumio sudo[31066]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 04 13:53:37 volumio sudo[31066]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 13:53:37 volumio sudo[31066]: pam_unix(sudo:session): session closed for user root Sep 04 13:53:38 volumio volumio[1005]: info: CoreCommandRouter::volumioVolatilePlay Sep 04 13:53:38 volumio volumio[1005]: info: CoreStateMachine::volatilePlay Sep 04 13:53:38 volumio volumio[1005]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 13:53:38 volumio volumio[1005]: TypeError: Cannot read property 'play' of undefined Sep 04 13:53:38 volumio volumio[1005]: at CoreStateMachine.volatilePlay (/volumio/app/statemachine.js:1111:31) Sep 04 13:53:38 volumio volumio[1005]: at CoreCommandRouter.volumioVolatilePlay (/volumio/app/index.js:1292:30) Sep 04 13:53:38 volumio volumio[1005]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:223:44) Sep 04 13:53:38 volumio volumio[1005]: at emitTwo (events.js:126:13) Sep 04 13:53:38 volumio volumio[1005]: at Socket.emit (events.js:214:7) Sep 04 13:53:38 volumio volumio[1005]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Sep 04 13:53:38 volumio volumio[1005]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Sep 04 13:53:38 volumio volumio[1005]: at process._tickCallback (internal/process/next_tick.js:180:9) Sep 04 13:53:38 volumio volumio[1005]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 13:53:39 volumio sudo[31097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-04 13:52 Sep 04 13:53:39 volumio sudo[31097]: pam_unix(sudo:session): session opened for user root by (uid=0) 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="19491f50eded236de6874d31640dedebc248dfa0" VOLUMIO_FE_VERSION="bdab5ff71f84b7d64b4259050747865ae25f581a" VOLUMIO_BE_VERSION="485649f69c1e0c0d8a6b99624ac69710ccc8c938" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Sep 25 12:56:51 CEST 2018" VOLUMIO_VERSION="2.461" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="a0985b2d083525cfca97fe4471037373"