-- Logs begin at Fri 2024-10-25 14:29:06 CEST, end at Fri 2024-10-25 14:45:07 CEST. -- Oct 25 14:44:00 volumio kernel: sd 0:0:0:0: [sda] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=0s Oct 25 14:44:00 volumio kernel: sd 0:0:0:0: [sda] tag#0 CDB: opcode=0x28 28 00 00 59 f6 a0 00 00 80 00 Oct 25 14:44:00 volumio kernel: I/O error, dev sda, sector 5895840 op 0x0:(READ) flags 0x80700 phys_seg 2 prio class 2 Oct 25 14:44:00 volumio kernel: usb 1-1.4: USB disconnect, device number 30 Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread error reading '/Bob-Bobek/S03E04 - V manezi.avi' at offset 79351808: 32768 <> -1: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio kernel: buffer_io_error: 42 callbacks suppressed Oct 25 14:44:01 volumio kernel: Buffer I/O error on dev sda1, logical block 736724, async page read Oct 25 14:44:01 volumio kernel: Buffer I/O error on dev sda1, logical block 736724, async page read Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread error reading '/Bob-Bobek/S03E04 - V manezi.avi' at offset 79351808: 4096 <> -1: Input/output error Oct 25 14:44:01 volumio volumio[1123]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/ata-FUJITSU_MHV2120BH_PL_NW9ST7327KTF-part1 /dev/disk/by-path/platform-3f980000.usb-usb-0:1.4:1.0-scsi-0:0:0:0-part1 /dev/disk/by-uuid/8C7E5B047E5AE70C /dev/disk/by-label/ServiceV002 /dev/disk/by-partuuid/95f3457a-01","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"53","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_AAM":"1","ID_ATA_FEATURE_SET_AAM_CURRENT_VALUE":"254","ID_ATA_FEATURE_SET_AAM_ENABLED":"1","ID_ATA_FEATURE_SET_AAM_VENDOR_RECOMMENDED_VALUE":"254","ID_ATA_FEATURE_SET_APM":"1","ID_ATA_FEATURE_SET_APM_CURRENT_VALUE":"128","ID_ATA_FEATURE_SET_APM_ENABLED":"1","ID_ATA_FEATURE_SET_HPA":"1","ID_ATA_FEATURE_SET_HPA_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"120","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_FS_LABEL":"ServiceV002","ID_FS_LABEL_ENC":"ServiceV002","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"8C7E5B047E5AE70C","ID_FS_UUID_ENC":"8C7E5B047E5AE70C","ID_MODEL":"FUJITSU_MHV2120BH_PL","ID_MODEL_ENC":"FUJITSU\\x20MHV2120BH\\x20PL\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"12351488","ID_PART_ENTRY_TYPE":"0x27","ID_PART_ENTRY_UUID":"95f3457a-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"95f3457a","ID_PATH":"platform-3f980000.usb-usb-0:1.4:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_4_1_0-scsi-0_0_0_0","ID_REVISION":"0084002A","ID_SERIAL":"FUJITSU_MHV2120BH_PL_NW9ST7327KTF","ID_SERIAL_SHORT":"NW9ST7327KTF","ID_TYPE":"disk","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"2934","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"351200154"} Oct 25 14:44:01 volumio kernel: Buffer I/O error on dev sda1, logical block 736724, async page read Oct 25 14:44:01 volumio kernel: Buffer I/O error on dev sda1, logical block 736724, async page read Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread error reading '/Bob-Bobek/S03E04 - V manezi.avi' at offset 79351808: 4096 <> -1: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread error reading '/Bob-Bobek/S03E04 - V manezi.avi' at offset 79351808: 4096 <> -1: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio kernel: Buffer I/O error on dev sda1, logical block 736808, async page read Oct 25 14:44:01 volumio kernel: Buffer I/O error on dev sda1, logical block 736808, async page read Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread error reading '/Bob-Bobek/S03E04 - V manezi.avi' at offset 79695872: 4096 <> -1: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread error reading '/Bob-Bobek/S03E04 - V manezi.avi' at offset 79695872: 4096 <> -1: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread error reading '/Bob-Bobek/S03E04 - V manezi.avi' at offset 79695872: 4096 <> -1: Input/output error Oct 25 14:44:01 volumio kernel: Buffer I/O error on dev sda1, logical block 736808, async page read Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread error reading '/Bob-Bobek/S03E04 - V manezi.avi' at offset 98304: 131072 <> -1: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread error reading '/Bob-Bobek/S03E04 - V manezi.avi' at offset 229376: 8192 <> -1: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread error reading '/Bob-Bobek/S03E04 - V manezi.avi' at offset 237568: 131072 <> -1: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio kernel: Buffer I/O error on dev sda1, logical block 717375, async page read Oct 25 14:44:01 volumio kernel: Buffer I/O error on dev sda1, logical block 717407, async page read Oct 25 14:44:01 volumio kernel: Buffer I/O error on dev sda1, logical block 717409, async page read Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread error reading '/Bob-Bobek/S03E04 - V manezi.avi' at offset 368640: 131072 <> -1: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread error reading '/Bob-Bobek/S03E04 - V manezi.avi' at offset 98304: 4096 <> -1: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread error reading '/Bob-Bobek/S03E04 - V manezi.avi' at offset 98304: 4096 <> -1: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread error reading '/Bob-Bobek/S03E04 - V manezi.avi' at offset 98304: 4096 <> -1: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread error reading '/Bob-Bobek/S03E04 - V manezi.avi' at offset 98304: 4096 <> -1: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread error reading '/Bob-Bobek/S03E04 - V manezi.avi' at offset 98304: 4096 <> -1: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread error reading '/Bob-Bobek/S03E04 - V manezi.avi' at offset 79695872: 4096 <> -1: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread error reading '/Bob-Bobek/S03E04 - V manezi.avi' at offset 79695872: 4096 <> -1: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread error reading '/Bob-Bobek/S03E04 - V manezi.avi' at offset 79695872: 4096 <> -1: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread error reading '/Bob-Bobek/S03E04 - V manezi.avi' at offset 79695872: 4096 <> -1: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: Failed to read vcn 0x3 from inode 44: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: Failed to read vcn 0x3 from inode 44: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: Failed to read vcn 0x3 from inode 44: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: Failed to read vcn 0x3 from inode 44: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: Failed to read vcn 0x3 from inode 44: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: Failed to read vcn 0x3 from inode 44: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: Failed to read vcn 0x3 from inode 44: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: Failed to read vcn 0x3 from inode 44: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: Failed to read vcn 0x3 from inode 44: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: Failed to read vcn 0x3 from inode 44: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: Failed to read vcn 0x3 from inode 44: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: Failed to read vcn 0x3 from inode 44: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: Failed to read vcn 0x3 from inode 44: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: Failed to read vcn 0x3 from inode 44: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: Failed to read vcn 0x3 from inode 44: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: Failed to read vcn 0x0 from inode 5: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: Failed to read vcn 0x0 from inode 5: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: Failed to read vcn 0x0 from inode 5: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: Failed to read vcn 0x0 from inode 5: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: Failed to read vcn 0x0 from inode 5: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: Failed to read vcn 0x0 from inode 5: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3495]: Failed to read vcn 0x0 from inode 5: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3503]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3503]: Failed to read vcn 0x0 from inode 5: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3503]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:01 volumio ntfs-3g[3503]: Failed to read index block: Input/output error Oct 25 14:44:01 volumio sudo[3536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1 Oct 25 14:44:01 volumio sudo[3536]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:01 volumio ntfs-3g[3495]: Unmounting /dev/sda1 (ServiceV002) Oct 25 14:44:01 volumio sudo[3536]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:01 volumio systemd[1]: media-ServiceV002.mount: Succeeded. Oct 25 14:44:01 volumio volumio[1123]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","ACTION":"remove","DEVLINKS":"/dev/disk/by-path/platform-3f980000.usb-usb-0:1.4:1.0-scsi-0:0:0:0-part2 /dev/disk/by-label/Zaloha2 /dev/disk/by-uuid/1448E55C48E53CDC /dev/disk/by-id/ata-FUJITSU_MHV2120BH_PL_NW9ST7327KTF-part2 /dev/disk/by-partuuid/95f3457a-02","DEVNAME":"/dev/sda2","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","DEVTYPE":"partition","DISKSEQ":"53","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_AAM":"1","ID_ATA_FEATURE_SET_AAM_CURRENT_VALUE":"254","ID_ATA_FEATURE_SET_AAM_ENABLED":"1","ID_ATA_FEATURE_SET_AAM_VENDOR_RECOMMENDED_VALUE":"254","ID_ATA_FEATURE_SET_APM":"1","ID_ATA_FEATURE_SET_APM_CURRENT_VALUE":"128","ID_ATA_FEATURE_SET_APM_ENABLED":"1","ID_ATA_FEATURE_SET_HPA":"1","ID_ATA_FEATURE_SET_HPA_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"120","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_FS_LABEL":"Zaloha2","ID_FS_LABEL_ENC":"Zaloha2","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"1448E55C48E53CDC","ID_FS_UUID_ENC":"1448E55C48E53CDC","ID_MODEL":"FUJITSU_MHV2120BH_PL","ID_MODEL_ENC":"FUJITSU\\x20MHV2120BH\\x20PL\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_FLAGS":"0x80","ID_PART_ENTRY_NUMBER":"2","ID_PART_ENTRY_OFFSET":"12353536","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"222083072","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"95f3457a-02","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"95f3457a","ID_PATH":"platform-3f980000.usb-usb-0:1.4:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_4_1_0-scsi-0_0_0_0","ID_REVISION":"0084002A","ID_SERIAL":"FUJITSU_MHV2120BH_PL_NW9ST7327KTF","ID_SERIAL_SHORT":"NW9ST7327KTF","ID_TYPE":"disk","MAJOR":"8","MINOR":"2","PARTN":"2","SEQNUM":"2935","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"351200605"} Oct 25 14:44:01 volumio go-librespot[1945]: time="2024-10-25T14:44:01+02:00" level=error msg="did not receive last pong from dealer, 150s passed" Oct 25 14:44:01 volumio sudo[3540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda2 Oct 25 14:44:01 volumio sudo[3540]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:01 volumio ntfs-3g[3503]: Unmounting /dev/sda2 (Zaloha2) Oct 25 14:44:01 volumio systemd[1]: media-Zaloha2.mount: Succeeded. Oct 25 14:44:01 volumio sudo[3540]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:01 volumio volumio[1123]: info: MPD Database updated - AlbumList cache refreshed Oct 25 14:44:01 volumio volumio[1123]: info: Oct 25 14:44:01 volumio volumio[1123]: ---------------------------- MPD announces state update: database Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:01 volumio volumio[1123]: info: Oct 25 14:44:01 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:01 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:01 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:01 volumio volumio[1123]: info: MPD Database updated - AlbumList cache refreshed Oct 25 14:44:01 volumio volumio[1123]: info: Oct 25 14:44:01 volumio volumio[1123]: ---------------------------- MPD announces state update: database Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:01 volumio volumio[1123]: info: Oct 25 14:44:01 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:01 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:01 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:01 volumio volumio[1123]: info: MPD Database updated - AlbumList cache refreshed Oct 25 14:44:01 volumio volumio[1123]: info: Oct 25 14:44:01 volumio volumio[1123]: ---------------------------- MPD announces state update: database Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:01 volumio volumio[1123]: info: Oct 25 14:44:01 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:01 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:01 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:01 volumio volumio[1123]: info: MPD Database updated - AlbumList cache refreshed Oct 25 14:44:01 volumio volumio[1123]: info: Oct 25 14:44:01 volumio volumio[1123]: ---------------------------- MPD announces state update: database Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:01 volumio volumio[1123]: info: Oct 25 14:44:01 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:01 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:01 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:01 volumio volumio[1123]: info: Oct 25 14:44:01 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:01 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:01 volumio volumio[1123]: info: sendMpdCommand status took 54 milliseconds Oct 25 14:44:01 volumio volumio[1123]: info: sendMpdCommand status took 52 milliseconds Oct 25 14:44:01 volumio volumio[1123]: info: sendMpdCommand status took 52 milliseconds Oct 25 14:44:01 volumio volumio[1123]: info: sendMpdCommand status took 49 milliseconds Oct 25 14:44:01 volumio volumio[1123]: info: sendMpdCommand status took 48 milliseconds Oct 25 14:44:01 volumio volumio[1123]: info: sendMpdCommand status took 48 milliseconds Oct 25 14:44:01 volumio volumio[1123]: info: sendMpdCommand status took 46 milliseconds Oct 25 14:44:01 volumio volumio[1123]: info: sendMpdCommand status took 45 milliseconds Oct 25 14:44:01 volumio volumio[1123]: info: sendMpdCommand status took 45 milliseconds Oct 25 14:44:01 volumio volumio[1123]: info: sendMpdCommand status took 43 milliseconds Oct 25 14:44:01 volumio volumio[1123]: info: sendMpdCommand status took 42 milliseconds Oct 25 14:44:01 volumio volumio[1123]: info: sendMpdCommand status took 42 milliseconds Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:01 volumio volumio[1123]: info: Command Router : Notfying DB Updatefalse Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:01 volumio volumio[1123]: info: Command Router : Notfying DB Updatefalse Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:01 volumio volumio[1123]: info: Command Router : Notfying DB Updatefalse Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:01 volumio volumio[1123]: info: Command Router : Notfying DB Updatefalse Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:01 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:01 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:01 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:01 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:01 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:01 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:01 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:01 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:01 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:01 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:01 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:01 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:01 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:01 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:01 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:01 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:01 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:01 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:01 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:01 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:01 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:01 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:01 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:01 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:01 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:01 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:01 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:01 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:01 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:01 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:01 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:01 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:01 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:01 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:01 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:01 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:01 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:01 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:01 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:01 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:01 volumio volumio[1123]: info: ------------------------------ 367ms Oct 25 14:44:01 volumio volumio[1123]: info: ------------------------------ 368ms Oct 25 14:44:01 volumio volumio[1123]: info: ------------------------------ 364ms Oct 25 14:44:01 volumio volumio[1123]: info: ------------------------------ 364ms Oct 25 14:44:01 volumio volumio[1123]: info: ------------------------------ 361ms Oct 25 14:44:01 volumio volumio[1123]: info: ------------------------------ 362ms Oct 25 14:44:01 volumio volumio[1123]: info: ------------------------------ 358ms Oct 25 14:44:01 volumio volumio[1123]: info: ------------------------------ 359ms Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:01 volumio volumio[1123]: info: Oct 25 14:44:01 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:01 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:01 volumio volumio[1123]: info: Oct 25 14:44:01 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:01 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:01 volumio volumio[1123]: info: Oct 25 14:44:01 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:01 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:01 volumio volumio[1123]: info: sendMpdCommand status took 364 milliseconds Oct 25 14:44:01 volumio volumio[1123]: info: sendMpdCommand status took 334 milliseconds Oct 25 14:44:01 volumio volumio[1123]: info: sendMpdCommand status took 13 milliseconds Oct 25 14:44:01 volumio volumio[1123]: info: sendMpdCommand status took 11 milliseconds Oct 25 14:44:01 volumio volumio[1123]: info: sendMpdCommand status took 10 milliseconds Oct 25 14:44:01 volumio volumio[1123]: info: sendMpdCommand status took 10 milliseconds Oct 25 14:44:01 volumio volumio[1123]: info: sendMpdCommand status took 8 milliseconds Oct 25 14:44:01 volumio volumio[1123]: info: sendMpdCommand status took 7 milliseconds Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:01 volumio volumio[1123]: info: Command Router : Notfying DB Updatefalse Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:01 volumio volumio[1123]: info: Command Router : Notfying DB Updatefalse Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:01 volumio volumio[1123]: info: Command Router : Notfying DB Updatefalse Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:01 volumio volumio[1123]: info: Command Router : Notfying DB Updatefalse Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:01 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:01 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:01 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:01 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:01 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:01 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:01 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:01 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:01 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:01 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:01 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:01 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:01 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:01 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:01 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:01 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:01 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:01 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:01 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:01 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:01 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:01 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:01 volumio volumio[1123]: info: ------------------------------ 619ms Oct 25 14:44:01 volumio volumio[1123]: info: ------------------------------ 268ms Oct 25 14:44:01 volumio volumio[1123]: info: ------------------------------ 266ms Oct 25 14:44:01 volumio volumio[1123]: info: ------------------------------ 264ms Oct 25 14:44:01 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:02 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:02 volumio sudo[3560]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:02 volumio sudo[3560]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:02 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:02 volumio sudo[3563]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:02 volumio sudo[3563]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:02 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:02 volumio sudo[3566]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:02 volumio sudo[3566]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:02 volumio sudo[3560]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:02 volumio sudo[3563]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:02 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:02 volumio sudo[3566]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:02 volumio sudo[3569]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:02 volumio sudo[3569]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:02 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:02 volumio sudo[3572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:02 volumio sudo[3572]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:02 volumio sudo[3569]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:02 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:02 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:02 volumio sudo[3572]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:02 volumio sudo[3575]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:02 volumio sudo[3575]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:02 volumio sudo[3577]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:02 volumio sudo[3577]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:02 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:02 volumio sudo[3575]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:02 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:02 volumio sudo[3581]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:02 volumio sudo[3581]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:02 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:02 volumio sudo[3577]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:02 volumio sudo[3584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:02 volumio sudo[3584]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:02 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:02 volumio sudo[3587]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:02 volumio sudo[3587]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:02 volumio sudo[3590]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:02 volumio sudo[3590]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:02 volumio sudo[3584]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:02 volumio sudo[3581]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:02 volumio sudo[3593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:02 volumio sudo[3593]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:02 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:02 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:02 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:02 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:02 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:02 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:02 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:02 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:02 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:02 volumio sudo[3587]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:02 volumio sudo[3590]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:02 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:02 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:02 volumio sudo[3593]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:02 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:04 volumio volumio[1123]: info: CoreCommandRouter::volumioGetQueue Oct 25 14:44:04 volumio volumio[1123]: info: CoreStateMachine::getQueue Oct 25 14:44:04 volumio volumio[1123]: info: CorePlayQueue::getQueue Oct 25 14:44:04 volumio kernel: usb 1-1.4: new high-speed USB device number 31 using dwc_otg Oct 25 14:44:04 volumio kernel: usb 1-1.4: New USB device found, idVendor=152d, idProduct=2329, bcdDevice= 1.00 Oct 25 14:44:04 volumio kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=5 Oct 25 14:44:04 volumio kernel: usb 1-1.4: Product: USB to ATA/ATAPI Bridge Oct 25 14:44:04 volumio kernel: usb 1-1.4: Manufacturer: JMicron Oct 25 14:44:04 volumio kernel: usb 1-1.4: SerialNumber: 97327FFFFFFF Oct 25 14:44:04 volumio kernel: usb-storage 1-1.4:1.0: USB Mass Storage device detected Oct 25 14:44:04 volumio kernel: usb-storage 1-1.4:1.0: Quirks match for vid 152d pid 2329: 8020 Oct 25 14:44:04 volumio kernel: scsi host0: usb-storage 1-1.4:1.0 Oct 25 14:44:05 volumio volumio[1123]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/ServiceV002 Oct 25 14:44:05 volumio volumio[1123]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/Zaloha2 Oct 25 14:44:05 volumio kernel: scsi 0:0:0:0: Direct-Access FUJITSU MHV2120BH PL PQ: 0 ANSI: 2 CCS Oct 25 14:44:05 volumio kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Oct 25 14:44:05 volumio kernel: sd 0:0:0:0: [sda] 234441648 512-byte logical blocks: (120 GB/112 GiB) Oct 25 14:44:05 volumio kernel: sd 0:0:0:0: [sda] Write Protect is off Oct 25 14:44:05 volumio kernel: sd 0:0:0:0: [sda] Mode Sense: 34 00 00 00 Oct 25 14:44:05 volumio kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Oct 25 14:44:05 volumio kernel: sda: sda1 sda2 Oct 25 14:44:05 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI disk Oct 25 14:44:06 volumio volumio[1123]: info: Mounting Device ServiceV002 Oct 25 14:44:07 volumio sudo[3608]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/ServiceV002 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Oct 25 14:44:07 volumio sudo[3608]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:07 volumio ntfs-3g[3611]: Version 2017.3.23AR.3 integrated FUSE 28 Oct 25 14:44:07 volumio ntfs-3g[3611]: Mounted /dev/sda1 (Read-Write, label "ServiceV002", NTFS 3.1) Oct 25 14:44:07 volumio ntfs-3g[3611]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Oct 25 14:44:07 volumio ntfs-3g[3611]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Oct 25 14:44:07 volumio ntfs-3g[3611]: Global ownership and permissions enforced, configuration type 7 Oct 25 14:44:07 volumio sudo[3608]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:07 volumio volumio[1123]: info: Mounting Device Zaloha2 Oct 25 14:44:07 volumio sudo[3616]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/Zaloha2 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Oct 25 14:44:07 volumio sudo[3616]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:07 volumio ntfs-3g[3619]: Version 2017.3.23AR.3 integrated FUSE 28 Oct 25 14:44:07 volumio ntfs-3g[3619]: Mounted /dev/sda2 (Read-Write, label "Zaloha2", NTFS 3.1) Oct 25 14:44:07 volumio ntfs-3g[3619]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Oct 25 14:44:07 volumio ntfs-3g[3619]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda2,blkdev,blksize=4096 Oct 25 14:44:07 volumio ntfs-3g[3619]: Global ownership and permissions enforced, configuration type 7 Oct 25 14:44:07 volumio sudo[3616]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:07 volumio volumio[1123]: info: Scanning new location : "USB/ServiceV002" Oct 25 14:44:07 volumio volumio[1123]: info: Scanning new location : "USB/Zaloha2" Oct 25 14:44:07 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:07 volumio volumio[1123]: info: Oct 25 14:44:07 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:07 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:07 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:07 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:07 volumio volumio[1123]: info: Oct 25 14:44:07 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:07 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:07 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:07 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:07 volumio volumio[1123]: info: Oct 25 14:44:07 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:07 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:07 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:07 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:07 volumio volumio[1123]: info: Oct 25 14:44:07 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:07 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:07 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:07 volumio volumio[1123]: info: sendMpdCommand status took 16 milliseconds Oct 25 14:44:07 volumio volumio[1123]: info: sendMpdCommand status took 15 milliseconds Oct 25 14:44:07 volumio volumio[1123]: info: sendMpdCommand status took 14 milliseconds Oct 25 14:44:07 volumio volumio[1123]: info: sendMpdCommand status took 13 milliseconds Oct 25 14:44:07 volumio volumio[1123]: info: sendMpdCommand status took 12 milliseconds Oct 25 14:44:07 volumio volumio[1123]: info: sendMpdCommand status took 11 milliseconds Oct 25 14:44:07 volumio volumio[1123]: info: sendMpdCommand status took 9 milliseconds Oct 25 14:44:07 volumio volumio[1123]: info: sendMpdCommand status took 9 milliseconds Oct 25 14:44:07 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:07 volumio volumio[1123]: info: Command Router : Notfying DB Updatetrue Oct 25 14:44:07 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:07 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:07 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:08 volumio volumio[1123]: info: Command Router : Notfying DB Updatetrue Oct 25 14:44:08 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:08 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:08 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:08 volumio volumio[1123]: info: Command Router : Notfying DB Updatetrue Oct 25 14:44:08 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:08 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:08 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:08 volumio volumio[1123]: info: Command Router : Notfying DB Updatetrue Oct 25 14:44:08 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:08 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:08 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:08 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:08 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:08 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:08 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 25 14:44:08 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:08 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:08 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:08 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:08 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:08 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:08 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:08 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:08 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:08 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:08 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:08 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:08 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:08 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:08 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:08 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:08 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:08 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:08 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:08 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:08 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:08 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:08 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:08 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:08 volumio volumio[1123]: info: ------------------------------ 309ms Oct 25 14:44:08 volumio volumio[1123]: info: ------------------------------ 308ms Oct 25 14:44:08 volumio volumio[1123]: info: ------------------------------ 304ms Oct 25 14:44:08 volumio volumio[1123]: info: ------------------------------ 302ms Oct 25 14:44:08 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:08 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:08 volumio sudo[3634]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:08 volumio sudo[3634]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:08 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:08 volumio sudo[3637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:08 volumio sudo[3637]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:08 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:08 volumio sudo[3634]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:08 volumio sudo[3640]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:08 volumio sudo[3640]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:08 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:08 volumio sudo[3642]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:08 volumio sudo[3642]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:08 volumio sudo[3637]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:08 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:08 volumio sudo[3640]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:08 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:08 volumio sudo[3642]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:08 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:09 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 25 14:44:09 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 25 14:44:09 volumio volumio[1123]: info: Discovery: Getting this device information Oct 25 14:44:09 volumio volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 25 14:44:09 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:09 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 25 14:44:15 volumio volumio[1123]: info: MPD Database updated - AlbumList cache refreshed Oct 25 14:44:15 volumio volumio[1123]: info: Oct 25 14:44:15 volumio volumio[1123]: ---------------------------- MPD announces state update: database Oct 25 14:44:15 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:15 volumio volumio[1123]: info: Oct 25 14:44:15 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:15 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:15 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:15 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:15 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:15 volumio volumio[1123]: info: MPD Database updated - AlbumList cache refreshed Oct 25 14:44:15 volumio volumio[1123]: info: Oct 25 14:44:15 volumio volumio[1123]: ---------------------------- MPD announces state update: database Oct 25 14:44:15 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:15 volumio volumio[1123]: info: Oct 25 14:44:15 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:15 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:15 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:15 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:15 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:15 volumio volumio[1123]: info: MPD Database updated - AlbumList cache refreshed Oct 25 14:44:15 volumio volumio[1123]: info: Oct 25 14:44:15 volumio volumio[1123]: ---------------------------- MPD announces state update: database Oct 25 14:44:15 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:15 volumio volumio[1123]: info: Oct 25 14:44:15 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:15 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:15 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:15 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:15 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:15 volumio volumio[1123]: info: MPD Database updated - AlbumList cache refreshed Oct 25 14:44:15 volumio volumio[1123]: info: Oct 25 14:44:15 volumio volumio[1123]: ---------------------------- MPD announces state update: database Oct 25 14:44:15 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:15 volumio volumio[1123]: info: Oct 25 14:44:15 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:15 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:15 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:15 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:15 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:16 volumio volumio[1123]: info: sendMpdCommand status took 45 milliseconds Oct 25 14:44:16 volumio volumio[1123]: info: sendMpdCommand status took 44 milliseconds Oct 25 14:44:16 volumio volumio[1123]: info: sendMpdCommand status took 44 milliseconds Oct 25 14:44:16 volumio volumio[1123]: info: sendMpdCommand status took 41 milliseconds Oct 25 14:44:16 volumio volumio[1123]: info: sendMpdCommand status took 40 milliseconds Oct 25 14:44:16 volumio volumio[1123]: info: sendMpdCommand status took 40 milliseconds Oct 25 14:44:16 volumio volumio[1123]: info: sendMpdCommand status took 38 milliseconds Oct 25 14:44:16 volumio volumio[1123]: info: sendMpdCommand status took 37 milliseconds Oct 25 14:44:16 volumio volumio[1123]: info: sendMpdCommand status took 37 milliseconds Oct 25 14:44:16 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:16 volumio volumio[1123]: info: Command Router : Notfying DB Updatetrue Oct 25 14:44:16 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:16 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:16 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:16 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:16 volumio volumio[1123]: info: Command Router : Notfying DB Updatetrue Oct 25 14:44:16 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:16 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:16 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:16 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:16 volumio volumio[1123]: info: Command Router : Notfying DB Updatetrue Oct 25 14:44:16 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:16 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:16 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:16 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:16 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:16 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:16 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:16 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 25 14:44:16 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:16 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:16 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:16 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:16 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:16 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:16 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:16 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:16 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:16 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:16 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:16 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:16 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:16 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:16 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:16 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:16 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:16 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:16 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:16 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:16 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:16 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:16 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:16 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:16 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:16 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:16 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:16 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:16 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:16 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:16 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:16 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:16 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:16 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:16 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:16 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:16 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:16 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:16 volumio volumio[1123]: info: ------------------------------ 318ms Oct 25 14:44:16 volumio volumio[1123]: info: ------------------------------ 318ms Oct 25 14:44:16 volumio volumio[1123]: info: ------------------------------ 315ms Oct 25 14:44:16 volumio volumio[1123]: info: ------------------------------ 315ms Oct 25 14:44:16 volumio volumio[1123]: info: ------------------------------ 312ms Oct 25 14:44:16 volumio volumio[1123]: info: ------------------------------ 313ms Oct 25 14:44:16 volumio volumio[1123]: info: sendMpdCommand status took 319 milliseconds Oct 25 14:44:16 volumio volumio[1123]: info: sendMpdCommand status took 319 milliseconds Oct 25 14:44:16 volumio volumio[1123]: info: sendMpdCommand status took 318 milliseconds Oct 25 14:44:16 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:16 volumio volumio[1123]: info: Command Router : Notfying DB Updatetrue Oct 25 14:44:16 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:16 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:16 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:16 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:16 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:16 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:16 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:16 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 25 14:44:16 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:16 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:16 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:16 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:16 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:16 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:16 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:16 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:16 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:16 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:16 volumio volumio[1123]: info: ------------------------------ 399ms Oct 25 14:44:16 volumio volumio[1123]: info: ------------------------------ 399ms Oct 25 14:44:16 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:16 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:16 volumio sudo[3657]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:16 volumio sudo[3657]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:16 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:16 volumio sudo[3660]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:16 volumio sudo[3660]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:16 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:16 volumio sudo[3657]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:16 volumio sudo[3663]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:16 volumio sudo[3663]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:16 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:16 volumio sudo[3660]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:16 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:16 volumio sudo[3665]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:16 volumio sudo[3665]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:16 volumio sudo[3663]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:16 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:16 volumio sudo[3669]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:16 volumio sudo[3665]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:16 volumio sudo[3669]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:16 volumio sudo[3671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:16 volumio sudo[3671]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:16 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:16 volumio sudo[3669]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:16 volumio sudo[3674]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:16 volumio sudo[3674]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:16 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:16 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:16 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:16 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:16 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:16 volumio sudo[3677]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:16 volumio sudo[3677]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:17 volumio sudo[3671]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:17 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:17 volumio sudo[3674]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:17 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:17 volumio sudo[3677]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:17 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:31 volumio go-librespot[1945]: time="2024-10-25T14:44:31+02:00" level=error msg="did not receive last pong from dealer, 180s passed" Oct 25 14:44:34 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 25 14:44:34 volumio volumio[1123]: info: CURURI: music-library Oct 25 14:44:34 volumio volumio[1123]: info: Preload queue cleared Oct 25 14:44:35 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 25 14:44:35 volumio volumio[1123]: info: CURURI: music-library/USB Oct 25 14:44:35 volumio volumio[1123]: info: Preload queue cleared Oct 25 14:44:40 volumio kernel: sd 0:0:0:0: [sda] Unaligned partial completion (resid=101875, sector_sz=512) Oct 25 14:44:40 volumio kernel: sd 0:0:0:0: [sda] tag#0 CDB: opcode=0x28 28 00 00 df 8c d8 00 00 f0 00 Oct 25 14:44:40 volumio kernel: sd 0:0:0:0: [sda] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=17s Oct 25 14:44:40 volumio kernel: sd 0:0:0:0: [sda] tag#0 CDB: opcode=0x28 28 00 00 df 8c d8 00 00 f0 00 Oct 25 14:44:40 volumio kernel: I/O error, dev sda, sector 14650584 op 0x0:(READ) flags 0x84700 phys_seg 2 prio class 2 Oct 25 14:44:40 volumio kernel: sd 0:0:0:0: [sda] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=0s Oct 25 14:44:40 volumio kernel: sd 0:0:0:0: [sda] tag#0 CDB: opcode=0x28 28 00 00 df 8d c8 00 00 10 00 Oct 25 14:44:40 volumio kernel: I/O error, dev sda, sector 14650824 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Oct 25 14:44:40 volumio kernel: sd 0:0:0:0: [sda] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=0s Oct 25 14:44:40 volumio kernel: sd 0:0:0:0: [sda] tag#0 CDB: opcode=0x28 28 00 00 df dc d8 00 00 08 00 Oct 25 14:44:40 volumio kernel: I/O error, dev sda, sector 14671064 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Oct 25 14:44:40 volumio kernel: usb 1-1.4: USB disconnect, device number 31 Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread error reading '/HUDBA/The Corrs/White Light/11 Harmony.mp3' at offset 11141120: 754 <> -1: Input/output error Oct 25 14:44:40 volumio kernel: device offline error, dev sda, sector 14671064 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Oct 25 14:44:40 volumio kernel: buffer_io_error: 34 callbacks suppressed Oct 25 14:44:40 volumio kernel: Buffer I/O error on dev sda2, logical block 289691, async page read Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread error reading '/HUDBA/The Corrs/White Light/11 Harmony.mp3' at offset 11141120: 754 <> -1: Input/output error Oct 25 14:44:40 volumio kernel: device offline error, dev sda, sector 14671064 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Oct 25 14:44:40 volumio kernel: Buffer I/O error on dev sda2, logical block 289691, async page read Oct 25 14:44:40 volumio volumio[1123]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/ata-FUJITSU_MHV2120BH_PL_NW9ST7327KTF-part1 /dev/disk/by-path/platform-3f980000.usb-usb-0:1.4:1.0-scsi-0:0:0:0-part1 /dev/disk/by-uuid/8C7E5B047E5AE70C /dev/disk/by-label/ServiceV002 /dev/disk/by-partuuid/95f3457a-01","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"54","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_AAM":"1","ID_ATA_FEATURE_SET_AAM_CURRENT_VALUE":"254","ID_ATA_FEATURE_SET_AAM_ENABLED":"1","ID_ATA_FEATURE_SET_AAM_VENDOR_RECOMMENDED_VALUE":"254","ID_ATA_FEATURE_SET_APM":"1","ID_ATA_FEATURE_SET_APM_CURRENT_VALUE":"128","ID_ATA_FEATURE_SET_APM_ENABLED":"1","ID_ATA_FEATURE_SET_HPA":"1","ID_ATA_FEATURE_SET_HPA_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"120","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_FS_LABEL":"ServiceV002","ID_FS_LABEL_ENC":"ServiceV002","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"8C7E5B047E5AE70C","ID_FS_UUID_ENC":"8C7E5B047E5AE70C","ID_MODEL":"FUJITSU_MHV2120BH_PL","ID_MODEL_ENC":"FUJITSU\\x20MHV2120BH\\x20PL\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"12351488","ID_PART_ENTRY_TYPE":"0x27","ID_PART_ENTRY_UUID":"95f3457a-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"95f3457a","ID_PATH":"platform-3f980000.usb-usb-0:1.4:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_4_1_0-scsi-0_0_0_0","ID_REVISION":"0084002A","ID_SERIAL":"FUJITSU_MHV2120BH_PL_NW9ST7327KTF","ID_SERIAL_SHORT":"NW9ST7327KTF","ID_TYPE":"disk","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"2974","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"368389490"} Oct 25 14:44:40 volumio sudo[3727]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1 Oct 25 14:44:40 volumio sudo[3727]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:40 volumio ntfs-3g[3611]: Unmounting /dev/sda1 (ServiceV002) Oct 25 14:44:40 volumio systemd[1]: media-ServiceV002.mount: Succeeded. Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread error reading '/HUDBA/The Corrs/White Light/12 With Me Stay.mp3' at offset 0: 131072 <> -1: Input/output error Oct 25 14:44:40 volumio sudo[3727]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread error reading '/HUDBA/The Corrs/White Light/12 With Me Stay.mp3' at offset 0: 4096 <> -1: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread error reading '/HUDBA/The Corrs/White Light/12 With Me Stay.mp3' at offset 0: 4096 <> -1: Input/output error Oct 25 14:44:40 volumio kernel: Buffer I/O error on dev sda2, logical block 289692, async page read Oct 25 14:44:40 volumio kernel: Buffer I/O error on dev sda2, logical block 289692, async page read Oct 25 14:44:40 volumio kernel: Buffer I/O error on dev sda2, logical block 289692, async page read Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread error reading '/HUDBA/The Corrs/White Light/12 With Me Stay.mp3' at offset 9048064: 889 <> -1: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread error reading '/HUDBA/The Corrs/White Light/12 With Me Stay.mp3' at offset 9048064: 889 <> -1: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread error reading '/HUDBA/The Corrs/White Light/12 With Me Stay.mp3' at offset 9048064: 889 <> -1: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread error reading '/HUDBA/The Corrs/White Light/12 With Me Stay.mp3' at offset 0: 4096 <> -1: Input/output error Oct 25 14:44:40 volumio kernel: Buffer I/O error on dev sda2, logical block 291901, async page read Oct 25 14:44:40 volumio kernel: Buffer I/O error on dev sda2, logical block 291901, async page read Oct 25 14:44:40 volumio kernel: Buffer I/O error on dev sda2, logical block 291901, async page read Oct 25 14:44:40 volumio kernel: Buffer I/O error on dev sda2, logical block 289692, async page read Oct 25 14:44:40 volumio kernel: Buffer I/O error on dev sda2, logical block 289692, async page read Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread error reading '/HUDBA/The Corrs/White Light/12 With Me Stay.mp3' at offset 0: 4096 <> -1: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread error reading '/HUDBA/The Corrs/White Light/12 With Me Stay.mp3' at offset 0: 4096 <> -1: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread error reading '/HUDBA/The Corrs/White Light/12 With Me Stay.mp3' at offset 0: 4096 <> -1: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread error reading '/HUDBA/The Corrs/White Light/12 With Me Stay.mp3' at offset 9048064: 889 <> -1: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread error reading '/HUDBA/The Corrs/White Light/12 With Me Stay.mp3' at offset 9048064: 889 <> -1: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread error reading '/HUDBA/The Corrs/White Light/12 With Me Stay.mp3' at offset 0: 4096 <> -1: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread error reading '/HUDBA/The Corrs/White Light/12 With Me Stay.mp3' at offset 0: 4096 <> -1: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread error reading '/HUDBA/The Corrs/White Light/12 With Me Stay.mp3' at offset 0: 4096 <> -1: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:40 volumio volumio[1123]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","ACTION":"remove","DEVLINKS":"/dev/disk/by-path/platform-3f980000.usb-usb-0:1.4:1.0-scsi-0:0:0:0-part2 /dev/disk/by-label/Zaloha2 /dev/disk/by-uuid/1448E55C48E53CDC /dev/disk/by-id/ata-FUJITSU_MHV2120BH_PL_NW9ST7327KTF-part2 /dev/disk/by-partuuid/95f3457a-02","DEVNAME":"/dev/sda2","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","DEVTYPE":"partition","DISKSEQ":"54","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_AAM":"1","ID_ATA_FEATURE_SET_AAM_CURRENT_VALUE":"254","ID_ATA_FEATURE_SET_AAM_ENABLED":"1","ID_ATA_FEATURE_SET_AAM_VENDOR_RECOMMENDED_VALUE":"254","ID_ATA_FEATURE_SET_APM":"1","ID_ATA_FEATURE_SET_APM_CURRENT_VALUE":"128","ID_ATA_FEATURE_SET_APM_ENABLED":"1","ID_ATA_FEATURE_SET_HPA":"1","ID_ATA_FEATURE_SET_HPA_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"120","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_FS_LABEL":"Zaloha2","ID_FS_LABEL_ENC":"Zaloha2","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"1448E55C48E53CDC","ID_FS_UUID_ENC":"1448E55C48E53CDC","ID_MODEL":"FUJITSU_MHV2120BH_PL","ID_MODEL_ENC":"FUJITSU\\x20MHV2120BH\\x20PL\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_FLAGS":"0x80","ID_PART_ENTRY_NUMBER":"2","ID_PART_ENTRY_OFFSET":"12353536","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"222083072","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"95f3457a-02","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"95f3457a","ID_PATH":"platform-3f980000.usb-usb-0:1.4:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_4_1_0-scsi-0_0_0_0","ID_REVISION":"0084002A","ID_SERIAL":"FUJITSU_MHV2120BH_PL_NW9ST7327KTF","ID_SERIAL_SHORT":"NW9ST7327KTF","ID_TYPE":"disk","MAJOR":"8","MINOR":"2","PARTN":"2","SEQNUM":"2976","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"368389780"} Oct 25 14:44:40 volumio ntfs-3g[3619]: Failed to read vcn 0x0 from inode 39: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: Failed to read vcn 0x0 from inode 39: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: Failed to read vcn 0x0 from inode 39: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Oct 25 14:44:40 volumio ntfs-3g[3619]: Failed to read vcn 0x0 from inode 5: Input/output error Oct 25 14:44:40 volumio sudo[3731]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda2 Oct 25 14:44:40 volumio sudo[3731]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:40 volumio ntfs-3g[3619]: Unmounting /dev/sda2 (Zaloha2) Oct 25 14:44:40 volumio systemd[1]: media-Zaloha2.mount: Succeeded. Oct 25 14:44:40 volumio sudo[3731]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:40 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 25 14:44:40 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 25 14:44:40 volumio volumio[1123]: info: Discovery: Getting this device information Oct 25 14:44:40 volumio volumio[1123]: info: CoreCommandRouter::volumioGetState Oct 25 14:44:40 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:40 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 25 14:44:40 volumio volumio[1123]: info: MPD Database updated - AlbumList cache refreshed Oct 25 14:44:40 volumio volumio[1123]: info: Oct 25 14:44:40 volumio volumio[1123]: ---------------------------- MPD announces state update: database Oct 25 14:44:40 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:40 volumio volumio[1123]: info: Oct 25 14:44:40 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:40 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:40 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:40 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:40 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:40 volumio volumio[1123]: info: MPD Database updated - AlbumList cache refreshed Oct 25 14:44:40 volumio volumio[1123]: info: Oct 25 14:44:40 volumio volumio[1123]: ---------------------------- MPD announces state update: database Oct 25 14:44:40 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:40 volumio volumio[1123]: info: Oct 25 14:44:40 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:40 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:40 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:40 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:40 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:40 volumio volumio[1123]: info: MPD Database updated - AlbumList cache refreshed Oct 25 14:44:40 volumio volumio[1123]: info: Oct 25 14:44:40 volumio volumio[1123]: ---------------------------- MPD announces state update: database Oct 25 14:44:40 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:40 volumio volumio[1123]: info: Oct 25 14:44:40 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:40 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:40 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:40 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:40 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:40 volumio volumio[1123]: info: MPD Database updated - AlbumList cache refreshed Oct 25 14:44:40 volumio volumio[1123]: info: Oct 25 14:44:40 volumio volumio[1123]: ---------------------------- MPD announces state update: database Oct 25 14:44:40 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:40 volumio volumio[1123]: info: Oct 25 14:44:40 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:40 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:40 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:40 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:40 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:40 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 25 14:44:40 volumio volumio[1123]: info: CURURI: music-library/USB/Zaloha2 Oct 25 14:44:40 volumio volumio[1123]: info: sendMpdCommand status took 99 milliseconds Oct 25 14:44:40 volumio volumio[1123]: info: sendMpdCommand status took 96 milliseconds Oct 25 14:44:40 volumio volumio[1123]: info: sendMpdCommand status took 95 milliseconds Oct 25 14:44:40 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:40 volumio volumio[1123]: info: Command Router : Notfying DB Updatefalse Oct 25 14:44:40 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:40 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:40 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:40 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:40 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:40 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:40 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:40 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 25 14:44:40 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:40 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:40 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:40 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:40 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:40 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:40 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:40 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:40 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:40 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:40 volumio volumio[1123]: info: ------------------------------ 198ms Oct 25 14:44:40 volumio volumio[1123]: info: ------------------------------ 197ms Oct 25 14:44:40 volumio volumio[1123]: info: sendMpdCommand status took 225 milliseconds Oct 25 14:44:40 volumio volumio[1123]: info: sendMpdCommand status took 222 milliseconds Oct 25 14:44:40 volumio volumio[1123]: info: sendMpdCommand status took 221 milliseconds Oct 25 14:44:40 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:41 volumio volumio[1123]: info: Command Router : Notfying DB Updatefalse Oct 25 14:44:41 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:41 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:41 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:41 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:41 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:41 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:41 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:41 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:41 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:41 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:41 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:41 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:41 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:41 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:41 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:41 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:41 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:41 volumio volumio[1123]: info: ------------------------------ 301ms Oct 25 14:44:41 volumio volumio[1123]: info: ------------------------------ 300ms Oct 25 14:44:41 volumio volumio[1123]: info: sendMpdCommand status took 323 milliseconds Oct 25 14:44:41 volumio volumio[1123]: info: sendMpdCommand status took 321 milliseconds Oct 25 14:44:41 volumio volumio[1123]: info: sendMpdCommand status took 319 milliseconds Oct 25 14:44:41 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:41 volumio volumio[1123]: info: Command Router : Notfying DB Updatefalse Oct 25 14:44:41 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:41 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:41 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:41 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:41 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:41 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:41 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:41 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:41 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:41 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:41 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:41 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:41 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:41 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:41 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:41 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:41 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:41 volumio volumio[1123]: info: ------------------------------ 400ms Oct 25 14:44:41 volumio volumio[1123]: info: ------------------------------ 399ms Oct 25 14:44:41 volumio volumio[1123]: info: sendMpdCommand status took 453 milliseconds Oct 25 14:44:41 volumio volumio[1123]: info: sendMpdCommand status took 450 milliseconds Oct 25 14:44:41 volumio volumio[1123]: info: sendMpdCommand status took 449 milliseconds Oct 25 14:44:41 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:41 volumio volumio[1123]: info: Command Router : Notfying DB Updatefalse Oct 25 14:44:41 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:41 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:41 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:41 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:41 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:41 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:41 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:41 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:41 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:41 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:41 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:41 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:41 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:41 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:41 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:41 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:41 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:41 volumio volumio[1123]: info: ------------------------------ 534ms Oct 25 14:44:41 volumio volumio[1123]: info: ------------------------------ 533ms Oct 25 14:44:41 volumio volumio[1123]: info: Preload queue cleared Oct 25 14:44:41 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:41 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:41 volumio sudo[3742]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:41 volumio sudo[3742]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:41 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:41 volumio sudo[3745]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:41 volumio sudo[3745]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:41 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:41 volumio sudo[3742]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:41 volumio sudo[3748]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:41 volumio sudo[3748]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:41 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:41 volumio sudo[3751]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:41 volumio sudo[3751]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:41 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:41 volumio sudo[3745]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:41 volumio sudo[3748]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:41 volumio sudo[3754]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:41 volumio sudo[3754]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:41 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:41 volumio sudo[3751]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:41 volumio sudo[3757]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:41 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:41 volumio sudo[3757]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:41 volumio sudo[3754]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:41 volumio sudo[3760]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:41 volumio sudo[3760]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:41 volumio sudo[3757]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:41 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:41 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:41 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:41 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:41 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:42 volumio sudo[3762]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:42 volumio sudo[3762]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:42 volumio sudo[3760]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:42 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:42 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:42 volumio sudo[3762]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:42 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:43 volumio kernel: usb 1-1.4: new high-speed USB device number 32 using dwc_otg Oct 25 14:44:44 volumio kernel: usb 1-1.4: New USB device found, idVendor=152d, idProduct=2329, bcdDevice= 1.00 Oct 25 14:44:44 volumio kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=5 Oct 25 14:44:44 volumio kernel: usb 1-1.4: Product: USB to ATA/ATAPI Bridge Oct 25 14:44:44 volumio kernel: usb 1-1.4: Manufacturer: JMicron Oct 25 14:44:44 volumio kernel: usb 1-1.4: SerialNumber: 97327FFFFFFF Oct 25 14:44:44 volumio kernel: usb-storage 1-1.4:1.0: USB Mass Storage device detected Oct 25 14:44:44 volumio kernel: usb-storage 1-1.4:1.0: Quirks match for vid 152d pid 2329: 8020 Oct 25 14:44:44 volumio kernel: scsi host0: usb-storage 1-1.4:1.0 Oct 25 14:44:44 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 25 14:44:44 volumio volumio[1123]: info: CURURI: music-library/USB/Zaloha2/HUDBA Oct 25 14:44:44 volumio volumio[1123]: info: Preload queue cleared Oct 25 14:44:44 volumio volumio[1123]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/ServiceV002 Oct 25 14:44:44 volumio volumio[1123]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/Zaloha2 Oct 25 14:44:45 volumio kernel: scsi 0:0:0:0: Direct-Access FUJITSU MHV2120BH PL PQ: 0 ANSI: 2 CCS Oct 25 14:44:45 volumio kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Oct 25 14:44:45 volumio kernel: sd 0:0:0:0: [sda] 234441648 512-byte logical blocks: (120 GB/112 GiB) Oct 25 14:44:45 volumio kernel: sd 0:0:0:0: [sda] Write Protect is off Oct 25 14:44:45 volumio kernel: sd 0:0:0:0: [sda] Mode Sense: 34 00 00 00 Oct 25 14:44:45 volumio kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Oct 25 14:44:45 volumio kernel: sda: sda1 sda2 Oct 25 14:44:45 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI disk Oct 25 14:44:45 volumio volumio[1123]: info: Mounting Device Zaloha2 Oct 25 14:44:46 volumio sudo[3774]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/Zaloha2 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Oct 25 14:44:46 volumio sudo[3774]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:46 volumio ntfs-3g[3777]: Version 2017.3.23AR.3 integrated FUSE 28 Oct 25 14:44:46 volumio ntfs-3g[3777]: Mounted /dev/sda2 (Read-Write, label "Zaloha2", NTFS 3.1) Oct 25 14:44:46 volumio ntfs-3g[3777]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Oct 25 14:44:46 volumio ntfs-3g[3777]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda2,blkdev,blksize=4096 Oct 25 14:44:46 volumio ntfs-3g[3777]: Global ownership and permissions enforced, configuration type 7 Oct 25 14:44:46 volumio sudo[3774]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:46 volumio volumio[1123]: info: Mounting Device ServiceV002 Oct 25 14:44:46 volumio sudo[3782]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/ServiceV002 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Oct 25 14:44:46 volumio sudo[3782]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:46 volumio ntfs-3g[3786]: Version 2017.3.23AR.3 integrated FUSE 28 Oct 25 14:44:46 volumio ntfs-3g[3786]: Mounted /dev/sda1 (Read-Write, label "ServiceV002", NTFS 3.1) Oct 25 14:44:46 volumio ntfs-3g[3786]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Oct 25 14:44:46 volumio ntfs-3g[3786]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Oct 25 14:44:46 volumio ntfs-3g[3786]: Global ownership and permissions enforced, configuration type 7 Oct 25 14:44:46 volumio sudo[3782]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:46 volumio volumio[1123]: info: Scanning new location : "USB/Zaloha2" Oct 25 14:44:46 volumio volumio[1123]: info: Scanning new location : "USB/ServiceV002" Oct 25 14:44:46 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:46 volumio volumio[1123]: info: Oct 25 14:44:46 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:46 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:46 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:46 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:46 volumio volumio[1123]: info: Oct 25 14:44:46 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:46 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:46 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:46 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:46 volumio volumio[1123]: info: Oct 25 14:44:46 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:46 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:46 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:46 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:46 volumio volumio[1123]: info: Oct 25 14:44:46 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:46 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:46 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:46 volumio volumio[1123]: info: sendMpdCommand status took 16 milliseconds Oct 25 14:44:46 volumio volumio[1123]: info: sendMpdCommand status took 14 milliseconds Oct 25 14:44:46 volumio volumio[1123]: info: sendMpdCommand status took 13 milliseconds Oct 25 14:44:46 volumio volumio[1123]: info: sendMpdCommand status took 24 milliseconds Oct 25 14:44:46 volumio volumio[1123]: info: sendMpdCommand status took 23 milliseconds Oct 25 14:44:46 volumio volumio[1123]: info: sendMpdCommand status took 21 milliseconds Oct 25 14:44:46 volumio volumio[1123]: info: sendMpdCommand status took 20 milliseconds Oct 25 14:44:46 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:46 volumio volumio[1123]: info: Command Router : Notfying DB Updatetrue Oct 25 14:44:46 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:46 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:46 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:46 volumio volumio[1123]: info: Command Router : Notfying DB Updatetrue Oct 25 14:44:46 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:46 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:46 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:47 volumio volumio[1123]: info: Command Router : Notfying DB Updatetrue Oct 25 14:44:47 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:47 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:47 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:47 volumio volumio[1123]: info: Command Router : Notfying DB Updatetrue Oct 25 14:44:47 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:47 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:47 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:47 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:47 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:47 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:47 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 25 14:44:47 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:47 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:47 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:47 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:47 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:47 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:47 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:47 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:47 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:47 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:47 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:47 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:47 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:47 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:47 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:47 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:47 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:47 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:47 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:47 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:47 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:47 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:47 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:47 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:47 volumio volumio[1123]: info: ------------------------------ 324ms Oct 25 14:44:47 volumio volumio[1123]: info: ------------------------------ 322ms Oct 25 14:44:47 volumio volumio[1123]: info: ------------------------------ 320ms Oct 25 14:44:47 volumio volumio[1123]: info: ------------------------------ 318ms Oct 25 14:44:47 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:47 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:47 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:47 volumio sudo[3801]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:47 volumio sudo[3801]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:47 volumio sudo[3803]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:47 volumio sudo[3803]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:47 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:47 volumio sudo[3807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:47 volumio sudo[3807]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:47 volumio sudo[3809]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:47 volumio sudo[3809]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:47 volumio sudo[3801]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:47 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:47 volumio sudo[3803]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:47 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:47 volumio sudo[3807]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:47 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:47 volumio sudo[3809]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:47 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:47 volumio volumio[1123]: info: MPD Database updated - AlbumList cache refreshed Oct 25 14:44:47 volumio volumio[1123]: info: Oct 25 14:44:47 volumio volumio[1123]: ---------------------------- MPD announces state update: database Oct 25 14:44:47 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:47 volumio volumio[1123]: info: Oct 25 14:44:47 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:47 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:47 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:47 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:47 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:47 volumio volumio[1123]: info: MPD Database updated - AlbumList cache refreshed Oct 25 14:44:47 volumio volumio[1123]: info: Oct 25 14:44:47 volumio volumio[1123]: ---------------------------- MPD announces state update: database Oct 25 14:44:47 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:47 volumio volumio[1123]: info: Oct 25 14:44:47 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:47 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:47 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:47 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:47 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:47 volumio volumio[1123]: info: MPD Database updated - AlbumList cache refreshed Oct 25 14:44:47 volumio volumio[1123]: info: Oct 25 14:44:47 volumio volumio[1123]: ---------------------------- MPD announces state update: database Oct 25 14:44:47 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:47 volumio volumio[1123]: info: Oct 25 14:44:47 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:47 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:47 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:47 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:47 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:47 volumio volumio[1123]: info: MPD Database updated - AlbumList cache refreshed Oct 25 14:44:47 volumio volumio[1123]: info: Oct 25 14:44:47 volumio volumio[1123]: ---------------------------- MPD announces state update: database Oct 25 14:44:47 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:47 volumio volumio[1123]: info: Oct 25 14:44:47 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:47 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:47 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:47 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:47 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:48 volumio volumio[1123]: info: sendMpdCommand status took 70 milliseconds Oct 25 14:44:48 volumio volumio[1123]: info: sendMpdCommand status took 69 milliseconds Oct 25 14:44:48 volumio volumio[1123]: info: sendMpdCommand status took 69 milliseconds Oct 25 14:44:48 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:48 volumio volumio[1123]: info: Command Router : Notfying DB Updatetrue Oct 25 14:44:48 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:48 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:48 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:48 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:48 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:48 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:48 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:48 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 25 14:44:48 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:48 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:48 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:48 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:48 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:48 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:48 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:48 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:48 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:48 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:48 volumio volumio[1123]: info: ------------------------------ 170ms Oct 25 14:44:48 volumio volumio[1123]: info: ------------------------------ 170ms Oct 25 14:44:48 volumio volumio[1123]: info: sendMpdCommand status took 199 milliseconds Oct 25 14:44:48 volumio volumio[1123]: info: sendMpdCommand status took 199 milliseconds Oct 25 14:44:48 volumio volumio[1123]: info: sendMpdCommand status took 198 milliseconds Oct 25 14:44:48 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:48 volumio volumio[1123]: info: Command Router : Notfying DB Updatetrue Oct 25 14:44:48 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:48 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:48 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:48 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:48 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:48 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:48 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:48 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:48 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:48 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:48 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:48 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:48 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:48 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:48 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:48 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:48 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:48 volumio volumio[1123]: info: ------------------------------ 292ms Oct 25 14:44:48 volumio volumio[1123]: info: ------------------------------ 293ms Oct 25 14:44:48 volumio volumio[1123]: info: sendMpdCommand status took 351 milliseconds Oct 25 14:44:48 volumio volumio[1123]: info: sendMpdCommand status took 351 milliseconds Oct 25 14:44:48 volumio volumio[1123]: info: sendMpdCommand status took 350 milliseconds Oct 25 14:44:48 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:48 volumio volumio[1123]: info: Command Router : Notfying DB Updatetrue Oct 25 14:44:48 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:48 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:48 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:48 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:48 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:48 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:48 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:48 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:48 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:48 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:48 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:48 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:48 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:48 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:48 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:48 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:48 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:48 volumio volumio[1123]: info: ------------------------------ 439ms Oct 25 14:44:48 volumio volumio[1123]: info: ------------------------------ 439ms Oct 25 14:44:48 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:48 volumio volumio[1123]: info: Oct 25 14:44:48 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:48 volumio volumio[1123]: info: sendMpdCommand status took 460 milliseconds Oct 25 14:44:48 volumio volumio[1123]: info: sendMpdCommand status took 459 milliseconds Oct 25 14:44:48 volumio volumio[1123]: info: sendMpdCommand status took 458 milliseconds Oct 25 14:44:48 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:48 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:48 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:48 volumio volumio[1123]: info: Command Router : Notfying DB Updatetrue Oct 25 14:44:48 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:48 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:48 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:48 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:48 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:48 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:48 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:48 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:48 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:48 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:48 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:48 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:48 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:48 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:48 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:48 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:48 volumio volumio[1123]: info: ------------------------------ 546ms Oct 25 14:44:48 volumio volumio[1123]: info: ------------------------------ 547ms Oct 25 14:44:48 volumio volumio[1123]: info: sendMpdCommand status took 100 milliseconds Oct 25 14:44:48 volumio volumio[1123]: info: sendMpdCommand status took 97 milliseconds Oct 25 14:44:48 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:48 volumio volumio[1123]: info: Command Router : Notfying DB Updatefalse Oct 25 14:44:48 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:48 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:48 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:48 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:48 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:48 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:48 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 25 14:44:48 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:48 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:48 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:48 volumio volumio[1123]: info: ------------------------------ 172ms Oct 25 14:44:48 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:48 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:48 volumio sudo[3824]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:48 volumio sudo[3824]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:48 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:48 volumio sudo[3827]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:48 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:48 volumio sudo[3827]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:48 volumio sudo[3829]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:48 volumio sudo[3829]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:48 volumio sudo[3824]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:48 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:48 volumio sudo[3833]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:48 volumio sudo[3833]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:48 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:48 volumio sudo[3836]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:48 volumio sudo[3836]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:48 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:49 volumio sudo[3839]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:49 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:49 volumio sudo[3839]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:49 volumio sudo[3829]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:49 volumio sudo[3833]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:49 volumio sudo[3827]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:49 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:49 volumio sudo[3842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:49 volumio sudo[3842]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:49 volumio sudo[3844]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:49 volumio sudo[3844]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:49 volumio sudo[3836]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:49 volumio sudo[3839]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:49 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:49 volumio volumio[1123]: info: Oct 25 14:44:49 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:49 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:49 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:49 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:49 volumio volumio[1123]: info: Oct 25 14:44:49 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:49 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:49 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:49 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:49 volumio volumio[1123]: info: Oct 25 14:44:49 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:49 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:49 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:49 volumio sudo[3848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:49 volumio sudo[3848]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:49 volumio volumio[1123]: info: sendMpdCommand status took 20 milliseconds Oct 25 14:44:49 volumio volumio[1123]: info: sendMpdCommand status took 18 milliseconds Oct 25 14:44:49 volumio volumio[1123]: info: sendMpdCommand status took 18 milliseconds Oct 25 14:44:49 volumio volumio[1123]: info: sendMpdCommand status took 16 milliseconds Oct 25 14:44:49 volumio volumio[1123]: info: sendMpdCommand status took 16 milliseconds Oct 25 14:44:49 volumio volumio[1123]: info: sendMpdCommand status took 14 milliseconds Oct 25 14:44:49 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:49 volumio sudo[3844]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:49 volumio volumio[1123]: info: Command Router : Notfying DB Updatefalse Oct 25 14:44:49 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:49 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:49 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:49 volumio sudo[3842]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:49 volumio sudo[3848]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:49 volumio volumio[1123]: info: Command Router : Notfying DB Updatefalse Oct 25 14:44:49 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:49 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:49 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:49 volumio volumio[1123]: info: Command Router : Notfying DB Updatefalse Oct 25 14:44:49 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:49 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:49 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:49 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:49 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:49 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:49 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 25 14:44:49 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:49 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:49 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:49 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:49 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:49 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:49 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:49 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:49 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:49 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:49 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:49 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:49 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:49 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:49 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:49 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:49 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:49 volumio volumio[1123]: info: ------------------------------ 287ms Oct 25 14:44:49 volumio volumio[1123]: info: ------------------------------ 285ms Oct 25 14:44:49 volumio volumio[1123]: info: ------------------------------ 283ms Oct 25 14:44:49 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:49 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:49 volumio sudo[3857]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:49 volumio sudo[3857]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:49 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:49 volumio sudo[3860]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:49 volumio sudo[3860]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:49 volumio sudo[3857]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:49 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:49 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:49 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:49 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:49 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:49 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:49 volumio sudo[3863]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:49 volumio sudo[3863]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:49 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:49 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:49 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:49 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:49 volumio sudo[3860]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:49 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:49 volumio sudo[3863]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:49 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:50 volumio kernel: usb 1-1.4: USB disconnect, device number 32 Oct 25 14:44:50 volumio volumio[1123]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/ata-FUJITSU_MHV2120BH_PL_NW9ST7327KTF-part1 /dev/disk/by-path/platform-3f980000.usb-usb-0:1.4:1.0-scsi-0:0:0:0-part1 /dev/disk/by-uuid/8C7E5B047E5AE70C /dev/disk/by-label/ServiceV002 /dev/disk/by-partuuid/95f3457a-01","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"55","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_AAM":"1","ID_ATA_FEATURE_SET_AAM_CURRENT_VALUE":"254","ID_ATA_FEATURE_SET_AAM_ENABLED":"1","ID_ATA_FEATURE_SET_AAM_VENDOR_RECOMMENDED_VALUE":"254","ID_ATA_FEATURE_SET_APM":"1","ID_ATA_FEATURE_SET_APM_CURRENT_VALUE":"128","ID_ATA_FEATURE_SET_APM_ENABLED":"1","ID_ATA_FEATURE_SET_HPA":"1","ID_ATA_FEATURE_SET_HPA_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"120","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_FS_LABEL":"ServiceV002","ID_FS_LABEL_ENC":"ServiceV002","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"8C7E5B047E5AE70C","ID_FS_UUID_ENC":"8C7E5B047E5AE70C","ID_MODEL":"FUJITSU_MHV2120BH_PL","ID_MODEL_ENC":"FUJITSU\\x20MHV2120BH\\x20PL\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"12351488","ID_PART_ENTRY_TYPE":"0x27","ID_PART_ENTRY_UUID":"95f3457a-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"95f3457a","ID_PATH":"platform-3f980000.usb-usb-0:1.4:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_4_1_0-scsi-0_0_0_0","ID_REVISION":"0084002A","ID_SERIAL":"FUJITSU_MHV2120BH_PL_NW9ST7327KTF","ID_SERIAL_SHORT":"NW9ST7327KTF","ID_TYPE":"disk","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"3014","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"407389455"} Oct 25 14:44:50 volumio sudo[3870]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1 Oct 25 14:44:50 volumio sudo[3870]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:50 volumio ntfs-3g[3786]: Unmounting /dev/sda1 (ServiceV002) Oct 25 14:44:50 volumio sudo[3870]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:50 volumio systemd[1]: media-ServiceV002.mount: Succeeded. Oct 25 14:44:50 volumio volumio[1123]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","ACTION":"remove","DEVLINKS":"/dev/disk/by-path/platform-3f980000.usb-usb-0:1.4:1.0-scsi-0:0:0:0-part2 /dev/disk/by-label/Zaloha2 /dev/disk/by-uuid/1448E55C48E53CDC /dev/disk/by-id/ata-FUJITSU_MHV2120BH_PL_NW9ST7327KTF-part2 /dev/disk/by-partuuid/95f3457a-02","DEVNAME":"/dev/sda2","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","DEVTYPE":"partition","DISKSEQ":"55","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_AAM":"1","ID_ATA_FEATURE_SET_AAM_CURRENT_VALUE":"254","ID_ATA_FEATURE_SET_AAM_ENABLED":"1","ID_ATA_FEATURE_SET_AAM_VENDOR_RECOMMENDED_VALUE":"254","ID_ATA_FEATURE_SET_APM":"1","ID_ATA_FEATURE_SET_APM_CURRENT_VALUE":"128","ID_ATA_FEATURE_SET_APM_ENABLED":"1","ID_ATA_FEATURE_SET_HPA":"1","ID_ATA_FEATURE_SET_HPA_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"120","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_FS_LABEL":"Zaloha2","ID_FS_LABEL_ENC":"Zaloha2","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"1448E55C48E53CDC","ID_FS_UUID_ENC":"1448E55C48E53CDC","ID_MODEL":"FUJITSU_MHV2120BH_PL","ID_MODEL_ENC":"FUJITSU\\x20MHV2120BH\\x20PL\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_FLAGS":"0x80","ID_PART_ENTRY_NUMBER":"2","ID_PART_ENTRY_OFFSET":"12353536","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"222083072","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"95f3457a-02","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"95f3457a","ID_PATH":"platform-3f980000.usb-usb-0:1.4:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_4_1_0-scsi-0_0_0_0","ID_REVISION":"0084002A","ID_SERIAL":"FUJITSU_MHV2120BH_PL_NW9ST7327KTF","ID_SERIAL_SHORT":"NW9ST7327KTF","ID_TYPE":"disk","MAJOR":"8","MINOR":"2","PARTN":"2","SEQNUM":"3015","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"407371935"} Oct 25 14:44:51 volumio sudo[3873]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda2 Oct 25 14:44:51 volumio sudo[3873]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:51 volumio ntfs-3g[3777]: Unmounting /dev/sda2 (Zaloha2) Oct 25 14:44:51 volumio systemd[1]: media-Zaloha2.mount: Succeeded. Oct 25 14:44:51 volumio sudo[3873]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:52 volumio kernel: usb 1-1.4: new high-speed USB device number 33 using dwc_otg Oct 25 14:44:53 volumio kernel: usb 1-1.4: New USB device found, idVendor=152d, idProduct=2329, bcdDevice= 1.00 Oct 25 14:44:53 volumio kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=5 Oct 25 14:44:53 volumio kernel: usb 1-1.4: Product: USB to ATA/ATAPI Bridge Oct 25 14:44:53 volumio kernel: usb 1-1.4: Manufacturer: JMicron Oct 25 14:44:53 volumio kernel: usb 1-1.4: SerialNumber: 97327FFFFFFF Oct 25 14:44:53 volumio kernel: usb-storage 1-1.4:1.0: USB Mass Storage device detected Oct 25 14:44:53 volumio kernel: usb-storage 1-1.4:1.0: Quirks match for vid 152d pid 2329: 8020 Oct 25 14:44:53 volumio kernel: scsi host0: usb-storage 1-1.4:1.0 Oct 25 14:44:54 volumio kernel: scsi 0:0:0:0: Direct-Access FUJITSU MHV2120BH PL PQ: 0 ANSI: 2 CCS Oct 25 14:44:54 volumio kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Oct 25 14:44:54 volumio kernel: sd 0:0:0:0: [sda] 234441648 512-byte logical blocks: (120 GB/112 GiB) Oct 25 14:44:54 volumio kernel: sd 0:0:0:0: [sda] Write Protect is off Oct 25 14:44:54 volumio kernel: sd 0:0:0:0: [sda] Mode Sense: 34 00 00 00 Oct 25 14:44:54 volumio kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Oct 25 14:44:54 volumio kernel: sda: sda1 sda2 Oct 25 14:44:54 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI disk Oct 25 14:44:54 volumio volumio[1123]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/ServiceV002 Oct 25 14:44:55 volumio volumio[1123]: info: Mounting Device ServiceV002 Oct 25 14:44:55 volumio sudo[3884]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/ServiceV002 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Oct 25 14:44:55 volumio sudo[3884]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:56 volumio kernel: sd 0:0:0:0: [sda] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=0s Oct 25 14:44:56 volumio kernel: sd 0:0:0:0: [sda] tag#0 CDB: opcode=0x28 28 00 00 bc 7f 80 00 00 08 00 Oct 25 14:44:56 volumio kernel: I/O error, dev sda, sector 12353408 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Oct 25 14:44:56 volumio kernel: usb 1-1.4: USB disconnect, device number 33 Oct 25 14:44:56 volumio kernel: buffer_io_error: 11 callbacks suppressed Oct 25 14:44:56 volumio kernel: Buffer I/O error on dev sda1, logical block 1543920, async page read Oct 25 14:44:56 volumio kernel: ext3: Unknown parameter 'dmask' Oct 25 14:44:56 volumio kernel: ext2: Unknown parameter 'dmask' Oct 25 14:44:56 volumio kernel: ext4: Unknown parameter 'dmask' Oct 25 14:44:56 volumio sudo[3884]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:56 volumio volumio[1123]: mount: /media/ServiceV002: special device /dev/sda1 does not exist. Oct 25 14:44:56 volumio volumio[1123]: error: Failed to mount ServiceV002: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda1" "/mnt/USB/ServiceV002" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Oct 25 14:44:56 volumio volumio[1123]: mount: /media/ServiceV002: special device /dev/sda1 does not exist. Oct 25 14:44:56 volumio volumio[1123]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/Zaloha2 Oct 25 14:44:56 volumio volumio[1123]: lsblk: /dev/sda2: not a block device Oct 25 14:44:56 volumio volumio[1123]: lsblk: /dev/: not a block device Oct 25 14:44:56 volumio volumio[1123]: error: Failed USB identification: Error: Command failed: /bin/lsblk -rno tran "/dev/$(lsblk -rno PKNAME /dev/sda2)" Oct 25 14:44:56 volumio volumio[1123]: lsblk: /dev/sda2: not a block device Oct 25 14:44:56 volumio volumio[1123]: lsblk: /dev/: not a block device Oct 25 14:44:56 volumio volumio[1123]: info: Ignoring mount for partition: Zaloha2 Oct 25 14:44:56 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 25 14:44:56 volumio volumio[1123]: info: CURURI: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je Oct 25 14:44:56 volumio volumio[1123]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/ata-FUJITSU_MHV2120BH_PL_NW9ST7327KTF-part1 /dev/disk/by-path/platform-3f980000.usb-usb-0:1.4:1.0-scsi-0:0:0:0-part1 /dev/disk/by-uuid/8C7E5B047E5AE70C /dev/disk/by-label/ServiceV002 /dev/disk/by-partuuid/95f3457a-01","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"56","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_AAM":"1","ID_ATA_FEATURE_SET_AAM_CURRENT_VALUE":"254","ID_ATA_FEATURE_SET_AAM_ENABLED":"1","ID_ATA_FEATURE_SET_AAM_VENDOR_RECOMMENDED_VALUE":"254","ID_ATA_FEATURE_SET_APM":"1","ID_ATA_FEATURE_SET_APM_CURRENT_VALUE":"128","ID_ATA_FEATURE_SET_APM_ENABLED":"1","ID_ATA_FEATURE_SET_HPA":"1","ID_ATA_FEATURE_SET_HPA_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"120","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_FS_LABEL":"ServiceV002","ID_FS_LABEL_ENC":"ServiceV002","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"8C7E5B047E5AE70C","ID_FS_UUID_ENC":"8C7E5B047E5AE70C","ID_MODEL":"FUJITSU_MHV2120BH_PL","ID_MODEL_ENC":"FUJITSU\\x20MHV2120BH\\x20PL\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"12351488","ID_PART_ENTRY_TYPE":"0x27","ID_PART_ENTRY_UUID":"95f3457a-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"95f3457a","ID_PATH":"platform-3f980000.usb-usb-0:1.4:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_4_1_0-scsi-0_0_0_0","ID_REVISION":"0084002A","ID_SERIAL":"FUJITSU_MHV2120BH_PL_NW9ST7327KTF","ID_SERIAL_SHORT":"NW9ST7327KTF","ID_TYPE":"disk","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"3052","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"416593438"} Oct 25 14:44:56 volumio sudo[3890]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1 Oct 25 14:44:56 volumio sudo[3890]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:56 volumio sudo[3890]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:56 volumio volumio[1123]: umount: /dev/sda1: no mount point specified. Oct 25 14:44:56 volumio volumio[1123]: error: Failed to umount ServiceV002: Error: Command failed: /usr/bin/sudo /bin/umount -f "/dev/sda1" Oct 25 14:44:56 volumio volumio[1123]: umount: /dev/sda1: no mount point specified. Oct 25 14:44:56 volumio volumio[1123]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","ACTION":"remove","DEVLINKS":"/dev/disk/by-path/platform-3f980000.usb-usb-0:1.4:1.0-scsi-0:0:0:0-part2 /dev/disk/by-label/Zaloha2 /dev/disk/by-uuid/1448E55C48E53CDC /dev/disk/by-id/ata-FUJITSU_MHV2120BH_PL_NW9ST7327KTF-part2 /dev/disk/by-partuuid/95f3457a-02","DEVNAME":"/dev/sda2","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.4/1-1.4:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","DEVTYPE":"partition","DISKSEQ":"56","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_AAM":"1","ID_ATA_FEATURE_SET_AAM_CURRENT_VALUE":"254","ID_ATA_FEATURE_SET_AAM_ENABLED":"1","ID_ATA_FEATURE_SET_AAM_VENDOR_RECOMMENDED_VALUE":"254","ID_ATA_FEATURE_SET_APM":"1","ID_ATA_FEATURE_SET_APM_CURRENT_VALUE":"128","ID_ATA_FEATURE_SET_APM_ENABLED":"1","ID_ATA_FEATURE_SET_HPA":"1","ID_ATA_FEATURE_SET_HPA_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"120","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_FS_LABEL":"Zaloha2","ID_FS_LABEL_ENC":"Zaloha2","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"1448E55C48E53CDC","ID_FS_UUID_ENC":"1448E55C48E53CDC","ID_MODEL":"FUJITSU_MHV2120BH_PL","ID_MODEL_ENC":"FUJITSU\\x20MHV2120BH\\x20PL\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_FLAGS":"0x80","ID_PART_ENTRY_NUMBER":"2","ID_PART_ENTRY_OFFSET":"12353536","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"222083072","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"95f3457a-02","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"95f3457a","ID_PATH":"platform-3f980000.usb-usb-0:1.4:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_4_1_0-scsi-0_0_0_0","ID_REVISION":"0084002A","ID_SERIAL":"FUJITSU_MHV2120BH_PL_NW9ST7327KTF","ID_SERIAL_SHORT":"NW9ST7327KTF","ID_TYPE":"disk","MAJOR":"8","MINOR":"2","PARTN":"2","SEQNUM":"3053","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"416593630"} Oct 25 14:44:56 volumio sudo[3893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda2 Oct 25 14:44:56 volumio sudo[3893]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:56 volumio sudo[3893]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:56 volumio volumio[1123]: umount: /dev/sda2: no mount point specified. Oct 25 14:44:56 volumio volumio[1123]: error: Failed to umount Zaloha2: Error: Command failed: /usr/bin/sudo /bin/umount -f "/dev/sda2" Oct 25 14:44:56 volumio volumio[1123]: umount: /dev/sda2: no mount point specified. Oct 25 14:44:56 volumio volumio[1123]: info: Preload queue cleared Oct 25 14:44:56 volumio volumio[1123]: info: Preloading song: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/01 - Starosta.mp3 Oct 25 14:44:56 volumio volumio[1123]: info: Preloading song: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/02 - Keby.mp3 Oct 25 14:44:56 volumio volumio[1123]: info: Preloading song: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/03 - Medzi blokmi.mp3 Oct 25 14:44:56 volumio volumio[1123]: info: Preloading song: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/04 - Stromy.mp3 Oct 25 14:44:56 volumio volumio[1123]: info: Preloading song: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/05 - Za oknami.mp3 Oct 25 14:44:56 volumio volumio[1123]: info: Preloading song: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/06 - Čím to je.mp3 Oct 25 14:44:56 volumio volumio[1123]: info: Preloading song: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/08 - Cesta.mp3 Oct 25 14:44:56 volumio volumio[1123]: info: Preloading song: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/09 - Na tej istej vlne.mp3 Oct 25 14:44:56 volumio volumio[1123]: info: Preloading song: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/10 - Čas minulý.mp3 Oct 25 14:44:56 volumio volumio[1123]: info: Preloading song: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/11 - To bude vekom.mp3 Oct 25 14:44:56 volumio volumio[1123]: info: Preloading song: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/07 - Spravne žiť.mp3 Oct 25 14:44:56 volumio volumio[1123]: info: Scanning removed location : "USB/ServiceV002" Oct 25 14:44:56 volumio volumio[1123]: info: Exploding uri music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/01 - Starosta.mp3 in service mpd Oct 25 14:44:56 volumio volumio[1123]: error: scanFolder - failure to stat '/mnt/USB/Zaloha2/HUDBA/No Name - Čím to je/01 - Starosta.mp3' Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:56 volumio volumio[1123]: info: Oct 25 14:44:56 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:56 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:56 volumio volumio[1123]: info: Oct 25 14:44:56 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:56 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:56 volumio volumio[1123]: info: Oct 25 14:44:56 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:56 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:56 volumio volumio[1123]: info: Oct 25 14:44:56 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:56 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:56 volumio volumio[1123]: info: MPD Database updated - AlbumList cache refreshed Oct 25 14:44:56 volumio volumio[1123]: info: Oct 25 14:44:56 volumio volumio[1123]: ---------------------------- MPD announces state update: database Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:56 volumio volumio[1123]: info: Oct 25 14:44:56 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:56 volumio volumio[1123]: info: sendMpdCommand status took 16 milliseconds Oct 25 14:44:56 volumio volumio[1123]: info: sendMpdCommand status took 14 milliseconds Oct 25 14:44:56 volumio volumio[1123]: info: sendMpdCommand status took 13 milliseconds Oct 25 14:44:56 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:56 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:56 volumio volumio[1123]: info: sendMpdCommand status took 14 milliseconds Oct 25 14:44:56 volumio volumio[1123]: info: sendMpdCommand status took 13 milliseconds Oct 25 14:44:56 volumio volumio[1123]: info: sendMpdCommand status took 11 milliseconds Oct 25 14:44:56 volumio volumio[1123]: info: sendMpdCommand status took 11 milliseconds Oct 25 14:44:56 volumio volumio[1123]: info: sendMpdCommand status took 10 milliseconds Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:56 volumio volumio[1123]: info: Command Router : Notfying DB Updatetrue Oct 25 14:44:56 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:56 volumio volumio[1123]: info: Command Router : Notfying DB Updatetrue Oct 25 14:44:56 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:56 volumio volumio[1123]: info: Command Router : Notfying DB Updatefalse Oct 25 14:44:56 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:56 volumio volumio[1123]: info: Command Router : Notfying DB Updatefalse Oct 25 14:44:56 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:56 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:56 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:56 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:56 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:56 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 25 14:44:56 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:56 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:56 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:56 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:56 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:56 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:56 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:56 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:56 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:56 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:56 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:56 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:56 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:56 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:56 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:56 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:56 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:56 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:56 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:56 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:56 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:56 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:56 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:56 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:56 volumio volumio[1123]: info: ------------------------------ 317ms Oct 25 14:44:56 volumio volumio[1123]: info: ------------------------------ 314ms Oct 25 14:44:56 volumio volumio[1123]: info: ------------------------------ 312ms Oct 25 14:44:56 volumio volumio[1123]: info: ------------------------------ 311ms Oct 25 14:44:56 volumio volumio[1123]: info: MPD Database updated - AlbumList cache refreshed Oct 25 14:44:56 volumio volumio[1123]: info: Oct 25 14:44:56 volumio volumio[1123]: ---------------------------- MPD announces state update: database Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:56 volumio volumio[1123]: info: Oct 25 14:44:56 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:56 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:56 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:56 volumio volumio[1123]: info: MPD Database updated - AlbumList cache refreshed Oct 25 14:44:56 volumio volumio[1123]: info: Oct 25 14:44:56 volumio volumio[1123]: ---------------------------- MPD announces state update: database Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:56 volumio volumio[1123]: info: Oct 25 14:44:56 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:56 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:56 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:56 volumio volumio[1123]: info: MPD Database updated - AlbumList cache refreshed Oct 25 14:44:56 volumio volumio[1123]: info: Oct 25 14:44:56 volumio volumio[1123]: ---------------------------- MPD announces state update: database Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:56 volumio volumio[1123]: info: Oct 25 14:44:56 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:44:56 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:56 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:44:56 volumio volumio[1123]: info: Exploding uri music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/02 - Keby.mp3 in service mpd Oct 25 14:44:56 volumio volumio[1123]: error: scanFolder - failure to stat '/mnt/USB/Zaloha2/HUDBA/No Name - Čím to je/02 - Keby.mp3' Oct 25 14:44:56 volumio volumio[1123]: info: Exploding uri music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/03 - Medzi blokmi.mp3 in service mpd Oct 25 14:44:56 volumio volumio[1123]: error: scanFolder - failure to stat '/mnt/USB/Zaloha2/HUDBA/No Name - Čím to je/03 - Medzi blokmi.mp3' Oct 25 14:44:56 volumio volumio[1123]: info: Exploding uri music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/04 - Stromy.mp3 in service mpd Oct 25 14:44:56 volumio volumio[1123]: error: scanFolder - failure to stat '/mnt/USB/Zaloha2/HUDBA/No Name - Čím to je/04 - Stromy.mp3' Oct 25 14:44:56 volumio volumio[1123]: info: Exploding uri music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/05 - Za oknami.mp3 in service mpd Oct 25 14:44:56 volumio volumio[1123]: error: scanFolder - failure to stat '/mnt/USB/Zaloha2/HUDBA/No Name - Čím to je/05 - Za oknami.mp3' Oct 25 14:44:56 volumio volumio[1123]: info: Exploding uri music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/06 - Čím to je.mp3 in service mpd Oct 25 14:44:56 volumio volumio[1123]: error: scanFolder - failure to stat '/mnt/USB/Zaloha2/HUDBA/No Name - Čím to je/06 - Čím to je.mp3' Oct 25 14:44:56 volumio volumio[1123]: info: Exploding uri music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/08 - Cesta.mp3 in service mpd Oct 25 14:44:56 volumio volumio[1123]: error: scanFolder - failure to stat '/mnt/USB/Zaloha2/HUDBA/No Name - Čím to je/08 - Cesta.mp3' Oct 25 14:44:56 volumio volumio[1123]: info: Exploding uri music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/09 - Na tej istej vlne.mp3 in service mpd Oct 25 14:44:56 volumio volumio[1123]: error: scanFolder - failure to stat '/mnt/USB/Zaloha2/HUDBA/No Name - Čím to je/09 - Na tej istej vlne.mp3' Oct 25 14:44:56 volumio volumio[1123]: info: sendMpdCommand status took 380 milliseconds Oct 25 14:44:56 volumio volumio[1123]: info: sendMpdCommand status took 379 milliseconds Oct 25 14:44:56 volumio volumio[1123]: info: sendMpdCommand status took 378 milliseconds Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:56 volumio volumio[1123]: info: Command Router : Notfying DB Updatefalse Oct 25 14:44:56 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:56 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:56 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:56 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:56 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:56 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 25 14:44:56 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:56 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:56 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:56 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:56 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:56 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:56 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:56 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:56 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:56 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:56 volumio volumio[1123]: info: ------------------------------ 458ms Oct 25 14:44:56 volumio volumio[1123]: info: ------------------------------ 458ms Oct 25 14:44:56 volumio volumio[1123]: info: sendMpdCommand status took 187 milliseconds Oct 25 14:44:56 volumio volumio[1123]: info: sendMpdCommand status took 186 milliseconds Oct 25 14:44:56 volumio volumio[1123]: info: sendMpdCommand status took 185 milliseconds Oct 25 14:44:56 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:57 volumio volumio[1123]: info: Command Router : Notfying DB Updatefalse Oct 25 14:44:57 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:57 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:57 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:57 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:57 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:57 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:57 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:57 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:57 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:57 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:57 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:57 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:57 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:57 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:57 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:57 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:57 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:57 volumio volumio[1123]: info: ------------------------------ 267ms Oct 25 14:44:57 volumio volumio[1123]: info: ------------------------------ 268ms Oct 25 14:44:57 volumio volumio[1123]: info: sendMpdCommand status took 290 milliseconds Oct 25 14:44:57 volumio volumio[1123]: info: sendMpdCommand status took 289 milliseconds Oct 25 14:44:57 volumio volumio[1123]: info: sendMpdCommand status took 289 milliseconds Oct 25 14:44:57 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:57 volumio volumio[1123]: info: Command Router : Notfying DB Updatefalse Oct 25 14:44:57 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:57 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:57 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:57 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:57 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:57 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:57 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:57 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:57 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:57 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:57 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:57 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:57 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:57 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:57 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:57 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:57 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:57 volumio volumio[1123]: info: ------------------------------ 371ms Oct 25 14:44:57 volumio volumio[1123]: info: ------------------------------ 371ms Oct 25 14:44:57 volumio volumio[1123]: info: sendMpdCommand status took 398 milliseconds Oct 25 14:44:57 volumio volumio[1123]: info: sendMpdCommand status took 397 milliseconds Oct 25 14:44:57 volumio volumio[1123]: info: sendMpdCommand status took 397 milliseconds Oct 25 14:44:57 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:57 volumio volumio[1123]: info: Command Router : Notfying DB Updatefalse Oct 25 14:44:57 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:44:57 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:57 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:44:57 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:57 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:57 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:57 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:57 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:57 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:57 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:57 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:44:57 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:44:57 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:44:57 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:57 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:44:57 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:44:57 volumio volumio[1123]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current spop Received mpd Oct 25 14:44:57 volumio volumio[1123]: info: ------------------------------ 474ms Oct 25 14:44:57 volumio volumio[1123]: info: ------------------------------ 475ms Oct 25 14:44:57 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:57 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:57 volumio sudo[3915]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:57 volumio sudo[3915]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:57 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:57 volumio sudo[3918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:57 volumio sudo[3918]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:57 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:57 volumio sudo[3921]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:57 volumio sudo[3921]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:57 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:57 volumio sudo[3915]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:57 volumio sudo[3924]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:57 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:57 volumio sudo[3924]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:57 volumio sudo[3918]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:57 volumio sudo[3927]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:57 volumio sudo[3927]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:57 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:57 volumio sudo[3929]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:57 volumio sudo[3929]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:57 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:57 volumio sudo[3933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:57 volumio sudo[3933]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:57 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:57 volumio sudo[3921]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:57 volumio sudo[3924]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:57 volumio sudo[3935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:57 volumio sudo[3935]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:57 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:57 volumio sudo[3939]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:57 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:57 volumio sudo[3939]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:57 volumio volumio[1123]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 25 14:44:57 volumio sudo[3933]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:58 volumio sudo[3942]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:58 volumio sudo[3929]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:58 volumio sudo[3942]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:58 volumio sudo[3927]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:58 volumio sudo[3935]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:58 volumio sudo[3944]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:58 volumio sudo[3944]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:58 volumio volumio[1123]: info: Exploding uri music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/10 - Čas minulý.mp3 in service mpd Oct 25 14:44:58 volumio volumio[1123]: error: scanFolder - failure to stat '/mnt/USB/Zaloha2/HUDBA/No Name - Čím to je/10 - Čas minulý.mp3' Oct 25 14:44:58 volumio volumio[1123]: info: Exploding uri music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/11 - To bude vekom.mp3 in service mpd Oct 25 14:44:58 volumio volumio[1123]: error: scanFolder - failure to stat '/mnt/USB/Zaloha2/HUDBA/No Name - Čím to je/11 - To bude vekom.mp3' Oct 25 14:44:58 volumio volumio[1123]: info: Exploding uri music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/07 - Spravne žiť.mp3 in service mpd Oct 25 14:44:58 volumio volumio[1123]: error: scanFolder - failure to stat '/mnt/USB/Zaloha2/HUDBA/No Name - Čím to je/07 - Spravne žiť.mp3' Oct 25 14:44:58 volumio sudo[3947]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 25 14:44:58 volumio sudo[3947]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:44:58 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:58 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:58 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:58 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:58 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:58 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:58 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:58 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:58 volumio sudo[3939]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:58 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:58 volumio sudo[3942]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:58 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:58 volumio sudo[3947]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:58 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:44:58 volumio sudo[3944]: pam_unix(sudo:session): session closed for user root Oct 25 14:44:58 volumio volumio[1123]: info: peppymeterbasic Daemon Stop Oct 25 14:45:00 volumio go-librespot[1945]: time="2024-10-25T14:45:00+02:00" level=error msg="did not receive last pong ack from accesspoint, 120s passed" Oct 25 14:45:01 volumio go-librespot[1945]: time="2024-10-25T14:45:01+02:00" level=error msg="did not receive last pong from dealer, 210s passed" Oct 25 14:45:01 volumio sudo[2464]: pam_unix(sudo:session): session closed for user root Oct 25 14:45:01 volumio volumio[1123]: info: Cannot mount NAS HUDBA_MP3 at system boot, trial number 2 ,retrying in 5 seconds Oct 25 14:45:02 volumio kernel: usb 1-1.4: new high-speed USB device number 34 using dwc_otg Oct 25 14:45:02 volumio volumio[1123]: info: Preload queue cleared Oct 25 14:45:02 volumio volumio[1123]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 25 14:45:02 volumio volumio[1123]: info: CoreStateMachine::ClearQueue Oct 25 14:45:02 volumio volumio[1123]: info: CoreStateMachine::stop Oct 25 14:45:02 volumio volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 25 14:45:02 volumio volumio[1123]: info: CorePlayQueue::clearPlayQueue Oct 25 14:45:02 volumio volumio[1123]: info: CorePlayQueue::saveQueue Oct 25 14:45:02 volumio volumio[1123]: info: CoreCommandRouter::volumioPushQueue Oct 25 14:45:02 volumio volumio[1123]: info: CoreStateMachine::addQueueItems Oct 25 14:45:02 volumio volumio[1123]: info: CorePlayQueue::addQueueItems Oct 25 14:45:02 volumio volumio[1123]: info: Preload queue cleared Oct 25 14:45:02 volumio volumio[1123]: info: Adding Item to queue: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/01 - Starosta.mp3 Oct 25 14:45:02 volumio volumio[1123]: info: Using cached record of: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/01 - Starosta.mp3 Oct 25 14:45:02 volumio volumio[1123]: info: Adding Item to queue: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/02 - Keby.mp3 Oct 25 14:45:02 volumio volumio[1123]: info: Using cached record of: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/02 - Keby.mp3 Oct 25 14:45:02 volumio volumio[1123]: info: Adding Item to queue: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/03 - Medzi blokmi.mp3 Oct 25 14:45:02 volumio volumio[1123]: info: Using cached record of: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/03 - Medzi blokmi.mp3 Oct 25 14:45:02 volumio volumio[1123]: info: Adding Item to queue: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/04 - Stromy.mp3 Oct 25 14:45:02 volumio volumio[1123]: info: Using cached record of: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/04 - Stromy.mp3 Oct 25 14:45:02 volumio volumio[1123]: info: Adding Item to queue: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/05 - Za oknami.mp3 Oct 25 14:45:02 volumio volumio[1123]: info: Using cached record of: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/05 - Za oknami.mp3 Oct 25 14:45:02 volumio volumio[1123]: info: Adding Item to queue: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/06 - Čím to je.mp3 Oct 25 14:45:02 volumio volumio[1123]: info: Using cached record of: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/06 - Čím to je.mp3 Oct 25 14:45:02 volumio volumio[1123]: info: Adding Item to queue: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/08 - Cesta.mp3 Oct 25 14:45:02 volumio volumio[1123]: info: Using cached record of: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/08 - Cesta.mp3 Oct 25 14:45:02 volumio volumio[1123]: info: Adding Item to queue: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/09 - Na tej istej vlne.mp3 Oct 25 14:45:02 volumio volumio[1123]: info: Using cached record of: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/09 - Na tej istej vlne.mp3 Oct 25 14:45:02 volumio volumio[1123]: info: Adding Item to queue: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/10 - Čas minulý.mp3 Oct 25 14:45:02 volumio volumio[1123]: info: Using cached record of: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/10 - Čas minulý.mp3 Oct 25 14:45:02 volumio volumio[1123]: info: Adding Item to queue: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/11 - To bude vekom.mp3 Oct 25 14:45:02 volumio volumio[1123]: info: Using cached record of: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/11 - To bude vekom.mp3 Oct 25 14:45:02 volumio volumio[1123]: info: Adding Item to queue: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/07 - Spravne žiť.mp3 Oct 25 14:45:02 volumio volumio[1123]: info: Using cached record of: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/07 - Spravne žiť.mp3 Oct 25 14:45:02 volumio volumio[1123]: info: CoreCommandRouter::volumioPushQueue Oct 25 14:45:02 volumio volumio[1123]: info: CorePlayQueue::saveQueue Oct 25 14:45:02 volumio volumio[1123]: info: CoreStateMachine::updateTrackBlock Oct 25 14:45:02 volumio volumio[1123]: info: CorePlayQueue::getTrackBlock Oct 25 14:45:02 volumio volumio[1123]: info: CoreCommandRouter::volumioPlay Oct 25 14:45:02 volumio volumio[1123]: info: CoreStateMachine::play index 5 Oct 25 14:45:02 volumio volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 25 14:45:02 volumio volumio[1123]: info: CoreStateMachine::stop Oct 25 14:45:02 volumio volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 25 14:45:02 volumio volumio[1123]: info: CoreStateMachine::play index undefined Oct 25 14:45:02 volumio volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 25 14:45:02 volumio volumio[1123]: info: CorePlayQueue::getTrack 5 Oct 25 14:45:02 volumio kernel: usb 1-1.4: New USB device found, idVendor=152d, idProduct=2329, bcdDevice= 1.00 Oct 25 14:45:02 volumio kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=5 Oct 25 14:45:02 volumio kernel: usb 1-1.4: Product: USB to ATA/ATAPI Bridge Oct 25 14:45:02 volumio kernel: usb 1-1.4: Manufacturer: JMicron Oct 25 14:45:03 volumio kernel: usb 1-1.4: SerialNumber: 97327FFFFFFF Oct 25 14:45:03 volumio kernel: usb-storage 1-1.4:1.0: USB Mass Storage device detected Oct 25 14:45:03 volumio kernel: usb-storage 1-1.4:1.0: Quirks match for vid 152d pid 2329: 8020 Oct 25 14:45:03 volumio kernel: scsi host0: usb-storage 1-1.4:1.0 Oct 25 14:45:04 volumio kernel: scsi 0:0:0:0: Direct-Access FUJITSU MHV2120BH PL PQ: 0 ANSI: 2 CCS Oct 25 14:45:04 volumio kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Oct 25 14:45:04 volumio kernel: sd 0:0:0:0: [sda] 234441648 512-byte logical blocks: (120 GB/112 GiB) Oct 25 14:45:04 volumio kernel: sd 0:0:0:0: [sda] Write Protect is off Oct 25 14:45:04 volumio kernel: sd 0:0:0:0: [sda] Mode Sense: 34 00 00 00 Oct 25 14:45:04 volumio kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Oct 25 14:45:04 volumio kernel: sda: sda1 sda2 Oct 25 14:45:04 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI disk Oct 25 14:45:04 volumio volumio[1123]: info: Preload queue cleared Oct 25 14:45:04 volumio volumio[1123]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 25 14:45:04 volumio volumio[1123]: info: CoreStateMachine::ClearQueue Oct 25 14:45:04 volumio volumio[1123]: info: CoreStateMachine::stop Oct 25 14:45:04 volumio volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 25 14:45:04 volumio volumio[1123]: info: CorePlayQueue::clearPlayQueue Oct 25 14:45:04 volumio volumio[1123]: info: CorePlayQueue::saveQueue Oct 25 14:45:04 volumio volumio[1123]: info: CoreCommandRouter::volumioPushQueue Oct 25 14:45:04 volumio volumio[1123]: info: CoreStateMachine::addQueueItems Oct 25 14:45:04 volumio volumio[1123]: info: CorePlayQueue::addQueueItems Oct 25 14:45:04 volumio volumio[1123]: info: Preload queue cleared Oct 25 14:45:04 volumio volumio[1123]: info: Adding Item to queue: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/01 - Starosta.mp3 Oct 25 14:45:04 volumio volumio[1123]: info: Using cached record of: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/01 - Starosta.mp3 Oct 25 14:45:04 volumio volumio[1123]: info: Adding Item to queue: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/02 - Keby.mp3 Oct 25 14:45:04 volumio volumio[1123]: info: Using cached record of: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/02 - Keby.mp3 Oct 25 14:45:04 volumio volumio[1123]: info: Adding Item to queue: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/03 - Medzi blokmi.mp3 Oct 25 14:45:04 volumio volumio[1123]: info: Using cached record of: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/03 - Medzi blokmi.mp3 Oct 25 14:45:04 volumio volumio[1123]: info: Adding Item to queue: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/04 - Stromy.mp3 Oct 25 14:45:04 volumio volumio[1123]: info: Using cached record of: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/04 - Stromy.mp3 Oct 25 14:45:04 volumio volumio[1123]: info: Adding Item to queue: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/05 - Za oknami.mp3 Oct 25 14:45:04 volumio volumio[1123]: info: Using cached record of: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/05 - Za oknami.mp3 Oct 25 14:45:04 volumio volumio[1123]: info: Adding Item to queue: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/06 - Čím to je.mp3 Oct 25 14:45:04 volumio volumio[1123]: info: Using cached record of: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/06 - Čím to je.mp3 Oct 25 14:45:04 volumio volumio[1123]: info: Adding Item to queue: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/08 - Cesta.mp3 Oct 25 14:45:04 volumio volumio[1123]: info: Using cached record of: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/08 - Cesta.mp3 Oct 25 14:45:04 volumio volumio[1123]: info: Adding Item to queue: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/09 - Na tej istej vlne.mp3 Oct 25 14:45:04 volumio volumio[1123]: info: Using cached record of: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/09 - Na tej istej vlne.mp3 Oct 25 14:45:04 volumio volumio[1123]: info: Adding Item to queue: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/10 - Čas minulý.mp3 Oct 25 14:45:04 volumio volumio[1123]: info: Using cached record of: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/10 - Čas minulý.mp3 Oct 25 14:45:04 volumio volumio[1123]: info: Adding Item to queue: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/11 - To bude vekom.mp3 Oct 25 14:45:04 volumio volumio[1123]: info: Using cached record of: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/11 - To bude vekom.mp3 Oct 25 14:45:04 volumio volumio[1123]: info: Adding Item to queue: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/07 - Spravne žiť.mp3 Oct 25 14:45:04 volumio volumio[1123]: info: Using cached record of: music-library/USB/Zaloha2/HUDBA/No Name - Čím to je/07 - Spravne žiť.mp3 Oct 25 14:45:04 volumio volumio[1123]: info: CoreCommandRouter::volumioPushQueue Oct 25 14:45:04 volumio volumio[1123]: info: CorePlayQueue::saveQueue Oct 25 14:45:04 volumio volumio[1123]: info: CoreStateMachine::updateTrackBlock Oct 25 14:45:04 volumio volumio[1123]: info: CorePlayQueue::getTrackBlock Oct 25 14:45:04 volumio volumio[1123]: info: CoreCommandRouter::volumioPlay Oct 25 14:45:04 volumio volumio[1123]: info: CoreStateMachine::play index 5 Oct 25 14:45:04 volumio volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 25 14:45:04 volumio volumio[1123]: info: CoreStateMachine::stop Oct 25 14:45:04 volumio volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 25 14:45:04 volumio volumio[1123]: info: CoreStateMachine::play index undefined Oct 25 14:45:04 volumio volumio[1123]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 25 14:45:04 volumio volumio[1123]: info: CorePlayQueue::getTrack 5 Oct 25 14:45:05 volumio volumio[1123]: info: Mounting Device ServiceV002 Oct 25 14:45:05 volumio sudo[3962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/ServiceV002 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Oct 25 14:45:05 volumio sudo[3962]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:45:05 volumio ntfs-3g[3965]: Version 2017.3.23AR.3 integrated FUSE 28 Oct 25 14:45:05 volumio ntfs-3g[3965]: Mounted /dev/sda1 (Read-Write, label "ServiceV002", NTFS 3.1) Oct 25 14:45:05 volumio ntfs-3g[3965]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Oct 25 14:45:05 volumio ntfs-3g[3965]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Oct 25 14:45:05 volumio ntfs-3g[3965]: Global ownership and permissions enforced, configuration type 7 Oct 25 14:45:05 volumio sudo[3962]: pam_unix(sudo:session): session closed for user root Oct 25 14:45:05 volumio volumio[1123]: info: Mounting Device Zaloha2 Oct 25 14:45:05 volumio sudo[3970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/Zaloha2 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Oct 25 14:45:05 volumio sudo[3970]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 14:45:06 volumio ntfs-3g[3973]: Version 2017.3.23AR.3 integrated FUSE 28 Oct 25 14:45:06 volumio ntfs-3g[3973]: Mounted /dev/sda2 (Read-Write, label "Zaloha2", NTFS 3.1) Oct 25 14:45:06 volumio ntfs-3g[3973]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Oct 25 14:45:06 volumio ntfs-3g[3973]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda2,blkdev,blksize=4096 Oct 25 14:45:06 volumio ntfs-3g[3973]: Global ownership and permissions enforced, configuration type 7 Oct 25 14:45:06 volumio sudo[3970]: pam_unix(sudo:session): session closed for user root Oct 25 14:45:06 volumio volumio[1123]: info: Scanning new location : "USB/ServiceV002" Oct 25 14:45:06 volumio volumio[1123]: info: Scanning new location : "USB/Zaloha2" Oct 25 14:45:06 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:45:06 volumio volumio[1123]: info: Oct 25 14:45:06 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:45:06 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:45:06 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:45:06 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:45:06 volumio volumio[1123]: info: Oct 25 14:45:06 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:45:06 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:45:06 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:45:06 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:45:06 volumio volumio[1123]: info: Oct 25 14:45:06 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:45:06 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:45:06 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:45:06 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:45:06 volumio volumio[1123]: info: Oct 25 14:45:06 volumio volumio[1123]: ---------------------------- MPD announces state update: update Oct 25 14:45:06 volumio volumio[1123]: info: ControllerMpd::getState Oct 25 14:45:06 volumio volumio[1123]: verbose: ControllerMpd::sendMpdCommand status Oct 25 14:45:06 volumio volumio[1123]: info: sendMpdCommand status took 14 milliseconds Oct 25 14:45:06 volumio volumio[1123]: info: sendMpdCommand status took 13 milliseconds Oct 25 14:45:06 volumio volumio[1123]: info: sendMpdCommand status took 12 milliseconds Oct 25 14:45:06 volumio volumio[1123]: info: sendMpdCommand status took 11 milliseconds Oct 25 14:45:06 volumio volumio[1123]: info: sendMpdCommand status took 11 milliseconds Oct 25 14:45:06 volumio volumio[1123]: info: sendMpdCommand status took 9 milliseconds Oct 25 14:45:06 volumio volumio[1123]: info: sendMpdCommand status took 8 milliseconds Oct 25 14:45:06 volumio volumio[1123]: info: sendMpdCommand status took 8 milliseconds Oct 25 14:45:06 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:45:06 volumio volumio[1123]: info: Command Router : Notfying DB Updatetrue Oct 25 14:45:06 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:45:06 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:45:06 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:45:06 volumio volumio[1123]: info: Command Router : Notfying DB Updatetrue Oct 25 14:45:06 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:45:06 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:45:06 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:45:06 volumio volumio[1123]: info: Command Router : Notfying DB Updatetrue Oct 25 14:45:06 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:45:06 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:45:06 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:45:06 volumio volumio[1123]: info: Command Router : Notfying DB Updatetrue Oct 25 14:45:06 volumio volumio[1123]: info: CoreCommandRouter::Close All Modals sent Oct 25 14:45:06 volumio volumio[1123]: verbose: ControllerMpd::parseState Oct 25 14:45:06 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:45:06 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:45:06 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:45:06 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:45:06 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 25 14:45:06 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:45:06 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:45:06 volumio volumio[1123]: 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} Oct 25 14:45:06 volumio volumio[1123]: verbose: CURRENT POSITION 0 Oct 25 14:45:06 volumio volumio[1123]: info: CoreStateMachine::syncState stateService stop Oct 25 14:45:06 volumio volumio[1123]: info: CoreStateMachine::syncState currentStatus stop Oct 25 14:45:06 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:45:06 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:45:06 volumio volumio[1123]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 25 14:45:06 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:45:06 volumio volumio[1123]: info: No code Oct 25 14:45:06 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:45:06 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:45:06 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:45:06 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:45:06 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:45:06 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:45:06 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:45:06 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:45:06 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:45:06 volumio volumio[1123]: 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} Oct 25 14:45:06 volumio volumio[1123]: verbose: CURRENT POSITION 0 Oct 25 14:45:06 volumio volumio[1123]: info: CoreStateMachine::syncState stateService stop Oct 25 14:45:06 volumio volumio[1123]: info: CoreStateMachine::syncState currentStatus stop Oct 25 14:45:06 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:45:06 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:45:06 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:45:06 volumio volumio[1123]: info: No code Oct 25 14:45:06 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:45:06 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:45:06 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:45:06 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:45:06 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:45:06 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:45:06 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:45:06 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:45:06 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:45:06 volumio volumio[1123]: 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} Oct 25 14:45:06 volumio volumio[1123]: verbose: CURRENT POSITION 0 Oct 25 14:45:06 volumio volumio[1123]: info: CoreStateMachine::syncState stateService stop Oct 25 14:45:06 volumio volumio[1123]: info: CoreStateMachine::syncState currentStatus stop Oct 25 14:45:06 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:45:06 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:45:06 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:45:06 volumio volumio[1123]: info: No code Oct 25 14:45:06 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:45:06 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:45:06 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:45:06 volumio volumio[1123]: info: ControllerMpd::pushState Oct 25 14:45:06 volumio volumio[1123]: info: CoreCommandRouter::servicePushState Oct 25 14:45:06 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:45:06 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:45:06 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:45:06 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:45:06 volumio volumio[1123]: 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} Oct 25 14:45:06 volumio volumio[1123]: verbose: CURRENT POSITION 0 Oct 25 14:45:06 volumio volumio[1123]: info: CoreStateMachine::syncState stateService stop Oct 25 14:45:06 volumio volumio[1123]: info: CoreStateMachine::syncState currentStatus stop Oct 25 14:45:06 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:45:06 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:45:06 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:45:06 volumio volumio[1123]: info: No code Oct 25 14:45:06 volumio volumio[1123]: info: CoreStateMachine::pushState Oct 25 14:45:06 volumio volumio[1123]: info: CorePlayQueue::getTrack 0 Oct 25 14:45:06 volumio volumio[1123]: info: CoreCommandRouter::volumioPushState Oct 25 14:45:06 volumio volumio[1123]: info: ------------------------------ 373ms Oct 25 14:45:06 volumio volumio[1123]: info: ------------------------------ 371ms Oct 25 14:45:06 volumio volumio[1123]: info: ------------------------------ 370ms Oct 25 14:45:06 volumio volumio[1123]: info: ------------------------------ 368ms Oct 25 14:45:06 volumio volumio[1123]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 25 14:45:06 volumio volumio[1123]: TypeError: Cannot read property 'replace' of undefined Oct 25 14:45:06 volumio volumio[1123]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28) Oct 25 14:45:06 volumio volumio[1123]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20) Oct 25 14:45:06 volumio volumio[1123]: at listOnTimeout (internal/timers.js:554:17) Oct 25 14:45:06 volumio volumio[1123]: at processTimers (internal/timers.js:497:7) Oct 25 14:45:06 volumio volumio[1123]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 25 14:45:07 volumio sudo[3996]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-25 14:44 Oct 25 14:45:07 volumio sudo[3996]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"