-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Sun 2024-05-12 07:25:45 UTC. --
May 12 07:24:01 volumio wpa_supplicant[680]: wlan0: Failed to initiate sched scan
May 12 07:24:08 volumio wpa_supplicant[680]: wlan0: Failed to initiate sched scan
May 12 07:24:16 volumio wpa_supplicant[680]: wlan0: Failed to initiate sched scan
May 12 07:24:23 volumio wpa_supplicant[680]: wlan0: Failed to initiate sched scan
May 12 07:24:31 volumio wpa_supplicant[680]: wlan0: Failed to initiate sched scan
May 12 07:24:38 volumio wpa_supplicant[680]: wlan0: Failed to initiate sched scan
May 12 07:24:46 volumio wpa_supplicant[680]: wlan0: Failed to initiate sched scan
May 12 07:24:53 volumio wpa_supplicant[680]: wlan0: Failed to initiate sched scan
May 12 07:25:00 volumio wpa_supplicant[680]: wlan0: Failed to initiate sched scan
May 12 07:25:08 volumio wpa_supplicant[680]: wlan0: Failed to initiate sched scan
May 12 07:25:15 volumio wpa_supplicant[680]: wlan0: Failed to initiate sched scan
May 12 07:25:23 volumio wpa_supplicant[680]: wlan0: Failed to initiate sched scan
May 12 07:25:30 volumio wpa_supplicant[680]: wlan0: Failed to initiate sched scan
May 12 07:25:38 volumio wpa_supplicant[680]: wlan0: Failed to initiate sched scan
May 12 07:25:44 volumio volumio[1470]: [Vollibrespot] : Connecting to AP "ap-gew1.spotify.com:443"
May 12 07:25:44 volumio volumio[1470]: [Vollibrespot] : Authenticated as "axgd92bbmko2x1i7drnvnfolc" !
May 12 07:25:44 volumio volumio[1470]: [Vollibrespot] : Setting up new mixer: card:hw:5 mixer:PCM index:0
May 12 07:25:44 volumio volumio[1470]: [Vollibrespot] : Alsa min-db is not SND_CTL_TLV_DB_GAIN_MUTE!!
May 12 07:25:44 volumio volumio[1470]: [Vollibrespot] : Alsa Mixer info min: 0 (MilliBel(-12799)[dB]) -- max: 32767 (MilliBel(0)[dB]) HW: true
May 12 07:25:44 volumio volumio[1470]: [Vollibrespot] : Using Alsa linear volume
May 12 07:25:44 volumio volumio[1470]: [Vollibrespot] : Alsa min-db is not SND_CTL_TLV_DB_GAIN_MUTE!!
May 12 07:25:44 volumio volumio[1470]: [Vollibrespot] : Using alsa sink
May 12 07:25:44 volumio volumio[1470]: [Vollibrespot] : Country: "RO"
May 12 07:25:44 volumio volumio[1470]: [Vollibrespot] : Metadata pipe established
May 12 07:25:44 volumio volumio[1470]: [Vollibrespot] : Event: Volume { volume_to_mixer: 13107 }
May 12 07:25:44 volumio volumio[785]: [SpotifyConnect] 20
May 12 07:25:44 volumio volumio[785]: [SpotifyConnect] Volume: Spotify:20 Volumio: 20
May 12 07:25:44 volumio volumio[785]: info: CoreStateMachine::pushState
May 12 07:25:44 volumio volumio[785]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 12 07:25:44 volumio volumio[785]: info: CoreCommandRouter::volumioPushState
May 12 07:25:45 volumio volumio[1470]: [Vollibrespot] : Fetching autoplay context uri
May 12 07:25:45 volumio volumio[1470]: [Vollibrespot] : Event: SessionActive { became_active_at: 1715498745592 }
May 12 07:25:45 volumio volumio[1470]: [Vollibrespot] : SessionActive!
May 12 07:25:45 volumio volumio[1470]: [Vollibrespot] : Event: PlaybackStarted { track_id: SpotifyId { id: 234425130728536359195572677907879753503, audio_type: Track } }
May 12 07:25:45 volumio volumio[1470]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 234425130728536359195572677907879753503, audio_type: Track } }
May 12 07:25:45 volumio volumio[785]: [SpotifyConnect] A connect session has begun
May 12 07:25:45 volumio volumio[785]: [SpotifyConnect] Device palyback is active!
May 12 07:25:45 volumio volumio[785]: info: CoreCommandRouter::volumioGetState
May 12 07:25:45 volumio volumio[785]: [SpotifyConnect] Currently active: tidalconnect
May 12 07:25:45 volumio volumio[785]: [SpotifyConnect] Stopping currently active service
May 12 07:25:45 volumio volumio[785]: info: CoreCommandRouter::volumioStop
May 12 07:25:45 volumio volumio[785]: info: CoreStateMachine::stop
May 12 07:25:45 volumio volumio[785]: info: CoreStateMachine::serviceStop
May 12 07:25:45 volumio volumio[785]: info: CoreCommandRouter::serviceStop
May 12 07:25:45 volumio volumio[785]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 12 07:25:45 volumio volumio[785]: TypeError: Cannot read property 'then' of undefined
May 12 07:25:45 volumio volumio[785]: at SpotConnEvents. (/data/plugins/music_service/volspotconnect2/index.js:143:23)
May 12 07:25:45 volumio volumio[785]: at SpotConnEvents.emit (events.js:315:20)
May 12 07:25:45 volumio volumio[785]: at SpotConnEvents.parseData (/data/plugins/music_service/volspotconnect2/SpotConnController.js:73:16)
May 12 07:25:45 volumio volumio[785]: at Socket. (/data/plugins/music_service/volspotconnect2/SpotConnController.js:15:12)
May 12 07:25:45 volumio volumio[785]: at Socket.emit (events.js:315:20)
May 12 07:25:45 volumio volumio[785]: at UDP.onMessage [as onmessage] (dgram.js:919:8)
May 12 07:25:45 volumio volumio[785]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 12 07:25:45 volumio volumio[1470]: [Vollibrespot] : error 400 for uri hm://autoplay-enabled/query?uri=spotify:search:Mein+kleiner+gr%C3%BCner+Kaktus+The+King's+Singers
May 12 07:25:45 volumio volumio[1470]: [Vollibrespot] : AutoplayError: MercuryError
May 12 07:25:45 volumio vtcs[1513]: [2024-05-12 07:25:45.639] [tisoc] [warning] [PlaybackControllerImpl.cpp:472] Illegal state:0
May 12 07:25:45 volumio volumio[1470]: [Vollibrespot] : Event: GotToken { token: Token { access_token: "BQA72u5lOnnCCHeZ6Hyo5wy1ggy3wdUiYKgNt6As0sTRwZS8S_0a6BygaJa5MXBqtiuha9jDTF4zUxxb_vhFaSCzu6x5eqWlmeN3DyLT1z3QL4g80TMahw1Y9oFpRI8wbsuQit9tSG_DDCugePcs7mH6VBRNyBgxTfNHLek7cboxkSeuqegGtF0vnm7xLwjlylQ9g04y7nlKE9JmF_6YSpI_-g", expires_in: 3600, token_type: "Bearer", scope: ["streaming", "user-read-playback-state", "user-modify-playback-state", "user-read-currently-playing", "user-read-private"] } }
May 12 07:25:45 volumio volumio[1470]: [Vollibrespot] : Loading with Spotify URI
May 12 07:25:45 volumio wpa_supplicant[680]: wlan0: Failed to initiate sched scan
May 12 07:25:45 volumio sudo[2324]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-12 07:24
May 12 07:25:45 volumio sudo[2324]: 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="9eadfb08439e8c37bef9a38c0641d736c1391e0c"
VOLUMIO_FE_VERSION="e6f7875b0e497e33187ca2553d7998c4aeb06af9"
VOLUMIO_FE3_VERSION="8d9f9503eeacae3e8f349def90b368b32462d83b"
VOLUMIO_BE_VERSION="1cdccc4d006cc26abc6312edbeae58f3081200d4"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 24 Feb 2022 07:16:13 PM CET"
VOLUMIO_VERSION="3.233"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="88d67d58bfcedcd908dd7b955a1fa5bd"