-- Logs begin at Thu 2025-02-27 13:32:29 UTC, end at Wed 2025-03-05 13:26:29 UTC. -- Mar 05 13:25:03 volumio volumio[997]: info: touch_display: Setting screensaver timeout to 120 seconds. Mar 05 13:25:26 volumio vtcs[1566]: [2025-03-05 13:25:26] [info] asio async_shutdown error: asio.misc:2 (End of file) Mar 05 13:25:49 volumio volumio[997]: Upnp client error: Error: This socket has been ended by the other party Mar 05 13:25:50 volumio volumio[997]: info: touch_display: Setting screensaver timeout to 120 seconds. Mar 05 13:25:50 volumio volumio[997]: info: touch_display: Setting screensaver timeout to 120 seconds. Mar 05 13:25:50 volumio volumio[997]: info: touch_display: Setting screensaver timeout to 120 seconds. Mar 05 13:25:50 volumio volumio[997]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Mar 05 13:25:50 volumio volumio[997]: info: touch_display: Setting screensaver timeout to 120 seconds. Mar 05 13:25:58 volumio volumio[997]: info: Pushing metadata Mar 05 13:25:58 volumio volumio[997]: info: CoreCommandRouter::servicePushState Mar 05 13:25:58 volumio volumio[997]: info: CoreStateMachine::pushState Mar 05 13:25:58 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Mar 05 13:25:58 volumio volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 13:25:58 volumio volumio[997]: info: CoreCommandRouter::servicePushState Mar 05 13:25:58 volumio volumio[997]: info: CoreStateMachine::pushState Mar 05 13:25:58 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Mar 05 13:25:58 volumio volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 13:26:12 volumio volumio[997]: info: CoreCommandRouter::servicePushState Mar 05 13:26:12 volumio volumio[997]: info: CoreStateMachine::pushState Mar 05 13:26:12 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Mar 05 13:26:12 volumio volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 13:26:15 volumio volumio[997]: info: touch_display: Setting screensaver timeout to 120 seconds. Mar 05 13:26:17 volumio vtcs[1566]: [2025-03-05 13:26:17] [info] asio async_shutdown error: asio.misc:2 (End of file) Mar 05 13:26:20 volumio kernel: rpi_firmware_get_throttled: 16 callbacks suppressed Mar 05 13:26:20 volumio kernel: Voltage normalised (0x00000000) Mar 05 13:26:26 volumio volumio[1249]: [Vollibrespot] : Connecting to AP "ap-gae2.spotify.com:443" Mar 05 13:26:26 volumio volumio[1249]: [Vollibrespot] : Authenticated as "nnq62i9wk8g7gsn762utdsmoj" ! Mar 05 13:26:26 volumio volumio[1249]: [Vollibrespot] : Using alsa sink Mar 05 13:26:26 volumio volumio[1249]: [Vollibrespot] : Metadata pipe established Mar 05 13:26:26 volumio volumio[1249]: [Vollibrespot] : Country: "KR" Mar 05 13:26:26 volumio volumio[1249]: [Vollibrespot] : Event: Volume { volume_to_mixer: 9831 } Mar 05 13:26:26 volumio volumio[997]: [SpotifyConnect] Volume Spotify: 15.001144426642252 Volumio: 15 Mar 05 13:26:27 volumio volumio[1249]: [Vollibrespot] : Fetching autoplay context uri Mar 05 13:26:27 volumio volumio[1249]: [Vollibrespot] : Event: SessionActive { became_active_at: 1741181187077 } Mar 05 13:26:27 volumio volumio[1249]: [Vollibrespot] : SessionActive! Mar 05 13:26:27 volumio volumio[1249]: [Vollibrespot] : Event: PlaybackStarted { track_id: SpotifyId { id: 236997914418560919439909417487807640430, audio_type: Track } } Mar 05 13:26:27 volumio volumio[1249]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 236997914418560919439909417487807640430, audio_type: Track } } Mar 05 13:26:27 volumio volumio[997]: [SpotifyConnect] A connect session has begun Mar 05 13:26:27 volumio volumio[997]: info: Acquiring new spotify session Mar 05 13:26:27 volumio volumio[997]: info: CoreCommandRouter::volumioStop Mar 05 13:26:27 volumio volumio[997]: info: CoreStateMachine::stop Mar 05 13:26:27 volumio volumio[997]: info: CoreStateMachine::serviceStop Mar 05 13:26:27 volumio volumio[997]: info: CoreCommandRouter::serviceStop Mar 05 13:26:27 volumio volumio[997]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 05 13:26:27 volumio volumio[997]: TypeError: Cannot read property 'then' of undefined Mar 05 13:26:27 volumio volumio[997]: at SpotConnEvents.SpotConn.on (/data/plugins/music_service/spop/index.js:2095:31) Mar 05 13:26:27 volumio volumio[997]: at emitNone (events.js:106:13) Mar 05 13:26:27 volumio volumio[997]: at SpotConnEvents.emit (events.js:208:7) Mar 05 13:26:27 volumio volumio[997]: at SpotConnEvents.parseData (/data/plugins/music_service/spop/SpotConnController.js:81:16) Mar 05 13:26:27 volumio volumio[997]: at Socket.SpotConnEvents._udpsource.on.msg (/data/plugins/music_service/spop/SpotConnController.js:15:12) Mar 05 13:26:27 volumio volumio[997]: at emitTwo (events.js:126:13) Mar 05 13:26:27 volumio volumio[997]: at Socket.emit (events.js:214:7) Mar 05 13:26:27 volumio volumio[997]: at UDP.onMessage [as onmessage] (dgram.js:659:8) Mar 05 13:26:27 volumio volumio[997]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 05 13:26:27 volumio vtcs[1566]: [2025-03-05 13:26:27.095] [tisoc] [warning] [PlaybackControllerImpl.cpp:472] Illegal state:0 Mar 05 13:26:27 volumio volumio[1249]: [Vollibrespot] : Autoplay uri resolved to <"spotify:station:playlist:2cr9ovAEskjlam4XvTIuEe"> Mar 05 13:26:27 volumio volumio[1249]: [Vollibrespot] : Resolving uri "spotify:station:playlist:2cr9ovAEskjlam4XvTIuEe" Mar 05 13:26:27 volumio volumio[1249]: [Vollibrespot] : Event: GotToken { token: Token { access_token: "BQAuMEKuL04Tn4QGv83LNNKXLSzk-j1oetwmfzN7Pcf9ABHfSUG6TP5QLDNq-Xrqg5NuL2f4qVpvrFAywNe6WGHKteGT97aa1_fs2ndOr1A89Wkwei11bnotM-psiFoSyxJ7aIlCEnl86lVshiK7oqtHZmJguRJRE-Nvs98fPIBk9hhNyLslFFc3PGSu0WmJRvZHARqTvCccsROFSHRZ7hMCVakd39tjF28G0cLYpiivvnp59YcQk1HB6w", expires_in: 3600, token_type: "Bearer", scope: ["streaming", "user-read-playback-state", "user-modify-playback-state", "user-read-currently-playing", "user-read-private"] } } Mar 05 13:26:27 volumio volumio[1249]: [Vollibrespot] : Loading with Spotify URI Mar 05 13:26:27 volumio volumio[1249]: [Vollibrespot] : Resolved 50 tracks from <"spotify:playlist:2cr9ovAEskjlam4XvTIuEe"> Mar 05 13:26:28 volumio kernel: rpi_firmware_get_throttled: 9 callbacks suppressed Mar 05 13:26:28 volumio kernel: Under-voltage detected! (0x00050005) Mar 05 13:26:29 volumio sudo[24620]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-05 13:25 Mar 05 13:26:29 volumio sudo[24620]: 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Sep 30 22:42:09 CEST 2021" VOLUMIO_VERSION="2.915" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="02ee61bb422c79b6e5c0b6d1847a78d9"