-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Mon 2024-08-19 22:44:12 CEST. -- Aug 19 22:43:01 volumio nmbd[6462]: [2024/08/19 22:43:01.259835, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database) Aug 19 22:43:01 volumio nmbd[6462]: wins_write_database: Can't open /var/lib/samba/wins.dat.6462: Read-only file system Aug 19 22:43:07 volumio go-librespot[1224]: time="2024-08-19T22:43:07+02:00" level=debug msg="fetched chunk 12/12, size: 218784" Aug 19 22:43:16 volumio volumio[868]: 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 Aug 19 22:43:16 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 19 22:43:21 volumio nmbd[6473]: [2024/08/19 22:43:21.268522, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database) Aug 19 22:43:21 volumio nmbd[6473]: wins_write_database: Can't open /var/lib/samba/wins.dat.6473: Read-only file system Aug 19 22:43:41 volumio nmbd[6474]: [2024/08/19 22:43:41.294217, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database) Aug 19 22:43:41 volumio nmbd[6474]: wins_write_database: Can't open /var/lib/samba/wins.dat.6474: Read-only file system Aug 19 22:43:48 volumio volumio[868]: 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 Aug 19 22:43:48 volumio volumio[868]: info: CoreCommandRouter::volumioGetState Aug 19 22:43:56 volumio kernel: xhci_hcd 0000:01:00.0: ERROR Transfer event for disabled endpoint slot 3 ep 1 Aug 19 22:43:56 volumio kernel: xhci_hcd 0000:01:00.0: @000000042a114460 00000000 00000000 0e000000 03028001 Aug 19 22:43:56 volumio go-librespot[1224]: time="2024-08-19T22:43:56+02:00" level=trace msg="emitting websocket event: not_playing" Aug 19 22:43:56 volumio go-librespot[1224]: time="2024-08-19T22:43:56+02:00" level=debug msg="loading track spotify:track:3sMleqdCDalZ6xsAQe8xuY (paused: false, position: 0ms)" Aug 19 22:43:56 volumio volumio[868]: SPOTIFY: received: {"type":"not_playing","data":{"uri":"spotify:track:6kK2YbF8boQl32Lqkai3Ca","play_origin":"free-tier-artist"}} Aug 19 22:43:56 volumio volumio[868]: error: Failed to decode event: not_playing Aug 19 22:43:56 volumio go-librespot[1224]: time="2024-08-19T22:43:56+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Aug 19 22:43:56 volumio go-librespot[1224]: time="2024-08-19T22:43:56+02:00" level=trace msg="emitting websocket event: will_play" Aug 19 22:43:56 volumio volumio[868]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:3sMleqdCDalZ6xsAQe8xuY","play_origin":"free-tier-artist"}} Aug 19 22:43:56 volumio go-librespot[1224]: time="2024-08-19T22:43:56+02:00" level=debug msg="selected format OGG_VORBIS_320 for spotify:track:3sMleqdCDalZ6xsAQe8xuY" Aug 19 22:43:56 volumio go-librespot[1224]: time="2024-08-19T22:43:56+02:00" level=debug msg="requested aes key for file 9da77053d89877c5f9d4d8b4d618a41586172045, gid: 3sMleqdCDalZ6xsAQe8xuY" Aug 19 22:43:56 volumio go-librespot[1224]: time="2024-08-19T22:43:56+02:00" level=debug msg="fetched first chunk of 16, total size is 8240036 bytes" Aug 19 22:43:56 volumio go-librespot[1224]: time="2024-08-19T22:43:56+02:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" Aug 19 22:43:56 volumio go-librespot[1224]: time="2024-08-19T22:43:56+02:00" level=info msg="loaded track \"Booty Swing\" (uri: spotify:track:3sMleqdCDalZ6xsAQe8xuY, paused: false, position: 0ms, duration: 197506ms)" Aug 19 22:43:56 volumio go-librespot[1224]: time="2024-08-19T22:43:56+02:00" level=debug msg="fetched chunk 1/15, size: 524288" Aug 19 22:43:56 volumio go-librespot[1224]: time="2024-08-19T22:43:56+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Aug 19 22:43:56 volumio go-librespot[1224]: time="2024-08-19T22:43:56+02:00" level=trace msg="emitting websocket event: metadata" Aug 19 22:43:56 volumio volumio[868]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:3sMleqdCDalZ6xsAQe8xuY","name":"Booty Swing","artist_names":["Parov Stelar"],"album_name":"The Princess, Pt. Two","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02b6efd26ce36980c408104fa0","position":0,"duration":197506,"release_date":"year:2012 month:4 day:20","track_number":3,"disc_number":1}} Aug 19 22:43:56 volumio go-librespot[1224]: time="2024-08-19T22:43:56+02:00" level=debug msg="fetched chunk 2/15, size: 524288" Aug 19 22:43:56 volumio go-librespot[1224]: time="2024-08-19T22:43:56+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Aug 19 22:43:56 volumio go-librespot[1224]: time="2024-08-19T22:43:56+02:00" level=trace msg="emitting websocket event: playing" Aug 19 22:43:56 volumio volumio[868]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:3sMleqdCDalZ6xsAQe8xuY","play_origin":"free-tier-artist"}} Aug 19 22:43:56 volumio volumio[868]: SPOTIFY: PUSH STATE SPOTIFY Aug 19 22:43:56 volumio volumio[868]: SPOTIFY: {"status":"play","service":"spop","title":"Booty Swing","artist":"Parov Stelar","album":"The Princess, Pt. Two","albumart":"https://i.scdn.co/image/ab67616d00001e02b6efd26ce36980c408104fa0","uri":"spotify:track:3sMleqdCDalZ6xsAQe8xuY","trackType":"spotify","seek":0,"duration":197,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Aug 19 22:43:56 volumio volumio[868]: info: CoreCommandRouter::servicePushState Aug 19 22:43:56 volumio volumio[868]: info: CoreStateMachine::pushState Aug 19 22:43:56 volumio volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 19 22:43:56 volumio volumio[868]: info: CoreCommandRouter::volumioPushState Aug 19 22:43:56 volumio go-librespot[1224]: time="2024-08-19T22:43:56+02:00" level=debug msg="fetched chunk 3/15, size: 524288" Aug 19 22:43:56 volumio volumio[868]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Aug 19 22:43:57 volumio volumio[868]: SPOTIFY: PUSH STATE SPOTIFY Aug 19 22:43:57 volumio volumio[868]: SPOTIFY: {"status":"play","service":"spop","title":"Booty Swing","artist":"Parov Stelar","album":"The Princess, Pt. Two","albumart":"https://i.scdn.co/image/ab67616d00001e02b6efd26ce36980c408104fa0","uri":"spotify:track:3sMleqdCDalZ6xsAQe8xuY","trackType":"spotify","seek":0,"duration":197,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Aug 19 22:43:57 volumio volumio[868]: info: CoreCommandRouter::servicePushState Aug 19 22:43:57 volumio volumio[868]: info: CoreStateMachine::pushState Aug 19 22:43:57 volumio volumio[868]: info: CoreCommandRouter::volumioPushState Aug 19 22:43:57 volumio volumio[868]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Aug 19 22:44:01 volumio nmbd[6539]: [2024/08/19 22:44:01.313828, 0] ../source3/nmbd/nmbd_winsserver.c:2508(wins_write_database) Aug 19 22:44:01 volumio nmbd[6539]: wins_write_database: Can't open /var/lib/samba/wins.dat.6539: Read-only file system Aug 19 22:44:04 volumio go-librespot[1224]: time="2024-08-19T22:44:04+02:00" level=debug msg="fetched chunk 4/15, size: 524288" Aug 19 22:44:11 volumio volumio[868]: info: VolumeController::SetAlsaVolume- Aug 19 22:44:11 volumio volumio[868]: info: CoreStateMachine::pushState Aug 19 22:44:11 volumio volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 19 22:44:11 volumio volumio[868]: info: CoreCommandRouter::volumioPushState Aug 19 22:44:11 volumio volumio[868]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Aug 19 22:44:11 volumio volumio[868]: SPOTIFY: SPOTIFY VOLUME 78 Aug 19 22:44:11 volumio volumio[868]: SPOTIFY: VOLUMIO VOLUME 73 Aug 19 22:44:11 volumio volumio[868]: SPOTIFY: DELTA VOLUME ENOUGH: true Aug 19 22:44:11 volumio volumio[868]: info: Setting Spotify Volume from Volumio: 73 Aug 19 22:44:11 volumio volumio[868]: info: VolumeController::SetAlsaVolume- Aug 19 22:44:11 volumio volumio[868]: info: CoreStateMachine::pushState Aug 19 22:44:11 volumio volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 19 22:44:11 volumio volumio[868]: info: CoreCommandRouter::volumioPushState Aug 19 22:44:11 volumio volumio[868]: SPOTIFY: RECEIVED VOLUMIO VOLUME 68 Aug 19 22:44:11 volumio volumio[868]: SPOTIFY: SPOTIFY VOLUME 73 Aug 19 22:44:11 volumio volumio[868]: SPOTIFY: VOLUMIO VOLUME 68 Aug 19 22:44:11 volumio volumio[868]: SPOTIFY: DELTA VOLUME ENOUGH: true Aug 19 22:44:11 volumio volumio[868]: info: Setting Spotify Volume from Volumio: 68 Aug 19 22:44:11 volumio volumio[868]: info: VolumeController::SetAlsaVolume- Aug 19 22:44:11 volumio volumio[868]: info: CoreStateMachine::pushState Aug 19 22:44:11 volumio volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 19 22:44:11 volumio volumio[868]: info: CoreCommandRouter::volumioPushState Aug 19 22:44:11 volumio volumio[868]: SPOTIFY: RECEIVED VOLUMIO VOLUME 63 Aug 19 22:44:11 volumio volumio[868]: SPOTIFY: SPOTIFY VOLUME 68 Aug 19 22:44:11 volumio volumio[868]: SPOTIFY: VOLUMIO VOLUME 63 Aug 19 22:44:11 volumio volumio[868]: SPOTIFY: DELTA VOLUME ENOUGH: true Aug 19 22:44:11 volumio volumio[868]: info: Setting Spotify Volume from Volumio: 63 Aug 19 22:44:12 volumio volumio[868]: info: VolumeController::SetAlsaVolume- Aug 19 22:44:12 volumio volumio[868]: info: CoreStateMachine::pushState Aug 19 22:44:12 volumio volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 19 22:44:12 volumio volumio[868]: info: CoreCommandRouter::volumioPushState Aug 19 22:44:12 volumio volumio[868]: SPOTIFY: RECEIVED VOLUMIO VOLUME 58 Aug 19 22:44:12 volumio volumio[868]: SPOTIFY: SPOTIFY VOLUME 63 Aug 19 22:44:12 volumio volumio[868]: SPOTIFY: VOLUMIO VOLUME 58 Aug 19 22:44:12 volumio volumio[868]: SPOTIFY: DELTA VOLUME ENOUGH: true Aug 19 22:44:12 volumio volumio[868]: info: Setting Spotify Volume from Volumio: 58 Aug 19 22:44:12 volumio volumio[868]: info: VolumeController::SetAlsaVolume- Aug 19 22:44:12 volumio volumio[868]: info: CoreStateMachine::pushState Aug 19 22:44:12 volumio volumio[868]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 19 22:44:12 volumio volumio[868]: info: CoreCommandRouter::volumioPushState Aug 19 22:44:12 volumio volumio[868]: SPOTIFY: RECEIVED VOLUMIO VOLUME 53 Aug 19 22:44:12 volumio volumio[868]: SPOTIFY: SPOTIFY VOLUME 58 Aug 19 22:44:12 volumio volumio[868]: SPOTIFY: VOLUMIO VOLUME 53 Aug 19 22:44:12 volumio volumio[868]: SPOTIFY: DELTA VOLUME ENOUGH: true Aug 19 22:44:12 volumio volumio[868]: info: Setting Spotify Volume from Volumio: 53 Aug 19 22:44:12 volumio volumio[868]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 19 22:44:12 volumio volumio[868]: Error: EROFS: read-only file system, open '/data/configuration/system_hardware/gpio-buttons/config.json' Aug 19 22:44:12 volumio volumio[868]: at Object.openSync (fs.js:476:3) Aug 19 22:44:12 volumio volumio[868]: at Object.writeFileSync (fs.js:1467:35) Aug 19 22:44:12 volumio volumio[868]: at Object.writeFileSync (/data/plugins/system_hardware/gpio-buttons/node_modules/jsonfile/index.js:115:13) Aug 19 22:44:12 volumio volumio[868]: at Config.save (/data/plugins/system_hardware/gpio-buttons/node_modules/v-conf/index.js:142:12) Aug 19 22:44:12 volumio volumio[868]: at Timeout._onTimeout (/data/plugins/system_hardware/gpio-buttons/node_modules/v-conf/index.js:129:18) Aug 19 22:44:12 volumio volumio[868]: at listOnTimeout (internal/timers.js:554:17) Aug 19 22:44:12 volumio volumio[868]: at processTimers (internal/timers.js:497:7) { Aug 19 22:44:12 volumio volumio[868]: errno: -30, Aug 19 22:44:12 volumio volumio[868]: syscall: 'open', Aug 19 22:44:12 volumio volumio[868]: code: 'EROFS', Aug 19 22:44:12 volumio volumio[868]: path: '/data/configuration/system_hardware/gpio-buttons/config.json' Aug 19 22:44:12 volumio volumio[868]: } Aug 19 22:44:12 volumio volumio[868]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 19 22:44:12 volumio sudo[6574]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-19 22:43 Aug 19 22:44:12 volumio sudo[6574]: 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"