-- Logs begin at Thu 2025-05-22 16:22:33 CEST, end at Thu 2025-05-22 21:52:00 CEST. --
May 22 21:51:01 volumio volumio[870]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 10
May 22 21:51:01 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
May 22 21:51:09 volumio go-librespot[1213]: time="2025-05-22T21:51:09+02:00" level=debug msg="prefetching next track" uri="spotify:track:0y0k5s6TpzkTmNxx0r5HDP"
May 22 21:51:09 volumio go-librespot[1213]: time="2025-05-22T21:51:09+02:00" level=debug msg="selected format OGG_VORBIS_320 (628c74f96c6623f5ffe19035fb33d12d1dbb4cf5)" uri="spotify:track:0y0k5s6TpzkTmNxx0r5HDP"
May 22 21:51:09 volumio go-librespot[1213]: time="2025-05-22T21:51:09+02:00" level=debug msg="requested aes key for file 628c74f96c6623f5ffe19035fb33d12d1dbb4cf5, gid: 0y0k5s6TpzkTmNxx0r5HDP"
May 22 21:51:09 volumio go-librespot[1213]: time="2025-05-22T21:51:09+02:00" level=debug msg="fetched first chunk of 22, total size is 11118376 bytes" uri="spotify:track:0y0k5s6TpzkTmNxx0r5HDP"
May 22 21:51:09 volumio go-librespot[1213]: time="2025-05-22T21:51:09+02:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" uri="spotify:track:0y0k5s6TpzkTmNxx0r5HDP"
May 22 21:51:09 volumio go-librespot[1213]: time="2025-05-22T21:51:09+02:00" level=info msg="prefetched track \"Petite Etoile\" (duration: 275493ms)" uri="spotify:track:0y0k5s6TpzkTmNxx0r5HDP"
May 22 21:51:09 volumio go-librespot[1213]: time="2025-05-22T21:51:09+02:00" level=debug msg="fetched chunk 1/21, size: 524288" uri="spotify:track:0y0k5s6TpzkTmNxx0r5HDP"
May 22 21:51:09 volumio go-librespot[1213]: time="2025-05-22T21:51:09+02:00" level=debug msg="fetched chunk 3/21, size: 524288" uri="spotify:track:0y0k5s6TpzkTmNxx0r5HDP"
May 22 21:51:09 volumio go-librespot[1213]: time="2025-05-22T21:51:09+02:00" level=debug msg="fetched chunk 2/21, size: 524288" uri="spotify:track:0y0k5s6TpzkTmNxx0r5HDP"
May 22 21:51:16 volumio nmbd[8505]: [2025/05/22 21:51:16.117868, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database)
May 22 21:51:16 volumio nmbd[8505]: wins_write_database: Can't open /var/lib/samba/wins.dat.8505: Read-only file system
May 22 21:51:32 volumio volumio[870]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 10
May 22 21:51:32 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
May 22 21:51:36 volumio nmbd[8559]: [2025/05/22 21:51:36.139359, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database)
May 22 21:51:36 volumio nmbd[8559]: wins_write_database: Can't open /var/lib/samba/wins.dat.8559: Read-only file system
May 22 21:51:38 volumio go-librespot[1213]: time="2025-05-22T21:51:38+02:00" level=trace msg="emitting websocket event: not_playing"
May 22 21:51:38 volumio go-librespot[1213]: time="2025-05-22T21:51:38+02:00" level=debug msg="loading track (paused: false, position: 0ms)" uri="spotify:track:0y0k5s6TpzkTmNxx0r5HDP"
May 22 21:51:38 volumio volumio[870]: SPOTIFY: received: {"type":"not_playing","data":{"uri":"spotify:track:62d0YCTAtRcVQ8s44H9HbM","play_origin":"playlist/ondemand"}}
May 22 21:51:38 volumio volumio[870]: error: Failed to decode event: not_playing
May 22 21:51:39 volumio go-librespot[1213]: time="2025-05-22T21:51:39+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
May 22 21:51:39 volumio go-librespot[1213]: time="2025-05-22T21:51:39+02:00" level=trace msg="emitting websocket event: will_play"
May 22 21:51:39 volumio volumio[870]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:0y0k5s6TpzkTmNxx0r5HDP","play_origin":"playlist/ondemand"}}
May 22 21:51:39 volumio go-librespot[1213]: time="2025-05-22T21:51:39+02:00" level=info msg="loaded track \"Petite Etoile\" (paused: false, position: 0ms, duration: 275493ms, prefetched: true)" uri="spotify:track:0y0k5s6TpzkTmNxx0r5HDP"
May 22 21:51:39 volumio go-librespot[1213]: time="2025-05-22T21:51:39+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
May 22 21:51:39 volumio go-librespot[1213]: time="2025-05-22T21:51:39+02:00" level=trace msg="scheduling prefetch in 245s"
May 22 21:51:39 volumio go-librespot[1213]: time="2025-05-22T21:51:39+02:00" level=trace msg="emitting websocket event: metadata"
May 22 21:51:39 volumio volumio[870]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:0y0k5s6TpzkTmNxx0r5HDP","name":"Petite Etoile","artist_names":["Polo \u0026 Pan","Beth Ditto"],"album_name":"22:22","album_cover_url":"https://i.scdn.co/image/ab67616d00001e023c11030decfea5e8e8c53c42","position":0,"duration":275493,"release_date":"year:2025 month:3 day:28","track_number":5,"disc_number":1}}
May 22 21:51:39 volumio go-librespot[1213]: time="2025-05-22T21:51:39+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
May 22 21:51:39 volumio go-librespot[1213]: time="2025-05-22T21:51:39+02:00" level=trace msg="emitting websocket event: playing"
May 22 21:51:39 volumio volumio[870]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:0y0k5s6TpzkTmNxx0r5HDP","play_origin":"playlist/ondemand"}}
May 22 21:51:39 volumio volumio[870]: SPOTIFY: PUSH STATE SPOTIFY
May 22 21:51:39 volumio volumio[870]: SPOTIFY: {"status":"play","service":"spop","title":"Petite Etoile","artist":"Polo & Pan, Beth Ditto","album":"22:22","albumart":"https://i.scdn.co/image/ab67616d00001e023c11030decfea5e8e8c53c42","uri":"spotify:track:0y0k5s6TpzkTmNxx0r5HDP","trackType":"spotify","seek":0,"duration":275,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"}
May 22 21:51:39 volumio volumio[870]: info: CoreCommandRouter::servicePushState
May 22 21:51:39 volumio volumio[870]: info: CoreStateMachine::pushState
May 22 21:51:39 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 22 21:51:39 volumio volumio[870]: info: CoreCommandRouter::volumioPushState
May 22 21:51:39 volumio volumio[870]: SPOTIFY: RECEIVED VOLUMIO VOLUME 39
May 22 21:51:39 volumio volumio[870]: SPOTIFY: PUSH STATE SPOTIFY
May 22 21:51:39 volumio volumio[870]: SPOTIFY: {"status":"play","service":"spop","title":"Petite Etoile","artist":"Polo & Pan, Beth Ditto","album":"22:22","albumart":"https://i.scdn.co/image/ab67616d00001e023c11030decfea5e8e8c53c42","uri":"spotify:track:0y0k5s6TpzkTmNxx0r5HDP","trackType":"spotify","seek":0,"duration":275,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"}
May 22 21:51:39 volumio volumio[870]: info: CoreCommandRouter::servicePushState
May 22 21:51:39 volumio volumio[870]: info: CoreStateMachine::pushState
May 22 21:51:39 volumio volumio[870]: info: CoreCommandRouter::volumioPushState
May 22 21:51:39 volumio volumio[870]: SPOTIFY: RECEIVED VOLUMIO VOLUME 39
May 22 21:51:55 volumio go-librespot[1213]: time="2025-05-22T21:51:55+02:00" level=debug msg="fetched chunk 4/21, size: 524288" uri="spotify:track:0y0k5s6TpzkTmNxx0r5HDP"
May 22 21:51:56 volumio nmbd[8570]: [2025/05/22 21:51:56.152283, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database)
May 22 21:51:56 volumio nmbd[8570]: wins_write_database: Can't open /var/lib/samba/wins.dat.8570: Read-only file system
May 22 21:51:58 volumio volumio[870]: info: VolumeController::SetAlsaVolume-
May 22 21:51:58 volumio volumio[870]: info: CoreStateMachine::pushState
May 22 21:51:58 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 22 21:51:58 volumio volumio[870]: info: CoreCommandRouter::volumioPushState
May 22 21:51:58 volumio volumio[870]: SPOTIFY: RECEIVED VOLUMIO VOLUME 34
May 22 21:51:58 volumio volumio[870]: SPOTIFY: SPOTIFY VOLUME 39
May 22 21:51:58 volumio volumio[870]: SPOTIFY: VOLUMIO VOLUME 34
May 22 21:51:58 volumio volumio[870]: SPOTIFY: DELTA VOLUME ENOUGH: true
May 22 21:51:58 volumio volumio[870]: info: Setting Spotify Volume from Volumio: 34
May 22 21:51:59 volumio volumio[870]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 22 21:51:59 volumio volumio[870]: Error: EROFS: read-only file system, open '/data/configuration/system_hardware/gpio-buttons/config.json'
May 22 21:51:59 volumio volumio[870]: at Object.openSync (fs.js:476:3)
May 22 21:51:59 volumio volumio[870]: at Object.writeFileSync (fs.js:1467:35)
May 22 21:51:59 volumio volumio[870]: at Object.writeFileSync (/data/plugins/system_hardware/gpio-buttons/node_modules/jsonfile/index.js:115:13)
May 22 21:51:59 volumio volumio[870]: at Config.save (/data/plugins/system_hardware/gpio-buttons/node_modules/v-conf/index.js:142:12)
May 22 21:51:59 volumio volumio[870]: at Timeout._onTimeout (/data/plugins/system_hardware/gpio-buttons/node_modules/v-conf/index.js:129:18)
May 22 21:51:59 volumio volumio[870]: at listOnTimeout (internal/timers.js:554:17)
May 22 21:51:59 volumio volumio[870]: at processTimers (internal/timers.js:497:7) {
May 22 21:51:59 volumio volumio[870]: errno: -30,
May 22 21:51:59 volumio volumio[870]: syscall: 'open',
May 22 21:51:59 volumio volumio[870]: code: 'EROFS',
May 22 21:51:59 volumio volumio[870]: path: '/data/configuration/system_hardware/gpio-buttons/config.json'
May 22 21:51:59 volumio volumio[870]: }
May 22 21:51:59 volumio volumio[870]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 22 21:52:00 volumio sudo[8585]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-22 21:51
May 22 21:52:00 volumio sudo[8585]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST"
VOLUMIO_VERSION="3.703"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"