-- Logs begin at Thu 2025-02-27 13:32:29 UTC, end at Wed 2025-03-12 11:25:16 UTC. -- Mar 12 11:25:02 volumio kernel: rpi_firmware_get_throttled: 9 callbacks suppressed Mar 12 11:25:02 volumio kernel: Under-voltage detected! (0x00050005) Mar 12 11:25:06 volumio kernel: rpi_firmware_get_throttled: 10 callbacks suppressed Mar 12 11:25:06 volumio kernel: Voltage normalised (0x00000000) Mar 12 11:25:12 volumio kernel: Under-voltage detected! (0x00050005) Mar 12 11:25:13 volumio volumio[1253]: [Vollibrespot] : Connecting to AP "ap-gae2.spotify.com:443" Mar 12 11:25:14 volumio volumio[1253]: [Vollibrespot] : Authenticated as "nnq62i9wk8g7gsn762utdsmoj" ! Mar 12 11:25:14 volumio volumio[1253]: [Vollibrespot] : Using alsa sink Mar 12 11:25:14 volumio volumio[1253]: [Vollibrespot] : Metadata pipe established Mar 12 11:25:14 volumio volumio[1253]: [Vollibrespot] : Country: "KR" Mar 12 11:25:14 volumio volumio[1253]: [Vollibrespot] : Event: Volume { volume_to_mixer: 26212 } Mar 12 11:25:14 volumio volumio[998]: [SpotifyConnect] Volume Spotify: 39.99694819562066 Volumio: 40 Mar 12 11:25:14 volumio volumio[1253]: [Vollibrespot] : Fetching autoplay context uri Mar 12 11:25:14 volumio volumio[1253]: [Vollibrespot] : Event: SessionActive { became_active_at: 1741778714656 } Mar 12 11:25:14 volumio volumio[1253]: [Vollibrespot] : SessionActive! Mar 12 11:25:14 volumio volumio[998]: [SpotifyConnect] A connect session has begun Mar 12 11:25:14 volumio volumio[998]: info: Acquiring new spotify session Mar 12 11:25:14 volumio volumio[998]: info: CoreCommandRouter::volumioStop Mar 12 11:25:14 volumio volumio[1253]: [Vollibrespot] : Event: PlaybackStarted { track_id: SpotifyId { id: 129192463806043949148716853396868671145, audio_type: Track } } Mar 12 11:25:14 volumio volumio[1253]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 129192463806043949148716853396868671145, audio_type: Track } } Mar 12 11:25:14 volumio volumio[998]: info: CoreStateMachine::stop Mar 12 11:25:14 volumio volumio[998]: info: CoreStateMachine::serviceStop Mar 12 11:25:14 volumio volumio[998]: info: CoreCommandRouter::serviceStop Mar 12 11:25:14 volumio volumio[998]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 12 11:25:14 volumio volumio[998]: TypeError: Cannot read property 'then' of undefined Mar 12 11:25:14 volumio volumio[998]: at SpotConnEvents.SpotConn.on (/data/plugins/music_service/spop/index.js:2095:31) Mar 12 11:25:14 volumio volumio[998]: at emitNone (events.js:106:13) Mar 12 11:25:14 volumio volumio[998]: at SpotConnEvents.emit (events.js:208:7) Mar 12 11:25:14 volumio volumio[998]: at SpotConnEvents.parseData (/data/plugins/music_service/spop/SpotConnController.js:81:16) Mar 12 11:25:14 volumio volumio[998]: at Socket.SpotConnEvents._udpsource.on.msg (/data/plugins/music_service/spop/SpotConnController.js:15:12) Mar 12 11:25:14 volumio volumio[998]: at emitTwo (events.js:126:13) Mar 12 11:25:14 volumio volumio[998]: at Socket.emit (events.js:214:7) Mar 12 11:25:14 volumio volumio[998]: at UDP.onMessage [as onmessage] (dgram.js:659:8) Mar 12 11:25:14 volumio volumio[998]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 12 11:25:14 volumio vtcs[1580]: [2025-03-12 11:25:14.690] [tisoc] [warning] [PlaybackControllerImpl.cpp:472] Illegal state:0 Mar 12 11:25:14 volumio volumio[1253]: [Vollibrespot] : error 400 for uri hm://autoplay-enabled/query?uri=spotify:search:%EC%B2%A8%EB%B0%80%EB%B0%80 Mar 12 11:25:14 volumio volumio[1253]: [Vollibrespot] : AutoplayError: MercuryError Mar 12 11:25:14 volumio volumio[1253]: [Vollibrespot] : Event: GotToken { token: Token { access_token: "BQDlgIdsvKNert386usDPqafFUvpfCQlHMJGxZ4bFswMZ9YGYMIYgjcxpKmBulgEawp69akeM5sHj_cMsePgiZzZNTSNLNQ0Xyp68EG5uqK34jBI7ANaTe1PcjD-eLwf5zC0SOF9t20Sm5OLAydcd3N9NAimwtoY1H_UmsscIAc4D7ewmDaUHXb0OpGU5mc1AphTyihybe9Fb12XUfL2NJb7RKxe50Vye28loRLLTu8kKs8tmZKp-M8LBg", expires_in: 3600, token_type: "Bearer", scope: ["streaming", "user-read-playback-state", "user-modify-playback-state", "user-read-currently-playing", "user-read-private"] } } Mar 12 11:25:14 volumio volumio[1253]: [Vollibrespot] : Loading <甜蜜蜜> with Spotify URI Mar 12 11:25:15 volumio volumio[1253]: [Vollibrespot] : <甜蜜蜜> (211840 ms) loaded Mar 12 11:25:15 volumio volumio[1253]: [Vollibrespot] : Event: SinkActive Mar 12 11:25:16 volumio sudo[16887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-12 11:24 Mar 12 11:25:16 volumio sudo[16887]: 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"