-- Logs begin at Thu 2019-02-14 10:11:59 GMT, end at Sat 2025-03-15 13:35:26 GMT. -- Mar 15 13:34:24 volumio go-librespot[1195]: time="2025-03-15T13:34:24Z" level=trace msg="emitting websocket event: not_playing" Mar 15 13:34:24 volumio go-librespot[1195]: time="2025-03-15T13:34:24Z" level=debug msg="loading track (paused: false, position: 0ms)" uri="spotify:track:6RqEJvpEzzlwj8g0wKG1ln" Mar 15 13:34:24 volumio volumio[986]: SPOTIFY: received: {"type":"not_playing","data":{"uri":"spotify:track:3ow0TQVttXQF8rLckmXgRx","play_origin":"playlist"}} Mar 15 13:34:24 volumio volumio[986]: error: Failed to decode event: not_playing Mar 15 13:34:24 volumio go-librespot[1195]: time="2025-03-15T13:34:24Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Mar 15 13:34:24 volumio go-librespot[1195]: time="2025-03-15T13:34:24Z" level=trace msg="emitting websocket event: will_play" Mar 15 13:34:24 volumio volumio[986]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:6RqEJvpEzzlwj8g0wKG1ln","play_origin":"playlist"}} Mar 15 13:34:24 volumio go-librespot[1195]: time="2025-03-15T13:34:24Z" level=info msg="loaded track \"Motorbreath - Remastered\" (paused: false, position: 0ms, duration: 187840ms, prefetched: true)" uri="spotify:track:6RqEJvpEzzlwj8g0wKG1ln" Mar 15 13:34:24 volumio go-librespot[1195]: time="2025-03-15T13:34:24Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Mar 15 13:34:24 volumio go-librespot[1195]: time="2025-03-15T13:34:24Z" level=trace msg="scheduling prefetch in 157s" Mar 15 13:34:24 volumio go-librespot[1195]: time="2025-03-15T13:34:24Z" level=trace msg="emitting websocket event: metadata" Mar 15 13:34:24 volumio volumio[986]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:6RqEJvpEzzlwj8g0wKG1ln","name":"Motorbreath - Remastered","artist_names":["Metallica"],"album_name":"Kill 'Em All (Remastered)","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02d30fcf6340831edbafb45e38","position":0,"duration":187840,"release_date":"year:1983 month:7 day:24","track_number":3,"disc_number":1}} Mar 15 13:34:24 volumio go-librespot[1195]: time="2025-03-15T13:34:24Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Mar 15 13:34:24 volumio go-librespot[1195]: time="2025-03-15T13:34:24Z" level=trace msg="emitting websocket event: playing" Mar 15 13:34:24 volumio volumio[986]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:6RqEJvpEzzlwj8g0wKG1ln","play_origin":"playlist"}} Mar 15 13:34:24 volumio volumio[986]: SPOTIFY: PUSH STATE SPOTIFY Mar 15 13:34:24 volumio volumio[986]: SPOTIFY: {"status":"play","service":"spop","title":"Motorbreath - Remastered","artist":"Metallica","album":"Kill 'Em All (Remastered)","albumart":"https://i.scdn.co/image/ab67616d00001e02d30fcf6340831edbafb45e38","uri":"spotify:track:6RqEJvpEzzlwj8g0wKG1ln","trackType":"spotify","seek":0,"duration":187,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Mar 15 13:34:24 volumio volumio[986]: info: CoreCommandRouter::servicePushState Mar 15 13:34:24 volumio volumio[986]: info: CoreStateMachine::pushState Mar 15 13:34:24 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 15 13:34:24 volumio volumio[986]: info: CoreCommandRouter::volumioPushState Mar 15 13:34:24 volumio volumio[986]: info: [LastFM] Current track has sufficient metadata: title (Motorbreath - Remastered) and artist (Metallica) passed on explicitly Mar 15 13:34:25 volumio volumio[986]: SPOTIFY: PUSH STATE SPOTIFY Mar 15 13:34:25 volumio volumio[986]: SPOTIFY: {"status":"play","service":"spop","title":"Motorbreath - Remastered","artist":"Metallica","album":"Kill 'Em All (Remastered)","albumart":"https://i.scdn.co/image/ab67616d00001e02d30fcf6340831edbafb45e38","uri":"spotify:track:6RqEJvpEzzlwj8g0wKG1ln","trackType":"spotify","seek":0,"duration":187,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Mar 15 13:34:25 volumio volumio[986]: info: CoreCommandRouter::servicePushState Mar 15 13:34:25 volumio volumio[986]: info: CoreStateMachine::pushState Mar 15 13:34:25 volumio volumio[986]: info: CoreCommandRouter::volumioPushState Mar 15 13:34:35 volumio go-librespot[1195]: time="2025-03-15T13:34:35Z" level=debug msg="fetched chunk 4/14, size: 524288" uri="spotify:track:6RqEJvpEzzlwj8g0wKG1ln" Mar 15 13:34:46 volumio go-librespot[1195]: time="2025-03-15T13:34:46Z" level=debug msg="fetched chunk 5/14, size: 524288" uri="spotify:track:6RqEJvpEzzlwj8g0wKG1ln" Mar 15 13:34:58 volumio go-librespot[1195]: time="2025-03-15T13:34:58Z" level=debug msg="fetched chunk 6/14, size: 524288" uri="spotify:track:6RqEJvpEzzlwj8g0wKG1ln" Mar 15 13:35:11 volumio go-librespot[1195]: time="2025-03-15T13:35:11Z" level=debug msg="fetched chunk 7/14, size: 524288" uri="spotify:track:6RqEJvpEzzlwj8g0wKG1ln" Mar 15 13:35:25 volumio go-librespot[1195]: time="2025-03-15T13:35:25Z" level=debug msg="fetched chunk 8/14, size: 524288" uri="spotify:track:6RqEJvpEzzlwj8g0wKG1ln" Mar 15 13:35:26 volumio volumio[986]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 15 13:35:26 volumio volumio[986]: Error: connect ETIMEDOUT 130.211.19.189:80 Mar 15 13:35:26 volumio volumio[986]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Mar 15 13:35:26 volumio volumio[986]: errno: -110, Mar 15 13:35:26 volumio volumio[986]: code: 'ETIMEDOUT', Mar 15 13:35:26 volumio volumio[986]: syscall: 'connect', Mar 15 13:35:26 volumio volumio[986]: address: '130.211.19.189', Mar 15 13:35:26 volumio volumio[986]: port: 80 Mar 15 13:35:26 volumio volumio[986]: } Mar 15 13:35:26 volumio volumio[986]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 15 13:35:26 volumio sudo[2717]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-15 13:34 Mar 15 13:35:26 volumio sudo[2717]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"