-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sat 2024-05-04 12:28:18 CEST. --
May 04 12:27:00 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:01 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:02 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:03 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:04 volumio wpa_supplicant[695]: wlan0: Failed to initiate sched scan
May 04 12:27:04 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:05 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:06 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:07 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:07 volumio volumio[879]: info: CoreCommandRouter::servicePushState
May 04 12:27:07 volumio volumio[879]: info: CoreStateMachine::pushState
May 04 12:27:07 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 04 12:27:07 volumio volumio[879]: info: CoreCommandRouter::volumioPushState
May 04 12:27:08 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:09 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:10 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:11 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:12 volumio wpa_supplicant[695]: wlan0: Failed to initiate sched scan
May 04 12:27:12 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:13 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:14 volumio vtcs[1383]: [2024-05-04 12:27:14] [info] asio async_shutdown error: asio.misc:2 (End of file)
May 04 12:27:14 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:15 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:16 volumio volumio[879]: info: Pushing metadata
May 04 12:27:16 volumio volumio[879]: info: CoreCommandRouter::servicePushState
May 04 12:27:16 volumio volumio[879]: info: CoreStateMachine::pushState
May 04 12:27:16 volumio volumio[879]: info: CoreCommandRouter::volumioPushState
May 04 12:27:16 volumio volumio[879]: info: CoreCommandRouter::servicePushState
May 04 12:27:16 volumio volumio[879]: info: CoreStateMachine::pushState
May 04 12:27:16 volumio volumio[879]: info: CoreCommandRouter::volumioPushState
May 04 12:27:16 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:17 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:18 volumio vtcs[1383]: [2024-05-04 12:27:18] [info] asio async_shutdown error: asio.misc:2 (End of file)
May 04 12:27:18 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:19 volumio volumio[879]: info: Pushing metadata
May 04 12:27:19 volumio volumio[879]: info: CoreCommandRouter::servicePushState
May 04 12:27:19 volumio volumio[879]: info: CoreStateMachine::pushState
May 04 12:27:19 volumio volumio[879]: info: CoreCommandRouter::volumioPushState
May 04 12:27:19 volumio volumio[879]: info: CoreCommandRouter::servicePushState
May 04 12:27:19 volumio volumio[879]: info: CoreStateMachine::pushState
May 04 12:27:19 volumio volumio[879]: info: CoreCommandRouter::volumioPushState
May 04 12:27:19 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:20 volumio wpa_supplicant[695]: wlan0: Failed to initiate sched scan
May 04 12:27:20 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:21 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:22 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:23 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:24 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:25 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:26 volumio volumio[1452]: [Vollibrespot] : couldn't parse packet from 192.168.32.173:5353: type 47 is invalid
May 04 12:27:26 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:27 volumio wpa_supplicant[695]: wlan0: Failed to initiate sched scan
May 04 12:27:27 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:28 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:30 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:31 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:32 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:33 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:34 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:35 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:35 volumio wpa_supplicant[695]: wlan0: Failed to initiate sched scan
May 04 12:27:36 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:37 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:38 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:39 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:40 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:41 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:42 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:42 volumio wpa_supplicant[695]: wlan0: Failed to initiate sched scan
May 04 12:27:43 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:44 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:45 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:46 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:47 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:48 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:49 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:50 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:50 volumio wpa_supplicant[695]: wlan0: Failed to initiate sched scan
May 04 12:27:51 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:52 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:53 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:54 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:55 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:55 volumio volumio[1452]: [Vollibrespot] : couldn't parse packet from 192.168.32.173:5353: type 47 is invalid
May 04 12:27:56 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:57 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:57 volumio wpa_supplicant[695]: wlan0: Failed to initiate sched scan
May 04 12:27:58 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:27:59 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:28:00 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:28:01 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:28:02 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:28:03 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:28:04 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:28:05 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:28:05 volumio wpa_supplicant[695]: wlan0: Failed to initiate sched scan
May 04 12:28:06 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:28:07 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:28:08 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:28:09 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:28:10 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:28:10 volumio vtcs[1383]: [2024-05-04 12:28:10] [info] asio async_shutdown error: asio.misc:2 (End of file)
May 04 12:28:11 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:28:12 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:28:13 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:28:13 volumio wpa_supplicant[695]: wlan0: Failed to initiate sched scan
May 04 12:28:14 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:28:15 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:28:16 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:28:17 volumio volumio[879]: info: CoreCommandRouter::volumioGetState
May 04 12:28:17 volumio volumio[1452]: [Vollibrespot] : Event: SessionActive { became_active_at: 1714818497816 }
May 04 12:28:17 volumio volumio[1452]: [Vollibrespot] : SessionActive!
May 04 12:28:17 volumio volumio[1452]: [Vollibrespot] : Fetching autoplay context uri
May 04 12:28:17 volumio volumio[1452]: [Vollibrespot] : Event: PlaybackStarted { track_id: SpotifyId { id: 70660927984914882909437816798594167312, audio_type: Track } }
May 04 12:28:17 volumio volumio[1452]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 70660927984914882909437816798594167312, audio_type: Track } }
May 04 12:28:17 volumio volumio[879]: [SpotifyConnect] A connect session has begun
May 04 12:28:17 volumio volumio[879]: info: Acquiring new spotify session
May 04 12:28:17 volumio volumio[879]: info: CoreCommandRouter::volumioStop
May 04 12:28:17 volumio volumio[879]: info: CoreStateMachine::stop
May 04 12:28:17 volumio volumio[879]: info: CoreStateMachine::serviceStop
May 04 12:28:17 volumio volumio[879]: info: CoreCommandRouter::serviceStop
May 04 12:28:17 volumio volumio[879]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 04 12:28:17 volumio volumio[879]: TypeError: Cannot read property 'then' of undefined
May 04 12:28:17 volumio volumio[879]: at SpotConnEvents. (/data/plugins/music_service/spop/index.js:2111:31)
May 04 12:28:17 volumio volumio[879]: at SpotConnEvents.emit (events.js:315:20)
May 04 12:28:17 volumio volumio[879]: at SpotConnEvents.parseData (/data/plugins/music_service/spop/SpotConnController.js:81:16)
May 04 12:28:17 volumio volumio[879]: at Socket. (/data/plugins/music_service/spop/SpotConnController.js:15:12)
May 04 12:28:17 volumio volumio[879]: at Socket.emit (events.js:315:20)
May 04 12:28:17 volumio volumio[879]: at UDP.onMessage [as onmessage] (dgram.js:919:8)
May 04 12:28:17 volumio volumio[879]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 04 12:28:17 volumio vtcs[1383]: [2024-05-04 12:28:17.838] [tisoc] [warning] [PlaybackControllerImpl.cpp:472] Illegal state:0
May 04 12:28:17 volumio volumio[1452]: [Vollibrespot] : Autoplay uri resolved to <"spotify:station:album:4Q281GM63zCOemG5de6OKU">
May 04 12:28:17 volumio volumio[1452]: [Vollibrespot] : Resolving uri "spotify:station:album:4Q281GM63zCOemG5de6OKU"
May 04 12:28:17 volumio volumio[1452]: [Vollibrespot] : Loading with Spotify URI
May 04 12:28:17 volumio volumio[1452]: [Vollibrespot] : Event: GotToken { token: Token { access_token: "BQBcdja8PyBJq3fQqHyLPoPxpoeid-R9ITmB0Ee7Fuy4ukn-YsB09qa3cI9iqQdLnxBvQl13jAOgpp_OGxxlyXQS6RxXPiCGLdxK3UvjquLVXfss113PRB10NV-n6cf_6TBCqVDWbgX4L_pqN9AfjM5_ZCjN3kLY3ZPiTnGKyaOwsv-bgisj1_JMFFgbTR85g6kXYeGEYFrKpIKFF0GOYOo", expires_in: 3600, token_type: "Bearer", scope: ["streaming", "user-read-playback-state", "user-modify-playback-state", "user-read-currently-playing", "user-read-private"] } }
May 04 12:28:18 volumio sudo[1509]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-04 12:27
May 04 12:28:18 volumio sudo[1509]: 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="1c5fa5a8788b087ca429be9d10851b25c5cc4f5b"
VOLUMIO_FE_VERSION="e5ce74e254a237ac98580c4437c4ed223c7d5cd9"
VOLUMIO_FE3_VERSION="a86adf3c7ed2d6c50d9bca768f58ab2f56832dc1"
VOLUMIO_BE_VERSION="c8882d89d3d4e0a1571e0dc9701741128f5a1656"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 31 Mar 2022 02:51:41 PM CEST"
VOLUMIO_VERSION="3.251"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="e83cc5fcd68eb3ee4105ab0b8b3779ea"