Jan 26 14:00:03 spotumio volumio[1168]: info: Ejecting CD Jan 26 14:00:03 spotumio volumio[1168]: info: CoreCommandRouter::volumioGetState Jan 26 14:00:03 spotumio volumio[1168]: info: CorePlayQueue::getTrack 0 Jan 26 14:00:03 spotumio volumio[1168]: info: Clearing queue from CD entries Jan 26 14:00:03 spotumio volumio[1168]: info: CoreCommandRouter::volumioPushQueue Jan 26 14:00:03 spotumio volumio[1168]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesAudio CD Jan 26 14:00:03 spotumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 26 14:00:03 spotumio volumio[1168]: Cannot find translation for source YouTube Music Jan 26 14:00:03 spotumio volumio[1168]: Cannot find translation for source 80s80s Radio Jan 26 14:00:03 spotumio volumio[1168]: Cannot find translation for source Mother Earth Radio Jan 26 14:00:03 spotumio volumio[1168]: Cannot find translation for source Radio Paradise Jan 26 14:00:03 spotumio volumio[1168]: Cannot find translation for source Spotify Jan 26 14:00:05 spotumio go-librespot[1610]: time="2026-01-26T14:00:05-06:00" level=trace msg="sent dealer ping" Jan 26 14:00:05 spotumio go-librespot[1610]: time="2026-01-26T14:00:05-06:00" level=trace msg="received dealer pong" Jan 26 14:00:29 spotumio kernel: scsi_io_completion_action: 109 callbacks suppressed Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x00 driverbyte=DRIVER_OK cmd_age=0s Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 Sense Key : 0x5 [current] Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 ASC=0x64 ASCQ=0x0 Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 CDB: opcode=0x28 28 00 00 00 00 00 00 00 02 00 00 00 Jan 26 14:00:29 spotumio kernel: blk_print_req_error: 109 callbacks suppressed Jan 26 14:00:29 spotumio kernel: I/O error, dev sr0, sector 0 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x00 driverbyte=DRIVER_OK cmd_age=0s Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 Sense Key : 0x5 [current] Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 ASC=0x64 ASCQ=0x0 Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 CDB: opcode=0x28 28 00 00 00 00 00 00 00 02 00 00 00 Jan 26 14:00:29 spotumio kernel: I/O error, dev sr0, sector 0 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jan 26 14:00:29 spotumio kernel: buffer_io_error: 101 callbacks suppressed Jan 26 14:00:29 spotumio kernel: Buffer I/O error on dev sr0, logical block 0, async page read Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x00 driverbyte=DRIVER_OK cmd_age=0s Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 Sense Key : 0x5 [current] Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 ASC=0x64 ASCQ=0x0 Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 CDB: opcode=0x28 28 00 00 00 00 00 00 00 02 00 00 00 Jan 26 14:00:29 spotumio kernel: I/O error, dev sr0, sector 0 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jan 26 14:00:29 spotumio kernel: Buffer I/O error on dev sr0, logical block 0, async page read Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x00 driverbyte=DRIVER_OK cmd_age=0s Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 Sense Key : 0x5 [current] Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 ASC=0x64 ASCQ=0x0 Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 CDB: opcode=0x28 28 00 00 00 00 00 00 00 02 00 00 00 Jan 26 14:00:29 spotumio kernel: I/O error, dev sr0, sector 0 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jan 26 14:00:29 spotumio kernel: Buffer I/O error on dev sr0, logical block 0, async page read Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x00 driverbyte=DRIVER_OK cmd_age=0s Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 Sense Key : 0x5 [current] Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 ASC=0x64 ASCQ=0x0 Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 CDB: opcode=0x28 28 00 00 00 00 00 00 00 02 00 00 00 Jan 26 14:00:29 spotumio kernel: I/O error, dev sr0, sector 0 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jan 26 14:00:29 spotumio kernel: Buffer I/O error on dev sr0, logical block 0, async page read Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x00 driverbyte=DRIVER_OK cmd_age=0s Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 Sense Key : 0x5 [current] Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 ASC=0x64 ASCQ=0x0 Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 CDB: opcode=0x28 28 00 00 00 00 00 00 00 02 00 00 00 Jan 26 14:00:29 spotumio kernel: I/O error, dev sr0, sector 0 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jan 26 14:00:29 spotumio kernel: Buffer I/O error on dev sr0, logical block 0, async page read Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x00 driverbyte=DRIVER_OK cmd_age=0s Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 Sense Key : 0x5 [current] Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 ASC=0x64 ASCQ=0x0 Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 CDB: opcode=0x28 28 00 00 00 00 00 00 00 02 00 00 00 Jan 26 14:00:29 spotumio kernel: I/O error, dev sr0, sector 0 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jan 26 14:00:29 spotumio kernel: Buffer I/O error on dev sr0, logical block 0, async page read Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x00 driverbyte=DRIVER_OK cmd_age=0s Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 Sense Key : 0x5 [current] Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 ASC=0x64 ASCQ=0x0 Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 CDB: opcode=0x28 28 00 00 00 00 00 00 00 02 00 00 00 Jan 26 14:00:29 spotumio kernel: I/O error, dev sr0, sector 0 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jan 26 14:00:29 spotumio kernel: Buffer I/O error on dev sr0, logical block 0, async page read Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x00 driverbyte=DRIVER_OK cmd_age=0s Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 Sense Key : 0x5 [current] Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 ASC=0x64 ASCQ=0x0 Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 CDB: opcode=0x28 28 00 00 00 00 00 00 00 02 00 00 00 Jan 26 14:00:29 spotumio kernel: I/O error, dev sr0, sector 0 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jan 26 14:00:29 spotumio kernel: Buffer I/O error on dev sr0, logical block 0, async page read Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x00 driverbyte=DRIVER_OK cmd_age=0s Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 Sense Key : 0x5 [current] Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 ASC=0x64 ASCQ=0x0 Jan 26 14:00:29 spotumio kernel: sr 2:0:0:0: [sr0] tag#0 CDB: opcode=0x28 28 00 00 00 00 00 00 00 02 00 00 00 Jan 26 14:00:29 spotumio kernel: I/O error, dev sr0, sector 0 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Jan 26 14:00:29 spotumio kernel: Buffer I/O error on dev sr0, logical block 0, async page read Jan 26 14:00:29 spotumio kernel: Buffer I/O error on dev sr0, logical block 0, async page read Jan 26 14:00:30 spotumio sudo[21748]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /dev/sr0 Jan 26 14:00:30 spotumio sudo[21748]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 26 14:00:30 spotumio sudo[21748]: pam_unix(sudo:session): session closed for user root Jan 26 14:00:30 spotumio sudo[21752]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /dev/sr1 Jan 26 14:00:30 spotumio sudo[21752]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 26 14:00:30 spotumio sudo[21752]: pam_unix(sudo:session): session closed for user root Jan 26 14:00:30 spotumio volumio[1168]: /bin/chmod: cannot access '/dev/sr1': No such file or directory Jan 26 14:00:30 spotumio volumio[1168]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 26 14:00:30 spotumio volumio[1168]: info: [1769457630447] CoreMusicLibrary::Adding element Audio CD Jan 26 14:00:30 spotumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 26 14:00:30 spotumio volumio[1168]: Cannot find translation for source YouTube Music Jan 26 14:00:30 spotumio volumio[1168]: Cannot find translation for source 80s80s Radio Jan 26 14:00:30 spotumio volumio[1168]: Cannot find translation for source Mother Earth Radio Jan 26 14:00:30 spotumio volumio[1168]: Cannot find translation for source Radio Paradise Jan 26 14:00:30 spotumio volumio[1168]: Cannot find translation for source Spotify Jan 26 14:00:30 spotumio volumio[1168]: Cannot find translation for source Audio CD Jan 26 14:00:34 spotumio go-librespot[1610]: time="2026-01-26T14:00:34-06:00" level=trace msg="received accesspoint ping" Jan 26 14:00:35 spotumio go-librespot[1610]: time="2026-01-26T14:00:35-06:00" level=trace msg="received accesspoint pong ack" Jan 26 14:00:35 spotumio go-librespot[1610]: time="2026-01-26T14:00:35-06:00" level=trace msg="sent dealer ping" Jan 26 14:00:35 spotumio go-librespot[1610]: time="2026-01-26T14:00:35-06:00" level=trace msg="received dealer pong" Jan 26 14:00:35 spotumio volumio[1168]: info: [cd-plugin] Set CD speed to 1X Jan 26 14:00:37 spotumio volumio[1168]: info: Error on Writing CDDB entry: Error: Command failed: /usr/bin/abcde -N -a cddb -c /etc/abcdecddb.conf -d /dev/sr0 Jan 26 14:00:37 spotumio volumio[1168]: Premature connection close at /usr/share/perl5/WebService/MusicBrainz/Request.pm line 69. Jan 26 14:00:37 spotumio volumio[1168]: [ERROR] abcde: abcde-musicbrainz-tool failed to run; ABORT Jan 26 14:01:05 spotumio go-librespot[1610]: time="2026-01-26T14:01:05-06:00" level=trace msg="sent dealer ping" Jan 26 14:01:05 spotumio go-librespot[1610]: time="2026-01-26T14:01:05-06:00" level=trace msg="received dealer pong" Jan 26 14:01:09 spotumio volumio[1168]: verbose: New Socket.io Connection to 192.168.1.180:3000 from 192.168.1.79 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Jan 26 14:01:09 spotumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 14:01:09 spotumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 14:01:09 spotumio volumio[1168]: info: Discovery: Getting this device information Jan 26 14:01:09 spotumio volumio[1168]: info: CoreCommandRouter::volumioGetState Jan 26 14:01:09 spotumio volumio[1168]: info: CorePlayQueue::getTrack 0 Jan 26 14:01:09 spotumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 14:01:35 spotumio go-librespot[1610]: time="2026-01-26T14:01:35-06:00" level=trace msg="sent dealer ping" Jan 26 14:01:35 spotumio go-librespot[1610]: time="2026-01-26T14:01:35-06:00" level=trace msg="received dealer pong" Jan 26 14:01:36 spotumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: cd_controller , handleBrowseUri Jan 26 14:01:36 spotumio volumio[1168]: error: GETWHOLECD INFO Cannot read CDDB file Error: ENOENT: no such file or directory, open '/data/cddb/c407f30e' Jan 26 14:01:36 spotumio volumio[1168]: error: Could not fetch whole CD Info Jan 26 14:01:36 spotumio volumio[1168]: info: Preload queue cleared Jan 26 14:01:42 spotumio volumio[1168]: info: CALLMETHOD: music_service cd_controller getRipInfo Jan 26 14:01:42 spotumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: cd_controller , getRipInfo Jan 26 14:01:42 spotumio volumio[1168]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 26 14:01:42 spotumio volumio[1168]: Error: ENOTCONN: socket is not connected, lstat '/mnt/USB/Passport' Jan 26 14:01:42 spotumio volumio[1168]: at Object.lstatSync (node:fs:1684:3) Jan 26 14:01:42 spotumio volumio[1168]: at Object.lstatSync (/volumio/node_modules/graceful-fs/polyfills.js:319:16) Jan 26 14:01:42 spotumio volumio[1168]: at /myvolumio/plugins/music_service/cd_controller/cd_controller_real:1:14990 Jan 26 14:01:42 spotumio volumio[1168]: at /volumio/node_modules/graceful-fs/graceful-fs.js:228:16 Jan 26 14:01:42 spotumio volumio[1168]: at FSReqCallback.oncomplete (node:fs:190:23) { Jan 26 14:01:42 spotumio volumio[1168]: errno: -107, Jan 26 14:01:42 spotumio volumio[1168]: syscall: 'lstat', Jan 26 14:01:42 spotumio volumio[1168]: code: 'ENOTCONN', Jan 26 14:01:42 spotumio volumio[1168]: path: '/mnt/USB/Passport' Jan 26 14:01:42 spotumio volumio[1168]: } Jan 26 14:01:42 spotumio volumio[1168]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 26 14:01:43 spotumio sudo[22400]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-26 14:00' Jan 26 14:01:43 spotumio sudo[22400]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"