-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Wed 2025-04-16 17:24:19 CEST. -- Apr 16 17:23:16 rivo volumio[5489]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 16 17:23:16 rivo volumio[5489]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 16 17:23:16 rivo volumio[5489]: info: Retrieving Cloud Streaming UI Apr 16 17:23:16 rivo volumio[5489]: info: Getting Tidal Cloud Configuration Apr 16 17:23:16 rivo volumio[5489]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 16 17:23:16 rivo volumio[5489]: info: Getting Qobuz Cloud Configuration Apr 16 17:23:16 rivo volumio[5489]: info: Asking plugin for UI Config Apr 16 17:23:16 rivo volumio[5489]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 16 17:23:16 rivo volumio[5489]: info: Getting Spotify Cloud Configuration Apr 16 17:23:16 rivo volumio[5489]: info: Asking plugin for UI Config Apr 16 17:23:16 rivo volumio[5489]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 16 17:23:16 rivo volumio[5489]: info: Saving Spotify Acccount Apr 16 17:23:16 rivo volumio[5489]: info: Got it Apr 16 17:23:16 rivo volumio[5489]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 16 17:23:16 rivo volumio[5489]: info: Got Tidal Cloud Configuration Apr 16 17:23:16 rivo volumio[5489]: info: Got it Apr 16 17:23:16 rivo volumio[5489]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 16 17:23:16 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 16 17:23:16 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 16 17:23:16 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 16 17:23:16 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 16 17:23:16 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 16 17:23:16 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 16 17:23:16 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 16 17:23:16 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 16 17:23:16 rivo volumio[5489]: info: CoreCommandRouter::volumioGetBrowseSources Apr 16 17:23:16 rivo volumio[5489]: info: CoreCommandRouter::volumioGetBrowseSources Apr 16 17:23:16 rivo volumio[5489]: info: CoreCommandRouter::volumioGetBrowseSources Apr 16 17:23:16 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 16 17:23:16 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 16 17:23:20 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 16 17:23:22 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Apr 16 17:23:23 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 16 17:23:24 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 16 17:23:28 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 16 17:23:28 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare Apr 16 17:23:28 rivo volumio[5489]: info: Share NAS successfully unmounted Apr 16 17:23:28 rivo sudo[6467]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=apo,password=,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //::1/MUSICA /mnt/NAS/NAS Apr 16 17:23:28 rivo sudo[6467]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 17:23:28 rivo sudo[6467]: pam_unix(sudo:session): session closed for user root Apr 16 17:23:28 rivo volumio[5489]: info: An error occurred mounting the new share. Rolling back configuration Apr 16 17:23:29 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 16 17:23:32 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 16 17:23:36 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 16 17:23:40 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 16 17:23:44 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 16 17:23:48 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 16 17:23:52 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 16 17:23:56 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 16 17:24:00 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 16 17:24:04 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 16 17:24:08 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 16 17:24:12 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 16 17:24:12 rivo kernel: usb 1-1.1: USB disconnect, device number 3 Apr 16 17:24:12 rivo volumio[5489]: info: CoreCommandRouter::volumioGetState Apr 16 17:24:12 rivo volumio[5489]: info: CorePlayQueue::getTrack 0 Apr 16 17:24:12 rivo volumio[5489]: info: Clearing queue from CD entries Apr 16 17:24:12 rivo volumio[5489]: info: CoreCommandRouter::volumioPushQueue Apr 16 17:24:12 rivo volumio[5489]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesAudio CD Apr 16 17:24:12 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 16 17:24:12 rivo volumio[5489]: Cannot find translation for source QOBUZ Apr 16 17:24:12 rivo volumio[5489]: info: Partition removed: {"syspath":"/sys/devices/platform/ff500000.dwc3/xhci-hcd.0.auto/usb1/1-1/1-1.1/1-1.1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-uuid/2C8D-E202 /dev/disk/by-id/usb-SanDisk_Cruzer_Blade_00002530101421003321-0:0-part1 /dev/disk/by-path/platform-xhci-hcd.0.auto-usb-0:1.1:1.0-scsi-0:0:0:0-part1 /dev/disk/by-partuuid/2ddea11e-01","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/ff500000.dwc3/xhci-hcd.0.auto/usb1/1-1/1-1.1/1-1.1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","ID_BUS":"usb","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"2C8D-E202","ID_FS_UUID_ENC":"2C8D-E202","ID_FS_VERSION":"FAT32","ID_INSTANCE":"0:0","ID_MODEL":"Cruzer_Blade","ID_MODEL_ENC":"Cruzer\\x20Blade\\x20\\x20\\x20\\x20","ID_MODEL_ID":"5567","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"32","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"31260640","ID_PART_ENTRY_TYPE":"0xc","ID_PART_ENTRY_UUID":"2ddea11e-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"2ddea11e","ID_PATH":"platform-xhci-hcd.0.auto-usb-0:1.1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-xhci-hcd_0_auto-usb-0_1_1_1_0-scsi-0_0_0_0","ID_REVISION":"1.00","ID_SERIAL":"SanDisk_Cruzer_Blade_00002530101421003321-0:0","ID_SERIAL_SHORT":"00002530101421003321","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"SanDisk","ID_VENDOR_ENC":"SanDisk\\x20","ID_VENDOR_ID":"0781","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"6711","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"4352373"} Apr 16 17:24:12 rivo sudo[6614]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1 Apr 16 17:24:12 rivo sudo[6614]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 16 17:24:12 rivo sudo[6614]: pam_unix(sudo:session): session closed for user root Apr 16 17:24:12 rivo volumio[5489]: umount: /media/2C8D-E202: target is busy. Apr 16 17:24:12 rivo volumio[5489]: error: Failed to umount 2C8D-E202: Error: Command failed: /usr/bin/sudo /bin/umount -f "/dev/sda1" Apr 16 17:24:12 rivo volumio[5489]: umount: /media/2C8D-E202: target is busy. Apr 16 17:24:13 rivo sudo[5556]: pam_unix(sudo:session): session closed for user root Apr 16 17:24:13 rivo volumio[5489]: info: Cannot mount NAS HD_Local at system boot, trial number 1 ,retrying in 5 seconds Apr 16 17:24:16 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 16 17:24:17 rivo volumio[5489]: info: Scanning removed location : "USB/2C8D-E202" Apr 16 17:24:17 rivo volumio[5489]: verbose: ControllerMpd::sendMpdCommand status Apr 16 17:24:17 rivo kernel: FAT-fs (sda1): Directory bread(block 16384) failed Apr 16 17:24:17 rivo kernel: FAT-fs (sda1): Directory bread(block 16385) failed Apr 16 17:24:17 rivo kernel: FAT-fs (sda1): Directory bread(block 16386) failed Apr 16 17:24:17 rivo kernel: FAT-fs (sda1): Directory bread(block 16387) failed Apr 16 17:24:17 rivo kernel: FAT-fs (sda1): Directory bread(block 16388) failed Apr 16 17:24:17 rivo kernel: FAT-fs (sda1): Directory bread(block 16389) failed Apr 16 17:24:17 rivo kernel: FAT-fs (sda1): Directory bread(block 16390) failed Apr 16 17:24:17 rivo kernel: FAT-fs (sda1): Directory bread(block 16391) failed Apr 16 17:24:17 rivo kernel: FAT-fs (sda1): Directory bread(block 16392) failed Apr 16 17:24:17 rivo kernel: FAT-fs (sda1): Directory bread(block 16393) failed Apr 16 17:24:17 rivo volumio[5489]: info: Apr 16 17:24:17 rivo volumio[5489]: ---------------------------- MPD announces state update: update Apr 16 17:24:17 rivo volumio[5489]: info: ControllerMpd::getState Apr 16 17:24:17 rivo volumio[5489]: verbose: ControllerMpd::sendMpdCommand status Apr 16 17:24:17 rivo volumio[5489]: verbose: ControllerMpd::sendMpdCommand status Apr 16 17:24:17 rivo volumio[5489]: info: Apr 16 17:24:17 rivo volumio[5489]: ---------------------------- MPD announces state update: update Apr 16 17:24:17 rivo volumio[5489]: info: ControllerMpd::getState Apr 16 17:24:17 rivo volumio[5489]: verbose: ControllerMpd::sendMpdCommand status Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::sendMpdCommand status Apr 16 17:24:18 rivo volumio[5489]: info: Apr 16 17:24:18 rivo volumio[5489]: ---------------------------- MPD announces state update: update Apr 16 17:24:18 rivo volumio[5489]: info: ControllerMpd::getState Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::sendMpdCommand status Apr 16 17:24:18 rivo volumio[5489]: info: sendMpdCommand status took 18 milliseconds Apr 16 17:24:18 rivo volumio[5489]: info: sendMpdCommand status took 16 milliseconds Apr 16 17:24:18 rivo volumio[5489]: info: sendMpdCommand status took 15 milliseconds Apr 16 17:24:18 rivo volumio[5489]: info: sendMpdCommand status took 13 milliseconds Apr 16 17:24:18 rivo volumio[5489]: info: sendMpdCommand status took 12 milliseconds Apr 16 17:24:18 rivo volumio[5489]: info: sendMpdCommand status took 7 milliseconds Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::parseState Apr 16 17:24:18 rivo volumio[5489]: info: Command Router : Notfying DB Updatetrue Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::parseState Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::parseState Apr 16 17:24:18 rivo volumio[5489]: info: Command Router : Notfying DB Updatetrue Apr 16 17:24:18 rivo volumio[5489]: info: CoreCommandRouter::Close All Modals sent Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::parseState Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::parseState Apr 16 17:24:18 rivo volumio[5489]: info: Command Router : Notfying DB Updatetrue Apr 16 17:24:18 rivo volumio[5489]: info: CoreCommandRouter::Close All Modals sent Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::parseState Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 17:24:18 rivo volumio[5489]: info: MPD Database updated - AlbumList cache refreshed Apr 16 17:24:18 rivo volumio[5489]: info: Apr 16 17:24:18 rivo volumio[5489]: ---------------------------- MPD announces state update: database Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::sendMpdCommand status Apr 16 17:24:18 rivo volumio[5489]: info: Apr 16 17:24:18 rivo volumio[5489]: ---------------------------- MPD announces state update: update Apr 16 17:24:18 rivo volumio[5489]: info: ControllerMpd::getState Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::sendMpdCommand status Apr 16 17:24:18 rivo volumio[5489]: info: ControllerMpd::getState Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::sendMpdCommand status Apr 16 17:24:18 rivo volumio[5489]: info: sendMpdCommand playlistinfo took 102 milliseconds Apr 16 17:24:18 rivo volumio[5489]: info: sendMpdCommand playlistinfo took 68 milliseconds Apr 16 17:24:18 rivo volumio[5489]: info: sendMpdCommand playlistinfo took 35 milliseconds Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::parseTrackInfo Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::parseTrackInfo Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::parseTrackInfo Apr 16 17:24:18 rivo volumio[5489]: info: ControllerMpd::pushState Apr 16 17:24:18 rivo volumio[5489]: info: CoreCommandRouter::servicePushState Apr 16 17:24:18 rivo volumio[5489]: info: CorePlayQueue::getTrack 0 Apr 16 17:24:18 rivo volumio[5489]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":147734,"duration":294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"921 Kbps","isStreaming":false,"title":"These Are Days","artist":"10,000 Maniacs","album":"MTV Unplugged","uri":"USB/2C8D-E202/10,000_Maniacs-MTV_Unplugged/01.These_Are_Days.flac","trackType":"flac"} Apr 16 17:24:18 rivo volumio[5489]: verbose: CURRENT POSITION 0 Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::syncState stateService pause Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::syncState currentStatus pause Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::pushState Apr 16 17:24:18 rivo volumio[5489]: info: CorePlayQueue::getTrack 0 Apr 16 17:24:18 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 17:24:18 rivo volumio[5489]: info: CoreCommandRouter::volumioPushState Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::stPlaybackTimer Apr 16 17:24:18 rivo volumio[5489]: info: ControllerMpd::pushState Apr 16 17:24:18 rivo volumio[5489]: info: CoreCommandRouter::servicePushState Apr 16 17:24:18 rivo volumio[5489]: info: CorePlayQueue::getTrack 0 Apr 16 17:24:18 rivo volumio[5489]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":147734,"duration":294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"921 Kbps","isStreaming":false,"title":"These Are Days","artist":"10,000 Maniacs","album":"MTV Unplugged","uri":"USB/2C8D-E202/10,000_Maniacs-MTV_Unplugged/01.These_Are_Days.flac","trackType":"flac"} Apr 16 17:24:18 rivo volumio[5489]: verbose: CURRENT POSITION 0 Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::syncState stateService pause Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::syncState currentStatus pause Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::pushState Apr 16 17:24:18 rivo volumio[5489]: info: CorePlayQueue::getTrack 0 Apr 16 17:24:18 rivo volumio[5489]: info: CoreCommandRouter::volumioPushState Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::stPlaybackTimer Apr 16 17:24:18 rivo volumio[5489]: info: ControllerMpd::pushState Apr 16 17:24:18 rivo volumio[5489]: info: CoreCommandRouter::servicePushState Apr 16 17:24:18 rivo volumio[5489]: info: CorePlayQueue::getTrack 0 Apr 16 17:24:18 rivo volumio[5489]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":147734,"duration":294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"921 Kbps","isStreaming":false,"title":"These Are Days","artist":"10,000 Maniacs","album":"MTV Unplugged","uri":"USB/2C8D-E202/10,000_Maniacs-MTV_Unplugged/01.These_Are_Days.flac","trackType":"flac"} Apr 16 17:24:18 rivo volumio[5489]: verbose: CURRENT POSITION 0 Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::syncState stateService pause Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::syncState currentStatus pause Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::pushState Apr 16 17:24:18 rivo volumio[5489]: info: CorePlayQueue::getTrack 0 Apr 16 17:24:18 rivo volumio[5489]: info: CoreCommandRouter::volumioPushState Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::stPlaybackTimer Apr 16 17:24:18 rivo volumio[5489]: info: ------------------------------ 243ms Apr 16 17:24:18 rivo volumio[5489]: info: ------------------------------ 239ms Apr 16 17:24:18 rivo volumio[5489]: info: ------------------------------ 232ms Apr 16 17:24:18 rivo volumio[5489]: info: MPD Database updated - AlbumList cache refreshed Apr 16 17:24:18 rivo volumio[5489]: info: Apr 16 17:24:18 rivo volumio[5489]: ---------------------------- MPD announces state update: database Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::sendMpdCommand status Apr 16 17:24:18 rivo volumio[5489]: info: Apr 16 17:24:18 rivo volumio[5489]: ---------------------------- MPD announces state update: update Apr 16 17:24:18 rivo volumio[5489]: info: ControllerMpd::getState Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::sendMpdCommand status Apr 16 17:24:18 rivo volumio[5489]: info: ControllerMpd::getState Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::sendMpdCommand status Apr 16 17:24:18 rivo volumio[5489]: info: MPD Database updated - AlbumList cache refreshed Apr 16 17:24:18 rivo volumio[5489]: info: Apr 16 17:24:18 rivo volumio[5489]: ---------------------------- MPD announces state update: database Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::sendMpdCommand status Apr 16 17:24:18 rivo volumio[5489]: info: Apr 16 17:24:18 rivo volumio[5489]: ---------------------------- MPD announces state update: update Apr 16 17:24:18 rivo volumio[5489]: info: ControllerMpd::getState Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::sendMpdCommand status Apr 16 17:24:18 rivo volumio[5489]: info: ControllerMpd::getState Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::sendMpdCommand status Apr 16 17:24:18 rivo volumio[5489]: info: sendMpdCommand status took 122 milliseconds Apr 16 17:24:18 rivo volumio[5489]: info: sendMpdCommand status took 119 milliseconds Apr 16 17:24:18 rivo volumio[5489]: info: sendMpdCommand status took 119 milliseconds Apr 16 17:24:18 rivo volumio[5489]: info: sendMpdCommand status took 41 milliseconds Apr 16 17:24:18 rivo volumio[5489]: info: sendMpdCommand status took 40 milliseconds Apr 16 17:24:18 rivo volumio[5489]: info: sendMpdCommand status took 40 milliseconds Apr 16 17:24:18 rivo volumio[5489]: info: sendMpdCommand status took 37 milliseconds Apr 16 17:24:18 rivo volumio[5489]: info: sendMpdCommand status took 36 milliseconds Apr 16 17:24:18 rivo volumio[5489]: info: sendMpdCommand status took 35 milliseconds Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::parseState Apr 16 17:24:18 rivo volumio[5489]: info: Command Router : Notfying DB Updatefalse Apr 16 17:24:18 rivo volumio[5489]: info: CoreCommandRouter::Close All Modals sent Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::parseState Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::parseState Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::parseState Apr 16 17:24:18 rivo volumio[5489]: info: Command Router : Notfying DB Updatefalse Apr 16 17:24:18 rivo volumio[5489]: info: CoreCommandRouter::Close All Modals sent Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::parseState Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::parseState Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::parseState Apr 16 17:24:18 rivo volumio[5489]: info: Command Router : Notfying DB Updatefalse Apr 16 17:24:18 rivo volumio[5489]: info: CoreCommandRouter::Close All Modals sent Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::parseState Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::parseState Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 17:24:18 rivo volumio[5489]: info: sendMpdCommand playlistinfo took 103 milliseconds Apr 16 17:24:18 rivo volumio[5489]: info: sendMpdCommand playlistinfo took 102 milliseconds Apr 16 17:24:18 rivo volumio[5489]: info: sendMpdCommand playlistinfo took 68 milliseconds Apr 16 17:24:18 rivo volumio[5489]: info: sendMpdCommand playlistinfo took 67 milliseconds Apr 16 17:24:18 rivo volumio[5489]: info: sendMpdCommand playlistinfo took 35 milliseconds Apr 16 17:24:18 rivo volumio[5489]: info: sendMpdCommand playlistinfo took 35 milliseconds Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::parseTrackInfo Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::parseTrackInfo Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::parseTrackInfo Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::parseTrackInfo Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::parseTrackInfo Apr 16 17:24:18 rivo volumio[5489]: verbose: ControllerMpd::parseTrackInfo Apr 16 17:24:18 rivo volumio[5489]: info: ControllerMpd::pushState Apr 16 17:24:18 rivo volumio[5489]: info: CoreCommandRouter::servicePushState Apr 16 17:24:18 rivo volumio[5489]: info: CorePlayQueue::getTrack 0 Apr 16 17:24:18 rivo volumio[5489]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":147734,"duration":294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"921 Kbps","isStreaming":false,"title":"These Are Days","artist":"10,000 Maniacs","album":"MTV Unplugged","uri":"USB/2C8D-E202/10,000_Maniacs-MTV_Unplugged/01.These_Are_Days.flac","trackType":"flac"} Apr 16 17:24:18 rivo volumio[5489]: verbose: CURRENT POSITION 0 Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::syncState stateService pause Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::syncState currentStatus pause Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::pushState Apr 16 17:24:18 rivo volumio[5489]: info: CorePlayQueue::getTrack 0 Apr 16 17:24:18 rivo volumio[5489]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 17:24:18 rivo volumio[5489]: info: CoreCommandRouter::volumioPushState Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::stPlaybackTimer Apr 16 17:24:18 rivo volumio[5489]: info: ControllerMpd::pushState Apr 16 17:24:18 rivo volumio[5489]: info: CoreCommandRouter::servicePushState Apr 16 17:24:18 rivo volumio[5489]: info: CorePlayQueue::getTrack 0 Apr 16 17:24:18 rivo volumio[5489]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":147734,"duration":294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"921 Kbps","isStreaming":false,"title":"These Are Days","artist":"10,000 Maniacs","album":"MTV Unplugged","uri":"USB/2C8D-E202/10,000_Maniacs-MTV_Unplugged/01.These_Are_Days.flac","trackType":"flac"} Apr 16 17:24:18 rivo volumio[5489]: verbose: CURRENT POSITION 0 Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::syncState stateService pause Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::syncState currentStatus pause Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::pushState Apr 16 17:24:18 rivo volumio[5489]: info: CorePlayQueue::getTrack 0 Apr 16 17:24:18 rivo volumio[5489]: info: CoreCommandRouter::volumioPushState Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::stPlaybackTimer Apr 16 17:24:18 rivo volumio[5489]: info: ControllerMpd::pushState Apr 16 17:24:18 rivo volumio[5489]: info: CoreCommandRouter::servicePushState Apr 16 17:24:18 rivo volumio[5489]: info: CorePlayQueue::getTrack 0 Apr 16 17:24:18 rivo volumio[5489]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":147734,"duration":294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"921 Kbps","isStreaming":false,"title":"These Are Days","artist":"10,000 Maniacs","album":"MTV Unplugged","uri":"USB/2C8D-E202/10,000_Maniacs-MTV_Unplugged/01.These_Are_Days.flac","trackType":"flac"} Apr 16 17:24:18 rivo volumio[5489]: verbose: CURRENT POSITION 0 Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::syncState stateService pause Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::syncState currentStatus pause Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::pushState Apr 16 17:24:18 rivo volumio[5489]: info: CorePlayQueue::getTrack 0 Apr 16 17:24:18 rivo volumio[5489]: info: CoreCommandRouter::volumioPushState Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::stPlaybackTimer Apr 16 17:24:18 rivo volumio[5489]: info: ControllerMpd::pushState Apr 16 17:24:18 rivo volumio[5489]: info: CoreCommandRouter::servicePushState Apr 16 17:24:18 rivo volumio[5489]: info: CorePlayQueue::getTrack 0 Apr 16 17:24:18 rivo volumio[5489]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":147734,"duration":294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"921 Kbps","isStreaming":false,"title":"These Are Days","artist":"10,000 Maniacs","album":"MTV Unplugged","uri":"USB/2C8D-E202/10,000_Maniacs-MTV_Unplugged/01.These_Are_Days.flac","trackType":"flac"} Apr 16 17:24:18 rivo volumio[5489]: verbose: CURRENT POSITION 0 Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::syncState stateService pause Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::syncState currentStatus pause Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::pushState Apr 16 17:24:18 rivo volumio[5489]: info: CorePlayQueue::getTrack 0 Apr 16 17:24:18 rivo volumio[5489]: info: CoreCommandRouter::volumioPushState Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::stPlaybackTimer Apr 16 17:24:18 rivo volumio[5489]: info: ControllerMpd::pushState Apr 16 17:24:18 rivo volumio[5489]: info: CoreCommandRouter::servicePushState Apr 16 17:24:18 rivo volumio[5489]: info: CorePlayQueue::getTrack 0 Apr 16 17:24:18 rivo volumio[5489]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":147734,"duration":294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"921 Kbps","isStreaming":false,"title":"These Are Days","artist":"10,000 Maniacs","album":"MTV Unplugged","uri":"USB/2C8D-E202/10,000_Maniacs-MTV_Unplugged/01.These_Are_Days.flac","trackType":"flac"} Apr 16 17:24:18 rivo volumio[5489]: verbose: CURRENT POSITION 0 Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::syncState stateService pause Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::syncState currentStatus pause Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::pushState Apr 16 17:24:18 rivo volumio[5489]: info: CorePlayQueue::getTrack 0 Apr 16 17:24:18 rivo volumio[5489]: info: CoreCommandRouter::volumioPushState Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::stPlaybackTimer Apr 16 17:24:18 rivo volumio[5489]: info: ControllerMpd::pushState Apr 16 17:24:18 rivo volumio[5489]: info: CoreCommandRouter::servicePushState Apr 16 17:24:18 rivo volumio[5489]: info: CorePlayQueue::getTrack 0 Apr 16 17:24:18 rivo volumio[5489]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":147734,"duration":294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"921 Kbps","isStreaming":false,"title":"These Are Days","artist":"10,000 Maniacs","album":"MTV Unplugged","uri":"USB/2C8D-E202/10,000_Maniacs-MTV_Unplugged/01.These_Are_Days.flac","trackType":"flac"} Apr 16 17:24:18 rivo volumio[5489]: verbose: CURRENT POSITION 0 Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::syncState stateService pause Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::syncState currentStatus pause Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::pushState Apr 16 17:24:18 rivo volumio[5489]: info: CorePlayQueue::getTrack 0 Apr 16 17:24:18 rivo volumio[5489]: info: CoreCommandRouter::volumioPushState Apr 16 17:24:18 rivo volumio[5489]: info: CoreStateMachine::stPlaybackTimer Apr 16 17:24:18 rivo volumio[5489]: info: ------------------------------ 370ms Apr 16 17:24:18 rivo volumio[5489]: info: ------------------------------ 370ms Apr 16 17:24:18 rivo volumio[5489]: info: ------------------------------ 291ms Apr 16 17:24:18 rivo volumio[5489]: info: ------------------------------ 292ms Apr 16 17:24:18 rivo volumio[5489]: info: ------------------------------ 288ms Apr 16 17:24:18 rivo volumio[5489]: info: ------------------------------ 288ms Apr 16 17:24:18 rivo volumio[5489]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 16 17:24:18 rivo volumio[5489]: TypeError: Cannot read property 'replace' of undefined Apr 16 17:24:18 rivo volumio[5489]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28) Apr 16 17:24:18 rivo volumio[5489]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20) Apr 16 17:24:18 rivo volumio[5489]: at listOnTimeout (internal/timers.js:557:17) Apr 16 17:24:18 rivo volumio[5489]: at processTimers (internal/timers.js:500:7) Apr 16 17:24:18 rivo volumio[5489]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 16 17:24:19 rivo sudo[6642]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-16 17:23 Apr 16 17:24:19 rivo sudo[6642]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 08:01:39 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="71b19b3a3eb3d257ef93eee35eba5cf1"