-- Logs begin at Thu 2019-02-14 02:11:58 -08, end at Mon 2025-03-10 05:48:52 -08. -- Mar 10 05:47:04 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 10 05:47:04 volumio volumio[966]: info: CURURI: playlists/m Mar 10 05:47:04 volumio volumio[966]: info: Preload queue cleared Mar 10 05:47:10 volumio volumio[966]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Mar 10 05:47:10 volumio volumio[966]: info: Retrying Login Due to Network Error Mar 10 05:47:10 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 10 05:47:10 volumio volumio[966]: info: CURURI: playlists Mar 10 05:47:10 volumio volumio[966]: info: Listing playlists Mar 10 05:47:10 volumio volumio[966]: info: Preload queue cleared Mar 10 05:47:13 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 10 05:47:13 volumio volumio[966]: info: CURURI: music-library Mar 10 05:47:13 volumio volumio[966]: info: Preload queue cleared Mar 10 05:47:14 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 10 05:47:14 volumio volumio[966]: info: CURURI: music-library/USB Mar 10 05:47:14 volumio volumio[966]: info: Preload queue cleared Mar 10 05:47:15 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 10 05:47:15 volumio volumio[966]: info: CURURI: music-library/USB/9C09-F73E Mar 10 05:47:15 volumio volumio[966]: info: Preload queue cleared Mar 10 05:47:16 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 10 05:47:16 volumio volumio[966]: info: CURURI: music-library/USB/9C09-F73E/mp3 Mar 10 05:47:16 volumio volumio[966]: info: Preload queue cleared Mar 10 05:47:17 volumio volumio[966]: info: Preload queue cleared Mar 10 05:47:17 volumio volumio[966]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 10 05:47:17 volumio volumio[966]: info: CoreStateMachine::ClearQueue Mar 10 05:47:17 volumio volumio[966]: info: CoreStateMachine::stop Mar 10 05:47:17 volumio volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 05:47:17 volumio volumio[966]: info: CorePlayQueue::clearPlayQueue Mar 10 05:47:17 volumio volumio[966]: info: CorePlayQueue::saveQueue Mar 10 05:47:17 volumio volumio[966]: info: CoreCommandRouter::volumioPushQueue Mar 10 05:47:17 volumio volumio[966]: info: CoreStateMachine::addQueueItems Mar 10 05:47:17 volumio volumio[966]: info: CorePlayQueue::addQueueItems Mar 10 05:47:17 volumio volumio[966]: info: Preload queue cleared Mar 10 05:47:17 volumio volumio[966]: info: Adding Item to queue: music-library/USB/9C09-F73E/mp3/01. 马兰花.wav Mar 10 05:47:17 volumio volumio[966]: info: Using cached record of: music-library/USB/9C09-F73E/mp3/01. 马兰花.wav Mar 10 05:47:17 volumio volumio[966]: info: Adding Item to queue: music-library/USB/9C09-F73E/mp3/大欢-三生石下.mp3 Mar 10 05:47:17 volumio volumio[966]: info: Using cached record of: music-library/USB/9C09-F73E/mp3/大欢-三生石下.mp3 Mar 10 05:47:17 volumio volumio[966]: info: Adding Item to queue: music-library/USB/9C09-F73E/mp3/洋澜一 天际 .mp3 Mar 10 05:47:17 volumio volumio[966]: info: Using cached record of: music-library/USB/9C09-F73E/mp3/洋澜一 天际 .mp3 Mar 10 05:47:17 volumio volumio[966]: info: CoreCommandRouter::volumioPushQueue Mar 10 05:47:17 volumio volumio[966]: info: CorePlayQueue::saveQueue Mar 10 05:47:17 volumio volumio[966]: info: CoreStateMachine::updateTrackBlock Mar 10 05:47:17 volumio volumio[966]: info: CorePlayQueue::getTrackBlock Mar 10 05:47:17 volumio volumio[966]: info: CoreCommandRouter::volumioPlay Mar 10 05:47:17 volumio volumio[966]: info: CoreStateMachine::play index 2 Mar 10 05:47:17 volumio volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 05:47:17 volumio volumio[966]: info: CoreStateMachine::addQueueItems Mar 10 05:47:17 volumio volumio[966]: info: CorePlayQueue::addQueueItems Mar 10 05:47:17 volumio volumio[966]: info: Preload queue cleared Mar 10 05:47:17 volumio volumio[966]: info: Adding Item to queue: music-library/USB/9C09-F73E/mp3/陈瑞 情罪.mp3 Mar 10 05:47:17 volumio volumio[966]: info: Using cached record of: music-library/USB/9C09-F73E/mp3/陈瑞 情罪.mp3 Mar 10 05:47:17 volumio volumio[966]: info: Adding Item to queue: music-library/USB/9C09-F73E/mp3/洋澜一 谁.mp3 Mar 10 05:47:17 volumio volumio[966]: info: Using cached record of: music-library/USB/9C09-F73E/mp3/洋澜一 谁.mp3 Mar 10 05:47:17 volumio volumio[966]: info: CoreStateMachine::stop Mar 10 05:47:17 volumio volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 05:47:17 volumio volumio[966]: info: CoreCommandRouter::volumioPushQueue Mar 10 05:47:17 volumio volumio[966]: info: CorePlayQueue::saveQueue Mar 10 05:47:17 volumio volumio[966]: info: CoreStateMachine::play index undefined Mar 10 05:47:17 volumio volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 05:47:17 volumio volumio[966]: info: CoreStateMachine::updateTrackBlock Mar 10 05:47:17 volumio volumio[966]: info: CorePlayQueue::getTrackBlock Mar 10 05:47:17 volumio volumio[966]: info: CorePlayQueue::getTrack 2 Mar 10 05:47:18 volumio volumio[966]: info: Preload queue cleared Mar 10 05:47:18 volumio volumio[966]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 10 05:47:18 volumio volumio[966]: info: CoreStateMachine::ClearQueue Mar 10 05:47:18 volumio volumio[966]: info: CoreStateMachine::stop Mar 10 05:47:18 volumio volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 05:47:18 volumio volumio[966]: info: CorePlayQueue::clearPlayQueue Mar 10 05:47:18 volumio volumio[966]: info: CorePlayQueue::saveQueue Mar 10 05:47:18 volumio volumio[966]: info: CoreCommandRouter::volumioPushQueue Mar 10 05:47:18 volumio volumio[966]: info: CoreStateMachine::addQueueItems Mar 10 05:47:18 volumio volumio[966]: info: CorePlayQueue::addQueueItems Mar 10 05:47:18 volumio volumio[966]: info: Preload queue cleared Mar 10 05:47:18 volumio volumio[966]: info: Adding Item to queue: music-library/USB/9C09-F73E/mp3/01. 马兰花.wav Mar 10 05:47:18 volumio volumio[966]: info: Using cached record of: music-library/USB/9C09-F73E/mp3/01. 马兰花.wav Mar 10 05:47:18 volumio volumio[966]: info: Adding Item to queue: music-library/USB/9C09-F73E/mp3/大欢-三生石下.mp3 Mar 10 05:47:18 volumio volumio[966]: info: Using cached record of: music-library/USB/9C09-F73E/mp3/大欢-三生石下.mp3 Mar 10 05:47:18 volumio volumio[966]: info: Adding Item to queue: music-library/USB/9C09-F73E/mp3/洋澜一 天际 .mp3 Mar 10 05:47:18 volumio volumio[966]: info: Using cached record of: music-library/USB/9C09-F73E/mp3/洋澜一 天际 .mp3 Mar 10 05:47:18 volumio volumio[966]: info: CoreCommandRouter::volumioPushQueue Mar 10 05:47:18 volumio volumio[966]: info: CorePlayQueue::saveQueue Mar 10 05:47:18 volumio volumio[966]: info: CoreStateMachine::updateTrackBlock Mar 10 05:47:18 volumio volumio[966]: info: CorePlayQueue::getTrackBlock Mar 10 05:47:18 volumio volumio[966]: info: CoreCommandRouter::volumioPlay Mar 10 05:47:18 volumio volumio[966]: info: CoreStateMachine::play index 2 Mar 10 05:47:18 volumio volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 05:47:18 volumio volumio[966]: info: CoreStateMachine::addQueueItems Mar 10 05:47:18 volumio volumio[966]: info: CorePlayQueue::addQueueItems Mar 10 05:47:18 volumio volumio[966]: info: Preload queue cleared Mar 10 05:47:18 volumio volumio[966]: info: Adding Item to queue: music-library/USB/9C09-F73E/mp3/陈瑞 情罪.mp3 Mar 10 05:47:18 volumio volumio[966]: info: Using cached record of: music-library/USB/9C09-F73E/mp3/陈瑞 情罪.mp3 Mar 10 05:47:18 volumio volumio[966]: info: Adding Item to queue: music-library/USB/9C09-F73E/mp3/洋澜一 谁.mp3 Mar 10 05:47:18 volumio volumio[966]: info: Using cached record of: music-library/USB/9C09-F73E/mp3/洋澜一 谁.mp3 Mar 10 05:47:18 volumio volumio[966]: info: CoreStateMachine::stop Mar 10 05:47:18 volumio volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 05:47:18 volumio volumio[966]: info: CoreCommandRouter::volumioPushQueue Mar 10 05:47:18 volumio volumio[966]: info: CorePlayQueue::saveQueue Mar 10 05:47:18 volumio volumio[966]: info: CoreStateMachine::play index undefined Mar 10 05:47:18 volumio volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 05:47:18 volumio volumio[966]: info: CoreStateMachine::updateTrackBlock Mar 10 05:47:18 volumio volumio[966]: info: CorePlayQueue::getTrackBlock Mar 10 05:47:18 volumio volumio[966]: info: CorePlayQueue::getTrack 2 Mar 10 05:47:18 volumio volumio[966]: info: Preload queue cleared Mar 10 05:47:18 volumio volumio[966]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 10 05:47:18 volumio volumio[966]: info: CoreStateMachine::ClearQueue Mar 10 05:47:18 volumio volumio[966]: info: CoreStateMachine::stop Mar 10 05:47:18 volumio volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 05:47:18 volumio volumio[966]: info: CorePlayQueue::clearPlayQueue Mar 10 05:47:18 volumio volumio[966]: info: CorePlayQueue::saveQueue Mar 10 05:47:18 volumio volumio[966]: info: CoreCommandRouter::volumioPushQueue Mar 10 05:47:18 volumio volumio[966]: info: CoreStateMachine::addQueueItems Mar 10 05:47:18 volumio volumio[966]: info: CorePlayQueue::addQueueItems Mar 10 05:47:18 volumio volumio[966]: info: Preload queue cleared Mar 10 05:47:18 volumio volumio[966]: info: Adding Item to queue: music-library/USB/9C09-F73E/mp3/01. 马兰花.wav Mar 10 05:47:18 volumio volumio[966]: info: Using cached record of: music-library/USB/9C09-F73E/mp3/01. 马兰花.wav Mar 10 05:47:18 volumio volumio[966]: info: Adding Item to queue: music-library/USB/9C09-F73E/mp3/大欢-三生石下.mp3 Mar 10 05:47:18 volumio volumio[966]: info: Using cached record of: music-library/USB/9C09-F73E/mp3/大欢-三生石下.mp3 Mar 10 05:47:18 volumio volumio[966]: info: Adding Item to queue: music-library/USB/9C09-F73E/mp3/洋澜一 天际 .mp3 Mar 10 05:47:18 volumio volumio[966]: info: Using cached record of: music-library/USB/9C09-F73E/mp3/洋澜一 天际 .mp3 Mar 10 05:47:18 volumio volumio[966]: info: CoreCommandRouter::volumioPushQueue Mar 10 05:47:19 volumio volumio[966]: info: CorePlayQueue::saveQueue Mar 10 05:47:19 volumio volumio[966]: info: CoreStateMachine::updateTrackBlock Mar 10 05:47:19 volumio volumio[966]: info: CorePlayQueue::getTrackBlock Mar 10 05:47:19 volumio volumio[966]: info: CoreCommandRouter::volumioPlay Mar 10 05:47:19 volumio volumio[966]: info: CoreStateMachine::play index 2 Mar 10 05:47:19 volumio volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 05:47:19 volumio volumio[966]: info: CoreStateMachine::addQueueItems Mar 10 05:47:19 volumio volumio[966]: info: CorePlayQueue::addQueueItems Mar 10 05:47:19 volumio volumio[966]: info: Preload queue cleared Mar 10 05:47:19 volumio volumio[966]: info: Adding Item to queue: music-library/USB/9C09-F73E/mp3/陈瑞 情罪.mp3 Mar 10 05:47:19 volumio volumio[966]: info: Using cached record of: music-library/USB/9C09-F73E/mp3/陈瑞 情罪.mp3 Mar 10 05:47:19 volumio volumio[966]: info: Adding Item to queue: music-library/USB/9C09-F73E/mp3/洋澜一 谁.mp3 Mar 10 05:47:19 volumio volumio[966]: info: Using cached record of: music-library/USB/9C09-F73E/mp3/洋澜一 谁.mp3 Mar 10 05:47:19 volumio volumio[966]: info: CoreStateMachine::stop Mar 10 05:47:19 volumio volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 05:47:19 volumio volumio[966]: info: CoreCommandRouter::volumioPushQueue Mar 10 05:47:19 volumio volumio[966]: info: CorePlayQueue::saveQueue Mar 10 05:47:19 volumio volumio[966]: info: CoreStateMachine::play index undefined Mar 10 05:47:19 volumio volumio[966]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 05:47:19 volumio volumio[966]: info: CoreStateMachine::updateTrackBlock Mar 10 05:47:19 volumio volumio[966]: info: CorePlayQueue::getTrackBlock Mar 10 05:47:19 volumio volumio[966]: info: CorePlayQueue::getTrack 2 Mar 10 05:47:20 volumio volumio[966]: info: MyVolumio login type: Token Mar 10 05:47:25 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:47:25 volumio volumio[966]: info: CorePlayQueue::getTrack 1 Mar 10 05:47:32 volumio kernel: usb 2-1: USB disconnect, device number 4 Mar 10 05:47:32 volumio volumio[966]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/usb-Prolific_Technology_Inc._SD_Card_Reader_ABCDEF0123456789AB-0:0-part1 /dev/disk/by-uuid/9C09-F73E /dev/disk/by-partuuid/e8ab1baf-01 /dev/disk/by-path/platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0-part1","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"29","ID_BUS":"usb","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"9C09-F73E","ID_FS_UUID_ENC":"9C09-F73E","ID_FS_VERSION":"FAT32","ID_INSTANCE":"0:0","ID_MODEL":"SD_Card_Reader","ID_MODEL_ENC":"SD\\x20Card\\x20Reader\\x20\\x20","ID_MODEL_ID":"2731","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":"15726592","ID_PART_ENTRY_TYPE":"0xc","ID_PART_ENTRY_UUID":"e8ab1baf-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"e8ab1baf","ID_PATH":"platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-fd500000_pcie-pci-0000_01_00_0-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"1.00","ID_SERIAL":"Prolific_Technology_Inc._SD_Card_Reader_ABCDEF0123456789AB-0:0","ID_SERIAL_SHORT":"ABCDEF0123456789AB","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"Prolific_Technology_Inc.","ID_VENDOR_ENC":"Prolific\\x20Technology\\x20Inc.","ID_VENDOR_ID":"067b","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"2526","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"208469463"} Mar 10 05:47:32 volumio systemd[1]: media-9C09\x2dF73E.mount: Succeeded. Mar 10 05:47:32 volumio sudo[2847]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1 Mar 10 05:47:32 volumio sudo[2847]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 05:47:32 volumio sudo[2847]: pam_unix(sudo:session): session closed for user root Mar 10 05:47:36 volumio volumio[966]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/9C09-F73E Mar 10 05:47:37 volumio volumio[966]: info: Scanning removed location : "USB/9C09-F73E" Mar 10 05:47:37 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Mar 10 05:47:37 volumio volumio[966]: info: Mar 10 05:47:37 volumio volumio[966]: ---------------------------- MPD announces state update: update Mar 10 05:47:37 volumio volumio[966]: info: ControllerMpd::getState Mar 10 05:47:37 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Mar 10 05:47:37 volumio volumio[966]: info: MPD Database updated - AlbumList cache refreshed Mar 10 05:47:37 volumio volumio[966]: info: Mar 10 05:47:37 volumio volumio[966]: ---------------------------- MPD announces state update: database Mar 10 05:47:37 volumio volumio[966]: info: Mar 10 05:47:37 volumio volumio[966]: ---------------------------- MPD announces system playlist update Mar 10 05:47:37 volumio volumio[966]: info: Ignoring MPD Status Update Mar 10 05:47:37 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Mar 10 05:47:37 volumio volumio[966]: info: Mar 10 05:47:37 volumio volumio[966]: ---------------------------- MPD announces state update: update Mar 10 05:47:37 volumio volumio[966]: info: ControllerMpd::getState Mar 10 05:47:37 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Mar 10 05:47:37 volumio volumio[966]: info: ControllerMpd::getState Mar 10 05:47:37 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Mar 10 05:47:37 volumio volumio[966]: info: sendMpdCommand status took 4 milliseconds Mar 10 05:47:37 volumio volumio[966]: info: sendMpdCommand status took 3 milliseconds Mar 10 05:47:37 volumio volumio[966]: verbose: ControllerMpd::parseState Mar 10 05:47:37 volumio volumio[966]: info: Command Router : Notfying DB Updatefalse Mar 10 05:47:37 volumio volumio[966]: info: CoreCommandRouter::Close All Modals sent Mar 10 05:47:37 volumio volumio[966]: verbose: ControllerMpd::parseState Mar 10 05:47:37 volumio volumio[966]: info: ControllerMpd::pushState Mar 10 05:47:37 volumio volumio[966]: info: CoreCommandRouter::servicePushState Mar 10 05:47:37 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:47:37 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:47:37 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:47:37 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:47:37 volumio volumio[966]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 10 05:47:37 volumio volumio[966]: verbose: CURRENT POSITION 0 Mar 10 05:47:37 volumio volumio[966]: info: CoreStateMachine::syncState stateService stop Mar 10 05:47:37 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Mar 10 05:47:37 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:47:37 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:47:37 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:47:37 volumio volumio[966]: info: No code Mar 10 05:47:37 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:47:37 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:47:37 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:47:37 volumio volumio[966]: info: ------------------------------ 95ms Mar 10 05:47:37 volumio volumio[966]: error: Upnp client error: Error: This socket has been ended by the other party Mar 10 05:47:37 volumio volumio[966]: error: updateQueue error: null Mar 10 05:47:37 volumio volumio[966]: info: sendMpdCommand status took 95 milliseconds Mar 10 05:47:37 volumio volumio[966]: info: sendMpdCommand status took 96 milliseconds Mar 10 05:47:37 volumio volumio[966]: info: ------------------------------ 97ms Mar 10 05:47:37 volumio volumio[966]: info: sendMpdCommand status took 95 milliseconds Mar 10 05:47:37 volumio volumio[966]: verbose: ControllerMpd::parseState Mar 10 05:47:37 volumio volumio[966]: info: Command Router : Notfying DB Updatefalse Mar 10 05:47:37 volumio volumio[966]: info: CoreCommandRouter::Close All Modals sent Mar 10 05:47:37 volumio volumio[966]: verbose: ControllerMpd::parseState Mar 10 05:47:37 volumio volumio[966]: verbose: ControllerMpd::parseState Mar 10 05:47:37 volumio volumio[966]: info: ControllerMpd::pushState Mar 10 05:47:37 volumio volumio[966]: info: CoreCommandRouter::servicePushState Mar 10 05:47:37 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:47:37 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:47:37 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:47:37 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:47:37 volumio volumio[966]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 10 05:47:37 volumio volumio[966]: verbose: CURRENT POSITION 0 Mar 10 05:47:37 volumio volumio[966]: info: CoreStateMachine::syncState stateService stop Mar 10 05:47:37 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Mar 10 05:47:37 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:47:37 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:47:37 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:47:37 volumio volumio[966]: info: No code Mar 10 05:47:37 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:47:37 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:47:37 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:47:37 volumio volumio[966]: info: ControllerMpd::pushState Mar 10 05:47:37 volumio volumio[966]: info: CoreCommandRouter::servicePushState Mar 10 05:47:37 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:47:37 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:47:37 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:47:37 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:47:37 volumio volumio[966]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 10 05:47:37 volumio volumio[966]: verbose: CURRENT POSITION 0 Mar 10 05:47:37 volumio volumio[966]: info: CoreStateMachine::syncState stateService stop Mar 10 05:47:37 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Mar 10 05:47:37 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:47:37 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:47:37 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:47:37 volumio volumio[966]: info: No code Mar 10 05:47:37 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:47:37 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:47:37 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:47:37 volumio volumio[966]: info: ------------------------------ 200ms Mar 10 05:47:37 volumio volumio[966]: info: ------------------------------ 200ms Mar 10 05:47:41 volumio volumio[966]: error: error Mar 10 05:47:50 volumio volumio[966]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Mar 10 05:47:50 volumio volumio[966]: info: Retrying Login Due to Network Error Mar 10 05:48:00 volumio volumio[966]: info: MyVolumio login type: Token Mar 10 05:48:30 volumio volumio[966]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Mar 10 05:48:30 volumio volumio[966]: info: Retrying Login Due to Network Error Mar 10 05:48:31 volumio volumio[966]: error: error Mar 10 05:48:34 volumio kernel: usb 2-1: new SuperSpeed USB device number 5 using xhci_hcd Mar 10 05:48:34 volumio kernel: usb 2-1: New USB device found, idVendor=067b, idProduct=2731, bcdDevice= 1.00 Mar 10 05:48:34 volumio kernel: usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Mar 10 05:48:34 volumio kernel: usb 2-1: Product: USB SD Card Reader Mar 10 05:48:34 volumio kernel: usb 2-1: Manufacturer: Prolific Technology Inc. Mar 10 05:48:34 volumio kernel: usb 2-1: SerialNumber: ABCDEF0123456789AB Mar 10 05:48:34 volumio kernel: usb-storage 2-1:1.0: USB Mass Storage device detected Mar 10 05:48:34 volumio kernel: scsi host0: usb-storage 2-1:1.0 Mar 10 05:48:36 volumio kernel: scsi 0:0:0:0: Direct-Access SD Card Reader 1.00 PQ: 0 ANSI: 6 Mar 10 05:48:36 volumio kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Mar 10 05:48:36 volumio kernel: sd 0:0:0:0: [sda] 15730688 512-byte logical blocks: (8.05 GB/7.50 GiB) Mar 10 05:48:36 volumio kernel: sd 0:0:0:0: [sda] Write Protect is off Mar 10 05:48:36 volumio kernel: sd 0:0:0:0: [sda] Mode Sense: 03 00 00 00 Mar 10 05:48:36 volumio kernel: sd 0:0:0:0: [sda] No Caching mode page found Mar 10 05:48:36 volumio kernel: sd 0:0:0:0: [sda] Assuming drive cache: write through Mar 10 05:48:36 volumio kernel: sda: sda1 Mar 10 05:48:36 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk Mar 10 05:48:36 volumio volumio[966]: info: Mounting Device 584C085D4C083870 Mar 10 05:48:36 volumio sudo[3054]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/584C085D4C083870 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 10 05:48:36 volumio sudo[3054]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 05:48:38 volumio ntfs-3g[3074]: Version 2017.3.23AR.3 integrated FUSE 28 Mar 10 05:48:38 volumio ntfs-3g[3074]: Mounted /dev/sda1 (Read-Write, label "", NTFS 3.1) Mar 10 05:48:38 volumio ntfs-3g[3074]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 10 05:48:38 volumio ntfs-3g[3074]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Mar 10 05:48:38 volumio ntfs-3g[3074]: Global ownership and permissions enforced, configuration type 7 Mar 10 05:48:38 volumio sudo[3054]: pam_unix(sudo:session): session closed for user root Mar 10 05:48:38 volumio volumio[966]: The disk contains an unclean file system (0, 0). Mar 10 05:48:38 volumio volumio[966]: The file system wasn't safely closed on Windows. Fixing. Mar 10 05:48:38 volumio volumio[966]: info: Scanning new location : "USB/584C085D4C083870" Mar 10 05:48:38 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Mar 10 05:48:38 volumio volumio[966]: info: Mar 10 05:48:38 volumio volumio[966]: ---------------------------- MPD announces state update: update Mar 10 05:48:38 volumio volumio[966]: info: ControllerMpd::getState Mar 10 05:48:38 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Mar 10 05:48:38 volumio volumio[966]: info: sendMpdCommand status took 3 milliseconds Mar 10 05:48:38 volumio volumio[966]: info: sendMpdCommand status took 1 milliseconds Mar 10 05:48:38 volumio volumio[966]: verbose: ControllerMpd::parseState Mar 10 05:48:38 volumio volumio[966]: info: Command Router : Notfying DB Updatetrue Mar 10 05:48:38 volumio volumio[966]: info: CoreCommandRouter::Close All Modals sent Mar 10 05:48:38 volumio volumio[966]: verbose: ControllerMpd::parseState Mar 10 05:48:38 volumio volumio[966]: info: ControllerMpd::pushState Mar 10 05:48:38 volumio volumio[966]: info: CoreCommandRouter::servicePushState Mar 10 05:48:38 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:48:38 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:38 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:48:38 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:38 volumio volumio[966]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 10 05:48:38 volumio volumio[966]: verbose: CURRENT POSITION 0 Mar 10 05:48:38 volumio volumio[966]: info: CoreStateMachine::syncState stateService stop Mar 10 05:48:38 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Mar 10 05:48:38 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:48:38 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:38 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 05:48:38 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:48:38 volumio volumio[966]: info: No code Mar 10 05:48:38 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:48:38 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:38 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:48:38 volumio volumio[966]: info: ------------------------------ 120ms Mar 10 05:48:38 volumio volumio[966]: info: MPD Database updated - AlbumList cache refreshed Mar 10 05:48:38 volumio volumio[966]: info: Mar 10 05:48:38 volumio volumio[966]: ---------------------------- MPD announces state update: database Mar 10 05:48:38 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Mar 10 05:48:38 volumio volumio[966]: info: Mar 10 05:48:38 volumio volumio[966]: ---------------------------- MPD announces state update: update Mar 10 05:48:38 volumio volumio[966]: info: ControllerMpd::getState Mar 10 05:48:38 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Mar 10 05:48:38 volumio volumio[966]: info: ControllerMpd::getState Mar 10 05:48:38 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Mar 10 05:48:38 volumio volumio[966]: info: sendMpdCommand status took 17 milliseconds Mar 10 05:48:38 volumio volumio[966]: info: sendMpdCommand status took 16 milliseconds Mar 10 05:48:38 volumio volumio[966]: info: sendMpdCommand status took 16 milliseconds Mar 10 05:48:38 volumio volumio[966]: verbose: ControllerMpd::parseState Mar 10 05:48:38 volumio volumio[966]: info: Command Router : Notfying DB Updatefalse Mar 10 05:48:38 volumio volumio[966]: info: CoreCommandRouter::Close All Modals sent Mar 10 05:48:38 volumio volumio[966]: verbose: ControllerMpd::parseState Mar 10 05:48:38 volumio volumio[966]: verbose: ControllerMpd::parseState Mar 10 05:48:38 volumio volumio[966]: info: ControllerMpd::pushState Mar 10 05:48:38 volumio volumio[966]: info: CoreCommandRouter::servicePushState Mar 10 05:48:38 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:48:38 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:38 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:48:38 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:38 volumio volumio[966]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 10 05:48:38 volumio volumio[966]: verbose: CURRENT POSITION 0 Mar 10 05:48:38 volumio volumio[966]: info: CoreStateMachine::syncState stateService stop Mar 10 05:48:38 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Mar 10 05:48:38 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:48:38 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:38 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 05:48:38 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:48:38 volumio volumio[966]: info: No code Mar 10 05:48:38 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:48:38 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:38 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:48:38 volumio volumio[966]: info: ControllerMpd::pushState Mar 10 05:48:38 volumio volumio[966]: info: CoreCommandRouter::servicePushState Mar 10 05:48:38 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:48:38 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:38 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:48:38 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:38 volumio volumio[966]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 10 05:48:38 volumio volumio[966]: verbose: CURRENT POSITION 0 Mar 10 05:48:38 volumio volumio[966]: info: CoreStateMachine::syncState stateService stop Mar 10 05:48:38 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Mar 10 05:48:38 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:48:38 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:38 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:48:38 volumio volumio[966]: info: No code Mar 10 05:48:38 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:48:38 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:38 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:48:38 volumio volumio[966]: info: ------------------------------ 123ms Mar 10 05:48:38 volumio volumio[966]: info: ------------------------------ 124ms Mar 10 05:48:40 volumio volumio[966]: info: MyVolumio login type: Token Mar 10 05:48:43 volumio volumio[966]: info: CoreCommandRouter::volumioGetState Mar 10 05:48:43 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:47 volumio volumio[966]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 05:48:47 volumio volumio[966]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 05:48:47 volumio volumio[966]: info: Retrieving Cloud Streaming UI Mar 10 05:48:47 volumio volumio[966]: info: Getting Tidal Cloud Configuration Mar 10 05:48:47 volumio volumio[966]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 05:48:47 volumio volumio[966]: info: Getting Qobuz Cloud Configuration Mar 10 05:48:47 volumio volumio[966]: info: Asking plugin for UI Config Mar 10 05:48:47 volumio volumio[966]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 05:48:47 volumio volumio[966]: info: Getting Spotify Cloud Configuration Mar 10 05:48:47 volumio volumio[966]: info: Asking plugin for UI Config Mar 10 05:48:47 volumio volumio[966]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 05:48:47 volumio volumio[966]: info: Saving Spotify Acccount Mar 10 05:48:47 volumio volumio[966]: info: Got Tidal Cloud Configuration Mar 10 05:48:47 volumio volumio[966]: info: Got it Mar 10 05:48:47 volumio volumio[966]: info: Got it Mar 10 05:48:47 volumio volumio[966]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 10 05:48:47 volumio volumio[966]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 05:48:47 volumio volumio[966]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 10 05:48:47 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 10 05:48:47 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 10 05:48:47 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 10 05:48:47 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 10 05:48:47 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 05:48:47 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 05:48:47 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 05:48:47 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 05:48:47 volumio volumio[966]: info: CoreCommandRouter::volumioGetBrowseSources Mar 10 05:48:47 volumio volumio[966]: info: CoreCommandRouter::volumioGetBrowseSources Mar 10 05:48:47 volumio volumio[966]: info: CoreCommandRouter::volumioGetBrowseSources Mar 10 05:48:47 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 10 05:48:47 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 10 05:48:48 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Mar 10 05:48:48 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand rescan Mar 10 05:48:48 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Mar 10 05:48:48 volumio volumio[966]: info: Mar 10 05:48:48 volumio volumio[966]: ---------------------------- MPD announces state update: update Mar 10 05:48:48 volumio volumio[966]: info: sendMpdCommand rescan took 9 milliseconds Mar 10 05:48:48 volumio volumio[966]: info: ControllerMpd::getState Mar 10 05:48:48 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Mar 10 05:48:48 volumio volumio[966]: info: sendMpdCommand status took 3 milliseconds Mar 10 05:48:48 volumio volumio[966]: info: sendMpdCommand status took 1 milliseconds Mar 10 05:48:48 volumio volumio[966]: verbose: ControllerMpd::parseState Mar 10 05:48:48 volumio volumio[966]: info: Command Router : Notfying DB Updatetrue Mar 10 05:48:48 volumio volumio[966]: info: CoreCommandRouter::Close All Modals sent Mar 10 05:48:48 volumio volumio[966]: verbose: ControllerMpd::parseState Mar 10 05:48:48 volumio volumio[966]: info: ControllerMpd::pushState Mar 10 05:48:48 volumio volumio[966]: info: CoreCommandRouter::servicePushState Mar 10 05:48:48 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:48:48 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:48 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:48:48 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:48 volumio volumio[966]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 10 05:48:48 volumio volumio[966]: verbose: CURRENT POSITION 0 Mar 10 05:48:48 volumio volumio[966]: info: CoreStateMachine::syncState stateService stop Mar 10 05:48:48 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Mar 10 05:48:48 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:48:48 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:48 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 05:48:48 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:48:48 volumio volumio[966]: info: No code Mar 10 05:48:48 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:48:48 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:48 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:48:48 volumio volumio[966]: info: ------------------------------ 99ms Mar 10 05:48:48 volumio volumio[966]: info: MPD Database updated - AlbumList cache refreshed Mar 10 05:48:48 volumio volumio[966]: info: Mar 10 05:48:48 volumio volumio[966]: ---------------------------- MPD announces state update: database Mar 10 05:48:48 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Mar 10 05:48:48 volumio volumio[966]: info: Mar 10 05:48:48 volumio volumio[966]: ---------------------------- MPD announces state update: update Mar 10 05:48:48 volumio volumio[966]: info: ControllerMpd::getState Mar 10 05:48:48 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Mar 10 05:48:48 volumio volumio[966]: info: ControllerMpd::getState Mar 10 05:48:48 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Mar 10 05:48:48 volumio volumio[966]: info: sendMpdCommand status took 16 milliseconds Mar 10 05:48:48 volumio volumio[966]: info: sendMpdCommand status took 16 milliseconds Mar 10 05:48:48 volumio volumio[966]: info: sendMpdCommand status took 15 milliseconds Mar 10 05:48:48 volumio volumio[966]: verbose: ControllerMpd::parseState Mar 10 05:48:49 volumio volumio[966]: info: Command Router : Notfying DB Updatefalse Mar 10 05:48:49 volumio volumio[966]: info: CoreCommandRouter::Close All Modals sent Mar 10 05:48:49 volumio volumio[966]: verbose: ControllerMpd::parseState Mar 10 05:48:49 volumio volumio[966]: verbose: ControllerMpd::parseState Mar 10 05:48:49 volumio volumio[966]: info: ControllerMpd::pushState Mar 10 05:48:49 volumio volumio[966]: info: CoreCommandRouter::servicePushState Mar 10 05:48:49 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:48:49 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:49 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:48:49 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:49 volumio volumio[966]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 10 05:48:49 volumio volumio[966]: verbose: CURRENT POSITION 0 Mar 10 05:48:49 volumio volumio[966]: info: CoreStateMachine::syncState stateService stop Mar 10 05:48:49 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Mar 10 05:48:49 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:48:49 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:49 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 05:48:49 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:48:49 volumio volumio[966]: info: No code Mar 10 05:48:49 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:48:49 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:49 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:48:49 volumio volumio[966]: info: ControllerMpd::pushState Mar 10 05:48:49 volumio volumio[966]: info: CoreCommandRouter::servicePushState Mar 10 05:48:49 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:48:49 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:49 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:48:49 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:49 volumio volumio[966]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 10 05:48:49 volumio volumio[966]: verbose: CURRENT POSITION 0 Mar 10 05:48:49 volumio volumio[966]: info: CoreStateMachine::syncState stateService stop Mar 10 05:48:49 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Mar 10 05:48:49 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:48:49 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:49 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:48:49 volumio volumio[966]: info: No code Mar 10 05:48:49 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:48:49 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:49 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:48:49 volumio volumio[966]: info: ------------------------------ 113ms Mar 10 05:48:49 volumio volumio[966]: info: ------------------------------ 114ms Mar 10 05:48:49 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Mar 10 05:48:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand update Mar 10 05:48:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Mar 10 05:48:49 volumio volumio[966]: info: Mar 10 05:48:49 volumio volumio[966]: ---------------------------- MPD announces state update: update Mar 10 05:48:49 volumio volumio[966]: info: sendMpdCommand update took 7 milliseconds Mar 10 05:48:49 volumio volumio[966]: info: ControllerMpd::getState Mar 10 05:48:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Mar 10 05:48:49 volumio volumio[966]: info: sendMpdCommand status took 2 milliseconds Mar 10 05:48:49 volumio volumio[966]: info: sendMpdCommand status took 1 milliseconds Mar 10 05:48:49 volumio volumio[966]: verbose: ControllerMpd::parseState Mar 10 05:48:49 volumio volumio[966]: info: Command Router : Notfying DB Updatetrue Mar 10 05:48:49 volumio volumio[966]: info: CoreCommandRouter::Close All Modals sent Mar 10 05:48:49 volumio volumio[966]: verbose: ControllerMpd::parseState Mar 10 05:48:49 volumio volumio[966]: info: ControllerMpd::pushState Mar 10 05:48:49 volumio volumio[966]: info: CoreCommandRouter::servicePushState Mar 10 05:48:49 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:48:49 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:49 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:48:49 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:49 volumio volumio[966]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 10 05:48:49 volumio volumio[966]: verbose: CURRENT POSITION 0 Mar 10 05:48:49 volumio volumio[966]: info: CoreStateMachine::syncState stateService stop Mar 10 05:48:49 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Mar 10 05:48:49 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:48:49 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:49 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 05:48:49 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:48:49 volumio volumio[966]: info: No code Mar 10 05:48:49 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:48:49 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:49 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:48:49 volumio volumio[966]: info: ------------------------------ 92ms Mar 10 05:48:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Mar 10 05:48:49 volumio volumio[966]: info: Mar 10 05:48:49 volumio volumio[966]: ---------------------------- MPD announces state update: update Mar 10 05:48:49 volumio volumio[966]: info: ControllerMpd::getState Mar 10 05:48:49 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Mar 10 05:48:49 volumio volumio[966]: info: sendMpdCommand status took 18 milliseconds Mar 10 05:48:49 volumio volumio[966]: info: sendMpdCommand status took 17 milliseconds Mar 10 05:48:49 volumio volumio[966]: verbose: ControllerMpd::parseState Mar 10 05:48:49 volumio volumio[966]: info: Command Router : Notfying DB Updatefalse Mar 10 05:48:49 volumio volumio[966]: info: CoreCommandRouter::Close All Modals sent Mar 10 05:48:49 volumio volumio[966]: verbose: ControllerMpd::parseState Mar 10 05:48:49 volumio volumio[966]: info: ControllerMpd::pushState Mar 10 05:48:49 volumio volumio[966]: info: CoreCommandRouter::servicePushState Mar 10 05:48:49 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:48:49 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:49 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:48:49 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:49 volumio volumio[966]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 10 05:48:49 volumio volumio[966]: verbose: CURRENT POSITION 0 Mar 10 05:48:49 volumio volumio[966]: info: CoreStateMachine::syncState stateService stop Mar 10 05:48:49 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus stop Mar 10 05:48:49 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:48:49 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:49 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 05:48:49 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:48:49 volumio volumio[966]: info: No code Mar 10 05:48:49 volumio volumio[966]: info: CoreStateMachine::pushState Mar 10 05:48:49 volumio volumio[966]: info: CorePlayQueue::getTrack 0 Mar 10 05:48:49 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Mar 10 05:48:50 volumio volumio[966]: info: ------------------------------ 84ms Mar 10 05:48:51 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 10 05:48:51 volumio volumio[966]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 10 05:48:51 volumio volumio[966]: Error: connect ETIMEDOUT 108.160.166.57:443 Mar 10 05:48:51 volumio volumio[966]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Mar 10 05:48:51 volumio volumio[966]: errno: -110, Mar 10 05:48:51 volumio volumio[966]: code: 'ETIMEDOUT', Mar 10 05:48:51 volumio volumio[966]: syscall: 'connect', Mar 10 05:48:51 volumio volumio[966]: address: '108.160.166.57', Mar 10 05:48:51 volumio volumio[966]: port: 443 Mar 10 05:48:51 volumio volumio[966]: } Mar 10 05:48:51 volumio volumio[966]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 10 05:48:52 volumio sudo[3115]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-10 05:47 Mar 10 05:48:52 volumio sudo[3115]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"