-- Logs begin at Tue 2024-03-26 15:15:19 +07, end at Tue 2024-03-26 15:27:06 +07. -- Mar 26 15:26:00 blueplayer volumio[943]: info: MPD Database updated - AlbumList cache refreshed Mar 26 15:26:00 blueplayer volumio[943]: info: Mar 26 15:26:00 blueplayer volumio[943]: ---------------------------- MPD announces state update: database Mar 26 15:26:00 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:00 blueplayer volumio[943]: info: Mar 26 15:26:00 blueplayer volumio[943]: ---------------------------- MPD announces state update: update Mar 26 15:26:00 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:00 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:00 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:00 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:00 blueplayer volumio[943]: info: MPD Database updated - AlbumList cache refreshed Mar 26 15:26:00 blueplayer volumio[943]: info: Mar 26 15:26:00 blueplayer volumio[943]: ---------------------------- MPD announces state update: database Mar 26 15:26:00 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:00 blueplayer volumio[943]: info: Mar 26 15:26:00 blueplayer volumio[943]: ---------------------------- MPD announces state update: update Mar 26 15:26:00 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:00 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:00 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:00 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:00 blueplayer volumio[943]: info: MPD Database updated - AlbumList cache refreshed Mar 26 15:26:00 blueplayer volumio[943]: info: Mar 26 15:26:00 blueplayer volumio[943]: ---------------------------- MPD announces state update: database Mar 26 15:26:00 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:00 blueplayer volumio[943]: info: Mar 26 15:26:00 blueplayer volumio[943]: ---------------------------- MPD announces state update: update Mar 26 15:26:00 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:00 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:00 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:00 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:01 blueplayer kernel: hwmon hwmon1: Undervoltage detected! Mar 26 15:26:03 blueplayer volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 26 15:26:03 blueplayer volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 26 15:26:03 blueplayer volumio[943]: info: Discovery: Getting this device information Mar 26 15:26:03 blueplayer volumio[943]: info: CoreCommandRouter::volumioGetState Mar 26 15:26:03 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:03 blueplayer volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 26 15:26:03 blueplayer kernel: usb 1-1.1.3: USB disconnect, device number 14 Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer kernel: device offline error, dev sdb, sector 6294632 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Mar 26 15:26:04 blueplayer kernel: device offline error, dev sdb, sector 6294632 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Mar 26 15:26:04 blueplayer kernel: buffer_io_error: 122 callbacks suppressed Mar 26 15:26:04 blueplayer kernel: Buffer I/O error on dev sdb1, logical block 786573, async page read Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=566 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=567 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=568 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=569 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=576 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Could not decode the type of inode 576 Mar 26 15:26:04 blueplayer kernel: device offline error, dev sdb, sector 6294632 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Mar 26 15:26:04 blueplayer kernel: Buffer I/O error on dev sdb1, logical block 786573, async page read Mar 26 15:26:04 blueplayer kernel: device offline error, dev sdb, sector 6294640 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Mar 26 15:26:04 blueplayer kernel: device offline error, dev sdb, sector 6294640 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Mar 26 15:26:04 blueplayer kernel: Buffer I/O error on dev sdb1, logical block 786574, async page read Mar 26 15:26:04 blueplayer kernel: device offline error, dev sdb, sector 6294640 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Mar 26 15:26:04 blueplayer kernel: Buffer I/O error on dev sdb1, logical block 786574, async page read Mar 26 15:26:04 blueplayer kernel: device offline error, dev sdb, sector 6294656 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Mar 26 15:26:04 blueplayer kernel: device offline error, dev sdb, sector 6294656 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Mar 26 15:26:04 blueplayer kernel: Buffer I/O error on dev sdb1, logical block 786576, async page read Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=566 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer kernel: device offline error, dev sdb, sector 6294632 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Mar 26 15:26:04 blueplayer kernel: Buffer I/O error on dev sdb1, logical block 786573, async page read Mar 26 15:26:04 blueplayer kernel: device offline error, dev sdb, sector 6294632 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Mar 26 15:26:04 blueplayer kernel: Buffer I/O error on dev sdb1, logical block 786573, async page read Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=567 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=568 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=569 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x0 from inode 557: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x0 from inode 557: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x0 from inode 557: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x0 from inode 557: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x0 from inode 557: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x0 from inode 557: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x0 from inode 557: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=577 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer kernel: Buffer I/O error on dev sdb1, logical block 786574, async page read Mar 26 15:26:04 blueplayer kernel: Buffer I/O error on dev sdb1, logical block 786574, async page read Mar 26 15:26:04 blueplayer kernel: Buffer I/O error on dev sdb1, logical block 4252947, async page read Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=591 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=620 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=638 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=659 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=675 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=690 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=707 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=725 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=739 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=756 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=770 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=784 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=798 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=831 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=847 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=873 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=887 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=904 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=920 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=943 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=957 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=974 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=992 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read of MFT, mft=1011 count=1 br=-1: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x5 from inode 38: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x0 from inode 5: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x0 from inode 5: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x0 from inode 5: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x0 from inode 5: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x0 from inode 5: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x0 from inode 5: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x0 from inode 5: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x0 from inode 5: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x0 from inode 5: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x0 from inode 5: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x0 from inode 5: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Failed to read vcn 0x0 from inode 5: Input/output error Mar 26 15:26:04 blueplayer volumio[943]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.3/1-1.1.3:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","ACTION":"remove","DEVLINKS":"/dev/disk/by-uuid/0052102052101CCA /dev/disk/by-id/usb-WDC_WD10_SPZX-00Z10T0_012345678999-0:0-part1 /dev/disk/by-path/platform-3f980000.usb-usb-0:1.1.3:1.0-scsi-0:0:0:0-part1 /dev/disk/by-partuuid/da09113e-01 /dev/disk/by-label/Dream\\x20High\\x20Audio","DEVNAME":"/dev/sdb1","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.3/1-1.1.3:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","DEVTYPE":"partition","DISKSEQ":"35","ID_BUS":"usb","ID_FS_LABEL":"Dream_High_Audio","ID_FS_LABEL_ENC":"Dream\\x20High\\x20Audio","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"0052102052101CCA","ID_FS_UUID_ENC":"0052102052101CCA","ID_INSTANCE":"0:0","ID_MODEL":"SPZX-00Z10T0","ID_MODEL_ENC":"SPZX-00Z10T0\\x20\\x20\\x20\\x20","ID_MODEL_ID":"9201","ID_PART_ENTRY_DISK":"8:16","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"1953519616","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"da09113e-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"da09113e","ID_PATH":"platform-3f980000.usb-usb-0:1.1.3:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_1_3_1_0-scsi-0_0_0_0","ID_REVISION":"1.02","ID_SERIAL":"WDC_WD10_SPZX-00Z10T0_012345678999-0:0","ID_SERIAL_SHORT":"012345678999","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"WDC_WD10","ID_VENDOR_ENC":"WDC\\x20WD10","ID_VENDOR_ID":"0bda","MAJOR":"8","MINOR":"17","PARTN":"1","SEQNUM":"1810","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"602056042"} Mar 26 15:26:04 blueplayer sudo[1885]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sdb1 Mar 26 15:26:04 blueplayer sudo[1885]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 15:26:04 blueplayer sudo[1885]: pam_unix(sudo:session): session closed for user root Mar 26 15:26:04 blueplayer systemd[1]: media-Dream_High_Audio.mount: Succeeded. Mar 26 15:26:04 blueplayer ntfs-3g[1819]: Unmounting /dev/sdb1 (Dream High Audio) Mar 26 15:26:05 blueplayer volumio[943]: info: MPD Database updated - AlbumList cache refreshed Mar 26 15:26:05 blueplayer volumio[943]: info: Mar 26 15:26:05 blueplayer volumio[943]: ---------------------------- MPD announces state update: database Mar 26 15:26:05 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:05 blueplayer volumio[943]: info: Mar 26 15:26:05 blueplayer volumio[943]: ---------------------------- MPD announces state update: update Mar 26 15:26:05 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:05 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:05 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:05 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:05 blueplayer volumio[943]: info: MPD Database updated - AlbumList cache refreshed Mar 26 15:26:05 blueplayer volumio[943]: info: Mar 26 15:26:05 blueplayer volumio[943]: ---------------------------- MPD announces state update: database Mar 26 15:26:05 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:05 blueplayer volumio[943]: info: Mar 26 15:26:05 blueplayer volumio[943]: ---------------------------- MPD announces state update: update Mar 26 15:26:05 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:05 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:05 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:05 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:07 blueplayer kernel: usb 1-1.1.3: new high-speed USB device number 15 using dwc_otg Mar 26 15:26:07 blueplayer kernel: usb 1-1.1.3: New USB device found, idVendor=0bda, idProduct=9201, bcdDevice=f2.00 Mar 26 15:26:07 blueplayer kernel: usb 1-1.1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Mar 26 15:26:07 blueplayer kernel: usb 1-1.1.3: Product: RTL9201 Mar 26 15:26:07 blueplayer kernel: usb 1-1.1.3: Manufacturer: Realtek Mar 26 15:26:07 blueplayer kernel: usb 1-1.1.3: SerialNumber: 012345678999 Mar 26 15:26:07 blueplayer kernel: usb-storage 1-1.1.3:1.0: USB Mass Storage device detected Mar 26 15:26:07 blueplayer kernel: scsi host1: usb-storage 1-1.1.3:1.0 Mar 26 15:26:08 blueplayer kernel: scsi 1:0:0:0: Direct-Access WDC WD10 SPZX-00Z10T0 1.02 PQ: 0 ANSI: 6 Mar 26 15:26:08 blueplayer kernel: sd 1:0:0:0: Attached scsi generic sg1 type 0 Mar 26 15:26:08 blueplayer kernel: sd 1:0:0:0: [sdb] 1953525168 512-byte logical blocks: (1.00 TB/932 GiB) Mar 26 15:26:08 blueplayer kernel: sd 1:0:0:0: [sdb] Write Protect is off Mar 26 15:26:08 blueplayer kernel: sd 1:0:0:0: [sdb] Mode Sense: 37 00 00 08 Mar 26 15:26:08 blueplayer kernel: sd 1:0:0:0: [sdb] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Mar 26 15:26:08 blueplayer kernel: sdb: sdb1 Mar 26 15:26:08 blueplayer kernel: sd 1:0:0:0: [sdb] Attached SCSI disk Mar 26 15:26:08 blueplayer volumio[943]: info: sendMpdCommand status took 8440 milliseconds Mar 26 15:26:08 blueplayer volumio[943]: info: sendMpdCommand status took 8447 milliseconds Mar 26 15:26:08 blueplayer volumio[943]: info: sendMpdCommand status took 8447 milliseconds Mar 26 15:26:08 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:09 blueplayer volumio[943]: info: Command Router : Notfying DB Updatetrue Mar 26 15:26:09 blueplayer volumio[943]: info: CoreCommandRouter::Close All Modals sent Mar 26 15:26:09 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:09 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:09 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:09 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:09 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:09 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:09 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:09 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:09 blueplayer volumio[943]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 26 15:26:09 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:09 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:09 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:09 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:09 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:09 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:09 blueplayer volumio[943]: info: No code Mar 26 15:26:09 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:09 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:09 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:09 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:09 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:09 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:09 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:09 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:09 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:09 blueplayer volumio[943]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 26 15:26:09 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:09 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:09 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:09 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:09 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:09 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:09 blueplayer volumio[943]: info: No code Mar 26 15:26:09 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:09 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:09 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:09 blueplayer volumio[943]: info: ------------------------------ 8609ms Mar 26 15:26:09 blueplayer volumio[943]: info: ------------------------------ 8610ms Mar 26 15:26:09 blueplayer volumio[943]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/Dream_High_Audio Mar 26 15:26:09 blueplayer volumio[943]: info: Mounting Device Dream_High_Audio Mar 26 15:26:09 blueplayer sudo[1900]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/Dream_High_Audio -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 26 15:26:09 blueplayer sudo[1900]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 15:26:09 blueplayer kernel: hwmon hwmon1: Voltage normalised Mar 26 15:26:10 blueplayer ntfs-3g[1903]: Version 2017.3.23AR.3 integrated FUSE 28 Mar 26 15:26:10 blueplayer ntfs-3g[1903]: Mounted /dev/sdb1 (Read-Write, label "Dream High Audio", NTFS 3.1) Mar 26 15:26:10 blueplayer ntfs-3g[1903]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 26 15:26:10 blueplayer ntfs-3g[1903]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sdb1,blkdev,blksize=4096 Mar 26 15:26:10 blueplayer ntfs-3g[1903]: Global ownership and permissions enforced, configuration type 7 Mar 26 15:26:10 blueplayer sudo[1900]: pam_unix(sudo:session): session closed for user root Mar 26 15:26:10 blueplayer volumio[943]: info: Scanning new location : "USB/Dream_High_Audio" Mar 26 15:26:10 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:10 blueplayer volumio[943]: info: Mar 26 15:26:10 blueplayer volumio[943]: ---------------------------- MPD announces state update: update Mar 26 15:26:10 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:10 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:10 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:10 blueplayer volumio[943]: info: Mar 26 15:26:10 blueplayer volumio[943]: ---------------------------- MPD announces state update: update Mar 26 15:26:10 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:10 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:11 blueplayer kernel: sd 1:0:0:0: [sdb] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=0s Mar 26 15:26:11 blueplayer kernel: sd 1:0:0:0: [sdb] tag#0 CDB: opcode=0x28 28 00 00 00 09 20 00 00 08 00 Mar 26 15:26:11 blueplayer kernel: blk_print_req_error: 61 callbacks suppressed Mar 26 15:26:11 blueplayer kernel: I/O error, dev sdb, sector 2336 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Mar 26 15:26:11 blueplayer kernel: usb 1-1.1.3: USB disconnect, device number 15 Mar 26 15:26:11 blueplayer ntfs-3g[1903]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:11 blueplayer ntfs-3g[1903]: Failed to read vcn 0x0 from inode 5: Input/output error Mar 26 15:26:11 blueplayer ntfs-3g[1903]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:11 blueplayer ntfs-3g[1903]: Failed to read vcn 0x0 from inode 5: Input/output error Mar 26 15:26:11 blueplayer kernel: buffer_io_error: 103 callbacks suppressed Mar 26 15:26:11 blueplayer kernel: Buffer I/O error on dev sdb1, logical block 36, async page read Mar 26 15:26:11 blueplayer kernel: Buffer I/O error on dev sdb1, logical block 36, async page read Mar 26 15:26:11 blueplayer ntfs-3g[1903]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:11 blueplayer ntfs-3g[1903]: Failed to read index block: Input/output error Mar 26 15:26:11 blueplayer kernel: Buffer I/O error on dev sdb1, logical block 36, async page read Mar 26 15:26:11 blueplayer kernel: hwmon hwmon1: Undervoltage detected! Mar 26 15:26:11 blueplayer volumio[943]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.3/1-1.1.3:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","ACTION":"remove","DEVLINKS":"/dev/disk/by-uuid/0052102052101CCA /dev/disk/by-id/usb-WDC_WD10_SPZX-00Z10T0_012345678999-0:0-part1 /dev/disk/by-path/platform-3f980000.usb-usb-0:1.1.3:1.0-scsi-0:0:0:0-part1 /dev/disk/by-partuuid/da09113e-01 /dev/disk/by-label/Dream\\x20High\\x20Audio","DEVNAME":"/dev/sdb1","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.3/1-1.1.3:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","DEVTYPE":"partition","DISKSEQ":"36","ID_BUS":"usb","ID_FS_LABEL":"Dream_High_Audio","ID_FS_LABEL_ENC":"Dream\\x20High\\x20Audio","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"0052102052101CCA","ID_FS_UUID_ENC":"0052102052101CCA","ID_INSTANCE":"0:0","ID_MODEL":"SPZX-00Z10T0","ID_MODEL_ENC":"SPZX-00Z10T0\\x20\\x20\\x20\\x20","ID_MODEL_ID":"9201","ID_PART_ENTRY_DISK":"8:16","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"1953519616","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"da09113e-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"da09113e","ID_PATH":"platform-3f980000.usb-usb-0:1.1.3:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_1_3_1_0-scsi-0_0_0_0","ID_REVISION":"1.02","ID_SERIAL":"WDC_WD10_SPZX-00Z10T0_012345678999-0:0","ID_SERIAL_SHORT":"012345678999","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"WDC_WD10","ID_VENDOR_ENC":"WDC\\x20WD10","ID_VENDOR_ID":"0bda","MAJOR":"8","MINOR":"17","PARTN":"1","SEQNUM":"1847","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"662211126"} Mar 26 15:26:11 blueplayer sudo[1909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sdb1 Mar 26 15:26:11 blueplayer sudo[1909]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 15:26:11 blueplayer ntfs-3g[1903]: Unmounting /dev/sdb1 (Dream High Audio) Mar 26 15:26:11 blueplayer systemd[1]: media-Dream_High_Audio.mount: Succeeded. Mar 26 15:26:11 blueplayer sudo[1909]: pam_unix(sudo:session): session closed for user root Mar 26 15:26:11 blueplayer volumio[943]: info: MPD Database updated - AlbumList cache refreshed Mar 26 15:26:11 blueplayer volumio[943]: info: Mar 26 15:26:11 blueplayer volumio[943]: ---------------------------- MPD announces state update: database Mar 26 15:26:11 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:11 blueplayer volumio[943]: info: Mar 26 15:26:11 blueplayer volumio[943]: ---------------------------- MPD announces state update: update Mar 26 15:26:11 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:11 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:11 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:11 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:11 blueplayer volumio[943]: info: MPD Database updated - AlbumList cache refreshed Mar 26 15:26:11 blueplayer volumio[943]: info: Mar 26 15:26:11 blueplayer volumio[943]: ---------------------------- MPD announces state update: database Mar 26 15:26:11 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:11 blueplayer volumio[943]: info: Mar 26 15:26:11 blueplayer volumio[943]: ---------------------------- MPD announces state update: update Mar 26 15:26:11 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:11 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:11 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:11 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:14 blueplayer kernel: usb 1-1.1.3: new high-speed USB device number 16 using dwc_otg Mar 26 15:26:14 blueplayer kernel: usb 1-1.1.3: New USB device found, idVendor=0bda, idProduct=9201, bcdDevice=f2.00 Mar 26 15:26:14 blueplayer kernel: usb 1-1.1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Mar 26 15:26:14 blueplayer kernel: usb 1-1.1.3: Product: RTL9201 Mar 26 15:26:14 blueplayer kernel: usb 1-1.1.3: Manufacturer: Realtek Mar 26 15:26:14 blueplayer kernel: usb 1-1.1.3: SerialNumber: 012345678999 Mar 26 15:26:14 blueplayer kernel: usb-storage 1-1.1.3:1.0: USB Mass Storage device detected Mar 26 15:26:14 blueplayer kernel: scsi host1: usb-storage 1-1.1.3:1.0 Mar 26 15:26:15 blueplayer kernel: scsi 1:0:0:0: Direct-Access WDC WD10 SPZX-00Z10T0 1.02 PQ: 0 ANSI: 6 Mar 26 15:26:15 blueplayer kernel: sd 1:0:0:0: Attached scsi generic sg1 type 0 Mar 26 15:26:15 blueplayer kernel: sd 1:0:0:0: [sdb] 1953525168 512-byte logical blocks: (1.00 TB/932 GiB) Mar 26 15:26:15 blueplayer kernel: sd 1:0:0:0: [sdb] Write Protect is off Mar 26 15:26:15 blueplayer kernel: sd 1:0:0:0: [sdb] Mode Sense: 37 00 00 08 Mar 26 15:26:15 blueplayer kernel: sd 1:0:0:0: [sdb] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Mar 26 15:26:15 blueplayer kernel: sdb: sdb1 Mar 26 15:26:15 blueplayer kernel: sd 1:0:0:0: [sdb] Attached SCSI disk Mar 26 15:26:15 blueplayer volumio[943]: info: sendMpdCommand status took 15287 milliseconds Mar 26 15:26:15 blueplayer volumio[943]: info: sendMpdCommand status took 15293 milliseconds Mar 26 15:26:15 blueplayer volumio[943]: info: sendMpdCommand status took 15292 milliseconds Mar 26 15:26:15 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:15 blueplayer volumio[943]: info: Command Router : Notfying DB Updatetrue Mar 26 15:26:15 blueplayer volumio[943]: info: CoreCommandRouter::Close All Modals sent Mar 26 15:26:15 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:15 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:15 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:15 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:15 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:15 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:15 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:15 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:15 blueplayer volumio[943]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 26 15:26:15 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:15 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:15 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:15 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:15 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:15 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:15 blueplayer volumio[943]: info: No code Mar 26 15:26:15 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:15 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:15 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:15 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:15 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:15 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:15 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:15 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:15 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:15 blueplayer volumio[943]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 26 15:26:15 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:15 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:15 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:15 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:15 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:15 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:15 blueplayer volumio[943]: info: No code Mar 26 15:26:15 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:15 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:15 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:16 blueplayer volumio[943]: info: ------------------------------ 15538ms Mar 26 15:26:16 blueplayer volumio[943]: info: ------------------------------ 15542ms Mar 26 15:26:16 blueplayer volumio[943]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/Dream_High_Audio Mar 26 15:26:16 blueplayer volumio[943]: info: Mounting Device Dream_High_Audio Mar 26 15:26:17 blueplayer sudo[1921]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/Dream_High_Audio -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 26 15:26:17 blueplayer sudo[1921]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 15:26:18 blueplayer ntfs-3g[1924]: Version 2017.3.23AR.3 integrated FUSE 28 Mar 26 15:26:18 blueplayer ntfs-3g[1924]: Mounted /dev/sdb1 (Read-Write, label "Dream High Audio", NTFS 3.1) Mar 26 15:26:18 blueplayer ntfs-3g[1924]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 26 15:26:18 blueplayer ntfs-3g[1924]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sdb1,blkdev,blksize=4096 Mar 26 15:26:18 blueplayer ntfs-3g[1924]: Global ownership and permissions enforced, configuration type 7 Mar 26 15:26:18 blueplayer sudo[1921]: pam_unix(sudo:session): session closed for user root Mar 26 15:26:19 blueplayer volumio[943]: info: CoreCommandRouter::volumioPlay Mar 26 15:26:19 blueplayer volumio[943]: info: CoreStateMachine::play index undefined Mar 26 15:26:19 blueplayer volumio[943]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 15:26:19 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:19 blueplayer kernel: usb 1-1.1.3: USB disconnect, device number 16 Mar 26 15:26:19 blueplayer ntpd[665]: Soliciting pool server 103.199.19.135 Mar 26 15:26:19 blueplayer ntfs-3g[1924]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:19 blueplayer kernel: Buffer I/O error on dev sdb1, logical block 36, async page read Mar 26 15:26:19 blueplayer kernel: Buffer I/O error on dev sdb1, logical block 36, async page read Mar 26 15:26:19 blueplayer ntfs-3g[1924]: Failed to read vcn 0x0 from inode 5: Input/output error Mar 26 15:26:19 blueplayer ntfs-3g[1924]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 26 15:26:19 blueplayer ntfs-3g[1924]: Failed to read index block: Input/output error Mar 26 15:26:19 blueplayer volumio[943]: info: Scanning removed location : "USB/Dream_High_Audio" Mar 26 15:26:19 blueplayer volumio[943]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.3/1-1.1.3:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","ACTION":"remove","DEVLINKS":"/dev/disk/by-uuid/0052102052101CCA /dev/disk/by-id/usb-WDC_WD10_SPZX-00Z10T0_012345678999-0:0-part1 /dev/disk/by-path/platform-3f980000.usb-usb-0:1.1.3:1.0-scsi-0:0:0:0-part1 /dev/disk/by-partuuid/da09113e-01 /dev/disk/by-label/Dream\\x20High\\x20Audio","DEVNAME":"/dev/sdb1","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.1/1-1.1.3/1-1.1.3:1.0/host1/target1:0:0/1:0:0:0/block/sdb/sdb1","DEVTYPE":"partition","DISKSEQ":"37","ID_BUS":"usb","ID_FS_LABEL":"Dream_High_Audio","ID_FS_LABEL_ENC":"Dream\\x20High\\x20Audio","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"0052102052101CCA","ID_FS_UUID_ENC":"0052102052101CCA","ID_INSTANCE":"0:0","ID_MODEL":"SPZX-00Z10T0","ID_MODEL_ENC":"SPZX-00Z10T0\\x20\\x20\\x20\\x20","ID_MODEL_ID":"9201","ID_PART_ENTRY_DISK":"8:16","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"1953519616","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"da09113e-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"da09113e","ID_PATH":"platform-3f980000.usb-usb-0:1.1.3:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_1_3_1_0-scsi-0_0_0_0","ID_REVISION":"1.02","ID_SERIAL":"WDC_WD10_SPZX-00Z10T0_012345678999-0:0","ID_SERIAL_SHORT":"012345678999","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"WDC_WD10","ID_VENDOR_ENC":"WDC\\x20WD10","ID_VENDOR_ID":"0bda","MAJOR":"8","MINOR":"17","PARTN":"1","SEQNUM":"1884","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"669097374"} Mar 26 15:26:19 blueplayer sudo[1929]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sdb1 Mar 26 15:26:19 blueplayer sudo[1929]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 15:26:19 blueplayer ntfs-3g[1924]: Unmounting /dev/sdb1 (Dream High Audio) Mar 26 15:26:19 blueplayer sudo[1929]: pam_unix(sudo:session): session closed for user root Mar 26 15:26:19 blueplayer systemd[1]: media-Dream_High_Audio.mount: Succeeded. Mar 26 15:26:19 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:19 blueplayer volumio[943]: info: Mar 26 15:26:19 blueplayer volumio[943]: ---------------------------- MPD announces state update: update Mar 26 15:26:19 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:19 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:19 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:19 blueplayer volumio[943]: info: Mar 26 15:26:19 blueplayer volumio[943]: ---------------------------- MPD announces state update: update Mar 26 15:26:19 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:19 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:20 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:20 blueplayer volumio[943]: info: Mar 26 15:26:20 blueplayer volumio[943]: ---------------------------- MPD announces state update: update Mar 26 15:26:20 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:20 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:20 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:20 blueplayer volumio[943]: info: Mar 26 15:26:20 blueplayer volumio[943]: ---------------------------- MPD announces state update: update Mar 26 15:26:20 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:20 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:21 blueplayer ntpd[665]: Soliciting pool server 103.184.124.254 Mar 26 15:26:22 blueplayer kernel: usb 1-1.1.3: new high-speed USB device number 17 using dwc_otg Mar 26 15:26:23 blueplayer kernel: usb 1-1.1.3: New USB device found, idVendor=0bda, idProduct=9201, bcdDevice=f2.00 Mar 26 15:26:23 blueplayer kernel: usb 1-1.1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Mar 26 15:26:23 blueplayer kernel: usb 1-1.1.3: Product: RTL9201 Mar 26 15:26:23 blueplayer kernel: usb 1-1.1.3: Manufacturer: Realtek Mar 26 15:26:23 blueplayer kernel: usb 1-1.1.3: SerialNumber: 012345678999 Mar 26 15:26:23 blueplayer kernel: usb-storage 1-1.1.3:1.0: USB Mass Storage device detected Mar 26 15:26:23 blueplayer kernel: scsi host1: usb-storage 1-1.1.3:1.0 Mar 26 15:26:23 blueplayer volumio[943]: info: sendMpdCommand status took 23127 milliseconds Mar 26 15:26:23 blueplayer volumio[943]: info: sendMpdCommand status took 23134 milliseconds Mar 26 15:26:23 blueplayer volumio[943]: info: sendMpdCommand status took 23134 milliseconds Mar 26 15:26:23 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:23 blueplayer volumio[943]: info: Command Router : Notfying DB Updatetrue Mar 26 15:26:23 blueplayer volumio[943]: info: CoreCommandRouter::Close All Modals sent Mar 26 15:26:23 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:23 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:23 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:23 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:23 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:23 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:23 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:23 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:23 blueplayer volumio[943]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 26 15:26:23 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:23 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:23 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:23 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:23 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:23 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:23 blueplayer volumio[943]: info: No code Mar 26 15:26:23 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:23 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:23 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:23 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:23 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:23 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:23 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:23 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:23 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:23 blueplayer volumio[943]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 26 15:26:23 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:23 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:23 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:23 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:23 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:23 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:23 blueplayer volumio[943]: info: No code Mar 26 15:26:23 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:23 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:23 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:23 blueplayer volumio[943]: info: ------------------------------ 23284ms Mar 26 15:26:23 blueplayer volumio[943]: info: ------------------------------ 23285ms Mar 26 15:26:23 blueplayer volumio[943]: info: MPD Database updated - AlbumList cache refreshed Mar 26 15:26:23 blueplayer volumio[943]: info: Mar 26 15:26:23 blueplayer volumio[943]: ---------------------------- MPD announces state update: database Mar 26 15:26:23 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:23 blueplayer volumio[943]: info: Mar 26 15:26:23 blueplayer volumio[943]: ---------------------------- MPD announces state update: update Mar 26 15:26:23 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:23 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:23 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:23 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:23 blueplayer volumio[943]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/Dream_High_Audio Mar 26 15:26:23 blueplayer volumio[943]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 26 15:26:23 blueplayer volumio[943]: info: CURURI: genres:// Mar 26 15:26:23 blueplayer volumio[943]: info: sendMpdCommand status took 18867 milliseconds Mar 26 15:26:23 blueplayer volumio[943]: info: sendMpdCommand status took 18864 milliseconds Mar 26 15:26:23 blueplayer volumio[943]: info: sendMpdCommand status took 18863 milliseconds Mar 26 15:26:23 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:23 blueplayer volumio[943]: info: Command Router : Notfying DB Updatefalse Mar 26 15:26:23 blueplayer volumio[943]: info: CoreCommandRouter::Close All Modals sent Mar 26 15:26:23 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:23 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:23 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:23 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:23 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:23 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:23 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:23 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:23 blueplayer volumio[943]: 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} Mar 26 15:26:23 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:23 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:23 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:23 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:23 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:23 blueplayer volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 15:26:23 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:23 blueplayer volumio[943]: info: No code Mar 26 15:26:23 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:23 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:23 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:23 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:23 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:23 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:23 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:23 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:23 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:23 blueplayer volumio[943]: 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} Mar 26 15:26:23 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:23 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:23 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:23 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:23 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:23 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:23 blueplayer volumio[943]: info: No code Mar 26 15:26:23 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:23 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:23 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: ------------------------------ 18961ms Mar 26 15:26:24 blueplayer volumio[943]: info: ------------------------------ 18961ms Mar 26 15:26:24 blueplayer volumio[943]: info: sendMpdCommand status took 18997 milliseconds Mar 26 15:26:24 blueplayer volumio[943]: info: sendMpdCommand status took 18994 milliseconds Mar 26 15:26:24 blueplayer volumio[943]: info: sendMpdCommand status took 18993 milliseconds Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:24 blueplayer volumio[943]: info: Command Router : Notfying DB Updatefalse Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::Close All Modals sent Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:24 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: 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} Mar 26 15:26:24 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: No code Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: 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} Mar 26 15:26:24 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: No code Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: ------------------------------ 19076ms Mar 26 15:26:24 blueplayer volumio[943]: info: ------------------------------ 19077ms Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:24 blueplayer volumio[943]: info: Mar 26 15:26:24 blueplayer volumio[943]: ---------------------------- MPD announces state update: update Mar 26 15:26:24 blueplayer volumio[943]: info: MPD Database updated - AlbumList cache refreshed Mar 26 15:26:24 blueplayer volumio[943]: info: Mar 26 15:26:24 blueplayer volumio[943]: ---------------------------- MPD announces state update: database Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:24 blueplayer volumio[943]: info: Mar 26 15:26:24 blueplayer volumio[943]: ---------------------------- MPD announces state update: update Mar 26 15:26:24 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:24 blueplayer volumio[943]: info: sendMpdCommand status took 13350 milliseconds Mar 26 15:26:24 blueplayer volumio[943]: info: sendMpdCommand status took 13341 milliseconds Mar 26 15:26:24 blueplayer volumio[943]: info: sendMpdCommand status took 13340 milliseconds Mar 26 15:26:24 blueplayer volumio[943]: info: sendMpdCommand status took 13337 milliseconds Mar 26 15:26:24 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:24 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:24 blueplayer volumio[943]: info: Command Router : Notfying DB Updatetrue Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::Close All Modals sent Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:24 blueplayer kernel: scsi 1:0:0:0: Direct-Access WDC WD10 SPZX-00Z10T0 1.02 PQ: 0 ANSI: 6 Mar 26 15:26:24 blueplayer kernel: scsi 1:0:0:0: Attached scsi generic sg1 type 0 Mar 26 15:26:24 blueplayer kernel: sd 1:0:0:0: [sdb] 1953525168 512-byte logical blocks: (1.00 TB/932 GiB) Mar 26 15:26:24 blueplayer kernel: sd 1:0:0:0: [sdb] Write Protect is off Mar 26 15:26:24 blueplayer kernel: sd 1:0:0:0: [sdb] Mode Sense: 37 00 00 08 Mar 26 15:26:24 blueplayer kernel: sd 1:0:0:0: [sdb] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Mar 26 15:26:24 blueplayer volumio[943]: info: Command Router : Notfying DB Updatetrue Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::Close All Modals sent Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:24 blueplayer kernel: sdb: sdb1 Mar 26 15:26:24 blueplayer kernel: sd 1:0:0:0: [sdb] Attached SCSI disk Mar 26 15:26:24 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 26 15:26:24 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: No code Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 26 15:26:24 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: No code Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: ------------------------------ 13569ms Mar 26 15:26:24 blueplayer volumio[943]: info: ------------------------------ 13561ms Mar 26 15:26:24 blueplayer volumio[943]: info: sendMpdCommand status took 12465 milliseconds Mar 26 15:26:24 blueplayer volumio[943]: info: sendMpdCommand status took 12460 milliseconds Mar 26 15:26:24 blueplayer volumio[943]: info: sendMpdCommand status took 12459 milliseconds Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:24 blueplayer volumio[943]: info: Command Router : Notfying DB Updatefalse Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::Close All Modals sent Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:24 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: 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} Mar 26 15:26:24 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: No code Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: 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} Mar 26 15:26:24 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: No code Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: ------------------------------ 12557ms Mar 26 15:26:24 blueplayer volumio[943]: info: ------------------------------ 12557ms Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:24 blueplayer volumio[943]: info: Mar 26 15:26:24 blueplayer volumio[943]: ---------------------------- MPD announces state update: update Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:24 blueplayer volumio[943]: info: Mar 26 15:26:24 blueplayer volumio[943]: ---------------------------- MPD announces state update: update Mar 26 15:26:24 blueplayer volumio[943]: info: sendMpdCommand status took 12568 milliseconds Mar 26 15:26:24 blueplayer volumio[943]: info: sendMpdCommand status took 12565 milliseconds Mar 26 15:26:24 blueplayer volumio[943]: info: sendMpdCommand status took 12563 milliseconds Mar 26 15:26:24 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:24 blueplayer volumio[943]: info: sendMpdCommand status took 4657 milliseconds Mar 26 15:26:24 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:24 blueplayer volumio[943]: info: sendMpdCommand status took 4647 milliseconds Mar 26 15:26:24 blueplayer volumio[943]: info: sendMpdCommand status took 4645 milliseconds Mar 26 15:26:24 blueplayer volumio[943]: info: sendMpdCommand status took 4642 milliseconds Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:24 blueplayer volumio[943]: info: Command Router : Notfying DB Updatefalse Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::Close All Modals sent Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:24 blueplayer volumio[943]: info: Command Router : Notfying DB Updatefalse Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::Close All Modals sent Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:24 blueplayer volumio[943]: info: Command Router : Notfying DB Updatefalse Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::Close All Modals sent Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:24 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: 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} Mar 26 15:26:24 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: No code Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: 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} Mar 26 15:26:24 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: No code Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: 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} Mar 26 15:26:24 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: No code Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: 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} Mar 26 15:26:24 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: No code Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: ------------------------------ 12749ms Mar 26 15:26:24 blueplayer volumio[943]: info: ------------------------------ 12750ms Mar 26 15:26:24 blueplayer volumio[943]: info: ------------------------------ 4837ms Mar 26 15:26:24 blueplayer volumio[943]: info: ------------------------------ 4825ms Mar 26 15:26:24 blueplayer volumio[943]: info: sendMpdCommand status took 4563 milliseconds Mar 26 15:26:24 blueplayer volumio[943]: info: sendMpdCommand status took 4558 milliseconds Mar 26 15:26:24 blueplayer volumio[943]: info: sendMpdCommand status took 4554 milliseconds Mar 26 15:26:24 blueplayer volumio[943]: info: sendMpdCommand status took 4549 milliseconds Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:24 blueplayer volumio[943]: info: Command Router : Notfying DB Updatefalse Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::Close All Modals sent Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:24 blueplayer volumio[943]: info: Command Router : Notfying DB Updatefalse Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::Close All Modals sent Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:24 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: 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} Mar 26 15:26:24 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: No code Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: 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} Mar 26 15:26:24 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: No code Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: ------------------------------ 4671ms Mar 26 15:26:24 blueplayer volumio[943]: info: ------------------------------ 4662ms Mar 26 15:26:24 blueplayer volumio[943]: info: sendMpdCommand status took 1077 milliseconds Mar 26 15:26:24 blueplayer volumio[943]: info: sendMpdCommand status took 1072 milliseconds Mar 26 15:26:24 blueplayer volumio[943]: info: sendMpdCommand status took 1073 milliseconds Mar 26 15:26:24 blueplayer volumio[943]: info: sendMpdCommand status took 767 milliseconds Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:24 blueplayer volumio[943]: info: Command Router : Notfying DB Updatefalse Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::Close All Modals sent Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:24 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:24 blueplayer volumio[943]: info: Command Router : Notfying DB Updatefalse Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::Close All Modals sent Mar 26 15:26:24 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: 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} Mar 26 15:26:24 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: No code Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: 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} Mar 26 15:26:24 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:24 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:24 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:24 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:25 blueplayer volumio[943]: info: No code Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:25 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:25 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:25 blueplayer volumio[943]: info: ------------------------------ 1190ms Mar 26 15:26:25 blueplayer volumio[943]: info: ------------------------------ 1189ms Mar 26 15:26:25 blueplayer volumio[943]: info: Preload queue cleared Mar 26 15:26:25 blueplayer volumio[943]: info: sendMpdCommand status took 942 milliseconds Mar 26 15:26:25 blueplayer volumio[943]: info: sendMpdCommand status took 940 milliseconds Mar 26 15:26:25 blueplayer volumio[943]: info: sendMpdCommand status took 938 milliseconds Mar 26 15:26:25 blueplayer volumio[943]: info: sendMpdCommand status took 938 milliseconds Mar 26 15:26:25 blueplayer volumio[943]: info: sendMpdCommand status took 547 milliseconds Mar 26 15:26:25 blueplayer volumio[943]: info: sendMpdCommand status took 546 milliseconds Mar 26 15:26:25 blueplayer volumio[943]: info: sendMpdCommand status took 544 milliseconds Mar 26 15:26:25 blueplayer volumio[943]: info: sendMpdCommand status took 543 milliseconds Mar 26 15:26:25 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:25 blueplayer volumio[943]: info: Command Router : Notfying DB Updatefalse Mar 26 15:26:25 blueplayer volumio[943]: info: CoreCommandRouter::Close All Modals sent Mar 26 15:26:25 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:25 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:25 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:25 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:25 blueplayer volumio[943]: info: Command Router : Notfying DB Updatefalse Mar 26 15:26:25 blueplayer volumio[943]: info: CoreCommandRouter::Close All Modals sent Mar 26 15:26:25 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:25 blueplayer volumio[943]: info: Command Router : Notfying DB Updatefalse Mar 26 15:26:25 blueplayer volumio[943]: info: CoreCommandRouter::Close All Modals sent Mar 26 15:26:25 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:25 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:25 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:25 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:25 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:25 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:25 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:25 blueplayer volumio[943]: 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} Mar 26 15:26:25 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:25 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:25 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:25 blueplayer volumio[943]: info: No code Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:25 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:25 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:25 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:25 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:25 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:25 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:25 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:25 blueplayer volumio[943]: 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} Mar 26 15:26:25 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:25 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:25 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:25 blueplayer volumio[943]: info: No code Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:25 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:25 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:25 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:25 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:25 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:25 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:25 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:25 blueplayer volumio[943]: 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} Mar 26 15:26:25 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:25 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:25 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:25 blueplayer volumio[943]: info: No code Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:25 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:25 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:25 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:25 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:25 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:25 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:25 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:25 blueplayer volumio[943]: 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} Mar 26 15:26:25 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:25 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:25 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:25 blueplayer volumio[943]: info: No code Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:25 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:25 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:25 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:25 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:25 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:25 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:25 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:25 blueplayer volumio[943]: 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} Mar 26 15:26:25 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:25 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:25 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:25 blueplayer volumio[943]: info: No code Mar 26 15:26:25 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:25 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:25 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:25 blueplayer volumio[943]: info: ------------------------------ 1122ms Mar 26 15:26:25 blueplayer volumio[943]: info: ------------------------------ 1122ms Mar 26 15:26:25 blueplayer volumio[943]: info: ------------------------------ 1123ms Mar 26 15:26:25 blueplayer volumio[943]: info: ------------------------------ 727ms Mar 26 15:26:25 blueplayer volumio[943]: info: ------------------------------ 727ms Mar 26 15:26:25 blueplayer volumio[943]: info: Mounting Device Dream_High_Audio Mar 26 15:26:25 blueplayer sudo[1972]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/Dream_High_Audio -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 26 15:26:25 blueplayer sudo[1972]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 15:26:26 blueplayer ntfs-3g[1975]: Version 2017.3.23AR.3 integrated FUSE 28 Mar 26 15:26:26 blueplayer ntfs-3g[1975]: Mounted /dev/sdb1 (Read-Write, label "Dream High Audio", NTFS 3.1) Mar 26 15:26:26 blueplayer ntfs-3g[1975]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 26 15:26:26 blueplayer ntfs-3g[1975]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sdb1,blkdev,blksize=4096 Mar 26 15:26:26 blueplayer ntfs-3g[1975]: Global ownership and permissions enforced, configuration type 7 Mar 26 15:26:26 blueplayer sudo[1972]: pam_unix(sudo:session): session closed for user root Mar 26 15:26:26 blueplayer volumio[943]: info: Scanning new location : "USB/Dream_High_Audio" Mar 26 15:26:26 blueplayer volumio[943]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Mar 26 15:26:26 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:26 blueplayer volumio[943]: info: Mar 26 15:26:26 blueplayer volumio[943]: ---------------------------- MPD announces state update: update Mar 26 15:26:26 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:26 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:27 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:27 blueplayer volumio[943]: info: Mar 26 15:26:27 blueplayer volumio[943]: ---------------------------- MPD announces state update: update Mar 26 15:26:27 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:27 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:27 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:27 blueplayer volumio[943]: info: Mar 26 15:26:27 blueplayer volumio[943]: ---------------------------- MPD announces state update: update Mar 26 15:26:27 blueplayer volumio[943]: info: ControllerMpd::getState Mar 26 15:26:27 blueplayer volumio[943]: verbose: ControllerMpd::sendMpdCommand status Mar 26 15:26:27 blueplayer volumio[943]: info: sendMpdCommand status took 20 milliseconds Mar 26 15:26:27 blueplayer volumio[943]: info: sendMpdCommand status took 19 milliseconds Mar 26 15:26:27 blueplayer volumio[943]: info: sendMpdCommand status took 17 milliseconds Mar 26 15:26:27 blueplayer volumio[943]: info: sendMpdCommand status took 15 milliseconds Mar 26 15:26:27 blueplayer volumio[943]: info: sendMpdCommand status took 14 milliseconds Mar 26 15:26:27 blueplayer volumio[943]: info: sendMpdCommand status took 12 milliseconds Mar 26 15:26:27 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:27 blueplayer volumio[943]: info: Command Router : Notfying DB Updatetrue Mar 26 15:26:27 blueplayer volumio[943]: info: CoreCommandRouter::Close All Modals sent Mar 26 15:26:27 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:27 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:27 blueplayer volumio[943]: info: Command Router : Notfying DB Updatetrue Mar 26 15:26:27 blueplayer volumio[943]: info: CoreCommandRouter::Close All Modals sent Mar 26 15:26:27 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:27 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:27 blueplayer volumio[943]: info: Command Router : Notfying DB Updatetrue Mar 26 15:26:27 blueplayer volumio[943]: info: CoreCommandRouter::Close All Modals sent Mar 26 15:26:27 blueplayer volumio[943]: verbose: ControllerMpd::parseState Mar 26 15:26:27 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:27 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:27 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:27 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:27 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:27 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:27 blueplayer volumio[943]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 26 15:26:27 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:27 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:27 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:27 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:27 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:27 blueplayer volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 15:26:27 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:27 blueplayer volumio[943]: info: No code Mar 26 15:26:27 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:27 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:27 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:27 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:27 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:27 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:27 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:27 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:27 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:27 blueplayer volumio[943]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 26 15:26:27 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:27 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:27 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:27 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:27 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:27 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:27 blueplayer volumio[943]: info: No code Mar 26 15:26:27 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:27 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:27 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:27 blueplayer volumio[943]: info: ControllerMpd::pushState Mar 26 15:26:27 blueplayer volumio[943]: info: CoreCommandRouter::servicePushState Mar 26 15:26:27 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:27 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:27 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:27 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:27 blueplayer volumio[943]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 26 15:26:27 blueplayer volumio[943]: verbose: CURRENT POSITION 0 Mar 26 15:26:27 blueplayer volumio[943]: info: CoreStateMachine::syncState stateService stop Mar 26 15:26:27 blueplayer volumio[943]: info: CoreStateMachine::syncState currentStatus stop Mar 26 15:26:27 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:27 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:27 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:27 blueplayer volumio[943]: info: No code Mar 26 15:26:27 blueplayer volumio[943]: info: CoreStateMachine::pushState Mar 26 15:26:27 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:27 blueplayer volumio[943]: info: CoreCommandRouter::volumioPushState Mar 26 15:26:27 blueplayer volumio[943]: info: ------------------------------ 350ms Mar 26 15:26:27 blueplayer volumio[943]: info: ------------------------------ 348ms Mar 26 15:26:27 blueplayer volumio[943]: info: ------------------------------ 345ms Mar 26 15:26:30 blueplayer ntpd[665]: Soliciting pool server 115.165.161.155 Mar 26 15:26:30 blueplayer ntpd[665]: Soliciting pool server 103.199.19.135 Mar 26 15:26:32 blueplayer kernel: hwmon hwmon1: Voltage normalised Mar 26 15:26:33 blueplayer volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 26 15:26:33 blueplayer volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 26 15:26:33 blueplayer volumio[943]: info: Discovery: Getting this device information Mar 26 15:26:33 blueplayer volumio[943]: info: CoreCommandRouter::volumioGetState Mar 26 15:26:33 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:26:33 blueplayer volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 26 15:26:47 blueplayer kernel: hwmon hwmon1: Undervoltage detected! Mar 26 15:26:53 blueplayer kernel: hwmon hwmon1: Voltage normalised Mar 26 15:27:03 blueplayer volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 26 15:27:03 blueplayer volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 26 15:27:03 blueplayer volumio[943]: info: Discovery: Getting this device information Mar 26 15:27:03 blueplayer volumio[943]: info: CoreCommandRouter::volumioGetState Mar 26 15:27:03 blueplayer volumio[943]: info: CorePlayQueue::getTrack 0 Mar 26 15:27:03 blueplayer volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 26 15:27:04 blueplayer volumio[943]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 26 15:27:04 blueplayer volumio[943]: info: CURURI: genres://Acoustic Mar 26 15:27:04 blueplayer volumio[943]: info: Preload queue cleared Mar 26 15:27:04 blueplayer volumio[943]: info: Preload queue cleared Mar 26 15:27:05 blueplayer volumio[943]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 26 15:27:05 blueplayer volumio[943]: Error: certificate is not yet valid Mar 26 15:27:05 blueplayer volumio[943]: at TLSSocket.onConnectSecure (_tls_wrap.js:1497:34) Mar 26 15:27:05 blueplayer volumio[943]: at TLSSocket.emit (events.js:315:20) Mar 26 15:27:05 blueplayer volumio[943]: at TLSSocket._finishInit (_tls_wrap.js:932:8) Mar 26 15:27:05 blueplayer volumio[943]: at TLSWrap.ssl.onhandshakedone (_tls_wrap.js:706:12) { Mar 26 15:27:05 blueplayer volumio[943]: code: 'CERT_NOT_YET_VALID' Mar 26 15:27:05 blueplayer volumio[943]: } Mar 26 15:27:05 blueplayer volumio[943]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 26 15:27:05 blueplayer kernel: hwmon hwmon1: Undervoltage detected! Mar 26 15:27:06 blueplayer sudo[2039]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-26 15:26 Mar 26 15:27:06 blueplayer sudo[2039]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"