Feb 07 21:57:38 volumio ntpd[870]: CLOCK: time stepped by 549874.398862
Feb 07 21:57:38 volumio ntpd[870]: CLOCK: time changed from 2026-02-01 to 2026-02-07
Feb 07 21:57:38 volumio ntpd[870]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes
Feb 07 21:57:38 volumio systemd[1]: Starting dpkg-db-backup.service - Daily dpkg database backup service...
Feb 07 21:57:38 volumio systemd[1]: Started ntpsec-rotate-stats.service - Rotate ntpd stats.
Feb 07 21:57:38 volumio systemd[1]: ntpsec-rotate-stats.service: Deactivated successfully.
Feb 07 21:57:38 volumio systemd[1]: dpkg-db-backup.service: Deactivated successfully.
Feb 07 21:57:38 volumio systemd[1]: Finished dpkg-db-backup.service - Daily dpkg database backup service.
Feb 07 21:57:38 volumio volumio-remote-updater[719]: [2026-02-07 21:57:38] [connect] Successful connection
Feb 07 21:57:38 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully.
Feb 07 21:57:38 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service.
Feb 07 21:57:38 volumio systemd[1]: Reached target multi-user.target - Multi-User System.
Feb 07 21:57:38 volumio systemd[1]: Reached target graphical.target - Graphical Interface.
Feb 07 21:57:38 volumio systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP...
Feb 07 21:57:39 volumio systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully.
Feb 07 21:57:39 volumio systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP.
Feb 07 21:57:39 volumio systemd[1]: Startup finished in 19.990s (kernel) + 44.409s (userspace) = 1min 4.400s.
Feb 07 21:57:39 volumio volumio[1181]: info: Loading plugin "network"...
Feb 07 21:57:39 volumio volumio[1181]: info: Refreshing Cached IP Addresses
Feb 07 21:57:39 volumio volumio[1181]: info: Loading plugin "services"...
Feb 07 21:57:39 volumio sudo[1388]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 07 21:57:39 volumio sudo[1388]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 07 21:57:39 volumio sudo[1396]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Feb 07 21:57:39 volumio sudo[1396]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 07 21:57:39 volumio sudo[1389]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 07 21:57:39 volumio sudo[1389]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 07 21:57:39 volumio volumio[1181]: info: Loading plugin "alsa_controller"...
Feb 07 21:57:39 volumio sudo[1388]: pam_unix(sudo:session): session closed for user root
Feb 07 21:57:39 volumio sudo[1389]: pam_unix(sudo:session): session closed for user root
Feb 07 21:57:39 volumio volumio[1181]: warn: Unable to locate the audio output device USB HIFI Audio. Please configure a valid output device.
Feb 07 21:57:39 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 07 21:57:39 volumio volumio[1181]: info: Loading plugin "wizard"...
Feb 07 21:57:39 volumio volumio[1181]: info: Loading plugin "networkfs"...
Feb 07 21:57:39 volumio volumio[1181]: info: Starting Udev Watcher for removable devices
Feb 07 21:57:40 volumio volumio[1181]: info: Ignoring mount for partition: boot
Feb 07 21:57:40 volumio volumio[1181]: info: Ignoring mount for partition: volumio
Feb 07 21:57:40 volumio volumio[1181]: info: Ignoring mount for partition: volumio_data
Feb 07 21:57:40 volumio volumio[1181]: error: Cannot associate FS Label, not mounting
Feb 07 21:57:40 volumio volumio[1181]: info: Mounting Device TOSHIBA_EXT
Feb 07 21:57:40 volumio sudo[1423]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdc2 /mnt/USB/TOSHIBA_EXT -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Feb 07 21:57:40 volumio sudo[1423]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 07 21:57:40 volumio kernel: hwmon hwmon1: Undervoltage detected!
Feb 07 21:57:41 volumio kernel: sd 2:0:0:0: [sdc] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=0s
Feb 07 21:57:41 volumio kernel: sd 2:0:0:0: [sdc] tag#0 CDB: opcode=0x88 88 00 00 00 00 00 00 5c 64 78 00 00 00 20 00 00
Feb 07 21:57:41 volumio kernel: I/O error, dev sdc, sector 6055032 op 0x0:(READ) flags 0x80700 phys_seg 4 prio class 2
Feb 07 21:57:41 volumio kernel: usb 1-1.1.2: USB disconnect, device number 17
Feb 07 21:57:41 volumio sudo[1423]: pam_unix(sudo:session): session closed for user root
Feb 07 21:57:41 volumio kernel: Buffer I/O error on dev sdc2, logical block 5790840, async page read
Feb 07 21:57:41 volumio kernel: Buffer I/O error on dev sdc2, logical block 5790841, async page read
Feb 07 21:57:41 volumio kernel: Buffer I/O error on dev sdc2, logical block 5790842, async page read
Feb 07 21:57:41 volumio kernel: Buffer I/O error on dev sdc2, logical block 5790843, async page read
Feb 07 21:57:41 volumio kernel: Buffer I/O error on dev sdc2, logical block 5790844, async page read
Feb 07 21:57:41 volumio kernel: Buffer I/O error on dev sdc2, logical block 5790845, async page read
Feb 07 21:57:41 volumio kernel: Buffer I/O error on dev sdc2, logical block 5790846, async page read
Feb 07 21:57:41 volumio kernel: Buffer I/O error on dev sdc2, logical block 5790847, async page read
Feb 07 21:57:41 volumio kernel: Buffer I/O error on dev sdc2, logical block 6291456, async page read
Feb 07 21:57:41 volumio kernel: Buffer I/O error on dev sdc2, logical block 6291457, async page read
Feb 07 21:57:41 volumio volumio[1181]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error
Feb 07 21:57:41 volumio volumio[1181]: Failed to read first NTFS_BLOCK_SIZE bytes of potential restart page.
Feb 07 21:57:41 volumio volumio[1181]: The file system wasn't safely closed on Windows. Fixing.
Feb 07 21:57:41 volumio volumio[1181]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error
Feb 07 21:57:41 volumio volumio[1181]: Failed to read of MFT, mft=2 count=1 br=-1: Input/output error
Feb 07 21:57:41 volumio volumio[1181]: Failed to open inode FILE_LogFile: Input/output error
Feb 07 21:57:41 volumio volumio[1181]: Failed to sync device /dev/sdc2: Input/output error
Feb 07 21:57:41 volumio volumio[1181]: Failed to mount '/dev/sdc2': Input/output error
Feb 07 21:57:41 volumio volumio[1181]: NTFS is either inconsistent, or there is a hardware fault, or it's a
Feb 07 21:57:41 volumio volumio[1181]: SoftRAID/FakeRAID hardware. In the first case run chkdsk /f on Windows
Feb 07 21:57:41 volumio volumio[1181]: then reboot into Windows twice. The usage of the /f parameter is very
Feb 07 21:57:41 volumio volumio[1181]: important! If the device is a SoftRAID/FakeRAID then first activate
Feb 07 21:57:41 volumio volumio[1181]: it and mount a different device under the /dev/mapper/ directory, (e.g.
Feb 07 21:57:41 volumio volumio[1181]: /dev/mapper/nvidia_eahaabcc1). Please see the 'dmraid' documentation
Feb 07 21:57:41 volumio volumio[1181]: for more details.
Feb 07 21:57:41 volumio volumio[1181]: error: Failed to mount TOSHIBA_EXT: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sdc2" "/mnt/USB/TOSHIBA_EXT" -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Feb 07 21:57:41 volumio volumio[1181]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error
Feb 07 21:57:41 volumio volumio[1181]: Failed to read first NTFS_BLOCK_SIZE bytes of potential restart page.
Feb 07 21:57:41 volumio volumio[1181]: The file system wasn't safely closed on Windows. Fixing.
Feb 07 21:57:41 volumio volumio[1181]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error
Feb 07 21:57:41 volumio volumio[1181]: Failed to read of MFT, mft=2 count=1 br=-1: Input/output error
Feb 07 21:57:41 volumio volumio[1181]: Failed to open inode FILE_LogFile: Input/output error
Feb 07 21:57:41 volumio volumio[1181]: Failed to sync device /dev/sdc2: Input/output error
Feb 07 21:57:41 volumio volumio[1181]: Failed to mount '/dev/sdc2': Input/output error
Feb 07 21:57:41 volumio volumio[1181]: NTFS is either inconsistent, or there is a hardware fault, or it's a
Feb 07 21:57:41 volumio volumio[1181]: SoftRAID/FakeRAID hardware. In the first case run chkdsk /f on Windows
Feb 07 21:57:41 volumio volumio[1181]: then reboot into Windows twice. The usage of the /f parameter is very
Feb 07 21:57:41 volumio volumio[1181]: important! If the device is a SoftRAID/FakeRAID then first activate
Feb 07 21:57:41 volumio volumio[1181]: it and mount a different device under the /dev/mapper/ directory, (e.g.
Feb 07 21:57:41 volumio volumio[1181]: /dev/mapper/nvidia_eahaabcc1). Please see the 'dmraid' documentation
Feb 07 21:57:41 volumio volumio[1181]: for more details.
Feb 07 21:57:41 volumio volumio[1181]: info: Mounting Device One_Touch
Feb 07 21:57:41 volumio kernel: sd 2:0:0:0: [sdc] Synchronizing SCSI cache
Feb 07 21:57:41 volumio kernel: sd 2:0:0:0: [sdc] Synchronize Cache(10) failed: Result: hostbyte=0x01 driverbyte=DRIVER_OK
Feb 07 21:57:41 volumio sudo[1440]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/One_Touch -o noatime
Feb 07 21:57:41 volumio sudo[1440]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 07 21:57:41 volumio kernel: usb 1-1.1.2: new high-speed USB device number 18 using dwc_otg
Feb 07 21:57:41 volumio kernel: exFAT-fs (sdb1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
Feb 07 21:57:42 volumio kernel: usb 1-1.1.2: New USB device found, idVendor=0480, idProduct=0826, bcdDevice= 0.00
Feb 07 21:57:42 volumio kernel: usb 1-1.1.2: New USB device strings: Mfr=2, Product=3, SerialNumber=1
Feb 07 21:57:42 volumio kernel: usb 1-1.1.2: Product: EXTERNAL_USB
Feb 07 21:57:42 volumio kernel: usb 1-1.1.2: Manufacturer: TOSHIBA
Feb 07 21:57:42 volumio kernel: usb 1-1.1.2: SerialNumber: 20240402007495F
Feb 07 21:57:42 volumio kernel: usb-storage 1-1.1.2:1.0: USB Mass Storage device detected
Feb 07 21:57:42 volumio kernel: scsi host2: usb-storage 1-1.1.2:1.0
Feb 07 21:57:42 volumio kernel: usb 1-1.1.2: USB disconnect, device number 18
Feb 07 21:57:42 volumio systemd[1]: systemd-hostnamed.service: Deactivated successfully.
Feb 07 21:57:43 volumio sudo[1396]: pam_unix(sudo:session): session closed for user root
Feb 07 21:57:43 volumio kernel: usb 1-1.1.2: new high-speed USB device number 19 using dwc_otg
Feb 07 21:57:43 volumio kernel: usb 1-1.1.2: New USB device found, idVendor=0480, idProduct=0826, bcdDevice= 0.00
Feb 07 21:57:43 volumio kernel: usb 1-1.1.2: New USB device strings: Mfr=2, Product=3, SerialNumber=1
Feb 07 21:57:43 volumio kernel: usb 1-1.1.2: Product: EXTERNAL_USB
Feb 07 21:57:43 volumio kernel: usb 1-1.1.2: Manufacturer: TOSHIBA
Feb 07 21:57:43 volumio kernel: usb 1-1.1.2: SerialNumber: 20240402007495F
Feb 07 21:57:43 volumio kernel: usb-storage 1-1.1.2:1.0: USB Mass Storage device detected
Feb 07 21:57:43 volumio kernel: scsi host2: usb-storage 1-1.1.2:1.0
Feb 07 21:57:43 volumio sudo[1440]: pam_unix(sudo:session): session closed for user root
Feb 07 21:57:43 volumio volumio[1181]: info: Mounting Device 54FB-0226
Feb 07 21:57:43 volumio sudo[1459]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/54FB-0226 -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Feb 07 21:57:44 volumio sudo[1459]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 07 21:57:44 volumio kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive!
Feb 07 21:57:44 volumio kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
Feb 07 21:57:44 volumio sudo[1459]: pam_unix(sudo:session): session closed for user root
Feb 07 21:57:44 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 07 21:57:44 volumio volumio[1181]: info: Loading plugin "volumio_command_line_client"...
Feb 07 21:57:44 volumio volumio[1181]: info: Loading plugin "upnp"...
Feb 07 21:57:44 volumio volumio[1181]: info: [1770481664467] Starting Upmpd Daemon
Feb 07 21:57:44 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 07 21:57:44 volumio volumio[1181]: info: Loading plugin "my_music"...
Feb 07 21:57:44 volumio volumio[1181]: info: Loading plugin "mpd"...
Feb 07 21:57:44 volumio kernel: usb 1-1.1.2: USB disconnect, device number 19
Feb 07 21:57:45 volumio volumio[1181]: info: Loading plugin "upnp_browser"...
Feb 07 21:57:45 volumio kernel: usb 1-1.1.2: new high-speed USB device number 20 using dwc_otg
Feb 07 21:57:45 volumio kernel: usb 1-1.1.2: New USB device found, idVendor=0480, idProduct=0826, bcdDevice= 0.00
Feb 07 21:57:45 volumio kernel: usb 1-1.1.2: New USB device strings: Mfr=2, Product=3, SerialNumber=1
Feb 07 21:57:45 volumio kernel: usb 1-1.1.2: Product: EXTERNAL_USB
Feb 07 21:57:45 volumio kernel: usb 1-1.1.2: Manufacturer: TOSHIBA
Feb 07 21:57:45 volumio kernel: usb 1-1.1.2: SerialNumber: 20240402007495F
Feb 07 21:57:45 volumio kernel: usb-storage 1-1.1.2:1.0: USB Mass Storage device detected
Feb 07 21:57:45 volumio kernel: scsi host2: usb-storage 1-1.1.2:1.0
Feb 07 21:57:46 volumio kernel: scsi 2:0:0:0: Direct-Access TOSHIBA EXTERNAL_USB 0 PQ: 0 ANSI: 6
Feb 07 21:57:46 volumio kernel: sd 2:0:0:0: Attached scsi generic sg2 type 0
Feb 07 21:57:46 volumio kernel: sd 2:0:0:0: [sdc] Spinning up disk...
Feb 07 21:57:47 volumio kernel: usb 1-1.1.2: USB disconnect, device number 20
Feb 07 21:57:47 volumio kernel: .ready
Feb 07 21:57:47 volumio kernel: sd 2:0:0:0: [sdc] Read Capacity(10) failed: Result: hostbyte=0x07 driverbyte=DRIVER_OK
Feb 07 21:57:47 volumio kernel: sd 2:0:0:0: [sdc] Sense not available.
Feb 07 21:57:47 volumio kernel: sd 2:0:0:0: [sdc] 0 512-byte logical blocks: (0 B/0 B)
Feb 07 21:57:47 volumio kernel: sd 2:0:0:0: [sdc] 0-byte physical blocks
Feb 07 21:57:47 volumio kernel: sd 2:0:0:0: [sdc] Write Protect is off
Feb 07 21:57:47 volumio kernel: sd 2:0:0:0: [sdc] Mode Sense: 00 00 00 00
Feb 07 21:57:47 volumio kernel: sd 2:0:0:0: [sdc] Asking for cache data failed
Feb 07 21:57:47 volumio kernel: sd 2:0:0:0: [sdc] Assuming drive cache: write through
Feb 07 21:57:47 volumio kernel: sd 2:0:0:0: [sdc] Attached SCSI disk
Feb 07 21:57:48 volumio kernel: usb 1-1.1.2: new high-speed USB device number 21 using dwc_otg
Feb 07 21:57:48 volumio kernel: usb 1-1.1.2: New USB device found, idVendor=0480, idProduct=0826, bcdDevice= 0.00
Feb 07 21:57:48 volumio kernel: usb 1-1.1.2: New USB device strings: Mfr=2, Product=3, SerialNumber=1
Feb 07 21:57:48 volumio kernel: usb 1-1.1.2: Product: EXTERNAL_USB
Feb 07 21:57:48 volumio kernel: usb 1-1.1.2: Manufacturer: TOSHIBA
Feb 07 21:57:48 volumio kernel: usb 1-1.1.2: SerialNumber: 20240402007495F
Feb 07 21:57:48 volumio kernel: usb-storage 1-1.1.2:1.0: USB Mass Storage device detected
Feb 07 21:57:48 volumio kernel: scsi host2: usb-storage 1-1.1.2:1.0
Feb 07 21:57:49 volumio kernel: scsi 2:0:0:0: Direct-Access TOSHIBA EXTERNAL_USB 0 PQ: 0 ANSI: 6
Feb 07 21:57:49 volumio kernel: sd 2:0:0:0: Attached scsi generic sg2 type 0
Feb 07 21:57:49 volumio kernel: sd 2:0:0:0: [sdc] Spinning up disk...
Feb 07 21:57:50 volumio kernel: usb 1-1.1.2: USB disconnect, device number 21
Feb 07 21:57:50 volumio volumio[1181]: info: Starting UPNP Browser
Feb 07 21:57:50 volumio volumio[1181]: info: Loading plugin "alarm-clock"...
Feb 07 21:57:50 volumio kernel: .ready
Feb 07 21:57:50 volumio kernel: sd 2:0:0:0: [sdc] Read Capacity(10) failed: Result: hostbyte=0x07 driverbyte=DRIVER_OK
Feb 07 21:57:50 volumio kernel: sd 2:0:0:0: [sdc] Sense not available.
Feb 07 21:57:50 volumio kernel: sd 2:0:0:0: [sdc] 0 512-byte logical blocks: (0 B/0 B)
Feb 07 21:57:50 volumio kernel: sd 2:0:0:0: [sdc] 0-byte physical blocks
Feb 07 21:57:50 volumio kernel: sd 2:0:0:0: [sdc] Write Protect is off
Feb 07 21:57:50 volumio kernel: sd 2:0:0:0: [sdc] Mode Sense: 00 00 00 00
Feb 07 21:57:50 volumio kernel: sd 2:0:0:0: [sdc] Asking for cache data failed
Feb 07 21:57:50 volumio kernel: sd 2:0:0:0: [sdc] Assuming drive cache: write through
Feb 07 21:57:50 volumio kernel: sd 2:0:0:0: [sdc] Attached SCSI disk
Feb 07 21:57:50 volumio volumio[1181]: info: Loading plugin "airplay_emulation"...
Feb 07 21:57:50 volumio volumio[1181]: info: Starting Shairport Sync
Feb 07 21:57:50 volumio volumio[1181]: info: Loading plugin "last_100"...
Feb 07 21:57:50 volumio volumio[1181]: info: Loading plugin "webradio"...
Feb 07 21:57:51 volumio volumio[1181]: info: Loading plugin "i2s_dacs"...
Feb 07 21:57:51 volumio volumio[1181]: info: Loading plugin "volumiodiscovery"...
Feb 07 21:57:51 volumio kernel: usb 1-1.1.2: new high-speed USB device number 22 using dwc_otg
Feb 07 21:57:51 volumio volumio[1181]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Feb 07 21:57:51 volumio node[1181]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Feb 07 21:57:51 volumio volumio[1181]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 07 21:57:51 volumio node[1181]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 07 21:57:51 volumio volumio[1181]: *** WARNING *** For more information see
Feb 07 21:57:51 volumio node[1181]: *** WARNING *** For more information see
Feb 07 21:57:51 volumio volumio[1181]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Feb 07 21:57:51 volumio node[1181]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Feb 07 21:57:51 volumio volumio[1181]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 07 21:57:51 volumio node[1181]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 07 21:57:51 volumio volumio[1181]: *** WARNING *** For more information see
Feb 07 21:57:51 volumio node[1181]: *** WARNING *** For more information see
Feb 07 21:57:51 volumio volumio[1181]: info: Applying required configuration parameters for plugin volumiodiscovery
Feb 07 21:57:51 volumio volumio[1181]: info: Discovery: Started advertising with name: Volumio
Feb 07 21:57:51 volumio kernel: usb 1-1.1.2: New USB device found, idVendor=0480, idProduct=0826, bcdDevice= 0.00
Feb 07 21:57:51 volumio kernel: usb 1-1.1.2: New USB device strings: Mfr=2, Product=3, SerialNumber=1
Feb 07 21:57:51 volumio kernel: usb 1-1.1.2: Product: EXTERNAL_USB
Feb 07 21:57:51 volumio kernel: usb 1-1.1.2: Manufacturer: TOSHIBA
Feb 07 21:57:51 volumio kernel: usb 1-1.1.2: SerialNumber: 20240402007495F
Feb 07 21:57:51 volumio kernel: usb-storage 1-1.1.2:1.0: USB Mass Storage device detected
Feb 07 21:57:51 volumio kernel: scsi host2: usb-storage 1-1.1.2:1.0
Feb 07 21:57:51 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 07 21:57:51 volumio volumio[1181]: info: Loading plugin "outputs"...
Feb 07 21:57:51 volumio volumio[1181]: info: Loading plugin "albumart"...
Feb 07 21:57:51 volumio volumio[1181]: info: Plugin example_plugin is not enabled
Feb 07 21:57:51 volumio volumio[1181]: info: Loading plugin "inputs"...
Feb 07 21:57:51 volumio volumio[1181]: info: Loading plugin "updater_comm"...
Feb 07 21:57:52 volumio volumio[1181]: info: Plugin mpdemulation is not enabled
Feb 07 21:57:52 volumio volumio[1181]: info: Loading plugin "rest_api"...
Feb 07 21:57:52 volumio volumio[1181]: info: Loading plugin "websocket"...
Feb 07 21:57:52 volumio volumio[1181]: info: Starting Socket.io Server version 1.7.4
Feb 07 21:57:52 volumio volumio[1181]: info: Loading plugin "fusiondsp"...
Feb 07 21:57:52 volumio kernel: scsi 2:0:0:0: Direct-Access TOSHIBA EXTERNAL_USB 0 PQ: 0 ANSI: 6
Feb 07 21:57:52 volumio kernel: sd 2:0:0:0: Attached scsi generic sg2 type 0
Feb 07 21:57:52 volumio kernel: sd 2:0:0:0: [sdc] Spinning up disk...
Feb 07 21:57:52 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 3.
Feb 07 21:57:52 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 07 21:57:53 volumio kernel: usb 1-1.1.2: USB disconnect, device number 22
Feb 07 21:57:53 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 07 21:57:53 volumio upmpdcli[1504]: Could not open config: /tmp/upmpdcli.conf
Feb 07 21:57:53 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Feb 07 21:57:53 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Feb 07 21:57:53 volumio kernel: .ready
Feb 07 21:57:53 volumio kernel: sd 2:0:0:0: [sdc] Read Capacity(10) failed: Result: hostbyte=0x07 driverbyte=DRIVER_OK
Feb 07 21:57:53 volumio kernel: sd 2:0:0:0: [sdc] Sense not available.
Feb 07 21:57:53 volumio kernel: sd 2:0:0:0: [sdc] 0 512-byte logical blocks: (0 B/0 B)
Feb 07 21:57:53 volumio kernel: sd 2:0:0:0: [sdc] 0-byte physical blocks
Feb 07 21:57:53 volumio kernel: sd 2:0:0:0: [sdc] Write Protect is off
Feb 07 21:57:53 volumio kernel: sd 2:0:0:0: [sdc] Mode Sense: 00 00 00 00
Feb 07 21:57:53 volumio kernel: sd 2:0:0:0: [sdc] Asking for cache data failed
Feb 07 21:57:53 volumio kernel: sd 2:0:0:0: [sdc] Assuming drive cache: write through
Feb 07 21:57:53 volumio kernel: sd 2:0:0:0: [sdc] Attached SCSI disk
Feb 07 21:57:53 volumio volumio-remote-updater[719]: [2026-02-07 21:57:53] [connect] Successful connection
Feb 07 21:57:54 volumio kernel: usb 1-1.1.2: new high-speed USB device number 23 using dwc_otg
Feb 07 21:57:54 volumio kernel: usb 1-1.1.2: New USB device found, idVendor=0480, idProduct=0826, bcdDevice= 0.00
Feb 07 21:57:54 volumio kernel: usb 1-1.1.2: New USB device strings: Mfr=2, Product=3, SerialNumber=1
Feb 07 21:57:54 volumio kernel: usb 1-1.1.2: Product: EXTERNAL_USB
Feb 07 21:57:54 volumio kernel: usb 1-1.1.2: Manufacturer: TOSHIBA
Feb 07 21:57:54 volumio kernel: usb 1-1.1.2: SerialNumber: 20240402007495F
Feb 07 21:57:54 volumio kernel: usb-storage 1-1.1.2:1.0: USB Mass Storage device detected
Feb 07 21:57:54 volumio kernel: scsi host2: usb-storage 1-1.1.2:1.0
Feb 07 21:57:54 volumio volumio[1181]: info: Applying required configuration parameters for plugin fusiondsp
Feb 07 21:57:54 volumio volumio[1494]: Forking 3 albumart workers
Feb 07 21:57:55 volumio kernel: scsi 2:0:0:0: Direct-Access TOSHIBA EXTERNAL_USB 0 PQ: 0 ANSI: 6
Feb 07 21:57:55 volumio kernel: sd 2:0:0:0: Attached scsi generic sg2 type 0
Feb 07 21:57:55 volumio kernel: sd 2:0:0:0: [sdc] Spinning up disk...
Feb 07 21:57:56 volumio volumio[1181]: info: Loading i18n strings for locale en
Feb 07 21:57:56 volumio volumio[1181]: Updating browse sources language
Feb 07 21:57:56 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 07 21:57:57 volumio kernel: ..ready
Feb 07 21:57:57 volumio kernel: sd 2:0:0:0: [sdc] Very big device. Trying to use READ CAPACITY(16).
Feb 07 21:57:57 volumio kernel: sd 2:0:0:0: [sdc] 7814037168 512-byte logical blocks: (4.00 TB/3.64 TiB)
Feb 07 21:57:57 volumio kernel: sd 2:0:0:0: [sdc] 4096-byte physical blocks
Feb 07 21:57:57 volumio kernel: sd 2:0:0:0: [sdc] Write Protect is off
Feb 07 21:57:57 volumio kernel: sd 2:0:0:0: [sdc] Mode Sense: 43 00 00 00
Feb 07 21:57:57 volumio kernel: sd 2:0:0:0: [sdc] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Feb 07 21:57:57 volumio kernel: Alternate GPT is invalid, using primary GPT.
Feb 07 21:57:57 volumio kernel: sdc: sdc1 sdc2
Feb 07 21:57:57 volumio kernel: sd 2:0:0:0: [sdc] Attached SCSI disk
Feb 07 21:57:59 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 07 21:57:59 volumio volumio[1181]: info: CoreCommandRouter::initPlayerControls
Feb 07 21:57:59 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:57:59 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:57:59 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:57:59 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:57:59 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:57:59 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:57:59 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:57:59 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:57:59 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 07 21:57:59 volumio volumio[1181]: Express server listening on port 3000
Feb 07 21:57:59 volumio volumio[1181]: [Metrics] WebUI: 29s 397.33ms
Feb 07 21:58:00 volumio volumio[1181]: info: CoreStateMachine::resetVolumioState
Feb 07 21:58:00 volumio volumio[1181]: info: CoreStateMachine::getcurrentVolume
Feb 07 21:58:00 volumio volumio[1181]: info: CoreCommandRouter::volumioRetrievevolume
Feb 07 21:58:01 volumio sudo[1561]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 07 21:58:01 volumio sudo[1561]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 07 21:58:01 volumio sudo[1561]: pam_unix(sudo:session): session closed for user root
Feb 07 21:58:01 volumio sudo[1563]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 07 21:58:01 volumio sudo[1563]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 07 21:58:01 volumio sudo[1563]: pam_unix(sudo:session): session closed for user root
Feb 07 21:58:01 volumio volumio[1181]: info: Volumio Network Manager: Network status updated: 2
Feb 07 21:58:01 volumio volumio[1181]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.2/1-1.1.2:1.0/host2/target2:0:0/2:0:0:0/block/sdc/sdc1","ACTION":"remove","CURRENT_TAGS":":systemd:","DEVLINKS":"/dev/disk/by-id/usb-TOSHIBA_EXTERNAL_USB_20240402007495F-0:0-part1 /dev/disk/by-partlabel/Microsoft\\x20reserved\\x20partition /dev/disk/by-path/platform-3f980000.usb-usb-0:1.1.2:1.0-scsi-0:0:0:0-part1 /dev/disk/by-id/ata-TOSHIBA_MQ04UBB400_442DT0QGT-part1 /dev/disk/by-partuuid/7c60458e-18dd-4600-be0a-e224204e9054","DEVNAME":"/dev/sdc1","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.2/1-1.1.2:1.0/host2/target2:0:0/2:0:0:0/block/sdc/sdc1","DEVTYPE":"partition","DISKSEQ":"35","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_APM":"1","ID_ATA_FEATURE_SET_APM_CURRENT_VALUE":"128","ID_ATA_FEATURE_SET_APM_ENABLED":"1","ID_ATA_FEATURE_SET_HPA":"1","ID_ATA_FEATURE_SET_HPA_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN":"66342","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"66342","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_ROTATION_RATE_RPM":"5400","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_SATA_SIGNAL_RATE_GEN2":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_MODEL":"TOSHIBA_MQ04UBB400","ID_MODEL_ENC":"TOSHIBA\\x20MQ04UBB400\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:32","ID_PART_ENTRY_NAME":"Microsoft\\x20reserved\\x20partition","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"34","ID_PART_ENTRY_SCHEME":"gpt","ID_PART_ENTRY_SIZE":"262144","ID_PART_ENTRY_TYPE":"e3c9e316-0b5c-4db8-817d-f92df00215ae","ID_PART_ENTRY_UUID":"7c60458e-18dd-4600-be0a-e224204e9054","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"0491e096-24a4-4db4-9f26-790daadccf08","ID_PATH":"platform-3f980000.usb-usb-0:1.1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"JS0B0U","ID_SERIAL":"TOSHIBA_MQ04UBB400_442DT0QGT","ID_SERIAL_SHORT":"442DT0QGT","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INSTANCE":"0:0","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_USB_MODEL":"EXTERNAL_USB","ID_USB_MODEL_ENC":"EXTERNAL_USB\\x20\\x20\\x20\\x20","ID_USB_MODEL_ID":"0826","ID_USB_REVISION":"0","ID_USB_SERIAL":"TOSHIBA_EXTERNAL_USB_20240402007495F-0:0","ID_USB_SERIAL_SHORT":"20240402007495F","ID_USB_TYPE":"disk","ID_USB_VENDOR":"TOSHIBA","ID_USB_VENDOR_ENC":"TOSHIBA\\x20","ID_USB_VENDOR_ID":"0480","MAJOR":"8","MINOR":"33","PARTN":"1","PARTNAME":"Microsoft reserved partition","SEQNUM":"2401","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"41313158"}
Feb 07 21:58:01 volumio volumio[1181]: error: Cannot associate FS Label, not mounting
Feb 07 21:58:01 volumio volumio[1181]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number '5'.
Feb 07 21:58:02 volumio volumio[1181]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.2/1-1.1.2:1.0/host2/target2:0:0/2:0:0:0/block/sdc/sdc2","ACTION":"remove","CURRENT_TAGS":":systemd:","DEVLINKS":"/dev/disk/by-uuid/A66639BC66398DD5 /dev/disk/by-path/platform-3f980000.usb-usb-0:1.1.2:1.0-scsi-0:0:0:0-part2 /dev/disk/by-partlabel/Basic\\x20data\\x20partition /dev/disk/by-label/TOSHIBA\\x20EXT /dev/disk/by-id/usb-TOSHIBA_EXTERNAL_USB_20240402007495F-0:0-part2 /dev/disk/by-id/ata-TOSHIBA_MQ04UBB400_442DT0QGT-part2 /dev/disk/by-partuuid/7c60458f-18dd-4600-be0a-e224204e9054","DEVNAME":"/dev/sdc2","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.2/1-1.1.2:1.0/host2/target2:0:0/2:0:0:0/block/sdc/sdc2","DEVTYPE":"partition","DISKSEQ":"35","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_APM":"1","ID_ATA_FEATURE_SET_APM_CURRENT_VALUE":"128","ID_ATA_FEATURE_SET_APM_ENABLED":"1","ID_ATA_FEATURE_SET_HPA":"1","ID_ATA_FEATURE_SET_HPA_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN":"66342","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"66342","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_ROTATION_RATE_RPM":"5400","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_SATA_SIGNAL_RATE_GEN2":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_FS_LABEL":"TOSHIBA_EXT","ID_FS_LABEL_ENC":"TOSHIBA\\x20EXT","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"A66639BC66398DD5","ID_FS_UUID_ENC":"A66639BC66398DD5","ID_MODEL":"TOSHIBA_MQ04UBB400","ID_MODEL_ENC":"TOSHIBA\\x20MQ04UBB400\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:32","ID_PART_ENTRY_NAME":"Basic\\x20data\\x20partition","ID_PART_ENTRY_NUMBER":"2","ID_PART_ENTRY_OFFSET":"264192","ID_PART_ENTRY_SCHEME":"gpt","ID_PART_ENTRY_SIZE":"7813771264","ID_PART_ENTRY_TYPE":"ebd0a0a2-b9e5-4433-87c0-68b6b72699c7","ID_PART_ENTRY_UUID":"7c60458f-18dd-4600-be0a-e224204e9054","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"0491e096-24a4-4db4-9f26-790daadccf08","ID_PATH":"platform-3f980000.usb-usb-0:1.1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"JS0B0U","ID_SERIAL":"TOSHIBA_MQ04UBB400_442DT0QGT","ID_SERIAL_SHORT":"442DT0QGT","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INSTANCE":"0:0","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_USB_MODEL":"EXTERNAL_USB","ID_USB_MODEL_ENC":"EXTERNAL_USB\\x20\\x20\\x20\\x20","ID_USB_MODEL_ID":"0826","ID_USB_REVISION":"0","ID_USB_SERIAL":"TOSHIBA_EXTERNAL_USB_20240402007495F-0:0","ID_USB_SERIAL_SHORT":"20240402007495F","ID_USB_TYPE":"disk","ID_USB_VENDOR":"TOSHIBA","ID_USB_VENDOR_ENC":"TOSHIBA\\x20","ID_USB_VENDOR_ID":"0480","MAJOR":"8","MINOR":"34","PARTN":"2","PARTNAME":"Basic data partition","SEQNUM":"2402","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"41267599"}
Feb 07 21:58:02 volumio sudo[1571]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sdc2
Feb 07 21:58:02 volumio sudo[1571]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 07 21:58:02 volumio sudo[1571]: pam_unix(sudo:session): session closed for user root
Feb 07 21:58:02 volumio volumio[1181]: umount: /dev/sdc2: not mounted.
Feb 07 21:58:02 volumio volumio[1181]: error: Failed to umount TOSHIBA_EXT: Error: Command failed: /usr/bin/sudo /bin/umount -f "/dev/sdc2"
Feb 07 21:58:02 volumio volumio[1181]: umount: /dev/sdc2: not mounted.
Feb 07 21:58:03 volumio volumio[1181]: info: VolumeController:: Volume=undefined Mute =false
Feb 07 21:58:03 volumio volumio[1181]: info: CoreStateMachine::pushState
Feb 07 21:58:03 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:03 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 07 21:58:03 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState
Feb 07 21:58:03 volumio volumio[1181]: info: CoreStateMachine::updateTrackBlock
Feb 07 21:58:03 volumio volumio[1181]: info: CorePlayQueue::getTrackBlock
Feb 07 21:58:03 volumio volumio[1181]: info: CoreCommandRouter::volumioRetrievevolume
Feb 07 21:58:03 volumio kernel: hwmon hwmon1: Voltage normalised
Feb 07 21:58:03 volumio volumio[1181]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number '5'.
Feb 07 21:58:03 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 07 21:58:03 volumio volumio[1181]: info: Executing start script for DAC IQaudIO DAC Plus
Feb 07 21:58:03 volumio volumio[1181]: info: Reloading queue from file
Feb 07 21:58:03 volumio volumio[1181]: info: VolumeController:: Volume=undefined Mute =false
Feb 07 21:58:03 volumio volumio[1181]: info: CoreStateMachine::pushState
Feb 07 21:58:03 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:03 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 07 21:58:03 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState
Feb 07 21:58:03 volumio volumio[1181]: info: Setting Device type: Raspberry PI
Feb 07 21:58:03 volumio volumio[1181]: info: CoreStateMachine::setRepeat null single undefined
Feb 07 21:58:03 volumio volumio[1181]: info: CoreStateMachine::pushState
Feb 07 21:58:03 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:03 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState
Feb 07 21:58:03 volumio volumio[1181]: info: CoreStateMachine::setRandom null
Feb 07 21:58:03 volumio volumio[1181]: info: CoreStateMachine::pushState
Feb 07 21:58:03 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:03 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState
Feb 07 21:58:04 volumio volumio[1181]: info: DAC script executed
Feb 07 21:58:04 volumio sudo[1589]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Feb 07 21:58:04 volumio sudo[1589]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 07 21:58:04 volumio volumio[1181]: info: Discovery: adding 452b6718-e804-459b-aa68-10426a1bf173
Feb 07 21:58:04 volumio volumio[1181]: info: Discovery: Found device Volumio
Feb 07 21:58:04 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState
Feb 07 21:58:04 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:04 volumio volumio[1181]: info: Discovery: this is already registered, 452b6718-e804-459b-aa68-10426a1bf173
Feb 07 21:58:04 volumio volumio[1181]: info: Discovery: Found device Volumio
Feb 07 21:58:04 volumio volumio[1181]: info: CoreCommandRouter::volumioGetState
Feb 07 21:58:04 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:04 volumio volumio[1181]: info: Mounting Device TOSHIBA_EXT
Feb 07 21:58:04 volumio sudo[1597]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdc2 /mnt/USB/TOSHIBA_EXT -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Feb 07 21:58:04 volumio sudo[1597]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 07 21:58:05 volumio kernel: hwmon hwmon1: Undervoltage detected!
Feb 07 21:58:05 volumio kernel: sd 2:0:0:0: [sdc] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=0s
Feb 07 21:58:05 volumio kernel: sd 2:0:0:0: [sdc] tag#0 CDB: opcode=0x88 88 00 00 00 00 00 00 5e 66 78 00 00 00 08 00 00
Feb 07 21:58:05 volumio kernel: I/O error, dev sdc, sector 6186616 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2
Feb 07 21:58:05 volumio kernel: usb 1-1.1.2: USB disconnect, device number 23
Feb 07 21:58:05 volumio kernel: buffer_io_error: 6 callbacks suppressed
Feb 07 21:58:05 volumio kernel: Buffer I/O error on dev sdc2, logical block 5922424, async page read
Feb 07 21:58:05 volumio kernel: Buffer I/O error on dev sdc2, logical block 5922425, async page read
Feb 07 21:58:05 volumio kernel: Buffer I/O error on dev sdc2, logical block 5922426, async page read
Feb 07 21:58:05 volumio kernel: Buffer I/O error on dev sdc2, logical block 5922427, async page read
Feb 07 21:58:05 volumio kernel: Buffer I/O error on dev sdc2, logical block 5922428, async page read
Feb 07 21:58:05 volumio kernel: Buffer I/O error on dev sdc2, logical block 5922429, async page read
Feb 07 21:58:05 volumio kernel: Buffer I/O error on dev sdc2, logical block 5922430, async page read
Feb 07 21:58:05 volumio kernel: Buffer I/O error on dev sdc2, logical block 5922431, async page read
Feb 07 21:58:05 volumio volumio[1181]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error
Feb 07 21:58:05 volumio volumio[1181]: Failed to read $AttrDef, unexpected length (-1 != 2560).
Feb 07 21:58:05 volumio volumio[1181]: Failed to sync device /dev/sdc2: Input/output error
Feb 07 21:58:05 volumio volumio[1181]: Failed to mount '/dev/sdc2': Input/output error
Feb 07 21:58:05 volumio volumio[1181]: NTFS is either inconsistent, or there is a hardware fault, or it's a
Feb 07 21:58:05 volumio volumio[1181]: SoftRAID/FakeRAID hardware. In the first case run chkdsk /f on Windows
Feb 07 21:58:05 volumio volumio[1181]: then reboot into Windows twice. The usage of the /f parameter is very
Feb 07 21:58:05 volumio volumio[1181]: important! If the device is a SoftRAID/FakeRAID then first activate
Feb 07 21:58:05 volumio volumio[1181]: it and mount a different device under the /dev/mapper/ directory, (e.g.
Feb 07 21:58:05 volumio volumio[1181]: /dev/mapper/nvidia_eahaabcc1). Please see the 'dmraid' documentation
Feb 07 21:58:05 volumio volumio[1181]: for more details.
Feb 07 21:58:05 volumio sudo[1597]: pam_unix(sudo:session): session closed for user root
Feb 07 21:58:05 volumio volumio[1181]: error: Failed to mount TOSHIBA_EXT: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sdc2" "/mnt/USB/TOSHIBA_EXT" -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Feb 07 21:58:05 volumio volumio[1181]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error
Feb 07 21:58:05 volumio volumio[1181]: Failed to read $AttrDef, unexpected length (-1 != 2560).
Feb 07 21:58:05 volumio volumio[1181]: Failed to sync device /dev/sdc2: Input/output error
Feb 07 21:58:05 volumio volumio[1181]: Failed to mount '/dev/sdc2': Input/output error
Feb 07 21:58:05 volumio volumio[1181]: NTFS is either inconsistent, or there is a hardware fault, or it's a
Feb 07 21:58:05 volumio volumio[1181]: SoftRAID/FakeRAID hardware. In the first case run chkdsk /f on Windows
Feb 07 21:58:05 volumio volumio[1181]: then reboot into Windows twice. The usage of the /f parameter is very
Feb 07 21:58:05 volumio volumio[1181]: important! If the device is a SoftRAID/FakeRAID then first activate
Feb 07 21:58:05 volumio volumio[1181]: it and mount a different device under the /dev/mapper/ directory, (e.g.
Feb 07 21:58:05 volumio volumio[1181]: /dev/mapper/nvidia_eahaabcc1). Please see the 'dmraid' documentation
Feb 07 21:58:05 volumio volumio[1181]: for more details.
Feb 07 21:58:05 volumio volumio[1181]: error: Cannot associate FS Label, not mounting
Feb 07 21:58:05 volumio volumio[1181]: info: Completed loading Core Plugins
Feb 07 21:58:05 volumio volumio[1181]: info: Preparing to generate the ALSA configuration file
Feb 07 21:58:05 volumio kernel: sd 2:0:0:0: [sdc] Synchronizing SCSI cache
Feb 07 21:58:05 volumio kernel: sd 2:0:0:0: [sdc] Synchronize Cache(10) failed: Result: hostbyte=0x01 driverbyte=DRIVER_OK
Feb 07 21:58:06 volumio kernel: usb 1-1.1.2: new high-speed USB device number 24 using dwc_otg
Feb 07 21:58:06 volumio volumio[1181]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.2/1-1.1.2:1.0/host2/target2:0:0/2:0:0:0/block/sdc/sdc1","ACTION":"remove","CURRENT_TAGS":":systemd:","DEVLINKS":"/dev/disk/by-id/usb-TOSHIBA_EXTERNAL_USB_20240402007495F-0:0-part1 /dev/disk/by-partlabel/Microsoft\\x20reserved\\x20partition /dev/disk/by-path/platform-3f980000.usb-usb-0:1.1.2:1.0-scsi-0:0:0:0-part1 /dev/disk/by-id/ata-TOSHIBA_MQ04UBB400_442DT0QGT-part1 /dev/disk/by-partuuid/7c60458e-18dd-4600-be0a-e224204e9054","DEVNAME":"/dev/sdc1","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.2/1-1.1.2:1.0/host2/target2:0:0/2:0:0:0/block/sdc/sdc1","DEVTYPE":"partition","DISKSEQ":"39","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_APM":"1","ID_ATA_FEATURE_SET_APM_CURRENT_VALUE":"128","ID_ATA_FEATURE_SET_APM_ENABLED":"1","ID_ATA_FEATURE_SET_HPA":"1","ID_ATA_FEATURE_SET_HPA_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN":"66342","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"66342","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_ROTATION_RATE_RPM":"5400","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_SATA_SIGNAL_RATE_GEN2":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_MODEL":"TOSHIBA_MQ04UBB400","ID_MODEL_ENC":"TOSHIBA\\x20MQ04UBB400\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:32","ID_PART_ENTRY_NAME":"Microsoft\\x20reserved\\x20partition","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"34","ID_PART_ENTRY_SCHEME":"gpt","ID_PART_ENTRY_SIZE":"262144","ID_PART_ENTRY_TYPE":"e3c9e316-0b5c-4db8-817d-f92df00215ae","ID_PART_ENTRY_UUID":"7c60458e-18dd-4600-be0a-e224204e9054","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"0491e096-24a4-4db4-9f26-790daadccf08","ID_PATH":"platform-3f980000.usb-usb-0:1.1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"JS0B0U","ID_SERIAL":"TOSHIBA_MQ04UBB400_442DT0QGT","ID_SERIAL_SHORT":"442DT0QGT","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INSTANCE":"0:0","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_USB_MODEL":"EXTERNAL_USB","ID_USB_MODEL_ENC":"EXTERNAL_USB\\x20\\x20\\x20\\x20","ID_USB_MODEL_ID":"0826","ID_USB_REVISION":"0","ID_USB_SERIAL":"TOSHIBA_EXTERNAL_USB_20240402007495F-0:0","ID_USB_SERIAL_SHORT":"20240402007495F","ID_USB_TYPE":"disk","ID_USB_VENDOR":"TOSHIBA","ID_USB_VENDOR_ENC":"TOSHIBA\\x20","ID_USB_VENDOR_ID":"0480","MAJOR":"8","MINOR":"33","PARTN":"1","PARTNAME":"Microsoft reserved partition","SEQNUM":"2566","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"83300386"}
Feb 07 21:58:06 volumio volumio[1181]: error: Cannot associate FS Label, not mounting
Feb 07 21:58:06 volumio kernel: usb 1-1.1.2: New USB device found, idVendor=0480, idProduct=0826, bcdDevice= 0.00
Feb 07 21:58:06 volumio kernel: usb 1-1.1.2: New USB device strings: Mfr=2, Product=3, SerialNumber=1
Feb 07 21:58:06 volumio kernel: usb 1-1.1.2: Product: EXTERNAL_USB
Feb 07 21:58:06 volumio kernel: usb 1-1.1.2: Manufacturer: TOSHIBA
Feb 07 21:58:06 volumio kernel: usb 1-1.1.2: SerialNumber: 20240402007495F
Feb 07 21:58:06 volumio kernel: usb-storage 1-1.1.2:1.0: USB Mass Storage device detected
Feb 07 21:58:06 volumio kernel: scsi host2: usb-storage 1-1.1.2:1.0
Feb 07 21:58:06 volumio volumio[1181]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Feb 07 21:58:06 volumio volumio[1181]: info: Reading ALSA contributions from plugins.
Feb 07 21:58:06 volumio volumio[1181]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.2/1-1.1.2:1.0/host2/target2:0:0/2:0:0:0/block/sdc/sdc2","ACTION":"remove","CURRENT_TAGS":":systemd:","DEVLINKS":"/dev/disk/by-uuid/A66639BC66398DD5 /dev/disk/by-path/platform-3f980000.usb-usb-0:1.1.2:1.0-scsi-0:0:0:0-part2 /dev/disk/by-partlabel/Basic\\x20data\\x20partition /dev/disk/by-label/TOSHIBA\\x20EXT /dev/disk/by-id/usb-TOSHIBA_EXTERNAL_USB_20240402007495F-0:0-part2 /dev/disk/by-id/ata-TOSHIBA_MQ04UBB400_442DT0QGT-part2 /dev/disk/by-partuuid/7c60458f-18dd-4600-be0a-e224204e9054","DEVNAME":"/dev/sdc2","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.2/1-1.1.2:1.0/host2/target2:0:0/2:0:0:0/block/sdc/sdc2","DEVTYPE":"partition","DISKSEQ":"39","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_APM":"1","ID_ATA_FEATURE_SET_APM_CURRENT_VALUE":"128","ID_ATA_FEATURE_SET_APM_ENABLED":"1","ID_ATA_FEATURE_SET_HPA":"1","ID_ATA_FEATURE_SET_HPA_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN":"66342","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"66342","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_ROTATION_RATE_RPM":"5400","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_SATA_SIGNAL_RATE_GEN2":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_FS_LABEL":"TOSHIBA_EXT","ID_FS_LABEL_ENC":"TOSHIBA\\x20EXT","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"A66639BC66398DD5","ID_FS_UUID_ENC":"A66639BC66398DD5","ID_MODEL":"TOSHIBA_MQ04UBB400","ID_MODEL_ENC":"TOSHIBA\\x20MQ04UBB400\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:32","ID_PART_ENTRY_NAME":"Basic\\x20data\\x20partition","ID_PART_ENTRY_NUMBER":"2","ID_PART_ENTRY_OFFSET":"264192","ID_PART_ENTRY_SCHEME":"gpt","ID_PART_ENTRY_SIZE":"7813771264","ID_PART_ENTRY_TYPE":"ebd0a0a2-b9e5-4433-87c0-68b6b72699c7","ID_PART_ENTRY_UUID":"7c60458f-18dd-4600-be0a-e224204e9054","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"0491e096-24a4-4db4-9f26-790daadccf08","ID_PATH":"platform-3f980000.usb-usb-0:1.1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"JS0B0U","ID_SERIAL":"TOSHIBA_MQ04UBB400_442DT0QGT","ID_SERIAL_SHORT":"442DT0QGT","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INSTANCE":"0:0","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_USB_MODEL":"EXTERNAL_USB","ID_USB_MODEL_ENC":"EXTERNAL_USB\\x20\\x20\\x20\\x20","ID_USB_MODEL_ID":"0826","ID_USB_REVISION":"0","ID_USB_SERIAL":"TOSHIBA_EXTERNAL_USB_20240402007495F-0:0","ID_USB_SERIAL_SHORT":"20240402007495F","ID_USB_TYPE":"disk","ID_USB_VENDOR":"TOSHIBA","ID_USB_VENDOR_ENC":"TOSHIBA\\x20","ID_USB_VENDOR_ID":"0480","MAJOR":"8","MINOR":"34","PARTN":"2","PARTNAME":"Basic data partition","SEQNUM":"2567","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"83254050"}
Feb 07 21:58:06 volumio sudo[1612]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sdc2
Feb 07 21:58:06 volumio sudo[1612]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 07 21:58:06 volumio sudo[1612]: pam_unix(sudo:session): session closed for user root
Feb 07 21:58:06 volumio volumio[1181]: umount: /dev/sdc2: no mount point specified.
Feb 07 21:58:06 volumio volumio[1181]: error: Failed to umount TOSHIBA_EXT: Error: Command failed: /usr/bin/sudo /bin/umount -f "/dev/sdc2"
Feb 07 21:58:06 volumio volumio[1181]: umount: /dev/sdc2: no mount point specified.
Feb 07 21:58:07 volumio volumio[1181]: info: Asound.conf file unchanged, so no further update is needed
Feb 07 21:58:07 volumio volumio[1181]: info: Output device has changed, restarting MPD
Feb 07 21:58:07 volumio kernel: scsi 2:0:0:0: Direct-Access TOSHIBA EXTERNAL_USB 0 PQ: 0 ANSI: 6
Feb 07 21:58:07 volumio kernel: sd 2:0:0:0: Attached scsi generic sg2 type 0
Feb 07 21:58:07 volumio kernel: sd 2:0:0:0: [sdc] Spinning up disk...
Feb 07 21:58:07 volumio volumio[1181]: info: Output device has changed, restarting Shairport Sync
Feb 07 21:58:07 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:58:07 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 07 21:58:07 volumio sudo[1616]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 07 21:58:07 volumio sudo[1616]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 07 21:58:07 volumio sudo[1616]: pam_unix(sudo:session): session closed for user root
Feb 07 21:58:07 volumio sudo[1618]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 07 21:58:07 volumio sudo[1618]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 07 21:58:07 volumio volumio[1181]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 07 21:58:07 volumio volumio[1181]: info: ___________ START PLUGINS ___________
Feb 07 21:58:08 volumio volumio[1181]: info: ControllerMpd::onStart: Initializing MPD
Feb 07 21:58:08 volumio volumio[1181]: info: Creating MPD Configuration file
Feb 07 21:58:08 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 4.
Feb 07 21:58:08 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 07 21:58:08 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 07 21:58:08 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 07 21:58:08 volumio volumio[1181]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 07 21:58:08 volumio volumio[1181]: info: [1770481688361] CoreMusicLibrary::Adding element Media Servers
Feb 07 21:58:08 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 07 21:58:08 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Feb 07 21:58:08 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
Feb 07 21:58:08 volumio sudo[1589]: pam_unix(sudo:session): session closed for user root
Feb 07 21:58:08 volumio sudo[1626]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 07 21:58:08 volumio sudo[1626]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 07 21:58:08 volumio sudo[1626]: pam_unix(sudo:session): session closed for user root
Feb 07 21:58:08 volumio volumio[1181]: info: UPNP Browser: Client initialized successfully
Feb 07 21:58:08 volumio sudo[1630]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 07 21:58:08 volumio sudo[1630]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 07 21:58:08 volumio volumio-remote-updater[719]: [2026-02-07 21:58:08] [connect] Successful connection
Feb 07 21:58:08 volumio sudo[1631]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 07 21:58:08 volumio sudo[1631]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 07 21:58:08 volumio sudo[1644]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
Feb 07 21:58:08 volumio sudo[1631]: pam_unix(sudo:session): session closed for user root
Feb 07 21:58:08 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:58:08 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 07 21:58:09 volumio systemd[1]: mpd.service: Deactivated successfully.
Feb 07 21:58:09 volumio systemd[1]: Stopped mpd.service - Music Player Daemon.
Feb 07 21:58:09 volumio systemd[1]: mpd.socket: Deactivated successfully.
Feb 07 21:58:09 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Feb 07 21:58:09 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Feb 07 21:58:09 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Feb 07 21:58:09 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
Feb 07 21:58:09 volumio volumio[1181]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 07 21:58:09 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:58:09 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 07 21:58:09 volumio kernel: ..ready
Feb 07 21:58:09 volumio kernel: sd 2:0:0:0: [sdc] Very big device. Trying to use READ CAPACITY(16).
Feb 07 21:58:09 volumio kernel: sd 2:0:0:0: [sdc] 7814037168 512-byte logical blocks: (4.00 TB/3.64 TiB)
Feb 07 21:58:09 volumio kernel: sd 2:0:0:0: [sdc] 4096-byte physical blocks
Feb 07 21:58:09 volumio kernel: sd 2:0:0:0: [sdc] Write Protect is off
Feb 07 21:58:09 volumio kernel: sd 2:0:0:0: [sdc] Mode Sense: 43 00 00 00
Feb 07 21:58:09 volumio kernel: sd 2:0:0:0: [sdc] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Feb 07 21:58:09 volumio sudo[1651]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 07 21:58:09 volumio sudo[1651]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 07 21:58:09 volumio sudo[1657]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
Feb 07 21:58:09 volumio sudo[1651]: pam_unix(sudo:session): session closed for user root
Feb 07 21:58:09 volumio kernel: Alternate GPT is invalid, using primary GPT.
Feb 07 21:58:09 volumio kernel: sdc: sdc1 sdc2
Feb 07 21:58:09 volumio kernel: sd 2:0:0:0: [sdc] Attached SCSI disk
Feb 07 21:58:09 volumio volumio[1181]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 07 21:58:09 volumio volumio[1181]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 07 21:58:09 volumio volumio[1181]: info: [1770481689811] CoreMusicLibrary::Adding element Last_100
Feb 07 21:58:09 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 07 21:58:09 volumio volumio[1181]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 07 21:58:09 volumio volumio[1181]: info: [1770481689953] CoreMusicLibrary::Adding element Webradio
Feb 07 21:58:10 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 07 21:58:10 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 07 21:58:10 volumio volumio[1512]: Starting albumart workers
Feb 07 21:58:10 volumio volumio[1181]: info: Initializing BBC Radios
Feb 07 21:58:11 volumio volumio[1510]: Starting albumart workers
Feb 07 21:58:11 volumio volumio[1511]: Starting albumart workers
Feb 07 21:58:11 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 07 21:58:11 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 07 21:58:12 volumio volumio[1181]: info: FusionDsp - CamillaDSP binary found.
Feb 07 21:58:12 volumio volumio[1181]: info: Loading i18n strings for locale en
Feb 07 21:58:12 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Feb 07 21:58:12 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:58:12 volumio volumio[1181]: info: FusionDsp - mixtype--------------------- undefined
Feb 07 21:58:12 volumio volumio[1181]: info: Volumio Calling Home
Feb 07 21:58:13 volumio volumio[1181]: info: Preparing to generate the ALSA configuration file
Feb 07 21:58:13 volumio kernel: hwmon hwmon1: Voltage normalised
Feb 07 21:58:17 volumio mpd[1658]: 2026-02-07T21:58:17 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Feb 07 21:58:17 volumio systemd[1]: Started mpd.service - Music Player Daemon.
Feb 07 21:58:17 volumio sudo[1630]: pam_unix(sudo:session): session closed for user root
Feb 07 21:58:17 volumio sudo[1618]: pam_unix(sudo:session): session closed for user root
Feb 07 21:58:18 volumio volumio[1181]: info: camilladsp service started and running in background, instance 1
Feb 07 21:58:18 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:58:18 volumio volumio[1181]: ALSA lib confmisc.c:165:(snd_config_get_card) Cannot get card index for Audio
Feb 07 21:58:18 volumio volumio[1181]: cannot open device 'volumioHw': No such device
Feb 07 21:58:18 volumio volumio[1181]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
Feb 07 21:58:18 volumio volumio[1181]: ALSA lib confmisc.c:165:(snd_config_get_card) Cannot get card index for Audio
Feb 07 21:58:18 volumio volumio[1181]: cannot open device 'volumioHw': No such device
Feb 07 21:58:18 volumio volumio[1181]: info: FusionDsp loaded
Feb 07 21:58:18 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 07 21:58:18 volumio volumio[1181]: error: FusionDsp - Socket connection not established
Feb 07 21:58:18 volumio volumio[1181]: info: FusionDsp - Reporting Fusion DSP Enabled
Feb 07 21:58:18 volumio volumio[1181]: info: Adding Signal Path Element [object Object]
Feb 07 21:58:18 volumio volumio[1181]: info: Adding fusiondspeq DSP Signal Path Element
Feb 07 21:58:18 volumio volumio[1181]: info: FusionDsp - ---- installed callbackRead
Feb 07 21:58:18 volumio volumio[1181]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Feb 07 21:58:18 volumio sudo[1723]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Feb 07 21:58:18 volumio sudo[1723]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 07 21:58:18 volumio volumio[1181]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Feb 07 21:58:18 volumio volumio[1181]: info: Reading ALSA contributions from plugins.
Feb 07 21:58:18 volumio volumio[1181]: info: Completed starting Core Plugins
Feb 07 21:58:18 volumio volumio[1181]: info: -------------------------------------------
Feb 07 21:58:18 volumio volumio[1181]: info: ----- MyVolumio plugins startup ----
Feb 07 21:58:18 volumio volumio[1181]: info: -------------------------------------------
Feb 07 21:58:18 volumio volumio[1181]: info: [MyVolumio PluginManager] Fetching plans data....
Feb 07 21:58:18 volumio volumio[1181]: info: MPD Permissions set
Feb 07 21:58:18 volumio volumio[1181]: info: MPD Permissions set
Feb 07 21:58:18 volumio volumio[1181]: info: Upmpdcli Daemon Started
Feb 07 21:58:18 volumio systemd[1]: Started fusiondsp.service - FusionDsp Daemon.
Feb 07 21:58:18 volumio sudo[1723]: pam_unix(sudo:session): session closed for user root
Feb 07 21:58:18 volumio volumio[1181]: info: Mounting Device TOSHIBA_EXT
Feb 07 21:58:18 volumio sudo[1737]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdc2 /mnt/USB/TOSHIBA_EXT -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Feb 07 21:58:18 volumio sudo[1737]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 07 21:58:19 volumio kernel: sd 2:0:0:0: [sdc] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=0s
Feb 07 21:58:19 volumio kernel: sd 2:0:0:0: [sdc] tag#0 CDB: opcode=0x88 88 00 00 00 00 00 00 5e 66 78 00 00 00 08 00 00
Feb 07 21:58:19 volumio kernel: I/O error, dev sdc, sector 6186616 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2
Feb 07 21:58:19 volumio kernel: usb 1-1.1.2: USB disconnect, device number 24
Feb 07 21:58:19 volumio kernel: device offline error, dev sdc, sector 6186616 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2
Feb 07 21:58:19 volumio kernel: Buffer I/O error on dev sdc2, logical block 5922424, async page read
Feb 07 21:58:19 volumio kernel: device offline error, dev sdc, sector 6186617 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2
Feb 07 21:58:19 volumio kernel: Buffer I/O error on dev sdc2, logical block 5922425, async page read
Feb 07 21:58:19 volumio kernel: device offline error, dev sdc, sector 6186618 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2
Feb 07 21:58:19 volumio kernel: Buffer I/O error on dev sdc2, logical block 5922426, async page read
Feb 07 21:58:19 volumio kernel: device offline error, dev sdc, sector 6186619 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2
Feb 07 21:58:19 volumio kernel: Buffer I/O error on dev sdc2, logical block 5922427, async page read
Feb 07 21:58:19 volumio kernel: device offline error, dev sdc, sector 6186620 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2
Feb 07 21:58:19 volumio kernel: Buffer I/O error on dev sdc2, logical block 5922428, async page read
Feb 07 21:58:19 volumio kernel: device offline error, dev sdc, sector 6186621 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2
Feb 07 21:58:19 volumio kernel: Buffer I/O error on dev sdc2, logical block 5922429, async page read
Feb 07 21:58:19 volumio kernel: device offline error, dev sdc, sector 6186622 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2
Feb 07 21:58:19 volumio kernel: Buffer I/O error on dev sdc2, logical block 5922430, async page read
Feb 07 21:58:19 volumio kernel: device offline error, dev sdc, sector 6186623 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2
Feb 07 21:58:19 volumio kernel: Buffer I/O error on dev sdc2, logical block 5922431, async page read
Feb 07 21:58:19 volumio kernel: device offline error, dev sdc, sector 0 op 0x1:(WRITE) flags 0x800 phys_seg 0 prio class 2
Feb 07 21:58:19 volumio sudo[1737]: pam_unix(sudo:session): session closed for user root
Feb 07 21:58:19 volumio volumio[1181]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error
Feb 07 21:58:19 volumio volumio[1181]: Failed to read $AttrDef, unexpected length (-1 != 2560).
Feb 07 21:58:19 volumio volumio[1181]: Failed to sync device /dev/sdc2: No such device
Feb 07 21:58:19 volumio volumio[1181]: Failed to mount '/dev/sdc2': Input/output error
Feb 07 21:58:19 volumio volumio[1181]: NTFS is either inconsistent, or there is a hardware fault, or it's a
Feb 07 21:58:19 volumio volumio[1181]: SoftRAID/FakeRAID hardware. In the first case run chkdsk /f on Windows
Feb 07 21:58:19 volumio volumio[1181]: then reboot into Windows twice. The usage of the /f parameter is very
Feb 07 21:58:19 volumio volumio[1181]: important! If the device is a SoftRAID/FakeRAID then first activate
Feb 07 21:58:19 volumio volumio[1181]: it and mount a different device under the /dev/mapper/ directory, (e.g.
Feb 07 21:58:19 volumio volumio[1181]: /dev/mapper/nvidia_eahaabcc1). Please see the 'dmraid' documentation
Feb 07 21:58:19 volumio volumio[1181]: for more details.
Feb 07 21:58:19 volumio volumio[1181]: error: Failed to mount TOSHIBA_EXT: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sdc2" "/mnt/USB/TOSHIBA_EXT" -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Feb 07 21:58:19 volumio volumio[1181]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error
Feb 07 21:58:19 volumio volumio[1181]: Failed to read $AttrDef, unexpected length (-1 != 2560).
Feb 07 21:58:19 volumio volumio[1181]: Failed to sync device /dev/sdc2: No such device
Feb 07 21:58:19 volumio volumio[1181]: Failed to mount '/dev/sdc2': Input/output error
Feb 07 21:58:19 volumio volumio[1181]: NTFS is either inconsistent, or there is a hardware fault, or it's a
Feb 07 21:58:19 volumio volumio[1181]: SoftRAID/FakeRAID hardware. In the first case run chkdsk /f on Windows
Feb 07 21:58:19 volumio volumio[1181]: then reboot into Windows twice. The usage of the /f parameter is very
Feb 07 21:58:19 volumio volumio[1181]: important! If the device is a SoftRAID/FakeRAID then first activate
Feb 07 21:58:19 volumio volumio[1181]: it and mount a different device under the /dev/mapper/ directory, (e.g.
Feb 07 21:58:19 volumio volumio[1181]: /dev/mapper/nvidia_eahaabcc1). Please see the 'dmraid' documentation
Feb 07 21:58:19 volumio volumio[1181]: for more details.
Feb 07 21:58:19 volumio kernel: sd 2:0:0:0: [sdc] Synchronizing SCSI cache
Feb 07 21:58:19 volumio kernel: sd 2:0:0:0: [sdc] Synchronize Cache(10) failed: Result: hostbyte=0x01 driverbyte=DRIVER_OK
Feb 07 21:58:20 volumio volumio[1181]: error: FusionDsp - Reload WebSocket error: [object Object]
Feb 07 21:58:20 volumio kernel: usb 1-1.1.2: new high-speed USB device number 25 using dwc_otg
Feb 07 21:58:20 volumio kernel: hwmon hwmon1: Undervoltage detected!
Feb 07 21:58:20 volumio kernel: usb 1-1.1.2: New USB device found, idVendor=0480, idProduct=0826, bcdDevice= 0.00
Feb 07 21:58:20 volumio kernel: usb 1-1.1.2: New USB device strings: Mfr=2, Product=3, SerialNumber=1
Feb 07 21:58:20 volumio kernel: usb 1-1.1.2: Product: EXTERNAL_USB
Feb 07 21:58:20 volumio kernel: usb 1-1.1.2: Manufacturer: TOSHIBA
Feb 07 21:58:20 volumio kernel: usb 1-1.1.2: SerialNumber: 20240402007495F
Feb 07 21:58:20 volumio kernel: usb-storage 1-1.1.2:1.0: USB Mass Storage device detected
Feb 07 21:58:20 volumio kernel: scsi host2: usb-storage 1-1.1.2:1.0
Feb 07 21:58:20 volumio volumio[1181]: info: Volumio called home
Feb 07 21:58:20 volumio volumio[1181]: error: Cannot associate FS Label, not mounting
Feb 07 21:58:21 volumio kernel: scsi 2:0:0:0: Direct-Access TOSHIBA EXTERNAL_USB 0 PQ: 0 ANSI: 6
Feb 07 21:58:21 volumio kernel: sd 2:0:0:0: Attached scsi generic sg2 type 0
Feb 07 21:58:21 volumio kernel: sd 2:0:0:0: [sdc] Spinning up disk...
Feb 07 21:58:23 volumio kernel: ..ready
Feb 07 21:58:23 volumio kernel: sd 2:0:0:0: [sdc] Very big device. Trying to use READ CAPACITY(16).
Feb 07 21:58:23 volumio kernel: sd 2:0:0:0: [sdc] 7814037168 512-byte logical blocks: (4.00 TB/3.64 TiB)
Feb 07 21:58:23 volumio kernel: sd 2:0:0:0: [sdc] 4096-byte physical blocks
Feb 07 21:58:23 volumio kernel: sd 2:0:0:0: [sdc] Write Protect is off
Feb 07 21:58:23 volumio kernel: sd 2:0:0:0: [sdc] Mode Sense: 43 00 00 00
Feb 07 21:58:23 volumio kernel: sd 2:0:0:0: [sdc] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Feb 07 21:58:23 volumio kernel: Alternate GPT is invalid, using primary GPT.
Feb 07 21:58:23 volumio kernel: sdc: sdc1 sdc2
Feb 07 21:58:23 volumio kernel: sd 2:0:0:0: [sdc] Attached SCSI disk
Feb 07 21:58:23 volumio volumio-remote-updater[719]: [2026-02-07 21:58:23] [connect] Successful connection
Feb 07 21:58:24 volumio volumio[1181]: error: MPD error: The expression evaluated to a falsy value:
Feb 07 21:58:24 volumio volumio[1181]: assert.ok(self.idling)
Feb 07 21:58:24 volumio volumio[1181]: error: The expression evaluated to a falsy value:
Feb 07 21:58:24 volumio volumio[1181]: assert.ok(self.idling)
Feb 07 21:58:24 volumio volumio[1181]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1
Feb 07 21:58:24 volumio volumio[1181]: info: MPD running with PID1658
Feb 07 21:58:24 volumio volumio[1181]: ,establishing connection
Feb 07 21:58:24 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:58:24 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:58:24 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:58:24 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:58:24 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:58:24 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:58:24 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:58:24 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:58:25 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 07 21:58:25 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:58:25 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:58:25 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:58:25 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:58:25 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:58:25 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:58:25 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:58:25 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:58:25 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:58:25 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 07 21:58:25 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:58:25 volumio volumio[1181]: info: Scanning removed location : "USB/TOSHIBA_EXT"
Feb 07 21:58:25 volumio volumio[1181]: info: Scanning removed location : "USB/TOSHIBA_EXT"
Feb 07 21:58:25 volumio volumio[1181]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.2/1-1.1.2:1.0/host2/target2:0:0/2:0:0:0/block/sdc/sdc2","ACTION":"remove","CURRENT_TAGS":":systemd:","DEVLINKS":"/dev/disk/by-uuid/A66639BC66398DD5 /dev/disk/by-path/platform-3f980000.usb-usb-0:1.1.2:1.0-scsi-0:0:0:0-part2 /dev/disk/by-partlabel/Basic\\x20data\\x20partition /dev/disk/by-label/TOSHIBA\\x20EXT /dev/disk/by-id/usb-TOSHIBA_EXTERNAL_USB_20240402007495F-0:0-part2 /dev/disk/by-id/ata-TOSHIBA_MQ04UBB400_442DT0QGT-part2 /dev/disk/by-partuuid/7c60458f-18dd-4600-be0a-e224204e9054","DEVNAME":"/dev/sdc2","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.2/1-1.1.2:1.0/host2/target2:0:0/2:0:0:0/block/sdc/sdc2","DEVTYPE":"partition","DISKSEQ":"40","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_APM":"1","ID_ATA_FEATURE_SET_APM_CURRENT_VALUE":"128","ID_ATA_FEATURE_SET_APM_ENABLED":"1","ID_ATA_FEATURE_SET_HPA":"1","ID_ATA_FEATURE_SET_HPA_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN":"66342","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"66342","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_ROTATION_RATE_RPM":"5400","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_SATA_SIGNAL_RATE_GEN2":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_FS_LABEL":"TOSHIBA_EXT","ID_FS_LABEL_ENC":"TOSHIBA\\x20EXT","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"A66639BC66398DD5","ID_FS_UUID_ENC":"A66639BC66398DD5","ID_MODEL":"TOSHIBA_MQ04UBB400","ID_MODEL_ENC":"TOSHIBA\\x20MQ04UBB400\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:32","ID_PART_ENTRY_NAME":"Basic\\x20data\\x20partition","ID_PART_ENTRY_NUMBER":"2","ID_PART_ENTRY_OFFSET":"264192","ID_PART_ENTRY_SCHEME":"gpt","ID_PART_ENTRY_SIZE":"7813771264","ID_PART_ENTRY_TYPE":"ebd0a0a2-b9e5-4433-87c0-68b6b72699c7","ID_PART_ENTRY_UUID":"7c60458f-18dd-4600-be0a-e224204e9054","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"0491e096-24a4-4db4-9f26-790daadccf08","ID_PATH":"platform-3f980000.usb-usb-0:1.1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"JS0B0U","ID_SERIAL":"TOSHIBA_MQ04UBB400_442DT0QGT","ID_SERIAL_SHORT":"442DT0QGT","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INSTANCE":"0:0","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_USB_MODEL":"EXTERNAL_USB","ID_USB_MODEL_ENC":"EXTERNAL_USB\\x20\\x20\\x20\\x20","ID_USB_MODEL_ID":"0826","ID_USB_REVISION":"0","ID_USB_SERIAL":"TOSHIBA_EXTERNAL_USB_20240402007495F-0:0","ID_USB_SERIAL_SHORT":"20240402007495F","ID_USB_TYPE":"disk","ID_USB_VENDOR":"TOSHIBA","ID_USB_VENDOR_ENC":"TOSHIBA\\x20","ID_USB_VENDOR_ID":"0480","MAJOR":"8","MINOR":"34","PARTN":"2","PARTNAME":"Basic data partition","SEQNUM":"2604","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"95603060"}
Feb 07 21:58:25 volumio sudo[1788]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sdc2
Feb 07 21:58:25 volumio sudo[1788]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 07 21:58:25 volumio sudo[1788]: pam_unix(sudo:session): session closed for user root
Feb 07 21:58:25 volumio volumio[1181]: umount: /dev/sdc2: not mounted.
Feb 07 21:58:25 volumio volumio[1181]: error: Failed to umount TOSHIBA_EXT: Error: Command failed: /usr/bin/sudo /bin/umount -f "/dev/sdc2"
Feb 07 21:58:25 volumio volumio[1181]: umount: /dev/sdc2: not mounted.
Feb 07 21:58:26 volumio volumio[1181]: error: updateQueue error: null
Feb 07 21:58:26 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status
Feb 07 21:58:26 volumio volumio[1181]: info:
Feb 07 21:58:26 volumio volumio[1181]: ---------------------------- MPD announces state update: update
Feb 07 21:58:26 volumio volumio[1181]: info: ControllerMpd::getState
Feb 07 21:58:26 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status
Feb 07 21:58:26 volumio volumio[1181]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2
Feb 07 21:58:26 volumio volumio[1181]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.2/1-1.1.2:1.0/host2/target2:0:0/2:0:0:0/block/sdc/sdc1","ACTION":"remove","CURRENT_TAGS":":systemd:","DEVLINKS":"/dev/disk/by-id/usb-TOSHIBA_EXTERNAL_USB_20240402007495F-0:0-part1 /dev/disk/by-partlabel/Microsoft\\x20reserved\\x20partition /dev/disk/by-path/platform-3f980000.usb-usb-0:1.1.2:1.0-scsi-0:0:0:0-part1 /dev/disk/by-id/ata-TOSHIBA_MQ04UBB400_442DT0QGT-part1 /dev/disk/by-partuuid/7c60458e-18dd-4600-be0a-e224204e9054","DEVNAME":"/dev/sdc1","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.2/1-1.1.2:1.0/host2/target2:0:0/2:0:0:0/block/sdc/sdc1","DEVTYPE":"partition","DISKSEQ":"40","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_APM":"1","ID_ATA_FEATURE_SET_APM_CURRENT_VALUE":"128","ID_ATA_FEATURE_SET_APM_ENABLED":"1","ID_ATA_FEATURE_SET_HPA":"1","ID_ATA_FEATURE_SET_HPA_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN":"66342","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"66342","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_ROTATION_RATE_RPM":"5400","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_SATA_SIGNAL_RATE_GEN2":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_MODEL":"TOSHIBA_MQ04UBB400","ID_MODEL_ENC":"TOSHIBA\\x20MQ04UBB400\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:32","ID_PART_ENTRY_NAME":"Microsoft\\x20reserved\\x20partition","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"34","ID_PART_ENTRY_SCHEME":"gpt","ID_PART_ENTRY_SIZE":"262144","ID_PART_ENTRY_TYPE":"e3c9e316-0b5c-4db8-817d-f92df00215ae","ID_PART_ENTRY_UUID":"7c60458e-18dd-4600-be0a-e224204e9054","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"0491e096-24a4-4db4-9f26-790daadccf08","ID_PATH":"platform-3f980000.usb-usb-0:1.1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"JS0B0U","ID_SERIAL":"TOSHIBA_MQ04UBB400_442DT0QGT","ID_SERIAL_SHORT":"442DT0QGT","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INSTANCE":"0:0","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_USB_MODEL":"EXTERNAL_USB","ID_USB_MODEL_ENC":"EXTERNAL_USB\\x20\\x20\\x20\\x20","ID_USB_MODEL_ID":"0826","ID_USB_REVISION":"0","ID_USB_SERIAL":"TOSHIBA_EXTERNAL_USB_20240402007495F-0:0","ID_USB_SERIAL_SHORT":"20240402007495F","ID_USB_TYPE":"disk","ID_USB_VENDOR":"TOSHIBA","ID_USB_VENDOR_ENC":"TOSHIBA\\x20","ID_USB_VENDOR_ID":"0480","MAJOR":"8","MINOR":"33","PARTN":"1","PARTNAME":"Microsoft reserved partition","SEQNUM":"2603","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"95639933"}
Feb 07 21:58:26 volumio volumio[1181]: error: Cannot associate FS Label, not mounting
Feb 07 21:58:26 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status
Feb 07 21:58:26 volumio volumio[1181]: info:
Feb 07 21:58:26 volumio volumio[1181]: ---------------------------- MPD announces state update: update
Feb 07 21:58:26 volumio volumio[1181]: info: ControllerMpd::getState
Feb 07 21:58:26 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status
Feb 07 21:58:26 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status
Feb 07 21:58:26 volumio volumio[1181]: info:
Feb 07 21:58:26 volumio volumio[1181]: ---------------------------- MPD announces state update: update
Feb 07 21:58:26 volumio volumio[1181]: info: ControllerMpd::getState
Feb 07 21:58:26 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status
Feb 07 21:58:26 volumio volumio-remote-updater[719]: [2026-02-07 21:58:26] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1770481703 101
Feb 07 21:58:26 volumio volumio[1181]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 3
Feb 07 21:58:26 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status
Feb 07 21:58:26 volumio volumio[1181]: info:
Feb 07 21:58:26 volumio volumio[1181]: ---------------------------- MPD announces state update: update
Feb 07 21:58:26 volumio volumio[1181]: error: updateQueue error: null
Feb 07 21:58:26 volumio volumio[1181]: info: ControllerMpd::getState
Feb 07 21:58:26 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status
Feb 07 21:58:26 volumio volumio[1181]: info: sendMpdCommand status took 625 milliseconds
Feb 07 21:58:26 volumio volumio[1181]: info: sendMpdCommand status took 623 milliseconds
Feb 07 21:58:26 volumio volumio[1181]: info: sendMpdCommand status took 368 milliseconds
Feb 07 21:58:26 volumio volumio[1181]: info: sendMpdCommand status took 362 milliseconds
Feb 07 21:58:26 volumio volumio[1181]: info: sendMpdCommand status took 349 milliseconds
Feb 07 21:58:26 volumio volumio[1181]: info: sendMpdCommand status took 342 milliseconds
Feb 07 21:58:26 volumio volumio[1181]: verbose: ControllerMpd::parseState
Feb 07 21:58:26 volumio volumio[1181]: info: Command Router : Notfying DB Updatefalse
Feb 07 21:58:26 volumio volumio[1181]: info: CoreCommandRouter::Close All Modals sent
Feb 07 21:58:26 volumio volumio[1181]: verbose: ControllerMpd::parseState
Feb 07 21:58:26 volumio volumio[1181]: verbose: ControllerMpd::parseState
Feb 07 21:58:26 volumio volumio[1181]: info: Command Router : Notfying DB Updatefalse
Feb 07 21:58:26 volumio volumio[1181]: info: CoreCommandRouter::Close All Modals sent
Feb 07 21:58:26 volumio volumio[1181]: verbose: ControllerMpd::parseState
Feb 07 21:58:26 volumio volumio[1181]: verbose: ControllerMpd::parseState
Feb 07 21:58:27 volumio volumio[1181]: info: Command Router : Notfying DB Updatefalse
Feb 07 21:58:27 volumio volumio[1181]: info: CoreCommandRouter::Close All Modals sent
Feb 07 21:58:27 volumio volumio[1181]: verbose: ControllerMpd::parseState
Feb 07 21:58:27 volumio volumio[1181]: info: ControllerMpd::pushState
Feb 07 21:58:27 volumio volumio[1181]: info: CoreCommandRouter::servicePushState
Feb 07 21:58:27 volumio volumio[1181]: info: CoreStateMachine::pushState
Feb 07 21:58:27 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:27 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState
Feb 07 21:58:27 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:27 volumio volumio[1181]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Feb 07 21:58:27 volumio volumio[1181]: verbose: CURRENT POSITION 0
Feb 07 21:58:27 volumio volumio[1181]: info: CoreStateMachine::syncState stateService stop
Feb 07 21:58:27 volumio volumio[1181]: info: CoreStateMachine::syncState currentStatus stop
Feb 07 21:58:27 volumio volumio[1181]: info: CoreStateMachine::pushState
Feb 07 21:58:27 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:27 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState
Feb 07 21:58:27 volumio volumio[1181]: info: No code
Feb 07 21:58:27 volumio volumio[1181]: info: CoreStateMachine::pushState
Feb 07 21:58:27 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:27 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState
Feb 07 21:58:27 volumio volumio[1181]: info: ControllerMpd::pushState
Feb 07 21:58:27 volumio volumio[1181]: info: CoreCommandRouter::servicePushState
Feb 07 21:58:27 volumio volumio[1181]: info: CoreStateMachine::pushState
Feb 07 21:58:27 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:27 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState
Feb 07 21:58:27 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:27 volumio volumio[1181]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Feb 07 21:58:27 volumio volumio[1181]: verbose: CURRENT POSITION 0
Feb 07 21:58:27 volumio volumio[1181]: info: CoreStateMachine::syncState stateService stop
Feb 07 21:58:27 volumio volumio[1181]: info: CoreStateMachine::syncState currentStatus stop
Feb 07 21:58:27 volumio volumio[1181]: info: CoreStateMachine::pushState
Feb 07 21:58:27 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:27 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState
Feb 07 21:58:27 volumio volumio[1181]: info: No code
Feb 07 21:58:27 volumio volumio[1181]: info: CoreStateMachine::pushState
Feb 07 21:58:27 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:27 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState
Feb 07 21:58:27 volumio volumio[1181]: info: ControllerMpd::pushState
Feb 07 21:58:27 volumio volumio[1181]: info: CoreCommandRouter::servicePushState
Feb 07 21:58:27 volumio volumio[1181]: info: CoreStateMachine::pushState
Feb 07 21:58:27 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:27 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState
Feb 07 21:58:27 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:27 volumio volumio[1181]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Feb 07 21:58:27 volumio volumio[1181]: verbose: CURRENT POSITION 0
Feb 07 21:58:27 volumio volumio[1181]: info: CoreStateMachine::syncState stateService stop
Feb 07 21:58:27 volumio volumio[1181]: info: CoreStateMachine::syncState currentStatus stop
Feb 07 21:58:27 volumio volumio[1181]: info: CoreStateMachine::pushState
Feb 07 21:58:27 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:27 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState
Feb 07 21:58:27 volumio volumio[1181]: info: No code
Feb 07 21:58:27 volumio volumio[1181]: info: CoreStateMachine::pushState
Feb 07 21:58:27 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:27 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState
Feb 07 21:58:27 volumio volumio[1181]: info: ------------------------------ 1322ms
Feb 07 21:58:27 volumio volumio[1181]: info: ------------------------------ 1067ms
Feb 07 21:58:27 volumio volumio[1181]: info: ------------------------------ 1041ms
Feb 07 21:58:27 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status
Feb 07 21:58:27 volumio volumio[1181]: info:
Feb 07 21:58:27 volumio volumio[1181]: ---------------------------- MPD announces state update: update
Feb 07 21:58:27 volumio volumio[1181]: info: ControllerMpd::getState
Feb 07 21:58:27 volumio volumio[1181]: verbose: ControllerMpd::sendMpdCommand status
Feb 07 21:58:27 volumio volumio[1181]: info: Starting Shairport Sync
Feb 07 21:58:27 volumio volumio[1181]: info: Starting Shairport Sync
Feb 07 21:58:27 volumio volumio[1181]: info: Starting Shairport Sync
Feb 07 21:58:27 volumio volumio[1181]: info: sendMpdCommand status took 942 milliseconds
Feb 07 21:58:27 volumio volumio[1181]: info: sendMpdCommand status took 927 milliseconds
Feb 07 21:58:27 volumio volumio[1181]: info: sendMpdCommand status took 187 milliseconds
Feb 07 21:58:27 volumio volumio[1181]: info: sendMpdCommand status took 174 milliseconds
Feb 07 21:58:27 volumio volumio[1181]: verbose: ControllerMpd::parseState
Feb 07 21:58:27 volumio volumio[1181]: info: Command Router : Notfying DB Updatefalse
Feb 07 21:58:27 volumio volumio[1181]: info: CoreCommandRouter::Close All Modals sent
Feb 07 21:58:27 volumio volumio[1181]: verbose: ControllerMpd::parseState
Feb 07 21:58:27 volumio volumio[1181]: verbose: ControllerMpd::parseState
Feb 07 21:58:27 volumio sudo[1807]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 07 21:58:27 volumio sudo[1807]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 07 21:58:27 volumio sudo[1806]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 07 21:58:27 volumio sudo[1806]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 07 21:58:27 volumio sudo[1809]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 07 21:58:27 volumio sudo[1809]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 07 21:58:27 volumio volumio[1181]: info: Command Router : Notfying DB Updatefalse
Feb 07 21:58:27 volumio volumio[1181]: info: CoreCommandRouter::Close All Modals sent
Feb 07 21:58:27 volumio volumio[1181]: verbose: ControllerMpd::parseState
Feb 07 21:58:27 volumio volumio[1181]: info: ControllerMpd::pushState
Feb 07 21:58:27 volumio volumio[1181]: info: CoreCommandRouter::servicePushState
Feb 07 21:58:27 volumio volumio[1181]: info: CoreStateMachine::pushState
Feb 07 21:58:27 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:27 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Feb 07 21:58:27 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
Feb 07 21:58:27 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 07 21:58:27 volumio systemd[1]: shairport-sync.service: Consumed 1.695s CPU time.
Feb 07 21:58:27 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState
Feb 07 21:58:27 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:27 volumio volumio[1181]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Feb 07 21:58:27 volumio volumio[1181]: verbose: CURRENT POSITION 0
Feb 07 21:58:27 volumio volumio[1181]: info: CoreStateMachine::syncState stateService stop
Feb 07 21:58:27 volumio volumio[1181]: info: CoreStateMachine::syncState currentStatus stop
Feb 07 21:58:27 volumio volumio[1181]: info: CoreStateMachine::pushState
Feb 07 21:58:27 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:27 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState
Feb 07 21:58:27 volumio volumio[1181]: info: No code
Feb 07 21:58:27 volumio volumio[1181]: info: CoreStateMachine::pushState
Feb 07 21:58:27 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:27 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState
Feb 07 21:58:27 volumio volumio[1181]: info: ControllerMpd::pushState
Feb 07 21:58:27 volumio volumio[1181]: info: CoreCommandRouter::servicePushState
Feb 07 21:58:27 volumio volumio[1181]: info: CoreStateMachine::pushState
Feb 07 21:58:27 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:27 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState
Feb 07 21:58:27 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:27 volumio volumio[1181]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Feb 07 21:58:27 volumio volumio[1181]: verbose: CURRENT POSITION 0
Feb 07 21:58:27 volumio volumio[1181]: info: CoreStateMachine::syncState stateService stop
Feb 07 21:58:27 volumio volumio[1181]: info: CoreStateMachine::syncState currentStatus stop
Feb 07 21:58:27 volumio volumio[1181]: info: CoreStateMachine::pushState
Feb 07 21:58:27 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:27 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState
Feb 07 21:58:27 volumio volumio[1181]: info: No code
Feb 07 21:58:27 volumio volumio[1181]: info: CoreStateMachine::pushState
Feb 07 21:58:27 volumio volumio[1181]: info: CorePlayQueue::getTrack 0
Feb 07 21:58:27 volumio volumio[1181]: info: CoreCommandRouter::volumioPushState
Feb 07 21:58:27 volumio volumio[1181]: info: ------------------------------ 1215ms
Feb 07 21:58:27 volumio volumio[1181]: info: ------------------------------ 461ms
Feb 07 21:58:27 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 07 21:58:27 volumio sudo[1806]: pam_unix(sudo:session): session closed for user root
Feb 07 21:58:27 volumio volumio[1181]: info: Mounting Device TOSHIBA_EXT
Feb 07 21:58:27 volumio sudo[1807]: pam_unix(sudo:session): session closed for user root
Feb 07 21:58:27 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Feb 07 21:58:27 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
Feb 07 21:58:27 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 07 21:58:28 volumio sudo[1826]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdc2 /mnt/USB/TOSHIBA_EXT -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Feb 07 21:58:28 volumio sudo[1826]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 07 21:58:28 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 07 21:58:28 volumio sudo[1809]: pam_unix(sudo:session): session closed for user root
Feb 07 21:58:51 volumio ntfs-3g[1883]: Version 2022.10.3 integrated FUSE 28
Feb 07 21:58:51 volumio ntfs-3g[1883]: Mounted /dev/sdc2 (Read-Write, label "TOSHIBA EXT", NTFS 3.1)
Feb 07 21:58:51 volumio ntfs-3g[1883]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8
Feb 07 21:58:51 volumio ntfs-3g[1883]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sdc2,blkdev,blksize=4096
Feb 07 21:58:51 volumio ntfs-3g[1883]: Global ownership and permissions enforced, configuration type 7
Feb 07 21:58:51 volumio sudo[1826]: pam_unix(sudo:session): session closed for user root
Feb 07 21:58:52 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 07 21:58:52 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 07 21:58:52 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Feb 07 21:58:52 volumio volumio[1181]: error: MyVolumio Plugin failed to start in a timely fashion
Feb 07 21:58:52 volumio volumio[1181]: [Metrics] CommandRouter: 77s 862.85ms
Feb 07 21:58:52 volumio volumio[1181]: info: CoreCommandRouter::volumiosetStartupVolume
Feb 07 21:58:52 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 07 21:58:52 volumio volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 07 21:58:52 volumio volumio[1181]: info: CoreCommandRouter::Close All Modals sent
Feb 07 21:58:52 volumio volumio[1181]: info: CoreCommandRouter::Close All Modals sent
Feb 07 21:58:52 volumio volumio[1181]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 07 21:58:52 volumio volumio[1181]: Error [ERR_INTERNAL_ASSERTION]: This is caused by either a bug in Node.js or incorrect usage of Node.js internals.
Feb 07 21:58:52 volumio volumio[1181]: Please open an issue with this stack trace at https://github.com/nodejs/node/issues
Feb 07 21:58:52 volumio volumio[1181]: at new NodeError (node:internal/errors:405:5)
Feb 07 21:58:52 volumio volumio[1181]: at assert (node:internal/assert:14:11)
Feb 07 21:58:52 volumio volumio[1181]: at internalConnectMultiple (node:net:1118:3)
Feb 07 21:58:52 volumio volumio[1181]: at Timeout.internalConnectMultipleTimeout (node:net:1687:3)
Feb 07 21:58:52 volumio volumio[1181]: at listOnTimeout (node:internal/timers:575:11)
Feb 07 21:58:52 volumio volumio[1181]: at process.processTimers (node:internal/timers:514:7) {
Feb 07 21:58:52 volumio volumio[1181]: code: 'ERR_INTERNAL_ASSERTION'
Feb 07 21:58:52 volumio volumio[1181]: }
Feb 07 21:58:52 volumio volumio[1181]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 07 21:58:55 volumio kernel: hwmon hwmon1: Voltage normalised
Feb 07 21:58:57 volumio sudo[1925]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-07 21:57'
Feb 07 21:58:57 volumio sudo[1925]: 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"