-- Logs begin at Thu 2019-02-14 17:11:59 +07, end at Mon 2024-04-15 22:59:19 +07. -- Apr 15 22:58:00 volumio volumio[1279]: info: CoreCommandRouter::volumioGetState Apr 15 22:58:02 volumio volumio[1279]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 15 22:58:02 volumio volumio[1279]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 15 22:58:02 volumio volumio[1279]: info: Retrieving Cloud Streaming UI Apr 15 22:58:02 volumio volumio[1279]: info: Getting Tidal Cloud Configuration Apr 15 22:58:02 volumio volumio[1279]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 15 22:58:02 volumio volumio[1279]: info: Getting Qobuz Cloud Configuration Apr 15 22:58:02 volumio volumio[1279]: info: Asking plugin for UI Config Apr 15 22:58:02 volumio volumio[1279]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 15 22:58:02 volumio volumio[1279]: info: Getting Spotify Cloud Configuration Apr 15 22:58:02 volumio volumio[1279]: info: Asking plugin for UI Config Apr 15 22:58:02 volumio volumio[1279]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 15 22:58:02 volumio volumio[1279]: info: Saving Spotify Acccount Apr 15 22:58:02 volumio volumio[1279]: info: Got Tidal Cloud Configuration Apr 15 22:58:02 volumio volumio[1279]: info: Got it Apr 15 22:58:02 volumio volumio[1279]: info: Got it Apr 15 22:58:02 volumio volumio[1279]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 15 22:58:02 volumio volumio[1279]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 15 22:58:02 volumio volumio[1279]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Apr 15 22:58:02 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 15 22:58:02 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 15 22:58:02 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 15 22:58:02 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 15 22:58:02 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 15 22:58:02 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 15 22:58:02 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 15 22:58:02 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 15 22:58:02 volumio volumio[1279]: info: CoreCommandRouter::volumioGetBrowseSources Apr 15 22:58:02 volumio volumio[1279]: info: CoreCommandRouter::volumioGetBrowseSources Apr 15 22:58:02 volumio volumio[1279]: info: CoreCommandRouter::volumioGetBrowseSources Apr 15 22:58:02 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 15 22:58:02 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 15 22:58:04 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Apr 15 22:58:04 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand rescan Apr 15 22:58:04 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:04 volumio volumio[1279]: info: Apr 15 22:58:04 volumio volumio[1279]: ---------------------------- MPD announces state update: update Apr 15 22:58:04 volumio volumio[1279]: info: sendMpdCommand rescan took 18 milliseconds Apr 15 22:58:04 volumio volumio[1279]: info: ControllerMpd::getState Apr 15 22:58:04 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:04 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:04 volumio volumio[1279]: info: Apr 15 22:58:04 volumio volumio[1279]: ---------------------------- MPD announces state update: update Apr 15 22:58:04 volumio volumio[1279]: info: ControllerMpd::getState Apr 15 22:58:04 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:04 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:04 volumio volumio[1279]: info: Apr 15 22:58:04 volumio volumio[1279]: ---------------------------- MPD announces state update: update Apr 15 22:58:04 volumio volumio[1279]: info: ControllerMpd::getState Apr 15 22:58:04 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:04 volumio volumio[1279]: info: sendMpdCommand status took 15 milliseconds Apr 15 22:58:04 volumio volumio[1279]: info: sendMpdCommand status took 10 milliseconds Apr 15 22:58:04 volumio volumio[1279]: info: sendMpdCommand status took 9 milliseconds Apr 15 22:58:04 volumio volumio[1279]: info: sendMpdCommand status took 8 milliseconds Apr 15 22:58:04 volumio volumio[1279]: info: sendMpdCommand status took 7 milliseconds Apr 15 22:58:04 volumio volumio[1279]: info: sendMpdCommand status took 6 milliseconds Apr 15 22:58:04 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:04 volumio volumio[1279]: info: Command Router : Notfying DB Updatetrue Apr 15 22:58:04 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:04 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 15 22:58:04 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:04 volumio volumio[1279]: info: Command Router : Notfying DB Updatetrue Apr 15 22:58:04 volumio volumio[1279]: info: CoreCommandRouter::Close All Modals sent Apr 15 22:58:04 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:04 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 15 22:58:04 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:04 volumio volumio[1279]: info: Command Router : Notfying DB Updatetrue Apr 15 22:58:04 volumio volumio[1279]: info: CoreCommandRouter::Close All Modals sent Apr 15 22:58:04 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:04 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 15 22:58:04 volumio volumio[1279]: info: sendMpdCommand playlistinfo took 121 milliseconds Apr 15 22:58:04 volumio volumio[1279]: info: sendMpdCommand playlistinfo took 78 milliseconds Apr 15 22:58:04 volumio volumio[1279]: info: sendMpdCommand playlistinfo took 32 milliseconds Apr 15 22:58:04 volumio volumio[1279]: verbose: ControllerMpd::parseTrackInfo Apr 15 22:58:04 volumio volumio[1279]: verbose: ControllerMpd::parseTrackInfo Apr 15 22:58:04 volumio volumio[1279]: verbose: ControllerMpd::parseTrackInfo Apr 15 22:58:04 volumio volumio[1279]: info: ControllerMpd::pushState Apr 15 22:58:04 volumio volumio[1279]: info: CoreCommandRouter::servicePushState Apr 15 22:58:04 volumio volumio[1279]: info: CorePlayQueue::getTrack 0 Apr 15 22:58:04 volumio volumio[1279]: verbose: STATE SERVICE {"status":"play","position":0,"seek":40878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Bergama Super FM","artist":"Bergama Super FM","album":null,"uri":"https://panel.radyomhd.com:1330/","trackType":"com:1330/"} Apr 15 22:58:04 volumio volumio[1279]: verbose: CURRENT POSITION 0 Apr 15 22:58:04 volumio volumio[1279]: info: CoreStateMachine::syncState stateService play Apr 15 22:58:04 volumio volumio[1279]: info: CoreStateMachine::syncState currentStatus play Apr 15 22:58:04 volumio volumio[1279]: info: Received an update from plugin. extracting info from payload Apr 15 22:58:04 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 15 22:58:04 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:04 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 22:58:04 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:04 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:04 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:04 volumio volumio[1279]: info: ControllerMpd::pushState Apr 15 22:58:04 volumio volumio[1279]: info: CoreCommandRouter::servicePushState Apr 15 22:58:04 volumio volumio[1279]: info: CorePlayQueue::getTrack 0 Apr 15 22:58:04 volumio volumio[1279]: verbose: STATE SERVICE {"status":"play","position":0,"seek":40878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Bergama Super FM","artist":"Bergama Super FM","album":null,"uri":"https://panel.radyomhd.com:1330/","trackType":"com:1330/"} Apr 15 22:58:04 volumio volumio[1279]: verbose: CURRENT POSITION 0 Apr 15 22:58:04 volumio volumio[1279]: info: CoreStateMachine::syncState stateService play Apr 15 22:58:04 volumio volumio[1279]: info: CoreStateMachine::syncState currentStatus play Apr 15 22:58:04 volumio volumio[1279]: info: Received an update from plugin. extracting info from payload Apr 15 22:58:04 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 15 22:58:04 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:04 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:04 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:04 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:04 volumio volumio[1279]: info: ControllerMpd::pushState Apr 15 22:58:04 volumio volumio[1279]: info: CoreCommandRouter::servicePushState Apr 15 22:58:04 volumio volumio[1279]: info: CorePlayQueue::getTrack 0 Apr 15 22:58:04 volumio volumio[1279]: verbose: STATE SERVICE {"status":"play","position":0,"seek":40878,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Bergama Super FM","artist":"Bergama Super FM","album":null,"uri":"https://panel.radyomhd.com:1330/","trackType":"com:1330/"} Apr 15 22:58:04 volumio volumio[1279]: verbose: CURRENT POSITION 0 Apr 15 22:58:04 volumio volumio[1279]: info: CoreStateMachine::syncState stateService play Apr 15 22:58:04 volumio volumio[1279]: info: CoreStateMachine::syncState currentStatus play Apr 15 22:58:04 volumio volumio[1279]: info: Received an update from plugin. extracting info from payload Apr 15 22:58:04 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 15 22:58:04 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:04 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:04 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:04 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:04 volumio volumio[1279]: info: ------------------------------ 320ms Apr 15 22:58:04 volumio volumio[1279]: info: ------------------------------ 315ms Apr 15 22:58:04 volumio volumio[1279]: info: ------------------------------ 313ms Apr 15 22:58:05 volumio kernel: sd 0:0:0:0: [sda] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=1s Apr 15 22:58:05 volumio kernel: sd 0:0:0:0: [sda] tag#0 CDB: opcode=0x28 28 00 00 00 09 20 00 00 08 00 Apr 15 22:58:05 volumio kernel: I/O error, dev sda, sector 2336 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Apr 15 22:58:05 volumio kernel: usb 1-1.3: USB disconnect, device number 6 Apr 15 22:58:05 volumio volumio[1279]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-partuuid/f8008c76-01 /dev/disk/by-path/platform-3f980000.usb-usb-0:1.3:1.0-scsi-0:0:0:0-part1 /dev/disk/by-uuid/F840559C40556304 /dev/disk/by-id/ata-TOSHIBA_MQ04ABF100_10HLTOD0T-part1 /dev/disk/by-label/2 /dev/disk/by-id/wwn-0x50000399c1a023c0-part1","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"28","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_APM":"1","ID_ATA_FEATURE_SET_APM_CURRENT_VALUE":"128","ID_ATA_FEATURE_SET_APM_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_PUIS":"1","ID_ATA_FEATURE_SET_PUIS_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN":"65714","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"65714","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_ROTATION_RATE_RPM":"5400","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_SATA_SIGNAL_RATE_GEN2":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_FS_LABEL":"2","ID_FS_LABEL_ENC":"2","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"F840559C40556304","ID_FS_UUID_ENC":"F840559C40556304","ID_MODEL":"TOSHIBA_MQ04ABF100","ID_MODEL_ENC":"TOSHIBA\\x20MQ04ABF100\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"1126397952","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"f8008c76-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"f8008c76","ID_PATH":"platform-3f980000.usb-usb-0:1.3:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_3_1_0-scsi-0_0_0_0","ID_REVISION":"JU007C","ID_SERIAL":"TOSHIBA_MQ04ABF100_10HLTOD0T","ID_SERIAL_SHORT":"10HLTOD0T","ID_TYPE":"disk","ID_WWN":"0x50000399c1a023c0","ID_WWN_WITH_EXTENSION":"0x50000399c1a023c0","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"1585","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"20235957"} Apr 15 22:58:05 volumio ntfs-3g[1323]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Apr 15 22:58:05 volumio ntfs-3g[1323]: Failed to read vcn 0x0 from inode 5: Input/output error Apr 15 22:58:05 volumio kernel: Buffer I/O error on dev sda1, logical block 36, async page read Apr 15 22:58:05 volumio ntfs-3g[1323]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Apr 15 22:58:05 volumio ntfs-3g[1323]: Failed to read index block: Input/output error Apr 15 22:58:05 volumio ntfs-3g[1331]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Apr 15 22:58:05 volumio ntfs-3g[1331]: Failed to read vcn 0x0 from inode 5: Input/output error Apr 15 22:58:05 volumio ntfs-3g[1331]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Apr 15 22:58:05 volumio ntfs-3g[1331]: Failed to read index block: Input/output error Apr 15 22:58:05 volumio kernel: Buffer I/O error on dev sda1, logical block 36, async page read Apr 15 22:58:05 volumio kernel: Buffer I/O error on dev sda2, logical block 60915717, async page read Apr 15 22:58:05 volumio kernel: Buffer I/O error on dev sda2, logical block 60915717, async page read Apr 15 22:58:05 volumio sudo[2143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1 Apr 15 22:58:05 volumio sudo[2143]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 22:58:05 volumio kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache Apr 15 22:58:05 volumio kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x01 driverbyte=DRIVER_OK Apr 15 22:58:05 volumio ntfs-3g[1323]: Unmounting /dev/sda1 (2) Apr 15 22:58:05 volumio ntfs-3g[1323]: Failed to sync device /dev/sda1: Input/output error Apr 15 22:58:05 volumio ntfs-3g[1323]: Failed to close volume /dev/sda1: Input/output error Apr 15 22:58:05 volumio sudo[2143]: pam_unix(sudo:session): session closed for user root Apr 15 22:58:05 volumio systemd[1]: media-2.mount: Succeeded. Apr 15 22:58:05 volumio volumio[1279]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3: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.3:1.0-scsi-0:0:0:0-part2 /dev/disk/by-uuid/6666A15966A12B2F /dev/disk/by-label/3 /dev/disk/by-id/wwn-0x50000399c1a023c0-part2 /dev/disk/by-partuuid/f8008c76-02 /dev/disk/by-id/ata-TOSHIBA_MQ04ABF100_10HLTOD0T-part2","DEVNAME":"/dev/sda2","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","DEVTYPE":"partition","DISKSEQ":"28","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_APM":"1","ID_ATA_FEATURE_SET_APM_CURRENT_VALUE":"128","ID_ATA_FEATURE_SET_APM_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_PUIS":"1","ID_ATA_FEATURE_SET_PUIS_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN":"65714","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"65714","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_ROTATION_RATE_RPM":"5400","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_SATA_SIGNAL_RATE_GEN2":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_FS_LABEL":"3","ID_FS_LABEL_ENC":"3","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"6666A15966A12B2F","ID_FS_UUID_ENC":"6666A15966A12B2F","ID_MODEL":"TOSHIBA_MQ04ABF100","ID_MODEL_ENC":"TOSHIBA\\x20MQ04ABF100\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"2","ID_PART_ENTRY_OFFSET":"1126402048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"827117568","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"f8008c76-02","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"f8008c76","ID_PATH":"platform-3f980000.usb-usb-0:1.3:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_3_1_0-scsi-0_0_0_0","ID_REVISION":"JU007C","ID_SERIAL":"TOSHIBA_MQ04ABF100_10HLTOD0T","ID_SERIAL_SHORT":"10HLTOD0T","ID_TYPE":"disk","ID_WWN":"0x50000399c1a023c0","ID_WWN_WITH_EXTENSION":"0x50000399c1a023c0","MAJOR":"8","MINOR":"2","PARTN":"2","SEQNUM":"1586","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"20216873"} Apr 15 22:58:05 volumio sudo[2146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda2 Apr 15 22:58:05 volumio sudo[2146]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 22:58:05 volumio ntfs-3g[1331]: Unmounting /dev/sda2 (3) Apr 15 22:58:05 volumio ntfs-3g[1331]: Failed to sync device /dev/sda2: Input/output error Apr 15 22:58:05 volumio ntfs-3g[1331]: Failed to close volume /dev/sda2: Input/output error Apr 15 22:58:05 volumio systemd[1]: media-3.mount: Succeeded. Apr 15 22:58:05 volumio sudo[2146]: pam_unix(sudo:session): session closed for user root Apr 15 22:58:05 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:05 volumio volumio[1279]: info: Apr 15 22:58:05 volumio volumio[1279]: ---------------------------- MPD announces state update: update Apr 15 22:58:05 volumio volumio[1279]: info: ControllerMpd::getState Apr 15 22:58:05 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:05 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:05 volumio volumio[1279]: info: Apr 15 22:58:05 volumio volumio[1279]: ---------------------------- MPD announces state update: update Apr 15 22:58:05 volumio volumio[1279]: info: ControllerMpd::getState Apr 15 22:58:05 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:05 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:05 volumio volumio[1279]: info: Apr 15 22:58:05 volumio volumio[1279]: ---------------------------- MPD announces state update: update Apr 15 22:58:05 volumio volumio[1279]: info: ControllerMpd::getState Apr 15 22:58:05 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:05 volumio volumio[1279]: info: sendMpdCommand status took 15 milliseconds Apr 15 22:58:05 volumio volumio[1279]: info: sendMpdCommand status took 13 milliseconds Apr 15 22:58:05 volumio volumio[1279]: info: sendMpdCommand status took 12 milliseconds Apr 15 22:58:05 volumio volumio[1279]: info: sendMpdCommand status took 10 milliseconds Apr 15 22:58:05 volumio volumio[1279]: info: sendMpdCommand status took 10 milliseconds Apr 15 22:58:05 volumio volumio[1279]: info: sendMpdCommand status took 7 milliseconds Apr 15 22:58:05 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:05 volumio volumio[1279]: info: Command Router : Notfying DB Updatefalse Apr 15 22:58:05 volumio volumio[1279]: info: CoreCommandRouter::Close All Modals sent Apr 15 22:58:05 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:05 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 15 22:58:05 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:05 volumio volumio[1279]: info: Command Router : Notfying DB Updatefalse Apr 15 22:58:05 volumio volumio[1279]: info: CoreCommandRouter::Close All Modals sent Apr 15 22:58:05 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:05 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 15 22:58:05 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:06 volumio volumio[1279]: info: Command Router : Notfying DB Updatefalse Apr 15 22:58:06 volumio volumio[1279]: info: CoreCommandRouter::Close All Modals sent Apr 15 22:58:06 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:06 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 15 22:58:06 volumio volumio[1279]: info: sendMpdCommand playlistinfo took 120 milliseconds Apr 15 22:58:06 volumio volumio[1279]: info: sendMpdCommand playlistinfo took 78 milliseconds Apr 15 22:58:06 volumio volumio[1279]: info: sendMpdCommand playlistinfo took 36 milliseconds Apr 15 22:58:06 volumio volumio[1279]: verbose: ControllerMpd::parseTrackInfo Apr 15 22:58:06 volumio volumio[1279]: verbose: ControllerMpd::parseTrackInfo Apr 15 22:58:06 volumio volumio[1279]: verbose: ControllerMpd::parseTrackInfo Apr 15 22:58:06 volumio volumio[1279]: info: ControllerMpd::pushState Apr 15 22:58:06 volumio volumio[1279]: info: CoreCommandRouter::servicePushState Apr 15 22:58:06 volumio volumio[1279]: info: CorePlayQueue::getTrack 0 Apr 15 22:58:06 volumio volumio[1279]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42284,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Bergama Super FM","artist":"Bergama Super FM","album":null,"uri":"https://panel.radyomhd.com:1330/","trackType":"com:1330/"} Apr 15 22:58:06 volumio volumio[1279]: verbose: CURRENT POSITION 0 Apr 15 22:58:06 volumio volumio[1279]: info: CoreStateMachine::syncState stateService play Apr 15 22:58:06 volumio volumio[1279]: info: CoreStateMachine::syncState currentStatus play Apr 15 22:58:06 volumio volumio[1279]: info: Received an update from plugin. extracting info from payload Apr 15 22:58:06 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 15 22:58:06 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:06 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 22:58:06 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:06 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:06 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:06 volumio volumio[1279]: info: ControllerMpd::pushState Apr 15 22:58:06 volumio volumio[1279]: info: CoreCommandRouter::servicePushState Apr 15 22:58:06 volumio volumio[1279]: info: CorePlayQueue::getTrack 0 Apr 15 22:58:06 volumio volumio[1279]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42284,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Bergama Super FM","artist":"Bergama Super FM","album":null,"uri":"https://panel.radyomhd.com:1330/","trackType":"com:1330/"} Apr 15 22:58:06 volumio volumio[1279]: verbose: CURRENT POSITION 0 Apr 15 22:58:06 volumio volumio[1279]: info: CoreStateMachine::syncState stateService play Apr 15 22:58:06 volumio volumio[1279]: info: CoreStateMachine::syncState currentStatus play Apr 15 22:58:06 volumio volumio[1279]: info: Received an update from plugin. extracting info from payload Apr 15 22:58:06 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 15 22:58:06 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:06 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:06 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:06 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:06 volumio volumio[1279]: info: ControllerMpd::pushState Apr 15 22:58:06 volumio volumio[1279]: info: CoreCommandRouter::servicePushState Apr 15 22:58:06 volumio volumio[1279]: info: CorePlayQueue::getTrack 0 Apr 15 22:58:06 volumio volumio[1279]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42284,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Bergama Super FM","artist":"Bergama Super FM","album":null,"uri":"https://panel.radyomhd.com:1330/","trackType":"com:1330/"} Apr 15 22:58:06 volumio volumio[1279]: verbose: CURRENT POSITION 0 Apr 15 22:58:06 volumio volumio[1279]: info: CoreStateMachine::syncState stateService play Apr 15 22:58:06 volumio volumio[1279]: info: CoreStateMachine::syncState currentStatus play Apr 15 22:58:06 volumio volumio[1279]: info: Received an update from plugin. extracting info from payload Apr 15 22:58:06 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 15 22:58:06 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:06 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:06 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:06 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:06 volumio volumio[1279]: info: ------------------------------ 298ms Apr 15 22:58:06 volumio volumio[1279]: info: ------------------------------ 295ms Apr 15 22:58:06 volumio volumio[1279]: info: ------------------------------ 292ms Apr 15 22:58:06 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 15 22:58:07 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Apr 15 22:58:07 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Apr 15 22:58:09 volumio kernel: usb 1-1.3: new high-speed USB device number 7 using dwc_otg Apr 15 22:58:09 volumio kernel: usb 1-1.3: New USB device found, idVendor=13fd, idProduct=3456, bcdDevice= 0.56 Apr 15 22:58:09 volumio kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Apr 15 22:58:09 volumio kernel: usb 1-1.3: Product: 3639S Apr 15 22:58:09 volumio kernel: usb 1-1.3: Manufacturer: sage Apr 15 22:58:09 volumio kernel: usb 1-1.3: SerialNumber: 2222222222222222005B Apr 15 22:58:09 volumio kernel: usb 1-1.3: The driver for the USB controller dwc_otg_hcd does not support scatter-gather which is Apr 15 22:58:09 volumio kernel: usb 1-1.3: required by the UAS driver. Please try an other USB controller if you wish to use UAS. Apr 15 22:58:09 volumio kernel: usb-storage 1-1.3:1.0: USB Mass Storage device detected Apr 15 22:58:09 volumio kernel: scsi host0: usb-storage 1-1.3:1.0 Apr 15 22:58:09 volumio volumio[1279]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/2 Apr 15 22:58:09 volumio volumio[1279]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/3 Apr 15 22:58:10 volumio kernel: scsi 0:0:0:0: Direct-Access sage 3639S 0056 PQ: 0 ANSI: 6 Apr 15 22:58:10 volumio kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Apr 15 22:58:10 volumio kernel: sd 0:0:0:0: [sda] 1953525167 512-byte logical blocks: (1.00 TB/932 GiB) Apr 15 22:58:10 volumio kernel: sd 0:0:0:0: [sda] Write Protect is off Apr 15 22:58:10 volumio kernel: sd 0:0:0:0: [sda] Mode Sense: 47 00 00 08 Apr 15 22:58:10 volumio kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Apr 15 22:58:10 volumio kernel: sda: sda1 sda2 Apr 15 22:58:10 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI disk Apr 15 22:58:10 volumio volumio[1279]: info: Scanning removed location : "USB/2" Apr 15 22:58:10 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:10 volumio volumio[1279]: info: Apr 15 22:58:10 volumio volumio[1279]: ---------------------------- MPD announces state update: update Apr 15 22:58:10 volumio volumio[1279]: info: ControllerMpd::getState Apr 15 22:58:10 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:10 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:10 volumio volumio[1279]: info: Apr 15 22:58:10 volumio volumio[1279]: ---------------------------- MPD announces state update: update Apr 15 22:58:10 volumio volumio[1279]: info: ControllerMpd::getState Apr 15 22:58:10 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:10 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:10 volumio volumio[1279]: info: Apr 15 22:58:10 volumio volumio[1279]: ---------------------------- MPD announces state update: update Apr 15 22:58:10 volumio volumio[1279]: info: ControllerMpd::getState Apr 15 22:58:10 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:10 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:10 volumio volumio[1279]: info: Apr 15 22:58:10 volumio volumio[1279]: ---------------------------- MPD announces state update: update Apr 15 22:58:10 volumio volumio[1279]: info: ControllerMpd::getState Apr 15 22:58:10 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:10 volumio volumio[1279]: info: sendMpdCommand status took 17 milliseconds Apr 15 22:58:10 volumio volumio[1279]: info: sendMpdCommand status took 15 milliseconds Apr 15 22:58:10 volumio volumio[1279]: info: sendMpdCommand status took 14 milliseconds Apr 15 22:58:10 volumio volumio[1279]: info: sendMpdCommand status took 13 milliseconds Apr 15 22:58:10 volumio volumio[1279]: info: sendMpdCommand status took 12 milliseconds Apr 15 22:58:10 volumio volumio[1279]: info: sendMpdCommand status took 11 milliseconds Apr 15 22:58:10 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:10 volumio volumio[1279]: info: Command Router : Notfying DB Updatefalse Apr 15 22:58:10 volumio volumio[1279]: info: CoreCommandRouter::Close All Modals sent Apr 15 22:58:10 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:10 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 15 22:58:10 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:10 volumio volumio[1279]: info: Command Router : Notfying DB Updatefalse Apr 15 22:58:10 volumio volumio[1279]: info: CoreCommandRouter::Close All Modals sent Apr 15 22:58:10 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:10 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 15 22:58:10 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:10 volumio volumio[1279]: info: Command Router : Notfying DB Updatefalse Apr 15 22:58:10 volumio volumio[1279]: info: CoreCommandRouter::Close All Modals sent Apr 15 22:58:10 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:10 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 15 22:58:11 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:11 volumio volumio[1279]: info: Apr 15 22:58:11 volumio volumio[1279]: ---------------------------- MPD announces state update: update Apr 15 22:58:11 volumio volumio[1279]: info: ControllerMpd::getState Apr 15 22:58:11 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:11 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:11 volumio volumio[1279]: info: Apr 15 22:58:11 volumio volumio[1279]: ---------------------------- MPD announces state update: update Apr 15 22:58:11 volumio volumio[1279]: info: ControllerMpd::getState Apr 15 22:58:11 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:11 volumio volumio[1279]: info: sendMpdCommand status took 249 milliseconds Apr 15 22:58:11 volumio volumio[1279]: info: sendMpdCommand status took 247 milliseconds Apr 15 22:58:11 volumio volumio[1279]: info: sendMpdCommand playlistinfo took 181 milliseconds Apr 15 22:58:11 volumio volumio[1279]: info: sendMpdCommand playlistinfo took 126 milliseconds Apr 15 22:58:11 volumio volumio[1279]: info: sendMpdCommand playlistinfo took 80 milliseconds Apr 15 22:58:11 volumio volumio[1279]: info: sendMpdCommand status took 20 milliseconds Apr 15 22:58:11 volumio volumio[1279]: info: sendMpdCommand status took 19 milliseconds Apr 15 22:58:11 volumio volumio[1279]: info: sendMpdCommand status took 17 milliseconds Apr 15 22:58:11 volumio volumio[1279]: info: sendMpdCommand status took 16 milliseconds Apr 15 22:58:11 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:11 volumio volumio[1279]: info: Command Router : Notfying DB Updatefalse Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::Close All Modals sent Apr 15 22:58:11 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:11 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 15 22:58:11 volumio volumio[1279]: verbose: ControllerMpd::parseTrackInfo Apr 15 22:58:11 volumio volumio[1279]: verbose: ControllerMpd::parseTrackInfo Apr 15 22:58:11 volumio volumio[1279]: verbose: ControllerMpd::parseTrackInfo Apr 15 22:58:11 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:11 volumio volumio[1279]: info: Command Router : Notfying DB Updatefalse Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::Close All Modals sent Apr 15 22:58:11 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:11 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 15 22:58:11 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:11 volumio volumio[1279]: info: Command Router : Notfying DB Updatefalse Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::Close All Modals sent Apr 15 22:58:11 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:11 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 15 22:58:11 volumio volumio[1279]: info: ControllerMpd::pushState Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::servicePushState Apr 15 22:58:11 volumio volumio[1279]: info: CorePlayQueue::getTrack 0 Apr 15 22:58:11 volumio volumio[1279]: verbose: STATE SERVICE {"status":"play","position":0,"seek":47186,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Bergama Super FM","artist":"Bergama Super FM","album":null,"uri":"https://panel.radyomhd.com:1330/","trackType":"com:1330/"} Apr 15 22:58:11 volumio volumio[1279]: verbose: CURRENT POSITION 0 Apr 15 22:58:11 volumio volumio[1279]: info: CoreStateMachine::syncState stateService play Apr 15 22:58:11 volumio volumio[1279]: info: CoreStateMachine::syncState currentStatus play Apr 15 22:58:11 volumio volumio[1279]: info: Received an update from plugin. extracting info from payload Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 15 22:58:11 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:11 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:11 volumio volumio[1279]: info: ControllerMpd::pushState Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::servicePushState Apr 15 22:58:11 volumio volumio[1279]: info: CorePlayQueue::getTrack 0 Apr 15 22:58:11 volumio volumio[1279]: verbose: STATE SERVICE {"status":"play","position":0,"seek":47186,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Bergama Super FM","artist":"Bergama Super FM","album":null,"uri":"https://panel.radyomhd.com:1330/","trackType":"com:1330/"} Apr 15 22:58:11 volumio volumio[1279]: verbose: CURRENT POSITION 0 Apr 15 22:58:11 volumio volumio[1279]: info: CoreStateMachine::syncState stateService play Apr 15 22:58:11 volumio volumio[1279]: info: CoreStateMachine::syncState currentStatus play Apr 15 22:58:11 volumio volumio[1279]: info: Received an update from plugin. extracting info from payload Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 15 22:58:11 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:11 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:11 volumio volumio[1279]: info: ControllerMpd::pushState Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::servicePushState Apr 15 22:58:11 volumio volumio[1279]: info: CorePlayQueue::getTrack 0 Apr 15 22:58:11 volumio volumio[1279]: verbose: STATE SERVICE {"status":"play","position":0,"seek":47186,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Bergama Super FM","artist":"Bergama Super FM","album":null,"uri":"https://panel.radyomhd.com:1330/","trackType":"com:1330/"} Apr 15 22:58:11 volumio volumio[1279]: verbose: CURRENT POSITION 0 Apr 15 22:58:11 volumio volumio[1279]: info: CoreStateMachine::syncState stateService play Apr 15 22:58:11 volumio volumio[1279]: info: CoreStateMachine::syncState currentStatus play Apr 15 22:58:11 volumio volumio[1279]: info: Received an update from plugin. extracting info from payload Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 15 22:58:11 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:11 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:11 volumio volumio[1279]: info: ------------------------------ 577ms Apr 15 22:58:11 volumio volumio[1279]: info: ------------------------------ 576ms Apr 15 22:58:11 volumio volumio[1279]: info: ------------------------------ 573ms Apr 15 22:58:11 volumio volumio[1279]: info: sendMpdCommand playlistinfo took 330 milliseconds Apr 15 22:58:11 volumio volumio[1279]: info: sendMpdCommand playlistinfo took 278 milliseconds Apr 15 22:58:11 volumio volumio[1279]: info: sendMpdCommand playlistinfo took 227 milliseconds Apr 15 22:58:11 volumio volumio[1279]: verbose: ControllerMpd::parseTrackInfo Apr 15 22:58:11 volumio volumio[1279]: verbose: ControllerMpd::parseTrackInfo Apr 15 22:58:11 volumio volumio[1279]: verbose: ControllerMpd::parseTrackInfo Apr 15 22:58:11 volumio volumio[1279]: info: ControllerMpd::pushState Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::servicePushState Apr 15 22:58:11 volumio volumio[1279]: info: CorePlayQueue::getTrack 0 Apr 15 22:58:11 volumio volumio[1279]: verbose: STATE SERVICE {"status":"play","position":0,"seek":47186,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Bergama Super FM","artist":"Bergama Super FM","album":null,"uri":"https://panel.radyomhd.com:1330/","trackType":"com:1330/"} Apr 15 22:58:11 volumio volumio[1279]: verbose: CURRENT POSITION 0 Apr 15 22:58:11 volumio volumio[1279]: info: CoreStateMachine::syncState stateService play Apr 15 22:58:11 volumio volumio[1279]: info: CoreStateMachine::syncState currentStatus play Apr 15 22:58:11 volumio volumio[1279]: info: Received an update from plugin. extracting info from payload Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 15 22:58:11 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:11 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:11 volumio volumio[1279]: info: ControllerMpd::pushState Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::servicePushState Apr 15 22:58:11 volumio volumio[1279]: info: CorePlayQueue::getTrack 0 Apr 15 22:58:11 volumio volumio[1279]: verbose: STATE SERVICE {"status":"play","position":0,"seek":47381,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Bergama Super FM","artist":"Bergama Super FM","album":null,"uri":"https://panel.radyomhd.com:1330/","trackType":"com:1330/"} Apr 15 22:58:11 volumio volumio[1279]: verbose: CURRENT POSITION 0 Apr 15 22:58:11 volumio volumio[1279]: info: CoreStateMachine::syncState stateService play Apr 15 22:58:11 volumio volumio[1279]: info: CoreStateMachine::syncState currentStatus play Apr 15 22:58:11 volumio volumio[1279]: info: Received an update from plugin. extracting info from payload Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 15 22:58:11 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:11 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:11 volumio volumio[1279]: info: ControllerMpd::pushState Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::servicePushState Apr 15 22:58:11 volumio volumio[1279]: info: CorePlayQueue::getTrack 0 Apr 15 22:58:11 volumio volumio[1279]: verbose: STATE SERVICE {"status":"play","position":0,"seek":47484,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Bergama Super FM","artist":"Bergama Super FM","album":null,"uri":"https://panel.radyomhd.com:1330/","trackType":"com:1330/"} Apr 15 22:58:11 volumio volumio[1279]: verbose: CURRENT POSITION 0 Apr 15 22:58:11 volumio volumio[1279]: info: CoreStateMachine::syncState stateService play Apr 15 22:58:11 volumio volumio[1279]: info: CoreStateMachine::syncState currentStatus play Apr 15 22:58:11 volumio volumio[1279]: info: Received an update from plugin. extracting info from payload Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 15 22:58:11 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:11 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:11 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:11 volumio volumio[1279]: info: ------------------------------ 761ms Apr 15 22:58:11 volumio volumio[1279]: info: ------------------------------ 531ms Apr 15 22:58:11 volumio volumio[1279]: info: ------------------------------ 529ms Apr 15 22:58:11 volumio volumio[1279]: info: Mounting Device 3 Apr 15 22:58:11 volumio sudo[2190]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/3 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 15 22:58:11 volumio sudo[2190]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 22:58:13 volumio ntfs-3g[2193]: Version 2017.3.23AR.3 integrated FUSE 28 Apr 15 22:58:13 volumio ntfs-3g[2193]: Mounted /dev/sda2 (Read-Write, label "3", NTFS 3.1) Apr 15 22:58:13 volumio ntfs-3g[2193]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 15 22:58:13 volumio ntfs-3g[2193]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda2,blkdev,blksize=4096 Apr 15 22:58:13 volumio ntfs-3g[2193]: Global ownership and permissions enforced, configuration type 7 Apr 15 22:58:13 volumio sudo[2190]: pam_unix(sudo:session): session closed for user root Apr 15 22:58:13 volumio volumio[1279]: info: Mounting Device 2 Apr 15 22:58:13 volumio sudo[2198]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/2 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 15 22:58:13 volumio sudo[2198]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 22:58:14 volumio ntfs-3g[2201]: Version 2017.3.23AR.3 integrated FUSE 28 Apr 15 22:58:14 volumio ntfs-3g[2201]: Mounted /dev/sda1 (Read-Write, label "2", NTFS 3.1) Apr 15 22:58:14 volumio ntfs-3g[2201]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 15 22:58:14 volumio ntfs-3g[2201]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Apr 15 22:58:14 volumio ntfs-3g[2201]: Global ownership and permissions enforced, configuration type 7 Apr 15 22:58:14 volumio sudo[2198]: pam_unix(sudo:session): session closed for user root Apr 15 22:58:14 volumio volumio[1279]: Upnp client error: Error: This socket has been ended by the other party Apr 15 22:58:14 volumio volumio[1279]: info: Scanning removed location : "USB/3" Apr 15 22:58:14 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 15 22:58:14 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:14 volumio volumio[1279]: info: Apr 15 22:58:14 volumio volumio[1279]: ---------------------------- MPD announces state update: update Apr 15 22:58:14 volumio volumio[1279]: info: ControllerMpd::getState Apr 15 22:58:14 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:14 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:14 volumio volumio[1279]: info: Apr 15 22:58:14 volumio volumio[1279]: ---------------------------- MPD announces state update: update Apr 15 22:58:14 volumio volumio[1279]: info: ControllerMpd::getState Apr 15 22:58:14 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:14 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:14 volumio volumio[1279]: info: Apr 15 22:58:14 volumio volumio[1279]: ---------------------------- MPD announces state update: update Apr 15 22:58:14 volumio volumio[1279]: info: ControllerMpd::getState Apr 15 22:58:14 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status Apr 15 22:58:14 volumio volumio[1279]: info: Scanning new location : "USB/3" Apr 15 22:58:14 volumio volumio[1279]: info: sendMpdCommand status took 66 milliseconds Apr 15 22:58:14 volumio volumio[1279]: info: sendMpdCommand status took 65 milliseconds Apr 15 22:58:14 volumio volumio[1279]: info: sendMpdCommand status took 64 milliseconds Apr 15 22:58:14 volumio volumio[1279]: info: sendMpdCommand status took 63 milliseconds Apr 15 22:58:14 volumio volumio[1279]: info: sendMpdCommand status took 61 milliseconds Apr 15 22:58:14 volumio volumio[1279]: info: sendMpdCommand status took 55 milliseconds Apr 15 22:58:14 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:14 volumio volumio[1279]: info: Command Router : Notfying DB Updatetrue Apr 15 22:58:14 volumio volumio[1279]: info: CoreCommandRouter::Close All Modals sent Apr 15 22:58:14 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:14 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 15 22:58:14 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:14 volumio volumio[1279]: info: Command Router : Notfying DB Updatetrue Apr 15 22:58:14 volumio volumio[1279]: info: CoreCommandRouter::Close All Modals sent Apr 15 22:58:14 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:14 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 15 22:58:14 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:14 volumio volumio[1279]: info: Command Router : Notfying DB Updatetrue Apr 15 22:58:14 volumio volumio[1279]: info: CoreCommandRouter::Close All Modals sent Apr 15 22:58:14 volumio volumio[1279]: verbose: ControllerMpd::parseState Apr 15 22:58:14 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 15 22:58:14 volumio volumio[1279]: info: sendMpdCommand playlistinfo took 125 milliseconds Apr 15 22:58:14 volumio volumio[1279]: info: sendMpdCommand playlistinfo took 81 milliseconds Apr 15 22:58:14 volumio volumio[1279]: info: sendMpdCommand playlistinfo took 38 milliseconds Apr 15 22:58:14 volumio volumio[1279]: verbose: ControllerMpd::parseTrackInfo Apr 15 22:58:14 volumio volumio[1279]: verbose: ControllerMpd::parseTrackInfo Apr 15 22:58:14 volumio volumio[1279]: verbose: ControllerMpd::parseTrackInfo Apr 15 22:58:14 volumio volumio[1279]: info: ControllerMpd::pushState Apr 15 22:58:14 volumio volumio[1279]: info: CoreCommandRouter::servicePushState Apr 15 22:58:14 volumio volumio[1279]: info: CorePlayQueue::getTrack 0 Apr 15 22:58:14 volumio volumio[1279]: verbose: STATE SERVICE {"status":"play","position":0,"seek":51084,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Bergama Super FM","artist":"Bergama Super FM","album":null,"uri":"https://panel.radyomhd.com:1330/","trackType":"com:1330/"} Apr 15 22:58:14 volumio volumio[1279]: verbose: CURRENT POSITION 0 Apr 15 22:58:14 volumio volumio[1279]: info: CoreStateMachine::syncState stateService play Apr 15 22:58:14 volumio volumio[1279]: info: CoreStateMachine::syncState currentStatus play Apr 15 22:58:14 volumio volumio[1279]: info: Received an update from plugin. extracting info from payload Apr 15 22:58:14 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 15 22:58:14 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:14 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 22:58:14 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:14 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:14 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:14 volumio volumio[1279]: info: ControllerMpd::pushState Apr 15 22:58:14 volumio volumio[1279]: info: CoreCommandRouter::servicePushState Apr 15 22:58:14 volumio volumio[1279]: info: CorePlayQueue::getTrack 0 Apr 15 22:58:14 volumio volumio[1279]: verbose: STATE SERVICE {"status":"play","position":0,"seek":51084,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Bergama Super FM","artist":"Bergama Super FM","album":null,"uri":"https://panel.radyomhd.com:1330/","trackType":"com:1330/"} Apr 15 22:58:14 volumio volumio[1279]: verbose: CURRENT POSITION 0 Apr 15 22:58:14 volumio volumio[1279]: info: CoreStateMachine::syncState stateService play Apr 15 22:58:14 volumio volumio[1279]: info: CoreStateMachine::syncState currentStatus play Apr 15 22:58:14 volumio volumio[1279]: info: Received an update from plugin. extracting info from payload Apr 15 22:58:14 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 15 22:58:14 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:14 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:14 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:14 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:14 volumio volumio[1279]: info: ControllerMpd::pushState Apr 15 22:58:14 volumio volumio[1279]: info: CoreCommandRouter::servicePushState Apr 15 22:58:14 volumio volumio[1279]: info: CorePlayQueue::getTrack 0 Apr 15 22:58:14 volumio volumio[1279]: verbose: STATE SERVICE {"status":"play","position":0,"seek":51084,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Bergama Super FM","artist":"Bergama Super FM","album":null,"uri":"https://panel.radyomhd.com:1330/","trackType":"com:1330/"} Apr 15 22:58:14 volumio volumio[1279]: verbose: CURRENT POSITION 0 Apr 15 22:58:14 volumio volumio[1279]: info: CoreStateMachine::syncState stateService play Apr 15 22:58:14 volumio volumio[1279]: info: CoreStateMachine::syncState currentStatus play Apr 15 22:58:14 volumio volumio[1279]: info: Received an update from plugin. extracting info from payload Apr 15 22:58:14 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 15 22:58:14 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:14 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:14 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:14 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:15 volumio volumio[1279]: info: ------------------------------ 364ms Apr 15 22:58:15 volumio volumio[1279]: info: ------------------------------ 363ms Apr 15 22:58:15 volumio volumio[1279]: info: ------------------------------ 360ms Apr 15 22:58:15 volumio volumio[1279]: info: Scanning new location : "USB/2" Apr 15 22:58:15 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 15 22:58:18 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 15 22:58:21 volumio volumio[1279]: info: CoreCommandRouter::volumioGetState Apr 15 22:58:29 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 15 22:58:29 volumio volumio[1279]: info: CURURI: music-library Apr 15 22:58:29 volumio volumio[1279]: info: Preload queue cleared Apr 15 22:58:30 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 15 22:58:30 volumio volumio[1279]: info: CURURI: music-library/USB Apr 15 22:58:30 volumio volumio[1279]: info: Preload queue cleared Apr 15 22:58:31 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 15 22:58:31 volumio volumio[1279]: info: CURURI: music-library/USB/2 Apr 15 22:58:31 volumio volumio[1279]: error: Failed LSINFO: null Apr 15 22:58:31 volumio volumio[1279]: info: Preload queue cleared Apr 15 22:58:34 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 15 22:58:34 volumio volumio[1279]: info: CURURI: music-library/USB/3 Apr 15 22:58:34 volumio volumio[1279]: info: Preload queue cleared Apr 15 22:58:35 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 15 22:58:35 volumio volumio[1279]: info: CURURI: music-library/USB/3/Hoa tau chon loc-Linh anh Apr 15 22:58:36 volumio volumio[1279]: info: Preload queue cleared Apr 15 22:58:36 volumio volumio[1279]: info: Preloading song: music-library/USB/3/Hoa tau chon loc-Linh anh/04 - Hinh Bong Que Nha (Thanh Son).flac Apr 15 22:58:36 volumio volumio[1279]: info: Preloading song: music-library/USB/3/Hoa tau chon loc-Linh anh/06-Kitaro-Matsuri.dsf Apr 15 22:58:36 volumio volumio[1279]: info: Preloading song: music-library/USB/3/Hoa tau chon loc-Linh anh/10.-Jingle-Bells-Jingle-Bells.wav Apr 15 22:58:36 volumio volumio[1279]: info: Preloading song: music-library/USB/3/Hoa tau chon loc-Linh anh/London Promenade Orchestra _ Alexander Faris - Ketèlbey - Persian Market - 06. In a Persian Market.wav Apr 15 22:58:36 volumio volumio[1279]: info: Preloading song: music-library/USB/3/Hoa tau chon loc-Linh anh/Two Steps From Hell - Star Sky (Instrumental).flac Apr 15 22:58:36 volumio volumio[1279]: info: Exploding uri music-library/USB/3/Hoa tau chon loc-Linh anh/04 - Hinh Bong Que Nha (Thanh Son).flac in service mpd Apr 15 22:58:36 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=496&web=Duc%20Thanh/Dan%20Bau%20-%20Ngoi%20Tua%20Man%20Thuyen/extralarge&path=%2Fmnt%2FUSB%2F3%2FHoa%20tau%20chon%20loc-Linh%20anh%2F04%20-%20Hinh%20Bong%20Que%20Nha%20(Thanh%20Son).flac&metadata=false Apr 15 22:58:36 volumio volumio[1279]: info: URI /mnt/USB/3/Hoa tau chon loc-Linh anh/04 - Hinh Bong Que Nha (Thanh Son).flac Apr 15 22:58:36 volumio volumio[1279]: info: Exploding uri music-library/USB/3/Hoa tau chon loc-Linh anh/06-Kitaro-Matsuri.dsf in service mpd Apr 15 22:58:36 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=496&web=Kitaro/Kojiki/extralarge&path=%2Fmnt%2FUSB%2F3%2FHoa%20tau%20chon%20loc-Linh%20anh%2F06-Kitaro-Matsuri.dsf&metadata=false Apr 15 22:58:36 volumio volumio[1279]: info: URI /mnt/USB/3/Hoa tau chon loc-Linh anh/06-Kitaro-Matsuri.dsf Apr 15 22:58:36 volumio volumio[1279]: info: Exploding uri music-library/USB/3/Hoa tau chon loc-Linh anh/10.-Jingle-Bells-Jingle-Bells.wav in service mpd Apr 15 22:58:36 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=496&web=Jingle%20Bells/Christmas%20Evening%20(A%20Saxophone%20Christmas)/extralarge&path=%2Fmnt%2FUSB%2F3%2FHoa%20tau%20chon%20loc-Linh%20anh%2F10.-Jingle-Bells-Jingle-Bells.wav&metadata=false Apr 15 22:58:36 volumio volumio[1279]: info: URI /mnt/USB/3/Hoa tau chon loc-Linh anh/10.-Jingle-Bells-Jingle-Bells.wav Apr 15 22:58:36 volumio volumio[1279]: info: Exploding uri music-library/USB/3/Hoa tau chon loc-Linh anh/London Promenade Orchestra _ Alexander Faris - Ketèlbey - Persian Market - 06. In a Persian Market.wav in service mpd Apr 15 22:58:36 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=496&web=London%20Promenade%20Orchestra%20%26%20Alexander%20Faris/Ket%3Flbey%20-%20Persian%20Market/extralarge&path=%2Fmnt%2FUSB%2F3%2FHoa%20tau%20chon%20loc-Linh%20anh%2FLondon%20Promenade%20Orchestra%20_%20Alexander%20Faris%20-%20Ket%C3%A8lbey%20-%20Persian%20Market%20-%2006.%20In%20a%20Persian%20Market.wav&metadata=false Apr 15 22:58:36 volumio volumio[1279]: info: URI /mnt/USB/3/Hoa tau chon loc-Linh anh/London Promenade Orchestra _ Alexander Faris - Ketèlbey - Persian Market - 06. In a Persian Market.wav Apr 15 22:58:36 volumio volumio[1279]: info: Exploding uri music-library/USB/3/Hoa tau chon loc-Linh anh/Two Steps From Hell - Star Sky (Instrumental).flac in service mpd Apr 15 22:58:36 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=496&web=Two%20Steps%20From%20Hell/Battlecry/extralarge&path=%2Fmnt%2FUSB%2F3%2FHoa%20tau%20chon%20loc-Linh%20anh%2FTwo%20Steps%20From%20Hell%20-%20Star%20Sky%20(Instrumental).flac&metadata=false Apr 15 22:58:36 volumio volumio[1279]: info: URI /mnt/USB/3/Hoa tau chon loc-Linh anh/Two Steps From Hell - Star Sky (Instrumental).flac Apr 15 22:58:37 volumio volumio[1279]: info: Preload queue cleared Apr 15 22:58:37 volumio volumio[1279]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 15 22:58:37 volumio volumio[1279]: info: CoreStateMachine::ClearQueue Apr 15 22:58:37 volumio volumio[1279]: info: CoreStateMachine::stop Apr 15 22:58:37 volumio volumio[1279]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 15 22:58:37 volumio volumio[1279]: info: CoreStateMachine::stPlaybackTimer Apr 15 22:58:37 volumio volumio[1279]: info: CoreStateMachine::updateTrackBlock Apr 15 22:58:37 volumio volumio[1279]: info: CorePlayQueue::getTrackBlock Apr 15 22:58:37 volumio volumio[1279]: info: CoreStateMachine::pushState Apr 15 22:58:37 volumio volumio[1279]: info: CorePlayQueue::getTrack 0 Apr 15 22:58:37 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 22:58:37 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:37 volumio volumio[1279]: info: CoreStateMachine::serviceStop Apr 15 22:58:37 volumio volumio[1279]: info: CorePlayQueue::getTrack 0 Apr 15 22:58:37 volumio volumio[1279]: info: CoreCommandRouter::serviceStop Apr 15 22:58:37 volumio volumio[1279]: info: [1713196717369] ControllerWebradio::stop Apr 15 22:58:37 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand stop Apr 15 22:58:37 volumio volumio[1279]: info: CorePlayQueue::clearPlayQueue Apr 15 22:58:37 volumio volumio[1279]: info: CorePlayQueue::saveQueue Apr 15 22:58:37 volumio volumio[1279]: info: CoreCommandRouter::volumioPushQueue Apr 15 22:58:37 volumio volumio[1279]: info: CoreStateMachine::addQueueItems Apr 15 22:58:37 volumio volumio[1279]: info: CorePlayQueue::addQueueItems Apr 15 22:58:37 volumio volumio[1279]: info: Preload queue cleared Apr 15 22:58:37 volumio volumio[1279]: info: Adding Item to queue: music-library/USB/3/Hoa tau chon loc-Linh anh/04 - Hinh Bong Que Nha (Thanh Son).flac Apr 15 22:58:37 volumio volumio[1279]: info: Using cached record of: music-library/USB/3/Hoa tau chon loc-Linh anh/04 - Hinh Bong Que Nha (Thanh Son).flac Apr 15 22:58:37 volumio volumio[1279]: info: Adding Item to queue: music-library/USB/3/Hoa tau chon loc-Linh anh/06-Kitaro-Matsuri.dsf Apr 15 22:58:37 volumio volumio[1279]: info: Using cached record of: music-library/USB/3/Hoa tau chon loc-Linh anh/06-Kitaro-Matsuri.dsf Apr 15 22:58:37 volumio volumio[1279]: info: Adding Item to queue: music-library/USB/3/Hoa tau chon loc-Linh anh/10.-Jingle-Bells-Jingle-Bells.wav Apr 15 22:58:37 volumio volumio[1279]: info: Using cached record of: music-library/USB/3/Hoa tau chon loc-Linh anh/10.-Jingle-Bells-Jingle-Bells.wav Apr 15 22:58:37 volumio volumio[1279]: info: Adding Item to queue: music-library/USB/3/Hoa tau chon loc-Linh anh/London Promenade Orchestra _ Alexander Faris - Ketèlbey - Persian Market - 06. In a Persian Market.wav Apr 15 22:58:37 volumio volumio[1279]: info: Using cached record of: music-library/USB/3/Hoa tau chon loc-Linh anh/London Promenade Orchestra _ Alexander Faris - Ketèlbey - Persian Market - 06. In a Persian Market.wav Apr 15 22:58:37 volumio volumio[1279]: info: Adding Item to queue: music-library/USB/3/Hoa tau chon loc-Linh anh/Two Steps From Hell - Star Sky (Instrumental).flac Apr 15 22:58:37 volumio volumio[1279]: info: Using cached record of: music-library/USB/3/Hoa tau chon loc-Linh anh/Two Steps From Hell - Star Sky (Instrumental).flac Apr 15 22:58:37 volumio volumio[1279]: info: Adding Item to queue: music-library/USB/3/Hoa tau chon loc-Linh anh/12 Girls Band - Merry Christmas to you (2005) Apr 15 22:58:37 volumio volumio[1279]: info: Exploding uri music-library/USB/3/Hoa tau chon loc-Linh anh/12 Girls Band - Merry Christmas to you (2005) in service mpd Apr 15 22:58:37 volumio volumio[1279]: info: Adding Item to queue: music-library/USB/3/Hoa tau chon loc-Linh anh/Bond Apr 15 22:58:37 volumio volumio[1279]: info: Exploding uri music-library/USB/3/Hoa tau chon loc-Linh anh/Bond in service mpd Apr 15 22:58:37 volumio volumio[1279]: info: Adding Item to queue: music-library/USB/3/Hoa tau chon loc-Linh anh/Hoa tau - Golden Cha Cha Cha 2 (2002) [AsiaCD 169 - Various Artists] Apr 15 22:58:37 volumio volumio[1279]: info: Exploding uri music-library/USB/3/Hoa tau chon loc-Linh anh/Hoa tau - Golden Cha Cha Cha 2 (2002) [AsiaCD 169 - Various Artists] in service mpd Apr 15 22:58:37 volumio volumio[1279]: info: Adding Item to queue: music-library/USB/3/Hoa tau chon loc-Linh anh/Hoa Tau - Lien Khuc Disco Chachacha (1996) [Sai Gon Vafaco] Apr 15 22:58:37 volumio volumio[1279]: info: Exploding uri music-library/USB/3/Hoa tau chon loc-Linh anh/Hoa Tau - Lien Khuc Disco Chachacha (1996) [Sai Gon Vafaco] in service mpd Apr 15 22:58:37 volumio volumio[1279]: info: Adding Item to queue: music-library/USB/3/Hoa tau chon loc-Linh anh/Hoa Tau - Lien Khuc Rumba (1995) [Nha Ca 22] Apr 15 22:58:37 volumio volumio[1279]: info: Exploding uri music-library/USB/3/Hoa tau chon loc-Linh anh/Hoa Tau - Lien Khuc Rumba (1995) [Nha Ca 22] in service mpd Apr 15 22:58:37 volumio volumio[1279]: info: Adding Item to queue: music-library/USB/3/Hoa tau chon loc-Linh anh/Hoa tau - Vo Thuong Vol 2 Apr 15 22:58:37 volumio volumio[1279]: info: Exploding uri music-library/USB/3/Hoa tau chon loc-Linh anh/Hoa tau - Vo Thuong Vol 2 in service mpd Apr 15 22:58:37 volumio volumio[1279]: info: Adding Item to queue: music-library/USB/3/Hoa tau chon loc-Linh anh/Hoa Tau Em Diu - Tranh Sao Bau (1995) [NDBD] Apr 15 22:58:37 volumio volumio[1279]: info: Exploding uri music-library/USB/3/Hoa tau chon loc-Linh anh/Hoa Tau Em Diu - Tranh Sao Bau (1995) [NDBD] in service mpd Apr 15 22:58:37 volumio volumio[1279]: info: Adding Item to queue: music-library/USB/3/Hoa tau chon loc-Linh anh/Hoa Tau Nguyen Van Chung - Melodies Of Love (2012) {Limited Edition} Apr 15 22:58:37 volumio volumio[1279]: info: Exploding uri music-library/USB/3/Hoa tau chon loc-Linh anh/Hoa Tau Nguyen Van Chung - Melodies Of Love (2012) {Limited Edition} in service mpd Apr 15 22:58:38 volumio volumio[1279]: info: Adding Item to queue: music-library/USB/3/Hoa tau chon loc-Linh anh/Kenny G - (1996) The Moment Apr 15 22:58:38 volumio volumio[1279]: info: Exploding uri music-library/USB/3/Hoa tau chon loc-Linh anh/Kenny G - (1996) The Moment in service mpd Apr 15 22:58:38 volumio ntpd[674]: Soliciting pool server 2001:470:1d:281::123 Apr 15 22:58:38 volumio volumio[1279]: info: Adding Item to queue: music-library/USB/3/Hoa tau chon loc-Linh anh/Ricky King - Happy Guitar (2001) Apr 15 22:58:38 volumio volumio[1279]: info: Exploding uri music-library/USB/3/Hoa tau chon loc-Linh anh/Ricky King - Happy Guitar (2001) in service mpd Apr 15 22:58:38 volumio volumio[1279]: info: Adding Item to queue: music-library/USB/3/Hoa tau chon loc-Linh anh/Romantic Guitar (2002) Apr 15 22:58:38 volumio volumio[1279]: info: Exploding uri music-library/USB/3/Hoa tau chon loc-Linh anh/Romantic Guitar (2002) in service mpd Apr 15 22:58:38 volumio volumio[1279]: info: Adding Item to queue: music-library/USB/3/Hoa tau chon loc-Linh anh/Thien Kim Hoa Tau Dan Tranh Apr 15 22:58:38 volumio volumio[1279]: info: Exploding uri music-library/USB/3/Hoa tau chon loc-Linh anh/Thien Kim Hoa Tau Dan Tranh in service mpd Apr 15 22:58:38 volumio volumio[1279]: info: Adding Item to queue: music-library/USB/3/Hoa tau chon loc-Linh anh/Two Steps From Hell - Battlecry (2015) FLAC Apr 15 22:58:38 volumio volumio[1279]: info: Exploding uri music-library/USB/3/Hoa tau chon loc-Linh anh/Two Steps From Hell - Battlecry (2015) FLAC in service mpd Apr 15 22:58:38 volumio volumio[1279]: info: Apr 15 22:58:38 volumio volumio[1279]: ---------------------------- MPD announces state update: player Apr 15 22:58:38 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=496&web=Twelve%20Girls%20Band/Merry%20Christmas%20To%20You/extralarge&path=%2Fmnt%2FUSB%2F3%2FHoa%20tau%20chon%20loc-Linh%20anh%2F12%20Girls%20Band%20-%20Merry%20Christmas%20to%20you%20(2005)%2F01%20-%20Joy%20To%20The%20World.flac&metadata=false Apr 15 22:58:38 volumio volumio[1279]: info: URI /mnt/USB/3/Hoa tau chon loc-Linh anh/12 Girls Band - Merry Christmas to you (2005)/01 - Joy To The World.flac Apr 15 22:58:38 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=496&web=Twelve%20Girls%20Band/Merry%20Christmas%20To%20You/extralarge&path=%2Fmnt%2FUSB%2F3%2FHoa%20tau%20chon%20loc-Linh%20anh%2F12%20Girls%20Band%20-%20Merry%20Christmas%20to%20you%20(2005)%2F02%20-%20Christmas%20Eve.flac&metadata=false Apr 15 22:58:38 volumio volumio[1279]: info: URI /mnt/USB/3/Hoa tau chon loc-Linh anh/12 Girls Band - Merry Christmas to you (2005)/02 - Christmas Eve.flac Apr 15 22:58:38 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=496&web=Twelve%20Girls%20Band/Merry%20Christmas%20To%20You/extralarge&path=%2Fmnt%2FUSB%2F3%2FHoa%20tau%20chon%20loc-Linh%20anh%2F12%20Girls%20Band%20-%20Merry%20Christmas%20to%20you%20(2005)%2F03%20-%20All%20I%20Want%20for%20Christmas%20Is%20You.flac&metadata=false Apr 15 22:58:38 volumio volumio[1279]: info: URI /mnt/USB/3/Hoa tau chon loc-Linh anh/12 Girls Band - Merry Christmas to you (2005)/03 - All I Want for Christmas Is You.flac Apr 15 22:58:38 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=496&web=Twelve%20Girls%20Band/Merry%20Christmas%20To%20You/extralarge&path=%2Fmnt%2FUSB%2F3%2FHoa%20tau%20chon%20loc-Linh%20anh%2F12%20Girls%20Band%20-%20Merry%20Christmas%20to%20you%20(2005)%2F04%20-%20Silent%20Night.flac&metadata=false Apr 15 22:58:38 volumio volumio[1279]: info: URI /mnt/USB/3/Hoa tau chon loc-Linh anh/12 Girls Band - Merry Christmas to you (2005)/04 - Silent Night.flac Apr 15 22:58:38 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=496&web=Twelve%20Girls%20Band/Merry%20Christmas%20To%20You/extralarge&path=%2Fmnt%2FUSB%2F3%2FHoa%20tau%20chon%20loc-Linh%20anh%2F12%20Girls%20Band%20-%20Merry%20Christmas%20to%20you%20(2005)%2F05%20-%20White%20Christmas.flac&metadata=false Apr 15 22:58:38 volumio volumio[1279]: info: URI /mnt/USB/3/Hoa tau chon loc-Linh anh/12 Girls Band - Merry Christmas to you (2005)/05 - White Christmas.flac Apr 15 22:58:38 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=496&web=Twelve%20Girls%20Band/Merry%20Christmas%20To%20You/extralarge&path=%2Fmnt%2FUSB%2F3%2FHoa%20tau%20chon%20loc-Linh%20anh%2F12%20Girls%20Band%20-%20Merry%20Christmas%20to%20you%20(2005)%2F06%20-%20My%20Lover%20is%20Santa%20Claus.flac&metadata=false Apr 15 22:58:38 volumio volumio[1279]: info: URI /mnt/USB/3/Hoa tau chon loc-Linh anh/12 Girls Band - Merry Christmas to you (2005)/06 - My Lover is Santa Claus.flac Apr 15 22:58:38 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=496&web=Twelve%20Girls%20Band/Merry%20Christmas%20To%20You/extralarge&path=%2Fmnt%2FUSB%2F3%2FHoa%20tau%20chon%20loc-Linh%20anh%2F12%20Girls%20Band%20-%20Merry%20Christmas%20to%20you%20(2005)%2F07%20-%20Santa%20Claus%20Is%20Comin'%20to%20Town.flac&metadata=false Apr 15 22:58:38 volumio volumio[1279]: info: URI /mnt/USB/3/Hoa tau chon loc-Linh anh/12 Girls Band - Merry Christmas to you (2005)/07 - Santa Claus Is Comin' to Town.flac Apr 15 22:58:38 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=496&web=Twelve%20Girls%20Band/Merry%20Christmas%20To%20You/extralarge&path=%2Fmnt%2FUSB%2F3%2FHoa%20tau%20chon%20loc-Linh%20anh%2F12%20Girls%20Band%20-%20Merry%20Christmas%20to%20you%20(2005)%2F08%20-%20Jingle%20Bells.flac&metadata=false Apr 15 22:58:38 volumio volumio[1279]: info: URI /mnt/USB/3/Hoa tau chon loc-Linh anh/12 Girls Band - Merry Christmas to you (2005)/08 - Jingle Bells.flac Apr 15 22:58:38 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=496&web=Twelve%20Girls%20Band/Merry%20Christmas%20To%20You/extralarge&path=%2Fmnt%2FUSB%2F3%2FHoa%20tau%20chon%20loc-Linh%20anh%2F12%20Girls%20Band%20-%20Merry%20Christmas%20to%20you%20(2005)%2F09%20-%20White%20Lovers.flac&metadata=false Apr 15 22:58:38 volumio volumio[1279]: info: URI /mnt/USB/3/Hoa tau chon loc-Linh anh/12 Girls Band - Merry Christmas to you (2005)/09 - White Lovers.flac Apr 15 22:58:38 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=496&web=Twelve%20Girls%20Band/Merry%20Christmas%20To%20You/extralarge&path=%2Fmnt%2FUSB%2F3%2FHoa%20tau%20chon%20loc-Linh%20anh%2F12%20Girls%20Band%20-%20Merry%20Christmas%20to%20you%20(2005)%2F10%20-%20Last%20Christmas.flac&metadata=false Apr 15 22:58:38 volumio volumio[1279]: info: URI /mnt/USB/3/Hoa tau chon loc-Linh anh/12 Girls Band - Merry Christmas to you (2005)/10 - Last Christmas.flac Apr 15 22:58:38 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=496&web=Twelve%20Girls%20Band/Merry%20Christmas%20To%20You/extralarge&path=%2Fmnt%2FUSB%2F3%2FHoa%20tau%20chon%20loc-Linh%20anh%2F12%20Girls%20Band%20-%20Merry%20Christmas%20to%20you%20(2005)%2F11%20-%20The%20First%20Noel.flac&metadata=false Apr 15 22:58:38 volumio volumio[1279]: info: URI /mnt/USB/3/Hoa tau chon loc-Linh anh/12 Girls Band - Merry Christmas to you (2005)/11 - The First Noel.flac Apr 15 22:58:38 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=496&web=Twelve%20Girls%20Band/Merry%20Christmas%20To%20You/extralarge&path=%2Fmnt%2FUSB%2F3%2FHoa%20tau%20chon%20loc-Linh%20anh%2F12%20Girls%20Band%20-%20Merry%20Christmas%20to%20you%20(2005)%2F12%20-%20Happy%20Xmas%20(War%20Is%20Over).flac&metadata=false Apr 15 22:58:38 volumio volumio[1279]: info: URI /mnt/USB/3/Hoa tau chon loc-Linh anh/12 Girls Band - Merry Christmas to you (2005)/12 - Happy Xmas (War Is Over).flac Apr 15 22:58:38 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=496&web=Twelve%20Girls%20Band/Merry%20Christmas%20To%20You/extralarge&path=%2Fmnt%2FUSB%2F3%2FHoa%20tau%20chon%20loc-Linh%20anh%2F12%20Girls%20Band%20-%20Merry%20Christmas%20to%20you%20(2005)%2FMerry%20Christmas%20To%20You.cue&metadata=false Apr 15 22:58:38 volumio volumio[1279]: info: URI /mnt/USB/3/Hoa tau chon loc-Linh anh/12 Girls Band - Merry Christmas to you (2005)/Merry Christmas To You.cue Apr 15 22:58:38 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=496&web=Twelve%20Girls%20Band/Merry%20Christmas%20To%20You/extralarge&path=%2Fmnt%2FUSB%2F3%2FHoa%20tau%20chon%20loc-Linh%20anh%2F12%20Girls%20Band%20-%20Merry%20Christmas%20to%20you%20(2005)%2FMerry%20Christmas%20To%20You.cue&metadata=false Apr 15 22:58:38 volumio volumio[1279]: info: URI /mnt/USB/3/Hoa tau chon loc-Linh anh/12 Girls Band - Merry Christmas to you (2005)/Merry Christmas To You.cue Apr 15 22:58:38 volumio volumio[1279]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 15 22:58:38 volumio volumio[1279]: Error: Unable to resolve or reject the same promise twice Apr 15 22:58:38 volumio volumio[1279]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Apr 15 22:58:38 volumio volumio[1279]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Apr 15 22:58:38 volumio volumio[1279]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Apr 15 22:58:38 volumio volumio[1279]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Apr 15 22:58:38 volumio volumio[1279]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Apr 15 22:58:38 volumio volumio[1279]: at Socket.emit (events.js:315:20) Apr 15 22:58:38 volumio volumio[1279]: at addChunk (internal/streams/readable.js:309:12) Apr 15 22:58:38 volumio volumio[1279]: at readableAddChunk (internal/streams/readable.js:280:11) Apr 15 22:58:38 volumio volumio[1279]: at Socket.Readable.push (internal/streams/readable.js:223:10) Apr 15 22:58:38 volumio volumio[1279]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Apr 15 22:58:38 volumio volumio[1279]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 15 22:58:39 volumio sudo[2270]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-15 22:57 Apr 15 22:58:39 volumio sudo[2270]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 22:58:40 volumio sudo[2270]: pam_unix(sudo:session): session closed for user root Apr 15 22:58:43 volumio volumio-remote-updater[535]: [2024-04-15 22:58:43] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Apr 15 22:58:43 volumio volumio-remote-updater[535]: [2024-04-15 22:58:43] [error] handle_read_frame error: websocketpp.transport:2 (Underlying Transport Error) Apr 15 22:58:43 volumio volumio-remote-updater[535]: [2024-04-15 22:58:43] [disconnect] Disconnect close local:[1006,Underlying Transport Error] remote:[1006] Apr 15 22:58:43 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Apr 15 22:58:43 volumio ntfs-3g[2201]: Unmounting /dev/sda1 (2) Apr 15 22:58:43 volumio systemd[1]: media-2.mount: Succeeded. Apr 15 22:58:43 volumio ntfs-3g[2193]: Unmounting /dev/sda2 (3) Apr 15 22:58:43 volumio systemd[1]: media-3.mount: Succeeded. Apr 15 22:58:43 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Apr 15 22:58:43 volumio systemd[1]: Started dynamicswap service. Apr 15 22:58:43 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Apr 15 22:58:43 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3. Apr 15 22:58:43 volumio systemd[1]: dynamicswap.service: Succeeded. Apr 15 22:58:43 volumio systemd[1]: Stopped Volumio Backend Module. Apr 15 22:58:43 volumio systemd[1]: Started Volumio Backend Module. Apr 15 22:58:47 volumio volumio[2289]: info: ------------------------------------------- Apr 15 22:58:47 volumio volumio[2289]: info: ----- Volumio3 ---- Apr 15 22:58:47 volumio volumio[2289]: info: ------------------------------------------- Apr 15 22:58:47 volumio volumio[2289]: info: ----- System startup ---- Apr 15 22:58:47 volumio volumio[2289]: info: ------------------------------------------- Apr 15 22:58:48 volumio volumio-remote-updater[535]: [2024-04-15 22:58:48] [connect] Successful connection Apr 15 22:58:48 volumio volumio[2289]: info: MYVOLUMIO Environment detected Apr 15 22:58:48 volumio volumio[2289]: info: Plugin folders cleanup Apr 15 22:58:48 volumio volumio[2289]: info: Scanning into folder /volumio/app/plugins/ Apr 15 22:58:48 volumio volumio[2289]: info: Scanning category audio_interface Apr 15 22:58:48 volumio volumio[2289]: info: Scanning category miscellanea Apr 15 22:58:48 volumio volumio[2289]: info: Scanning category music_service Apr 15 22:58:48 volumio volumio[2289]: info: Scanning category plugins.json Apr 15 22:58:48 volumio volumio[2289]: info: Scanning category system_controller Apr 15 22:58:48 volumio volumio[2289]: info: Scanning category user_interface Apr 15 22:58:48 volumio volumio[2289]: info: Scanning into folder /data/plugins/ Apr 15 22:58:48 volumio volumio[2289]: info: Plugin folders cleanup completed Apr 15 22:58:48 volumio volumio[2289]: info: ------------------------------------------- Apr 15 22:58:48 volumio volumio[2289]: info: ----- Core plugins startup ---- Apr 15 22:58:48 volumio volumio[2289]: info: ------------------------------------------- Apr 15 22:58:48 volumio volumio[2289]: info: Loading plugins from folder /volumio/app/plugins/ Apr 15 22:58:48 volumio volumio[2289]: info: Adding plugin upnp to MyMusic Plugins Apr 15 22:58:48 volumio volumio[2289]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 15 22:58:48 volumio volumio[2289]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 15 22:58:48 volumio volumio[2289]: info: Loading plugins from folder /data/plugins/ Apr 15 22:58:48 volumio volumio[2289]: info: Loading plugin "system"... Apr 15 22:58:48 volumio volumio[2289]: info: Loading plugin "appearance"... Apr 15 22:58:51 volumio volumio[2289]: info: Loading plugin "network"... Apr 15 22:58:51 volumio volumio[2289]: info: Refreshing Cached IP Addresses Apr 15 22:58:51 volumio volumio[2289]: info: Loading plugin "services"... Apr 15 22:58:51 volumio volumio[2289]: info: Loading plugin "alsa_controller"... Apr 15 22:58:51 volumio sudo[2315]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 15 22:58:51 volumio sudo[2317]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 15 22:58:51 volumio sudo[2317]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 22:58:51 volumio sudo[2315]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 22:58:51 volumio sudo[2317]: pam_unix(sudo:session): session closed for user root Apr 15 22:58:51 volumio sudo[2315]: pam_unix(sudo:session): session closed for user root Apr 15 22:58:51 volumio sudo[2319]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 15 22:58:51 volumio sudo[2319]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 22:58:51 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 15 22:58:51 volumio volumio[2289]: info: Loading plugin "wizard"... Apr 15 22:58:51 volumio volumio[2289]: info: Loading plugin "networkfs"... Apr 15 22:58:51 volumio volumio[2289]: info: Starting Udev Watcher for removable devices Apr 15 22:58:51 volumio volumio[2289]: info: Ignoring mount for partition: boot Apr 15 22:58:51 volumio volumio[2289]: info: Ignoring mount for partition: volumio Apr 15 22:58:51 volumio volumio[2289]: info: Ignoring mount for partition: volumio_data Apr 15 22:58:51 volumio volumio[2289]: info: Mounting Device 2 Apr 15 22:58:51 volumio sudo[2329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/2 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 15 22:58:51 volumio sudo[2329]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 22:58:52 volumio sudo[2319]: pam_unix(sudo:session): session closed for user root Apr 15 22:58:52 volumio ntfs-3g[2332]: Version 2017.3.23AR.3 integrated FUSE 28 Apr 15 22:58:52 volumio ntfs-3g[2332]: Mounted /dev/sda1 (Read-Write, label "2", NTFS 3.1) Apr 15 22:58:52 volumio ntfs-3g[2332]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 15 22:58:52 volumio ntfs-3g[2332]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Apr 15 22:58:52 volumio ntfs-3g[2332]: Global ownership and permissions enforced, configuration type 7 Apr 15 22:58:52 volumio sudo[2329]: pam_unix(sudo:session): session closed for user root Apr 15 22:58:52 volumio volumio[2289]: info: Mounting Device 3 Apr 15 22:58:52 volumio sudo[2338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/3 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 15 22:58:52 volumio sudo[2338]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 22:58:54 volumio ntfs-3g[2341]: Version 2017.3.23AR.3 integrated FUSE 28 Apr 15 22:58:54 volumio ntfs-3g[2341]: Mounted /dev/sda2 (Read-Write, label "3", NTFS 3.1) Apr 15 22:58:54 volumio ntfs-3g[2341]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 15 22:58:54 volumio ntfs-3g[2341]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda2,blkdev,blksize=4096 Apr 15 22:58:54 volumio ntfs-3g[2341]: Global ownership and permissions enforced, configuration type 7 Apr 15 22:58:54 volumio sudo[2338]: pam_unix(sudo:session): session closed for user root Apr 15 22:58:54 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 15 22:58:54 volumio volumio[2289]: info: Loading plugin "volumio_command_line_client"... Apr 15 22:58:54 volumio volumio[2289]: info: Loading plugin "upnp"... Apr 15 22:58:54 volumio volumio[2289]: info: [1713196734700] Starting Upmpd Daemon Apr 15 22:58:54 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 15 22:58:54 volumio volumio[2289]: info: Loading plugin "my_music"... Apr 15 22:58:54 volumio volumio[2289]: info: Loading plugin "mpd"... Apr 15 22:58:55 volumio volumio[2289]: info: Loading plugin "upnp_browser"... Apr 15 22:58:56 volumio volumio[2289]: info: Loading plugin "alarm-clock"... Apr 15 22:58:56 volumio volumio[2289]: info: Loading plugin "airplay_emulation"... Apr 15 22:58:56 volumio volumio[2289]: info: Starting Shairport Sync Apr 15 22:58:56 volumio volumio[2289]: info: Loading plugin "last_100"... Apr 15 22:58:56 volumio volumio[2289]: info: Loading plugin "webradio"... Apr 15 22:58:57 volumio volumio[2289]: info: Loading plugin "i2s_dacs"... Apr 15 22:58:57 volumio volumio[2289]: info: Loading plugin "volumiodiscovery"... Apr 15 22:58:57 volumio volumio[2289]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 15 22:58:57 volumio node[2289]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 15 22:58:57 volumio volumio[2289]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 15 22:58:57 volumio node[2289]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 15 22:58:57 volumio volumio[2289]: *** WARNING *** For more information see Apr 15 22:58:57 volumio node[2289]: *** WARNING *** For more information see Apr 15 22:58:57 volumio volumio[2289]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 15 22:58:57 volumio node[2289]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 15 22:58:57 volumio volumio[2289]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 15 22:58:57 volumio node[2289]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 15 22:58:57 volumio volumio[2289]: *** WARNING *** For more information see Apr 15 22:58:57 volumio node[2289]: *** WARNING *** For more information see Apr 15 22:58:57 volumio volumio[2289]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 15 22:58:57 volumio volumio[2289]: info: Discovery: Started advertising with name: Volumio Apr 15 22:58:57 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 15 22:58:57 volumio volumio[2289]: info: Loading plugin "outputs"... Apr 15 22:58:57 volumio volumio[2289]: info: Loading plugin "albumart"... Apr 15 22:58:57 volumio volumio[2289]: info: Plugin example_plugin is not enabled Apr 15 22:58:57 volumio volumio[2289]: info: Loading plugin "inputs"... Apr 15 22:58:57 volumio volumio[2289]: info: Loading plugin "updater_comm"... Apr 15 22:58:57 volumio volumio[2289]: info: Plugin mpdemulation is not enabled Apr 15 22:58:57 volumio volumio[2289]: info: Loading plugin "rest_api"... Apr 15 22:58:58 volumio volumio[2289]: info: Loading plugin "websocket"... Apr 15 22:58:58 volumio volumio[2289]: info: Loading i18n strings for locale vi Apr 15 22:58:58 volumio volumio[2289]: Updating browse sources language Apr 15 22:58:58 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 15 22:58:58 volumio volumio[2289]: Forking 3 albumart workers Apr 15 22:58:58 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 15 22:58:58 volumio volumio[2289]: info: CoreCommandRouter::initPlayerControls Apr 15 22:58:58 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 22:58:58 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 22:58:58 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 22:58:58 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 22:58:58 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 22:58:58 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 22:58:58 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 22:58:58 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 15 22:58:58 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 15 22:58:58 volumio volumio[2289]: Express server listening on port 3000 Apr 15 22:58:58 volumio volumio[2289]: [Metrics] WebUI: 12s 634.44ms Apr 15 22:58:58 volumio volumio[2289]: info: CoreStateMachine::resetVolumioState Apr 15 22:58:58 volumio volumio[2289]: info: CoreStateMachine::getcurrentVolume Apr 15 22:58:58 volumio volumio[2289]: info: CoreCommandRouter::volumioRetrievevolume Apr 15 22:58:59 volumio volumio[2289]: verbose: New Socket.io Connection to 192.168.0.104 from 192.168.0.106 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 1 Apr 15 22:58:59 volumio volumio[2289]: verbose: New Socket.io Connection to 192.168.0.104 from 192.168.0.106 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 2 Apr 15 22:58:59 volumio volumio[2289]: verbose: New Socket.io Connection to 192.168.0.104 from 192.168.0.106 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 3 Apr 15 22:58:59 volumio volumio[2289]: verbose: New Socket.io Connection to 192.168.0.104 from 192.168.0.106 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 4 Apr 15 22:58:59 volumio volumio[2289]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 15 22:58:59 volumio volumio[2289]: info: Scanning new location : "USB/3" Apr 15 22:58:59 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 15 22:58:59 volumio volumio[2289]: info: Reloading queue from file Apr 15 22:58:59 volumio volumio[2289]: info: CoreStateMachine::setRepeat null single undefined Apr 15 22:58:59 volumio volumio[2289]: info: CoreStateMachine::pushState Apr 15 22:58:59 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:58:59 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 22:58:59 volumio volumio[2289]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:59 volumio volumio[2289]: info: CoreStateMachine::setRandom false Apr 15 22:58:59 volumio volumio[2289]: info: CoreStateMachine::pushState Apr 15 22:58:59 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:58:59 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 22:58:59 volumio volumio[2289]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:59 volumio volumio[2289]: info: Setting Device type: Raspberry PI Apr 15 22:58:59 volumio volumio[2289]: info: VolumeController:: Volume=undefined Mute =false Apr 15 22:58:59 volumio volumio[2289]: info: CoreStateMachine::pushState Apr 15 22:58:59 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:58:59 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 15 22:58:59 volumio volumio[2289]: info: CoreCommandRouter::volumioPushState Apr 15 22:58:59 volumio volumio[2289]: info: CoreStateMachine::updateTrackBlock Apr 15 22:58:59 volumio volumio[2289]: info: CorePlayQueue::getTrackBlock Apr 15 22:58:59 volumio volumio[2289]: info: CoreCommandRouter::volumioRetrievevolume Apr 15 22:58:59 volumio volumio[2289]: info: Discovery: adding 6d81b121-7afe-410e-9903-7b528aeb7364 Apr 15 22:58:59 volumio volumio[2289]: info: Discovery: Found device Volumio Apr 15 22:58:59 volumio volumio[2289]: info: CoreCommandRouter::volumioGetState Apr 15 22:58:59 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:58:59 volumio volumio[2289]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Apr 15 22:58:59 volumio volumio[2289]: info: VolumeController:: Volume=undefined Mute =false Apr 15 22:58:59 volumio volumio[2289]: info: CoreStateMachine::pushState Apr 15 22:58:59 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:58:59 volumio volumio[2289]: info: CoreCommandRouter::volumioPushState Apr 15 22:59:00 volumio volumio[2289]: Starting albumart workers Apr 15 22:59:00 volumio volumio[2289]: Starting albumart workers Apr 15 22:59:00 volumio volumio[2289]: Starting albumart workers Apr 15 22:59:00 volumio kernel: sd 0:0:0:0: [sda] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x07 driverbyte=DRIVER_OK cmd_age=0s Apr 15 22:59:00 volumio kernel: sd 0:0:0:0: [sda] tag#0 CDB: opcode=0x28 28 00 4c 62 2e 08 00 00 08 00 Apr 15 22:59:00 volumio kernel: I/O error, dev sda, sector 1281502728 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Apr 15 22:59:00 volumio kernel: usb 1-1.3: USB disconnect, device number 7 Apr 15 22:59:00 volumio ntfs-3g[2341]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Apr 15 22:59:00 volumio ntfs-3g[2341]: Failed to read of MFT, mft=17244 count=1 br=-1: Input/output error Apr 15 22:59:00 volumio ntfs-3g[2341]: Could not decode the type of inode 17244 Apr 15 22:59:00 volumio ntfs-3g[2341]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Apr 15 22:59:00 volumio ntfs-3g[2341]: Failed to read of MFT, mft=4506 count=1 br=-1: Input/output error Apr 15 22:59:00 volumio ntfs-3g[2341]: Could not decode the type of inode 4506 Apr 15 22:59:00 volumio ntfs-3g[2341]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Apr 15 22:59:00 volumio ntfs-3g[2341]: Failed to read index block: Input/output error Apr 15 22:59:00 volumio kernel: Buffer I/O error on dev sda2, logical block 19387585, async page read Apr 15 22:59:00 volumio kernel: Buffer I/O error on dev sda2, logical block 787558, async page read Apr 15 22:59:00 volumio kernel: Buffer I/O error on dev sda2, logical block 53187567, async page read Apr 15 22:59:00 volumio kernel: Buffer I/O error on dev sda2, logical block 60915717, async page read Apr 15 22:59:00 volumio ntfs-3g[2341]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Apr 15 22:59:00 volumio ntfs-3g[2341]: Failed to read vcn 0x0 from inode 5: Input/output error Apr 15 22:59:00 volumio volumio[2289]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-label/2 /dev/disk/by-id/ata-TOSHIBA_MQ04ABF100_10HLTOD0T-part1 /dev/disk/by-id/wwn-0x50000399c1a023c0-part1 /dev/disk/by-uuid/F840559C40556304 /dev/disk/by-path/platform-3f980000.usb-usb-0:1.3:1.0-scsi-0:0:0:0-part1 /dev/disk/by-partuuid/f8008c76-01","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"29","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_APM":"1","ID_ATA_FEATURE_SET_APM_CURRENT_VALUE":"128","ID_ATA_FEATURE_SET_APM_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_PUIS":"1","ID_ATA_FEATURE_SET_PUIS_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN":"65714","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"65714","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_ROTATION_RATE_RPM":"5400","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_SATA_SIGNAL_RATE_GEN2":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_FS_LABEL":"2","ID_FS_LABEL_ENC":"2","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"F840559C40556304","ID_FS_UUID_ENC":"F840559C40556304","ID_MODEL":"TOSHIBA_MQ04ABF100","ID_MODEL_ENC":"TOSHIBA\\x20MQ04ABF100\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"1126397952","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"f8008c76-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"f8008c76","ID_PATH":"platform-3f980000.usb-usb-0:1.3:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_3_1_0-scsi-0_0_0_0","ID_REVISION":"JU007C","ID_SERIAL":"TOSHIBA_MQ04ABF100_10HLTOD0T","ID_SERIAL_SHORT":"10HLTOD0T","ID_TYPE":"disk","ID_WWN":"0x50000399c1a023c0","ID_WWN_WITH_EXTENSION":"0x50000399c1a023c0","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"1631","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"454992866"} Apr 15 22:59:00 volumio ntfs-3g[2341]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Apr 15 22:59:00 volumio ntfs-3g[2341]: Failed to read vcn 0x0 from inode 5: Input/output error Apr 15 22:59:00 volumio kernel: Buffer I/O error on dev sda2, logical block 60915717, async page read Apr 15 22:59:00 volumio ntfs-3g[2341]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Apr 15 22:59:00 volumio ntfs-3g[2341]: Failed to read vcn 0x0 from inode 5: Input/output error Apr 15 22:59:00 volumio kernel: Buffer I/O error on dev sda2, logical block 60915717, async page read Apr 15 22:59:00 volumio ntfs-3g[2341]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Apr 15 22:59:00 volumio ntfs-3g[2341]: Failed to read vcn 0x0 from inode 5: Input/output error Apr 15 22:59:00 volumio kernel: Buffer I/O error on dev sda2, logical block 60915717, async page read Apr 15 22:59:00 volumio ntfs-3g[2341]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Apr 15 22:59:00 volumio ntfs-3g[2341]: Failed to read vcn 0x0 from inode 5: Input/output error Apr 15 22:59:00 volumio kernel: Buffer I/O error on dev sda2, logical block 60915717, async page read Apr 15 22:59:00 volumio kernel: Buffer I/O error on dev sda2, logical block 60915717, async page read Apr 15 22:59:00 volumio ntfs-3g[2341]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Apr 15 22:59:00 volumio ntfs-3g[2341]: Failed to read vcn 0x0 from inode 5: Input/output error Apr 15 22:59:00 volumio ntfs-3g[2341]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Apr 15 22:59:00 volumio ntfs-3g[2341]: Failed to read vcn 0x0 from inode 5: Input/output error Apr 15 22:59:00 volumio kernel: Buffer I/O error on dev sda2, logical block 60915717, async page read Apr 15 22:59:00 volumio ntfs-3g[2341]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Apr 15 22:59:00 volumio ntfs-3g[2341]: Failed to read vcn 0x0 from inode 5: Input/output error Apr 15 22:59:00 volumio sudo[2430]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1 Apr 15 22:59:00 volumio ntfs-3g[2341]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Apr 15 22:59:00 volumio ntfs-3g[2341]: Failed to read vcn 0x0 from inode 5: Input/output error Apr 15 22:59:00 volumio sudo[2430]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 22:59:00 volumio ntfs-3g[2341]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Apr 15 22:59:00 volumio ntfs-3g[2341]: Failed to read vcn 0x0 from inode 5: Input/output error Apr 15 22:59:00 volumio ntfs-3g[2341]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Apr 15 22:59:00 volumio ntfs-3g[2341]: Failed to read vcn 0x0 from inode 5: Input/output error Apr 15 22:59:00 volumio ntfs-3g[2332]: Unmounting /dev/sda1 (2) Apr 15 22:59:00 volumio ntfs-3g[2332]: Failed to sync device /dev/sda1: Input/output error Apr 15 22:59:00 volumio ntfs-3g[2332]: Failed to close volume /dev/sda1: Input/output error Apr 15 22:59:00 volumio sudo[2430]: pam_unix(sudo:session): session closed for user root Apr 15 22:59:00 volumio systemd[1]: media-2.mount: Succeeded. Apr 15 22:59:00 volumio volumio-remote-updater[535]: [2024-04-15 22:59:00] [connect] Successful connection Apr 15 22:59:00 volumio volumio[2289]: info: Partition removed: {"syspath":"/sys/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/ata-TOSHIBA_MQ04ABF100_10HLTOD0T-part2 /dev/disk/by-path/platform-3f980000.usb-usb-0:1.3:1.0-scsi-0:0:0:0-part2 /dev/disk/by-id/wwn-0x50000399c1a023c0-part2 /dev/disk/by-uuid/6666A15966A12B2F /dev/disk/by-partuuid/f8008c76-02 /dev/disk/by-label/3","DEVNAME":"/dev/sda2","DEVPATH":"/devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","DEVTYPE":"partition","DISKSEQ":"29","ID_ATA":"1","ID_ATA_DOWNLOAD_MICROCODE":"1","ID_ATA_FEATURE_SET_APM":"1","ID_ATA_FEATURE_SET_APM_CURRENT_VALUE":"128","ID_ATA_FEATURE_SET_APM_ENABLED":"1","ID_ATA_FEATURE_SET_PM":"1","ID_ATA_FEATURE_SET_PM_ENABLED":"1","ID_ATA_FEATURE_SET_PUIS":"1","ID_ATA_FEATURE_SET_PUIS_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY":"1","ID_ATA_FEATURE_SET_SECURITY_ENABLED":"0","ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN":"65714","ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN":"65714","ID_ATA_FEATURE_SET_SMART":"1","ID_ATA_FEATURE_SET_SMART_ENABLED":"1","ID_ATA_ROTATION_RATE_RPM":"5400","ID_ATA_SATA":"1","ID_ATA_SATA_SIGNAL_RATE_GEN1":"1","ID_ATA_SATA_SIGNAL_RATE_GEN2":"1","ID_ATA_WRITE_CACHE":"1","ID_ATA_WRITE_CACHE_ENABLED":"1","ID_BUS":"ata","ID_FS_LABEL":"3","ID_FS_LABEL_ENC":"3","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"6666A15966A12B2F","ID_FS_UUID_ENC":"6666A15966A12B2F","ID_MODEL":"TOSHIBA_MQ04ABF100","ID_MODEL_ENC":"TOSHIBA\\x20MQ04ABF100\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"2","ID_PART_ENTRY_OFFSET":"1126402048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"827117568","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"f8008c76-02","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"f8008c76","ID_PATH":"platform-3f980000.usb-usb-0:1.3:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-3f980000_usb-usb-0_1_3_1_0-scsi-0_0_0_0","ID_REVISION":"JU007C","ID_SERIAL":"TOSHIBA_MQ04ABF100_10HLTOD0T","ID_SERIAL_SHORT":"10HLTOD0T","ID_TYPE":"disk","ID_WWN":"0x50000399c1a023c0","ID_WWN_WITH_EXTENSION":"0x50000399c1a023c0","MAJOR":"8","MINOR":"2","PARTN":"2","SEQNUM":"1632","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"454981440"} Apr 15 22:59:00 volumio kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache Apr 15 22:59:00 volumio kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x01 driverbyte=DRIVER_OK Apr 15 22:59:00 volumio sudo[2433]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda2 Apr 15 22:59:00 volumio sudo[2433]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 22:59:00 volumio ntfs-3g[2341]: Unmounting /dev/sda2 (3) Apr 15 22:59:00 volumio ntfs-3g[2341]: Failed to sync device /dev/sda2: Input/output error Apr 15 22:59:00 volumio ntfs-3g[2341]: Failed to close volume /dev/sda2: Input/output error Apr 15 22:59:00 volumio systemd[1]: media-3.mount: Succeeded. Apr 15 22:59:00 volumio sudo[2433]: pam_unix(sudo:session): session closed for user root Apr 15 22:59:00 volumio volumio-remote-updater[535]: [2024-04-15 22:59:00] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1713196740 101 Apr 15 22:59:00 volumio volumio[2289]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 5 Apr 15 22:59:02 volumio kernel: usb 1-1.3: new high-speed USB device number 8 using dwc_otg Apr 15 22:59:02 volumio kernel: usb 1-1.3: New USB device found, idVendor=13fd, idProduct=3456, bcdDevice= 0.56 Apr 15 22:59:02 volumio kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Apr 15 22:59:02 volumio kernel: usb 1-1.3: Product: 3639S Apr 15 22:59:02 volumio kernel: usb 1-1.3: Manufacturer: sage Apr 15 22:59:02 volumio kernel: usb 1-1.3: SerialNumber: 2222222222222222005B Apr 15 22:59:02 volumio kernel: usb 1-1.3: The driver for the USB controller dwc_otg_hcd does not support scatter-gather which is Apr 15 22:59:02 volumio kernel: usb 1-1.3: required by the UAS driver. Please try an other USB controller if you wish to use UAS. Apr 15 22:59:02 volumio kernel: usb-storage 1-1.3:1.0: USB Mass Storage device detected Apr 15 22:59:02 volumio kernel: scsi host0: usb-storage 1-1.3:1.0 Apr 15 22:59:03 volumio volumio[2289]: verbose: New Socket.io Connection to 192.168.0.104 from 192.168.0.106 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 6 Apr 15 22:59:03 volumio volumio[2289]: info: CoreCommandRouter::volumioGetState Apr 15 22:59:03 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:59:03 volumio kernel: scsi 0:0:0:0: Direct-Access sage 3639S 0056 PQ: 0 ANSI: 6 Apr 15 22:59:03 volumio kernel: scsi 0:0:0:0: Attached scsi generic sg0 type 0 Apr 15 22:59:03 volumio kernel: sd 0:0:0:0: [sda] 1953525167 512-byte logical blocks: (1.00 TB/932 GiB) Apr 15 22:59:03 volumio kernel: sd 0:0:0:0: [sda] Write Protect is off Apr 15 22:59:03 volumio kernel: sd 0:0:0:0: [sda] Mode Sense: 47 00 00 08 Apr 15 22:59:03 volumio kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Apr 15 22:59:03 volumio volumio[2289]: info: Received Get System Info Apr 15 22:59:03 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 15 22:59:03 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 15 22:59:03 volumio volumio[2289]: info: Discovery: Getting this device information Apr 15 22:59:03 volumio volumio[2289]: info: CoreCommandRouter::volumioGetState Apr 15 22:59:03 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:59:03 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 15 22:59:03 volumio volumio[2289]: info: CoreCommandRouter::volumioGetState Apr 15 22:59:03 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:59:03 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 15 22:59:03 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 15 22:59:03 volumio kernel: sda: sda1 sda2 Apr 15 22:59:03 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI disk Apr 15 22:59:03 volumio volumio[2289]: info: CoreCommandRouter::volumioGetVisibleSources Apr 15 22:59:03 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 15 22:59:03 volumio volumio[2289]: info: CoreCommandRouter::volumioGetState Apr 15 22:59:03 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:59:03 volumio volumio[2289]: info: CoreCommandRouter::volumioGetState Apr 15 22:59:03 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:59:03 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 15 22:59:03 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 15 22:59:03 volumio volumio[2289]: info: Received Get System Info Apr 15 22:59:03 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 15 22:59:03 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 15 22:59:03 volumio volumio[2289]: info: Discovery: Getting this device information Apr 15 22:59:03 volumio volumio[2289]: info: CoreCommandRouter::volumioGetState Apr 15 22:59:03 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:59:03 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 15 22:59:03 volumio volumio[2289]: info: CoreCommandRouter::volumioGetState Apr 15 22:59:03 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:59:03 volumio volumio[2289]: info: Listing playlists Apr 15 22:59:03 volumio volumio[2289]: info: CoreCommandRouter::volumioGetQueue Apr 15 22:59:03 volumio volumio[2289]: info: CoreStateMachine::getQueue Apr 15 22:59:03 volumio volumio[2289]: info: CorePlayQueue::getQueue Apr 15 22:59:03 volumio volumio[2289]: info: Received Get System Info Apr 15 22:59:03 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 15 22:59:03 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 15 22:59:03 volumio volumio[2289]: info: Discovery: Getting this device information Apr 15 22:59:03 volumio volumio[2289]: info: CoreCommandRouter::volumioGetState Apr 15 22:59:03 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:59:03 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 15 22:59:03 volumio volumio[2289]: info: CoreCommandRouter::volumioGetState Apr 15 22:59:03 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::volumioGetVisibleSources Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::volumioGetState Apr 15 22:59:04 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::volumioGetState Apr 15 22:59:04 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 15 22:59:04 volumio volumio[2289]: info: Received Get System Info Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 15 22:59:04 volumio volumio[2289]: info: Discovery: Getting this device information Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::volumioGetState Apr 15 22:59:04 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::volumioGetState Apr 15 22:59:04 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:59:04 volumio volumio[2289]: info: Listing playlists Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::volumioGetQueue Apr 15 22:59:04 volumio volumio[2289]: info: CoreStateMachine::getQueue Apr 15 22:59:04 volumio volumio[2289]: info: CorePlayQueue::getQueue Apr 15 22:59:04 volumio volumio[2289]: info: Received Get System Info Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 15 22:59:04 volumio volumio[2289]: info: Discovery: Getting this device information Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::volumioGetState Apr 15 22:59:04 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::volumioGetState Apr 15 22:59:04 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::volumioGetVisibleSources Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::volumioGetState Apr 15 22:59:04 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::volumioGetState Apr 15 22:59:04 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 15 22:59:04 volumio volumio[2289]: info: Received Get System Info Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 15 22:59:04 volumio volumio[2289]: info: Discovery: Getting this device information Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::volumioGetState Apr 15 22:59:04 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::volumioGetState Apr 15 22:59:04 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:59:04 volumio volumio[2289]: info: Listing playlists Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::volumioGetQueue Apr 15 22:59:04 volumio volumio[2289]: info: CoreStateMachine::getQueue Apr 15 22:59:04 volumio volumio[2289]: info: CorePlayQueue::getQueue Apr 15 22:59:04 volumio volumio[2289]: info: Received Get System Info Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 15 22:59:04 volumio volumio[2289]: info: Discovery: Getting this device information Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::volumioGetState Apr 15 22:59:04 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 15 22:59:04 volumio volumio[2289]: info: CoreCommandRouter::volumioGetState Apr 15 22:59:04 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:59:04 volumio volumio[2289]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/2 Apr 15 22:59:04 volumio sudo[2465]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 15 22:59:04 volumio sudo[2465]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 22:59:04 volumio sudo[2467]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 15 22:59:04 volumio sudo[2467]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 22:59:04 volumio sudo[2465]: pam_unix(sudo:session): session closed for user root Apr 15 22:59:04 volumio sudo[2467]: pam_unix(sudo:session): session closed for user root Apr 15 22:59:04 volumio volumio[2289]: info: Mounting Device 2 Apr 15 22:59:05 volumio sudo[2474]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/2 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 15 22:59:05 volumio sudo[2474]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 22:59:05 volumio ntfs-3g[2477]: Version 2017.3.23AR.3 integrated FUSE 28 Apr 15 22:59:05 volumio ntfs-3g[2477]: Mounted /dev/sda1 (Read-Write, label "2", NTFS 3.1) Apr 15 22:59:05 volumio ntfs-3g[2477]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 15 22:59:05 volumio ntfs-3g[2477]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Apr 15 22:59:05 volumio ntfs-3g[2477]: Global ownership and permissions enforced, configuration type 7 Apr 15 22:59:05 volumio sudo[2474]: pam_unix(sudo:session): session closed for user root Apr 15 22:59:05 volumio volumio[2289]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/3 Apr 15 22:59:07 volumio volumio[2289]: info: Mounting Device 3 Apr 15 22:59:07 volumio sudo[2482]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/3 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 15 22:59:07 volumio sudo[2482]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 22:59:09 volumio ntfs-3g[2485]: Version 2017.3.23AR.3 integrated FUSE 28 Apr 15 22:59:09 volumio ntfs-3g[2485]: Mounted /dev/sda2 (Read-Write, label "3", NTFS 3.1) Apr 15 22:59:09 volumio ntfs-3g[2485]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Apr 15 22:59:09 volumio ntfs-3g[2485]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda2,blkdev,blksize=4096 Apr 15 22:59:09 volumio ntfs-3g[2485]: Global ownership and permissions enforced, configuration type 7 Apr 15 22:59:09 volumio sudo[2482]: pam_unix(sudo:session): session closed for user root Apr 15 22:59:09 volumio volumio[2289]: info: Scanning removed location : "USB/2" Apr 15 22:59:09 volumio volumio[2289]: info: Scanning removed location : "USB/3" Apr 15 22:59:09 volumio sudo[2493]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 15 22:59:09 volumio sudo[2493]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 15 22:59:09 volumio sudo[2493]: pam_unix(sudo:session): session closed for user root Apr 15 22:59:09 volumio volumio[2289]: info: Upmpdcli Daemon Started Apr 15 22:59:13 volumio volumio[2289]: info: CoreCommandRouter::volumioPlay Apr 15 22:59:13 volumio volumio[2289]: info: CoreStateMachine::play index undefined Apr 15 22:59:13 volumio volumio[2289]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 15 22:59:13 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:59:16 volumio volumio[2289]: info: CoreCommandRouter::volumioPlay Apr 15 22:59:16 volumio volumio[2289]: info: CoreStateMachine::play index undefined Apr 15 22:59:16 volumio volumio[2289]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 15 22:59:16 volumio volumio[2289]: info: CorePlayQueue::getTrack 0 Apr 15 22:59:17 volumio volumio[2289]: info: Preload queue cleared Apr 15 22:59:17 volumio volumio[2289]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 15 22:59:17 volumio volumio[2289]: info: CoreStateMachine::ClearQueue Apr 15 22:59:17 volumio volumio[2289]: info: CoreStateMachine::stop Apr 15 22:59:17 volumio volumio[2289]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 15 22:59:17 volumio volumio[2289]: info: CorePlayQueue::clearPlayQueue Apr 15 22:59:17 volumio volumio[2289]: info: CorePlayQueue::saveQueue Apr 15 22:59:17 volumio volumio[2289]: info: CoreCommandRouter::volumioPushQueue Apr 15 22:59:17 volumio volumio[2289]: info: CoreStateMachine::addQueueItems Apr 15 22:59:17 volumio volumio[2289]: info: CorePlayQueue::addQueueItems Apr 15 22:59:17 volumio volumio[2289]: info: Preload queue cleared Apr 15 22:59:17 volumio volumio[2289]: info: Adding Item to queue: music-library/USB/3/Hoa tau chon loc-Linh anh/04 - Hinh Bong Que Nha (Thanh Son).flac Apr 15 22:59:17 volumio volumio[2289]: info: Exploding uri music-library/USB/3/Hoa tau chon loc-Linh anh/04 - Hinh Bong Que Nha (Thanh Son).flac in service mpd Apr 15 22:59:17 volumio volumio[2289]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 15 22:59:17 volumio volumio[2289]: TypeError: Cannot read property 'then' of undefined Apr 15 22:59:17 volumio volumio[2289]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2527:19) Apr 15 22:59:17 volumio volumio[2289]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2325:21) Apr 15 22:59:17 volumio volumio[2289]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1359:16) Apr 15 22:59:17 volumio volumio[2289]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Apr 15 22:59:17 volumio volumio[2289]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Apr 15 22:59:17 volumio volumio[2289]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Apr 15 22:59:17 volumio volumio[2289]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25) Apr 15 22:59:17 volumio volumio[2289]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:501:23) Apr 15 22:59:17 volumio volumio[2289]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:477:17) Apr 15 22:59:17 volumio volumio[2289]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:118:33) Apr 15 22:59:17 volumio volumio[2289]: at Socket.emit (events.js:315:20) Apr 15 22:59:17 volumio volumio[2289]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Apr 15 22:59:17 volumio volumio[2289]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 15 22:59:17 volumio volumio[2289]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 15 22:59:19 volumio sudo[2504]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-15 22:58 Apr 15 22:59:19 volumio sudo[2504]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"