-- Logs begin at Sun 2025-06-15 20:33:18 MSK, end at Sun 2025-06-15 21:00:58 MSK. -- Jun 15 20:59:08 volumio kernel: usb 1-1.4: USB disconnect, device number 6 Jun 15 20:59:36 volumio kernel: usb 1-1.4: new full-speed USB device number 7 using dwc2 Jun 15 20:59:36 volumio kernel: usb 1-1.4: New USB device found, idVendor=046d, idProduct=c52b Jun 15 20:59:36 volumio kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Jun 15 20:59:36 volumio kernel: usb 1-1.4: Product: USB Receiver Jun 15 20:59:36 volumio kernel: usb 1-1.4: Manufacturer: Logitech Jun 15 20:59:37 volumio kernel: logitech-djreceiver 0003:046D:C52B.000F: hiddev0,hidraw4: USB HID v1.11 Device [Logitech USB Receiver] on usb-ff540000.usb-1.4/input2 Jun 15 20:59:37 volumio kernel: input: Logitech ERGO M575 as /devices/platform/ff540000.usb/usb1/1-1/1-1.4/1-1.4:1.2/0003:046D:C52B.000F/0003:046D:4096.0010/input/input10 Jun 15 20:59:37 volumio kernel: logitech-hidpp-device 0003:046D:4096.0010: input,hidraw5: USB HID v1.11 Mouse [Logitech ERGO M575] on usb-ff540000.usb-1.4:1 Jun 15 20:59:37 volumio systemd-udevd[7987]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jun 15 20:59:43 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Jun 15 20:59:43 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:52 volumio kernel: usb 1-1.2: USB disconnect, device number 3 Jun 15 20:59:52 volumio volumio[972]: info: Partition removed: {"syspath":"/sys/devices/platform/ff540000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/usb-USB_Flash_Disk-0:0-part1 /dev/disk/by-uuid/5E8C-A571 /dev/disk/by-label/\\x8d\\x8e\\x82\\x9b\\x89\\x20\\x92\\x8e\\x8c /dev/disk/by-path/platform-ff540000.usb-usb-0:1.2:1.0-scsi-0:0:0:0-part1 /dev/disk/by-partuuid/02b18a26-01","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/ff540000.usb/usb1/1-1/1-1.2/1-1.2:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","ID_BUS":"usb","ID_FS_LABEL":"_________","ID_FS_LABEL_ENC":"\\x8d\\x8e\\x82\\x9b\\x89\\x20\\x92\\x8e\\x8c","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"5E8C-A571","ID_FS_UUID_ENC":"5E8C-A571","ID_FS_VERSION":"FAT32","ID_INSTANCE":"0:0","ID_MODEL":"Flash_Disk","ID_MODEL_ENC":"Flash\\x20Disk\\x20\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"3267","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"4194304","ID_PART_ENTRY_TYPE":"0xc","ID_PART_ENTRY_UUID":"02b18a26-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"02b18a26","ID_PATH":"platform-ff540000.usb-usb-0:1.2:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-ff540000_usb-usb-0_1_2_1_0-scsi-0_0_0_0","ID_REVISION":"1100","ID_SERIAL":"USB_Flash_Disk-0:0","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"USB","ID_VENDOR_ENC":"USB\\x20\\x20\\x20\\x20\\x20","ID_VENDOR_ID":"090c","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"3234","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"6474870"} Jun 15 20:59:52 volumio kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache Jun 15 20:59:52 volumio kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x01 driverbyte=0x00 Jun 15 20:59:52 volumio sudo[8014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1 Jun 15 20:59:52 volumio sudo[8014]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 15 20:59:52 volumio systemd[1]: media-_________.mount: Succeeded. Jun 15 20:59:52 volumio sudo[8014]: pam_unix(sudo:session): session closed for user root Jun 15 20:59:52 volumio kernel: FAT-fs (sda1): unable to read boot sector to mark fs as dirty Jun 15 20:59:56 volumio volumio[972]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/_________ Jun 15 20:59:57 volumio volumio[972]: info: Scanning removed location : "USB/_________" Jun 15 20:59:57 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jun 15 20:59:57 volumio volumio[972]: info: Jun 15 20:59:57 volumio volumio[972]: ---------------------------- MPD announces state update: update Jun 15 20:59:57 volumio volumio[972]: info: ControllerMpd::getState Jun 15 20:59:57 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jun 15 20:59:57 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jun 15 20:59:57 volumio volumio[972]: info: Jun 15 20:59:57 volumio volumio[972]: ---------------------------- MPD announces state update: update Jun 15 20:59:57 volumio volumio[972]: info: ControllerMpd::getState Jun 15 20:59:57 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jun 15 20:59:57 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jun 15 20:59:57 volumio volumio[972]: info: Jun 15 20:59:57 volumio volumio[972]: ---------------------------- MPD announces state update: update Jun 15 20:59:57 volumio volumio[972]: info: ControllerMpd::getState Jun 15 20:59:57 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jun 15 20:59:57 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jun 15 20:59:57 volumio volumio[972]: info: Jun 15 20:59:57 volumio volumio[972]: ---------------------------- MPD announces state update: update Jun 15 20:59:57 volumio volumio[972]: info: sendMpdCommand status took 10 milliseconds Jun 15 20:59:57 volumio volumio[972]: info: ControllerMpd::getState Jun 15 20:59:57 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jun 15 20:59:57 volumio volumio[972]: info: sendMpdCommand status took 9 milliseconds Jun 15 20:59:57 volumio volumio[972]: info: sendMpdCommand status took 8 milliseconds Jun 15 20:59:57 volumio volumio[972]: info: sendMpdCommand status took 7 milliseconds Jun 15 20:59:57 volumio volumio[972]: info: sendMpdCommand status took 6 milliseconds Jun 15 20:59:57 volumio volumio[972]: info: sendMpdCommand status took 6 milliseconds Jun 15 20:59:57 volumio volumio[972]: verbose: ControllerMpd::parseState Jun 15 20:59:57 volumio volumio[972]: info: Command Router : Notfying DB Updatetrue Jun 15 20:59:57 volumio volumio[972]: verbose: ControllerMpd::parseState Jun 15 20:59:57 volumio volumio[972]: info: Command Router : Notfying DB Updatefalse Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::Close All Modals sent Jun 15 20:59:57 volumio volumio[972]: verbose: ControllerMpd::parseState Jun 15 20:59:57 volumio volumio[972]: verbose: ControllerMpd::parseState Jun 15 20:59:57 volumio volumio[972]: info: Command Router : Notfying DB Updatefalse Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::Close All Modals sent Jun 15 20:59:57 volumio volumio[972]: verbose: ControllerMpd::parseState Jun 15 20:59:57 volumio volumio[972]: info: ControllerMpd::pushState Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::servicePushState Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::pushState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output update for this device Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: 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} Jun 15 20:59:57 volumio volumio[972]: verbose: CURRENT POSITION 0 Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::syncState stateService stop Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus stop Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::pushState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output update for this device Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: No code Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::pushState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output update for this device Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: ControllerMpd::pushState Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::servicePushState Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::pushState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output update for this device Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: 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} Jun 15 20:59:57 volumio volumio[972]: verbose: CURRENT POSITION 0 Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::syncState stateService stop Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus stop Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::pushState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output update for this device Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: No code Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::pushState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output update for this device Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: ControllerMpd::pushState Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::servicePushState Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::pushState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output update for this device Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: 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} Jun 15 20:59:57 volumio volumio[972]: verbose: CURRENT POSITION 0 Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::syncState stateService stop Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus stop Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::pushState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output update for this device Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: No code Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::pushState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output update for this device Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: ------------------------------ 352ms Jun 15 20:59:57 volumio volumio[972]: info: ------------------------------ 349ms Jun 15 20:59:57 volumio volumio[972]: info: ------------------------------ 348ms Jun 15 20:59:57 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jun 15 20:59:57 volumio volumio[972]: info: Jun 15 20:59:57 volumio volumio[972]: ---------------------------- MPD announces state update: update Jun 15 20:59:57 volumio volumio[972]: info: ControllerMpd::getState Jun 15 20:59:57 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jun 15 20:59:57 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jun 15 20:59:57 volumio volumio[972]: info: Jun 15 20:59:57 volumio volumio[972]: ---------------------------- MPD announces state update: update Jun 15 20:59:57 volumio volumio[972]: info: ControllerMpd::getState Jun 15 20:59:57 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jun 15 20:59:57 volumio volumio[972]: info: sendMpdCommand status took 358 milliseconds Jun 15 20:59:57 volumio volumio[972]: info: sendMpdCommand status took 356 milliseconds Jun 15 20:59:57 volumio volumio[972]: info: sendMpdCommand status took 11 milliseconds Jun 15 20:59:57 volumio volumio[972]: info: sendMpdCommand status took 9 milliseconds Jun 15 20:59:57 volumio volumio[972]: info: sendMpdCommand status took 8 milliseconds Jun 15 20:59:57 volumio volumio[972]: info: sendMpdCommand status took 6 milliseconds Jun 15 20:59:57 volumio volumio[972]: verbose: ControllerMpd::parseState Jun 15 20:59:57 volumio volumio[972]: info: Command Router : Notfying DB Updatefalse Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::Close All Modals sent Jun 15 20:59:57 volumio volumio[972]: verbose: ControllerMpd::parseState Jun 15 20:59:57 volumio volumio[972]: verbose: ControllerMpd::parseState Jun 15 20:59:57 volumio volumio[972]: info: Command Router : Notfying DB Updatefalse Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::Close All Modals sent Jun 15 20:59:57 volumio volumio[972]: verbose: ControllerMpd::parseState Jun 15 20:59:57 volumio volumio[972]: verbose: ControllerMpd::parseState Jun 15 20:59:57 volumio volumio[972]: info: Command Router : Notfying DB Updatefalse Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::Close All Modals sent Jun 15 20:59:57 volumio volumio[972]: verbose: ControllerMpd::parseState Jun 15 20:59:57 volumio volumio[972]: info: ControllerMpd::pushState Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::servicePushState Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::pushState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output update for this device Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: 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} Jun 15 20:59:57 volumio volumio[972]: verbose: CURRENT POSITION 0 Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::syncState stateService stop Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus stop Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::pushState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output update for this device Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: No code Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::pushState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output update for this device Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: ControllerMpd::pushState Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::servicePushState Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::pushState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output update for this device Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: 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} Jun 15 20:59:57 volumio volumio[972]: verbose: CURRENT POSITION 0 Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::syncState stateService stop Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus stop Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::pushState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output update for this device Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: No code Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::pushState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output update for this device Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: ControllerMpd::pushState Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::servicePushState Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::pushState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output update for this device Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: 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} Jun 15 20:59:57 volumio volumio[972]: verbose: CURRENT POSITION 0 Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::syncState stateService stop Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus stop Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::pushState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output update for this device Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: No code Jun 15 20:59:57 volumio volumio[972]: info: CoreStateMachine::pushState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output update for this device Jun 15 20:59:57 volumio volumio[972]: info: MRS: Pushing multiroomSync output Jun 15 20:59:57 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Jun 15 20:59:57 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 20:59:57 volumio volumio[972]: info: ------------------------------ 573ms Jun 15 20:59:57 volumio volumio[972]: info: ------------------------------ 225ms Jun 15 20:59:57 volumio volumio[972]: info: ------------------------------ 223ms Jun 15 21:00:05 volumio kernel: usb 1-1.1: new full-speed USB device number 8 using dwc2 Jun 15 21:00:05 volumio kernel: usb 1-1.1: New USB device found, idVendor=046d, idProduct=c534 Jun 15 21:00:05 volumio kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Jun 15 21:00:05 volumio kernel: usb 1-1.1: Product: USB Receiver Jun 15 21:00:05 volumio kernel: usb 1-1.1: Manufacturer: Logitech Jun 15 21:00:05 volumio kernel: input: Logitech USB Receiver as /devices/platform/ff540000.usb/usb1/1-1/1-1.1/1-1.1:1.0/0003:046D:C534.0011/input/input11 Jun 15 21:00:05 volumio kernel: hid-generic 0003:046D:C534.0011: input,hidraw6: USB HID v1.11 Keyboard [Logitech USB Receiver] on usb-ff540000.usb-1.1/input0 Jun 15 21:00:06 volumio kernel: input: Logitech USB Receiver as /devices/platform/ff540000.usb/usb1/1-1/1-1.1/1-1.1:1.1/0003:046D:C534.0012/input/input12 Jun 15 21:00:06 volumio kernel: hid-generic 0003:046D:C534.0012: input,hiddev0,hidraw7: USB HID v1.11 Mouse [Logitech USB Receiver] on usb-ff540000.usb-1.1/input1 Jun 15 21:00:06 volumio systemd-udevd[8078]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jun 15 21:00:06 volumio systemd-logind[585]: Watching system buttons on /dev/input/event6 (Logitech USB Receiver) Jun 15 21:00:06 volumio systemd-udevd[8070]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jun 15 21:00:06 volumio systemd-logind[585]: Watching system buttons on /dev/input/event7 (Logitech USB Receiver) Jun 15 21:00:15 volumio volumio[972]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 15 21:00:15 volumio volumio[972]: No protocol specified Jun 15 21:00:15 volumio volumio[972]: xcb_connection_has_error() returned true Jun 15 21:00:15 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 15 21:00:15 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 15 21:00:15 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 15 21:00:15 volumio volumio[972]: No protocol specified Jun 15 21:00:15 volumio volumio[972]: xcb_connection_has_error() returned true Jun 15 21:00:15 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 15 21:00:15 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 15 21:00:15 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 15 21:00:22 volumio volumio[972]: info: CoreCommandRouter::volumioGetState Jun 15 21:00:22 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 15 21:00:26 volumio volumio[972]: info: CoreCommandRouter::volumioGetQueue Jun 15 21:00:26 volumio volumio[972]: info: CoreStateMachine::getQueue Jun 15 21:00:26 volumio volumio[972]: info: CorePlayQueue::getQueue Jun 15 21:00:33 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 15 21:00:33 volumio volumio[972]: info: Preload queue cleared Jun 15 21:00:35 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 15 21:00:36 volumio volumio[972]: info: Preload queue cleared Jun 15 21:00:38 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 15 21:00:47 volumio volumio[972]: info: Preload queue cleared Jun 15 21:00:52 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 15 21:00:52 volumio volumio[972]: info: Preload queue cleared Jun 15 21:00:57 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 15 21:00:57 volumio volumio[972]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 15 21:00:57 volumio volumio[972]: TypeError: Cannot read property 'length' of undefined Jun 15 21:00:57 volumio volumio[972]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Jun 15 21:00:57 volumio volumio[972]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Jun 15 21:00:57 volumio volumio[972]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Jun 15 21:00:57 volumio volumio[972]: at Parser.emit (events.js:400:28) Jun 15 21:00:57 volumio volumio[972]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Jun 15 21:00:57 volumio volumio[972]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Jun 15 21:00:57 volumio volumio[972]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Jun 15 21:00:57 volumio volumio[972]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Jun 15 21:00:57 volumio volumio[972]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Jun 15 21:00:57 volumio volumio[972]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Jun 15 21:00:57 volumio volumio[972]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Jun 15 21:00:57 volumio volumio[972]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Jun 15 21:00:57 volumio volumio[972]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Jun 15 21:00:57 volumio volumio[972]: at IncomingMessage.emit (events.js:412:35) Jun 15 21:00:57 volumio volumio[972]: at endReadableNT (internal/streams/readable.js:1333:12) Jun 15 21:00:57 volumio volumio[972]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Jun 15 21:00:57 volumio volumio[972]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 15 21:00:58 volumio sudo[8221]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-15 20:59 Jun 15 21:00:58 volumio sudo[8221]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 05:12:56 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="f5ff903d28fee878b80ffec17b533674"