-- Logs begin at Thu 2023-04-20 11:12:46 UTC, end at Wed 2025-05-28 05:32:15 UTC. -- May 28 05:31:00 shd-power volumio-remote-updater[641]: PROGRESS: 23, STATUS: "Creating backup", ETA: "5m" May 28 05:31:00 shd-power volumio-remote-updater[641]: PROGRESS: 23, STATUS: "Creating backup", ETA: "5m" May 28 05:31:00 shd-power volumio-remote-updater[641]: PROGRESS: 23, STATUS: "Creating backup", ETA: "5m" May 28 05:31:00 shd-power volumio-remote-updater[641]: PROGRESS: 23, STATUS: "Creating backup", ETA: "5m" May 28 05:31:00 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:00 shd-power volumio[964]: updateProgress May 28 05:31:00 shd-power volumio[964]: { downloadSpeed: '', May 28 05:31:00 shd-power volumio[964]: eta: '5m', May 28 05:31:00 shd-power volumio[964]: progress: 23, May 28 05:31:00 shd-power volumio[964]: status: 'Creating backup' } May 28 05:31:00 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:00 shd-power volumio[964]: updateProgress May 28 05:31:00 shd-power volumio[964]: { downloadSpeed: '', May 28 05:31:00 shd-power volumio[964]: eta: '5m', May 28 05:31:00 shd-power volumio[964]: progress: 23, May 28 05:31:00 shd-power volumio[964]: status: 'Creating backup' } May 28 05:31:01 shd-power volumio-remote-updater[641]: PROGRESS: 23, STATUS: "Creating backup", ETA: "5m" May 28 05:31:01 shd-power volumio-remote-updater[641]: PROGRESS: 24, STATUS: "Creating backup", ETA: "5m" May 28 05:31:01 shd-power volumio-remote-updater[641]: PROGRESS: 24, STATUS: "Creating backup", ETA: "5m" May 28 05:31:01 shd-power volumio-remote-updater[641]: PROGRESS: 24, STATUS: "Creating backup", ETA: "5m" May 28 05:31:01 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:01 shd-power volumio[964]: updateProgress May 28 05:31:01 shd-power volumio[964]: { downloadSpeed: '', May 28 05:31:01 shd-power volumio[964]: eta: '5m', May 28 05:31:01 shd-power volumio[964]: progress: 24, May 28 05:31:01 shd-power volumio[964]: status: 'Creating backup' } May 28 05:31:01 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:01 shd-power volumio[964]: updateProgress May 28 05:31:01 shd-power volumio[964]: { downloadSpeed: '', May 28 05:31:01 shd-power volumio[964]: eta: '5m', May 28 05:31:01 shd-power volumio[964]: progress: 24, May 28 05:31:01 shd-power volumio[964]: status: 'Creating backup' } May 28 05:31:01 shd-power volumio-remote-updater[641]: PROGRESS: 24, STATUS: "Creating backup", ETA: "5m" May 28 05:31:01 shd-power volumio-remote-updater[641]: PROGRESS: 25, STATUS: "Creating backup", ETA: "5m" May 28 05:31:01 shd-power volumio-remote-updater[641]: PROGRESS: 25, STATUS: "Creating backup", ETA: "5m" May 28 05:31:01 shd-power volumio-remote-updater[641]: PROGRESS: 25, STATUS: "Creating backup", ETA: "5m" May 28 05:31:01 shd-power volumio-remote-updater[641]: PROGRESS: 25, STATUS: "Creating backup", ETA: "5m" May 28 05:31:01 shd-power volumio-remote-updater[641]: PROGRESS: 25, STATUS: "Creating backup", ETA: "5m" May 28 05:31:01 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:01 shd-power volumio[964]: updateProgress May 28 05:31:01 shd-power volumio[964]: { downloadSpeed: '', May 28 05:31:01 shd-power volumio[964]: eta: '5m', May 28 05:31:01 shd-power volumio[964]: progress: 25, May 28 05:31:01 shd-power volumio[964]: status: 'Creating backup' } May 28 05:31:01 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:01 shd-power volumio[964]: updateProgress May 28 05:31:01 shd-power volumio[964]: { downloadSpeed: '', May 28 05:31:01 shd-power volumio[964]: eta: '5m', May 28 05:31:01 shd-power volumio[964]: progress: 25, May 28 05:31:01 shd-power volumio[964]: status: 'Creating backup' } May 28 05:31:03 shd-power volumio-remote-updater[641]: PROGRESS: 25, STATUS: "Creating backup", ETA: "5m" May 28 05:31:03 shd-power volumio-remote-updater[641]: PROGRESS: 25, STATUS: "Creating backup", ETA: "5m" May 28 05:31:03 shd-power volumio-remote-updater[641]: PROGRESS: 25, STATUS: "Creating backup", ETA: "5m" May 28 05:31:03 shd-power volumio-remote-updater[641]: PROGRESS: 25, STATUS: "Creating backup", ETA: "5m" May 28 05:31:03 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:03 shd-power volumio-remote-updater[641]: PROGRESS: 25, STATUS: "Creating backup", ETA: "5m" May 28 05:31:03 shd-power volumio[964]: updateProgress May 28 05:31:03 shd-power volumio[964]: { downloadSpeed: '', May 28 05:31:03 shd-power volumio[964]: eta: '5m', May 28 05:31:03 shd-power volumio[964]: progress: 25, May 28 05:31:03 shd-power volumio[964]: status: 'Creating backup' } May 28 05:31:03 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:03 shd-power volumio[964]: updateProgress May 28 05:31:03 shd-power volumio[964]: { downloadSpeed: '', May 28 05:31:03 shd-power volumio[964]: eta: '5m', May 28 05:31:03 shd-power volumio[964]: progress: 25, May 28 05:31:03 shd-power volumio[964]: status: 'Creating backup' } May 28 05:31:03 shd-power volumio-remote-updater[641]: PROGRESS: 25, STATUS: "Creating backup", ETA: "5m" May 28 05:31:03 shd-power volumio-remote-updater[641]: PROGRESS: 25, STATUS: "Creating backup", ETA: "5m" May 28 05:31:03 shd-power volumio-remote-updater[641]: PROGRESS: 25, STATUS: "Creating backup", ETA: "5m" May 28 05:31:03 shd-power volumio-remote-updater[641]: PROGRESS: 25, STATUS: "Creating backup", ETA: "5m" May 28 05:31:03 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:03 shd-power volumio[964]: updateProgress May 28 05:31:03 shd-power volumio[964]: { downloadSpeed: '', May 28 05:31:03 shd-power volumio[964]: eta: '5m', May 28 05:31:03 shd-power volumio[964]: progress: 25, May 28 05:31:03 shd-power volumio[964]: status: 'Creating backup' } May 28 05:31:03 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:03 shd-power volumio[964]: updateProgress May 28 05:31:03 shd-power volumio[964]: { downloadSpeed: '', May 28 05:31:03 shd-power volumio[964]: eta: '5m', May 28 05:31:03 shd-power volumio[964]: progress: 25, May 28 05:31:03 shd-power volumio[964]: status: 'Creating backup' } May 28 05:31:04 shd-power volumio-remote-updater[641]: PROGRESS: 25, STATUS: "Creating backup", ETA: "5m" May 28 05:31:04 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Creating backup", ETA: "5m" May 28 05:31:04 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Creating backup", ETA: "5m" May 28 05:31:04 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Creating backup", ETA: "5m" May 28 05:31:04 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Creating backup", ETA: "5m" May 28 05:31:04 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Creating backup", ETA: "5m" May 28 05:31:04 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:05 shd-power volumio[964]: updateProgress May 28 05:31:05 shd-power volumio[964]: { downloadSpeed: '', May 28 05:31:05 shd-power volumio[964]: eta: '5m', May 28 05:31:05 shd-power volumio[964]: progress: 30, May 28 05:31:05 shd-power volumio[964]: status: 'Creating backup' } May 28 05:31:05 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:05 shd-power volumio[964]: updateProgress May 28 05:31:05 shd-power volumio[964]: { downloadSpeed: '', May 28 05:31:05 shd-power volumio[964]: eta: '5m', May 28 05:31:05 shd-power volumio[964]: progress: 30, May 28 05:31:05 shd-power volumio[964]: status: 'Creating backup' } May 28 05:31:05 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 28 05:31:05 shd-power volumio[964]: info: CURURI: music-library May 28 05:31:05 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:05 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:05 shd-power volumio[964]: updateProgress May 28 05:31:05 shd-power volumio[964]: { downloadSpeed: '', May 28 05:31:05 shd-power volumio[964]: eta: '4m', May 28 05:31:05 shd-power volumio[964]: progress: 30, May 28 05:31:05 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:06 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 28 05:31:06 shd-power volumio[964]: info: CURURI: music-library/NAS May 28 05:31:07 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 28 05:31:07 shd-power volumio[964]: info: CURURI: music-library/NAS/USBTA May 28 05:31:07 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:07 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:07 shd-power volumio[964]: updateProgress May 28 05:31:07 shd-power volumio[964]: { downloadSpeed: '66.9', May 28 05:31:07 shd-power volumio[964]: eta: '4m', May 28 05:31:07 shd-power volumio[964]: progress: 30, May 28 05:31:07 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:10 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 28 05:31:10 shd-power volumio[964]: info: CURURI: music-library/NAS/USBTA/11影视配乐 主题曲 May 28 05:31:11 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 28 05:31:12 shd-power volumio[964]: info: CURURI: music-library/NAS/USBTA/11影视配乐 主题曲/舌尖上的中国 May 28 05:31:13 shd-power volumio[964]: info: CoreCommandRouter::volumioReplaceandPlayItems May 28 05:31:13 shd-power volumio[964]: info: CoreStateMachine::ClearQueue May 28 05:31:13 shd-power volumio[964]: info: CoreStateMachine::stop May 28 05:31:13 shd-power volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 05:31:13 shd-power volumio[964]: verbose: UNSET VOLATILE May 28 05:31:13 shd-power volumio[964]: info: CoreStateMachine::stPlaybackTimer May 28 05:31:13 shd-power volumio[964]: info: CoreStateMachine::updateTrackBlock May 28 05:31:13 shd-power volumio[964]: info: CorePlayQueue::getTrackBlock May 28 05:31:13 shd-power volumio[964]: info: CoreStateMachine::pushState May 28 05:31:13 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:13 shd-power volumio[964]: info: CoreCommandRouter::volumioPushState May 28 05:31:13 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 05:31:13 shd-power volumio[964]: info: CoreStateMachine::serviceStop May 28 05:31:13 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:13 shd-power volumio[964]: info: CoreCommandRouter::serviceStop May 28 05:31:13 shd-power volumio[964]: info: [1748410273216] ControllerWebradio::stop May 28 05:31:13 shd-power volumio[964]: verbose: ControllerMpd::sendMpdCommand stop May 28 05:31:13 shd-power volumio[964]: info: CorePlayQueue::clearPlayQueue May 28 05:31:13 shd-power volumio[964]: info: CorePlayQueue::saveQueue May 28 05:31:13 shd-power volumio[964]: info: CoreCommandRouter::volumioPushState May 28 05:31:13 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 05:31:13 shd-power volumio[964]: info: CoreCommandRouter::volumioPushQueue May 28 05:31:13 shd-power volumio[964]: info: CoreStateMachine::addQueueItems May 28 05:31:13 shd-power volumio[964]: info: CorePlayQueue::addQueueItems May 28 05:31:13 shd-power volumio[964]: info: Adding Item to queue: music-library/NAS/USBTA/11影视配乐 主题曲/舌尖上的中国/舌尖上的中国 - 厨房的交响曲.mp3 May 28 05:31:13 shd-power volumio[964]: info: Exploding uri music-library/NAS/USBTA/11影视配乐 主题曲/舌尖上的中国/舌尖上的中国 - 厨房的交响曲.mp3 in service mpd May 28 05:31:13 shd-power volumio[964]: scanFolder - failure to stat '/mnt/NAS/USBTA/11影视配乐 主题曲/舌尖上的中国/舌尖上的中国 - 厨房的交响曲.mp3' May 28 05:31:13 shd-power volumio[964]: info: Adding Item to queue: music-library/NAS/USBTA/11影视配乐 主题曲/舌尖上的中国/舌尖上的中国 - 才下舌尖，又上心间.mp3 May 28 05:31:13 shd-power volumio[964]: info: Exploding uri music-library/NAS/USBTA/11影视配乐 主题曲/舌尖上的中国/舌尖上的中国 - 才下舌尖，又上心间.mp3 in service mpd May 28 05:31:13 shd-power volumio[964]: scanFolder - failure to stat '/mnt/NAS/USBTA/11影视配乐 主题曲/舌尖上的中国/舌尖上的中国 - 才下舌尖，又上心间.mp3' May 28 05:31:13 shd-power volumio[964]: info: CorePlayQueue::saveQueue May 28 05:31:13 shd-power volumio[964]: info: CoreCommandRouter::volumioPushQueue May 28 05:31:13 shd-power volumio[964]: info: CoreStateMachine::updateTrackBlock May 28 05:31:13 shd-power volumio[964]: info: CorePlayQueue::getTrackBlock May 28 05:31:13 shd-power volumio[964]: info: CoreCommandRouter::volumioPlay May 28 05:31:13 shd-power volumio[964]: verbose: UNSET VOLATILE May 28 05:31:13 shd-power volumio[964]: info: CoreStateMachine::play index 0 May 28 05:31:13 shd-power volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 05:31:13 shd-power volumio[964]: info: CoreStateMachine::stop May 28 05:31:13 shd-power volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 05:31:13 shd-power volumio[964]: verbose: UNSET VOLATILE May 28 05:31:13 shd-power volumio[964]: info: CoreStateMachine::play index undefined May 28 05:31:13 shd-power volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 05:31:13 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:13 shd-power volumio[964]: info: May 28 05:31:13 shd-power volumio[964]: ---------------------------- MPD announces state update: player May 28 05:31:13 shd-power volumio[964]: info: sendMpdCommand stop took 93 milliseconds May 28 05:31:13 shd-power volumio[964]: info: ControllerMpd::getState May 28 05:31:13 shd-power volumio[964]: verbose: ControllerMpd::sendMpdCommand status May 28 05:31:13 shd-power volumio[964]: info: sendMpdCommand status took 9 milliseconds May 28 05:31:13 shd-power volumio[964]: verbose: ControllerMpd::parseState May 28 05:31:13 shd-power volumio[964]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 05:31:13 shd-power volumio[964]: info: sendMpdCommand playlistinfo took 26 milliseconds May 28 05:31:13 shd-power volumio[964]: verbose: ControllerMpd::parseTrackInfo May 28 05:31:13 shd-power volumio[964]: info: ControllerMpd::pushState May 28 05:31:13 shd-power volumio[964]: info: CoreCommandRouter::servicePushState May 28 05:31:13 shd-power volumio[964]: info: CoreStateMachine::pushState May 28 05:31:13 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:13 shd-power volumio[964]: info: CoreCommandRouter::volumioPushState May 28 05:31:13 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 05:31:13 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:13 shd-power volumio[964]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ROCK ANTENNE - Rock Nonstop","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} May 28 05:31:13 shd-power volumio[964]: verbose: CURRENT POSITION 0 May 28 05:31:13 shd-power volumio[964]: info: CoreStateMachine::syncState stateService stop May 28 05:31:13 shd-power volumio[964]: info: CoreStateMachine::syncState currentStatus stop May 28 05:31:13 shd-power volumio[964]: info: CoreStateMachine::pushState May 28 05:31:13 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:13 shd-power volumio[964]: info: CoreCommandRouter::volumioPushState May 28 05:31:13 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 05:31:13 shd-power volumio[964]: info: No code May 28 05:31:13 shd-power volumio[964]: info: CoreStateMachine::pushState May 28 05:31:13 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:13 shd-power volumio[964]: info: CoreCommandRouter::volumioPushState May 28 05:31:13 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 05:31:13 shd-power volumio[964]: info: ------------------------------ 85ms May 28 05:31:14 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 28 05:31:14 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 28 05:31:14 shd-power volumio[964]: info: Discovery: Getting this device information May 28 05:31:14 shd-power volumio[964]: info: CoreCommandRouter::volumioGetState May 28 05:31:14 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:14 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses May 28 05:31:14 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 28 05:31:14 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 28 05:31:20 shd-power volumio[964]: info: CoreCommandRouter::volumioReplaceandPlayItems May 28 05:31:20 shd-power volumio[964]: info: CoreStateMachine::ClearQueue May 28 05:31:20 shd-power volumio[964]: info: CoreStateMachine::stop May 28 05:31:20 shd-power volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 05:31:20 shd-power volumio[964]: verbose: UNSET VOLATILE May 28 05:31:20 shd-power volumio[964]: info: CorePlayQueue::clearPlayQueue May 28 05:31:20 shd-power volumio[964]: info: CorePlayQueue::saveQueue May 28 05:31:20 shd-power volumio[964]: info: CoreCommandRouter::volumioPushState May 28 05:31:20 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 05:31:20 shd-power volumio[964]: info: CoreCommandRouter::volumioPushQueue May 28 05:31:20 shd-power volumio[964]: info: CoreStateMachine::addQueueItems May 28 05:31:20 shd-power volumio[964]: info: CorePlayQueue::addQueueItems May 28 05:31:20 shd-power volumio[964]: info: Adding Item to queue: music-library/NAS/USBTA/11影视配乐 主题曲/舌尖上的中国/舌尖上的中国 - 厨房的交响曲.mp3 May 28 05:31:20 shd-power volumio[964]: info: Exploding uri music-library/NAS/USBTA/11影视配乐 主题曲/舌尖上的中国/舌尖上的中国 - 厨房的交响曲.mp3 in service mpd May 28 05:31:20 shd-power volumio[964]: scanFolder - failure to stat '/mnt/NAS/USBTA/11影视配乐 主题曲/舌尖上的中国/舌尖上的中国 - 厨房的交响曲.mp3' May 28 05:31:20 shd-power volumio[964]: info: Adding Item to queue: music-library/NAS/USBTA/11影视配乐 主题曲/舌尖上的中国/舌尖上的中国 - 才下舌尖，又上心间.mp3 May 28 05:31:20 shd-power volumio[964]: info: Exploding uri music-library/NAS/USBTA/11影视配乐 主题曲/舌尖上的中国/舌尖上的中国 - 才下舌尖，又上心间.mp3 in service mpd May 28 05:31:20 shd-power volumio[964]: scanFolder - failure to stat '/mnt/NAS/USBTA/11影视配乐 主题曲/舌尖上的中国/舌尖上的中国 - 才下舌尖，又上心间.mp3' May 28 05:31:20 shd-power volumio[964]: info: CorePlayQueue::saveQueue May 28 05:31:20 shd-power volumio[964]: info: CoreCommandRouter::volumioPushQueue May 28 05:31:20 shd-power volumio[964]: info: CoreStateMachine::updateTrackBlock May 28 05:31:20 shd-power volumio[964]: info: CorePlayQueue::getTrackBlock May 28 05:31:20 shd-power volumio[964]: info: CoreCommandRouter::volumioPlay May 28 05:31:20 shd-power volumio[964]: verbose: UNSET VOLATILE May 28 05:31:20 shd-power volumio[964]: info: CoreStateMachine::play index 0 May 28 05:31:20 shd-power volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 05:31:20 shd-power volumio[964]: info: CoreStateMachine::stop May 28 05:31:20 shd-power volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 05:31:20 shd-power volumio[964]: verbose: UNSET VOLATILE May 28 05:31:20 shd-power volumio[964]: info: CoreStateMachine::play index undefined May 28 05:31:20 shd-power volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 05:31:20 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:23 shd-power volumio[964]: info: CoreCommandRouter::volumioGetState May 28 05:31:23 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:23 shd-power sudo[3800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 28 05:31:23 shd-power sudo[3800]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 05:31:23 shd-power sudo[3800]: pam_unix(sudo:session): session closed for user root May 28 05:31:23 shd-power sudo[3803]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 28 05:31:23 shd-power sudo[3803]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 05:31:23 shd-power sudo[3803]: pam_unix(sudo:session): session closed for user root May 28 05:31:24 shd-power sudo[3806]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 28 05:31:24 shd-power sudo[3806]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 05:31:24 shd-power sudo[3806]: pam_unix(sudo:session): session closed for user root May 28 05:31:24 shd-power sudo[3809]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 28 05:31:24 shd-power sudo[3809]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 05:31:24 shd-power sudo[3809]: pam_unix(sudo:session): session closed for user root May 28 05:31:24 shd-power volumio[964]: info: CoreCommandRouter::volumioGetState May 28 05:31:24 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:24 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 28 05:31:24 shd-power volumio[964]: error: Could not retrieve plugin audio_interface multiroom May 28 05:31:24 shd-power volumio[964]: info: Listing playlists May 28 05:31:24 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 28 05:31:24 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 28 05:31:24 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 28 05:31:24 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 28 05:31:26 shd-power volumio[964]: info: CoreCommandRouter::volumioGetVisibleSources May 28 05:31:26 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 28 05:31:26 shd-power volumio[964]: info: CoreCommandRouter::volumioGetQueue May 28 05:31:26 shd-power volumio[964]: info: CoreStateMachine::getQueue May 28 05:31:26 shd-power volumio[964]: info: CorePlayQueue::getQueue May 28 05:31:28 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 28 05:31:28 shd-power volumio[964]: info: CURURI: music-library May 28 05:31:28 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 28 05:31:28 shd-power volumio[964]: info: CURURI: music-library/NAS May 28 05:31:29 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 28 05:31:29 shd-power volumio[964]: info: CURURI: music-library/NAS/USBTA May 28 05:31:30 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 28 05:31:30 shd-power volumio[964]: info: CURURI: music-library/NAS/USBTA/2民乐 May 28 05:31:32 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 28 05:31:32 shd-power volumio[964]: info: CURURI: music-library/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集) May 28 05:31:33 shd-power volumio[964]: info: CoreCommandRouter::volumioReplaceandPlayItems May 28 05:31:33 shd-power volumio[964]: info: CoreStateMachine::ClearQueue May 28 05:31:33 shd-power volumio[964]: info: CoreStateMachine::stop May 28 05:31:33 shd-power volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 05:31:33 shd-power volumio[964]: verbose: UNSET VOLATILE May 28 05:31:33 shd-power volumio[964]: info: CorePlayQueue::clearPlayQueue May 28 05:31:33 shd-power volumio[964]: info: CorePlayQueue::saveQueue May 28 05:31:33 shd-power volumio[964]: info: CoreCommandRouter::volumioPushState May 28 05:31:33 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 05:31:33 shd-power volumio[964]: info: CoreCommandRouter::volumioPushQueue May 28 05:31:33 shd-power volumio[964]: info: CoreStateMachine::addQueueItems May 28 05:31:33 shd-power volumio[964]: info: CorePlayQueue::addQueueItems May 28 05:31:33 shd-power volumio[964]: info: Adding Item to queue: music-library/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/01 春江花月夜(古曲).flac May 28 05:31:33 shd-power volumio[964]: info: Exploding uri music-library/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/01 春江花月夜(古曲).flac in service mpd May 28 05:31:33 shd-power volumio[964]: scanFolder - failure to stat '/mnt/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/01 春江花月夜(古曲).flac' May 28 05:31:33 shd-power volumio[964]: info: Adding Item to queue: music-library/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/02 步步高(曲：吕文成).flac May 28 05:31:33 shd-power volumio[964]: info: Exploding uri music-library/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/02 步步高(曲：吕文成).flac in service mpd May 28 05:31:33 shd-power volumio[964]: scanFolder - failure to stat '/mnt/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/02 步步高(曲：吕文成).flac' May 28 05:31:33 shd-power volumio[964]: info: Adding Item to queue: music-library/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/03 喜洋洋(曲：刘明源).flac May 28 05:31:33 shd-power volumio[964]: info: Exploding uri music-library/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/03 喜洋洋(曲：刘明源).flac in service mpd May 28 05:31:33 shd-power volumio[964]: scanFolder - failure to stat '/mnt/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/03 喜洋洋(曲：刘明源).flac' May 28 05:31:33 shd-power volumio[964]: info: Adding Item to queue: music-library/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/04 紫竹调(民间乐曲).flac May 28 05:31:33 shd-power volumio[964]: info: Exploding uri music-library/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/04 紫竹调(民间乐曲).flac in service mpd May 28 05:31:33 shd-power volumio[964]: scanFolder - failure to stat '/mnt/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/04 紫竹调(民间乐曲).flac' May 28 05:31:33 shd-power volumio[964]: info: Adding Item to queue: music-library/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/05 月儿高　编曲：彭修文.flac May 28 05:31:33 shd-power volumio[964]: info: Exploding uri music-library/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/05 月儿高　编曲：彭修文.flac in service mpd May 28 05:31:33 shd-power volumio[964]: scanFolder - failure to stat '/mnt/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/05 月儿高　编曲：彭修文.flac' May 28 05:31:33 shd-power volumio[964]: info: Adding Item to queue: music-library/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/06 彩云追月(曲：任光).flac May 28 05:31:33 shd-power volumio[964]: info: Exploding uri music-library/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/06 彩云追月(曲：任光).flac in service mpd May 28 05:31:33 shd-power volumio[964]: scanFolder - failure to stat '/mnt/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/06 彩云追月(曲：任光).flac' May 28 05:31:33 shd-power volumio[964]: info: Adding Item to queue: music-library/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/07 花好月圆(曲：黄贻钧).flac May 28 05:31:33 shd-power volumio[964]: info: Exploding uri music-library/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/07 花好月圆(曲：黄贻钧).flac in service mpd May 28 05:31:33 shd-power volumio[964]: scanFolder - failure to stat '/mnt/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/07 花好月圆(曲：黄贻钧).flac' May 28 05:31:33 shd-power volumio[964]: info: Adding Item to queue: music-library/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/08 金蛇狂舞(民间乐曲).flac May 28 05:31:33 shd-power volumio[964]: info: Exploding uri music-library/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/08 金蛇狂舞(民间乐曲).flac in service mpd May 28 05:31:33 shd-power volumio[964]: scanFolder - failure to stat '/mnt/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/08 金蛇狂舞(民间乐曲).flac' May 28 05:31:33 shd-power volumio[964]: info: Adding Item to queue: music-library/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/09 瑶族舞曲(曲：刘铁山、茅沅).flac May 28 05:31:33 shd-power volumio[964]: info: Exploding uri music-library/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/09 瑶族舞曲(曲：刘铁山、茅沅).flac in service mpd May 28 05:31:33 shd-power volumio[964]: scanFolder - failure to stat '/mnt/NAS/USBTA/2民乐/春江花月夜(民乐合奏名曲典范集)/09 瑶族舞曲(曲：刘铁山、茅沅).flac' May 28 05:31:33 shd-power volumio[964]: info: CorePlayQueue::saveQueue May 28 05:31:33 shd-power volumio[964]: info: CoreCommandRouter::volumioPushQueue May 28 05:31:33 shd-power volumio[964]: info: CoreStateMachine::updateTrackBlock May 28 05:31:33 shd-power volumio[964]: info: CorePlayQueue::getTrackBlock May 28 05:31:33 shd-power volumio[964]: info: CoreCommandRouter::volumioPlay May 28 05:31:33 shd-power volumio[964]: verbose: UNSET VOLATILE May 28 05:31:33 shd-power volumio[964]: info: CoreStateMachine::play index 0 May 28 05:31:33 shd-power volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 05:31:33 shd-power volumio[964]: info: CoreStateMachine::stop May 28 05:31:33 shd-power volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 05:31:33 shd-power volumio[964]: verbose: UNSET VOLATILE May 28 05:31:33 shd-power volumio[964]: info: CoreStateMachine::play index undefined May 28 05:31:33 shd-power volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 05:31:33 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:37 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 28 05:31:37 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 28 05:31:37 shd-power volumio[964]: info: Discovery: Getting this device information May 28 05:31:37 shd-power volumio[964]: info: CoreCommandRouter::volumioGetState May 28 05:31:37 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:37 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses May 28 05:31:37 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 28 05:31:37 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 28 05:31:37 shd-power volumio[964]: info: CoreCommandRouter::volumioGetState May 28 05:31:37 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:37 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 28 05:31:37 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 28 05:31:39 shd-power volumio[964]: info: CoreCommandRouter::volumioGetState May 28 05:31:39 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:39 shd-power sudo[3849]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 28 05:31:39 shd-power sudo[3849]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 05:31:39 shd-power sudo[3849]: pam_unix(sudo:session): session closed for user root May 28 05:31:39 shd-power sudo[3852]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 28 05:31:39 shd-power sudo[3852]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 05:31:40 shd-power sudo[3852]: pam_unix(sudo:session): session closed for user root May 28 05:31:40 shd-power sudo[3855]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 28 05:31:40 shd-power sudo[3855]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 05:31:40 shd-power sudo[3855]: pam_unix(sudo:session): session closed for user root May 28 05:31:40 shd-power sudo[3858]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 28 05:31:40 shd-power sudo[3858]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 05:31:40 shd-power sudo[3858]: pam_unix(sudo:session): session closed for user root May 28 05:31:40 shd-power volumio[964]: info: CoreCommandRouter::volumioGetState May 28 05:31:40 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:40 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 28 05:31:40 shd-power volumio[964]: error: Could not retrieve plugin audio_interface multiroom May 28 05:31:40 shd-power volumio[964]: info: Listing playlists May 28 05:31:40 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 28 05:31:40 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 28 05:31:40 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 28 05:31:40 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 28 05:31:42 shd-power volumio[964]: info: CoreCommandRouter::volumioGetVisibleSources May 28 05:31:42 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 28 05:31:42 shd-power volumio[964]: info: CoreCommandRouter::volumioGetQueue May 28 05:31:42 shd-power volumio[964]: info: CoreStateMachine::getQueue May 28 05:31:42 shd-power volumio[964]: info: CorePlayQueue::getQueue May 28 05:31:43 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 28 05:31:43 shd-power volumio[964]: info: CURURI: music-library May 28 05:31:46 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 28 05:31:47 shd-power volumio[964]: verbose: ControllerMpd::sendMpdCommand update May 28 05:31:47 shd-power volumio[964]: verbose: ControllerMpd::sendMpdCommand status May 28 05:31:47 shd-power volumio[964]: info: May 28 05:31:47 shd-power volumio[964]: ---------------------------- MPD announces state update: update May 28 05:31:47 shd-power volumio[964]: info: sendMpdCommand update took 10 milliseconds May 28 05:31:47 shd-power volumio[964]: info: ControllerMpd::getState May 28 05:31:47 shd-power volumio[964]: verbose: ControllerMpd::sendMpdCommand status May 28 05:31:47 shd-power volumio[964]: info: sendMpdCommand status took 6 milliseconds May 28 05:31:47 shd-power volumio[964]: info: sendMpdCommand status took 3 milliseconds May 28 05:31:47 shd-power volumio[964]: verbose: ControllerMpd::parseState May 28 05:31:48 shd-power volumio-remote-updater[641]: [384B blob data] May 28 05:31:48 shd-power volumio-remote-updater[641]: downloading from http://updates.volumio.org/nanopineo2/minidspshd/3.608/volumio_current.sqsh: May 28 05:31:48 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:48 shd-power volumio[964]: info: Command Router : Notfying DB Updatetrue May 28 05:31:48 shd-power volumio[964]: verbose: ControllerMpd::parseState May 28 05:31:48 shd-power volumio[964]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 05:31:48 shd-power volumio[964]: info: MPD Database updated - AlbumList cache refreshed May 28 05:31:48 shd-power volumio[964]: info: May 28 05:31:48 shd-power volumio[964]: ---------------------------- MPD announces state update: database May 28 05:31:48 shd-power volumio[964]: verbose: ControllerMpd::sendMpdCommand status May 28 05:31:48 shd-power volumio[964]: info: May 28 05:31:48 shd-power volumio[964]: ---------------------------- MPD announces state update: update May 28 05:31:48 shd-power volumio[964]: info: ControllerMpd::getState May 28 05:31:48 shd-power volumio[964]: verbose: ControllerMpd::sendMpdCommand status May 28 05:31:48 shd-power volumio[964]: info: ControllerMpd::getState May 28 05:31:48 shd-power volumio[964]: verbose: ControllerMpd::sendMpdCommand status May 28 05:31:48 shd-power volumio[964]: info: sendMpdCommand playlistinfo took 42 milliseconds May 28 05:31:48 shd-power volumio[964]: verbose: ControllerMpd::parseTrackInfo May 28 05:31:48 shd-power volumio[964]: info: ControllerMpd::pushState May 28 05:31:48 shd-power volumio[964]: info: CoreCommandRouter::servicePushState May 28 05:31:48 shd-power volumio[964]: info: CoreStateMachine::pushState May 28 05:31:48 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:48 shd-power volumio[964]: info: CoreCommandRouter::volumioPushState May 28 05:31:48 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 05:31:48 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:48 shd-power volumio[964]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ROCK ANTENNE - Rock Nonstop","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} May 28 05:31:48 shd-power volumio[964]: verbose: CURRENT POSITION 0 May 28 05:31:48 shd-power volumio[964]: info: CoreStateMachine::syncState stateService stop May 28 05:31:48 shd-power volumio[964]: info: CoreStateMachine::syncState currentStatus stop May 28 05:31:48 shd-power volumio[964]: info: CoreStateMachine::pushState May 28 05:31:48 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:48 shd-power volumio[964]: info: CoreCommandRouter::volumioPushState May 28 05:31:48 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 05:31:48 shd-power volumio[964]: info: No code May 28 05:31:48 shd-power volumio[964]: info: CoreStateMachine::pushState May 28 05:31:48 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:48 shd-power volumio[964]: info: CoreCommandRouter::volumioPushState May 28 05:31:48 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 05:31:49 shd-power volumio[964]: info: ------------------------------ 1988ms May 28 05:31:49 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:49 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:49 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:49 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:49 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:49 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:49 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:49 shd-power volumio[964]: info: sendMpdCommand status took 83 milliseconds May 28 05:31:49 shd-power volumio[964]: info: sendMpdCommand status took 81 milliseconds May 28 05:31:49 shd-power volumio[964]: info: sendMpdCommand status took 80 milliseconds May 28 05:31:49 shd-power volumio[964]: verbose: ControllerMpd::parseState May 28 05:31:49 shd-power volumio[964]: info: Command Router : Notfying DB Updatefalse May 28 05:31:49 shd-power volumio[964]: info: CoreCommandRouter::Close All Modals sent May 28 05:31:49 shd-power volumio[964]: verbose: ControllerMpd::parseState May 28 05:31:49 shd-power volumio[964]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 05:31:49 shd-power volumio[964]: verbose: ControllerMpd::parseState May 28 05:31:49 shd-power volumio[964]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 28 05:31:49 shd-power volumio[964]: info: sendMpdCommand playlistinfo took 8 milliseconds May 28 05:31:49 shd-power volumio[964]: info: sendMpdCommand playlistinfo took 9 milliseconds May 28 05:31:49 shd-power volumio[964]: verbose: ControllerMpd::parseTrackInfo May 28 05:31:49 shd-power volumio[964]: verbose: ControllerMpd::parseTrackInfo May 28 05:31:49 shd-power volumio[964]: info: ControllerMpd::pushState May 28 05:31:49 shd-power volumio[964]: info: CoreCommandRouter::servicePushState May 28 05:31:49 shd-power volumio[964]: info: CoreStateMachine::pushState May 28 05:31:49 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:49 shd-power volumio[964]: info: CoreCommandRouter::volumioPushState May 28 05:31:49 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 05:31:49 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:49 shd-power volumio[964]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ROCK ANTENNE - Rock Nonstop","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} May 28 05:31:49 shd-power volumio[964]: verbose: CURRENT POSITION 0 May 28 05:31:49 shd-power volumio[964]: info: CoreStateMachine::syncState stateService stop May 28 05:31:49 shd-power volumio[964]: info: CoreStateMachine::syncState currentStatus stop May 28 05:31:49 shd-power volumio[964]: info: CoreStateMachine::pushState May 28 05:31:49 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:49 shd-power volumio[964]: info: CoreCommandRouter::volumioPushState May 28 05:31:49 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 05:31:49 shd-power volumio[964]: info: No code May 28 05:31:49 shd-power volumio[964]: info: CoreStateMachine::pushState May 28 05:31:49 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:49 shd-power volumio[964]: info: CoreCommandRouter::volumioPushState May 28 05:31:49 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 05:31:49 shd-power volumio[964]: info: ControllerMpd::pushState May 28 05:31:49 shd-power volumio[964]: info: CoreCommandRouter::servicePushState May 28 05:31:49 shd-power volumio[964]: info: CoreStateMachine::pushState May 28 05:31:49 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:49 shd-power volumio[964]: info: CoreCommandRouter::volumioPushState May 28 05:31:49 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 05:31:49 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:49 shd-power volumio[964]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ROCK ANTENNE - Rock Nonstop","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} May 28 05:31:49 shd-power volumio[964]: verbose: CURRENT POSITION 0 May 28 05:31:49 shd-power volumio[964]: info: CoreStateMachine::syncState stateService stop May 28 05:31:49 shd-power volumio[964]: info: CoreStateMachine::syncState currentStatus stop May 28 05:31:49 shd-power volumio[964]: info: CoreStateMachine::pushState May 28 05:31:49 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:49 shd-power volumio[964]: info: CoreCommandRouter::volumioPushState May 28 05:31:49 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 05:31:49 shd-power volumio[964]: info: No code May 28 05:31:49 shd-power volumio[964]: info: CoreStateMachine::pushState May 28 05:31:49 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:31:49 shd-power volumio[964]: info: CoreCommandRouter::volumioPushState May 28 05:31:49 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 05:31:49 shd-power volumio[964]: info: ------------------------------ 253ms May 28 05:31:49 shd-power volumio[964]: info: ------------------------------ 254ms May 28 05:31:49 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:49 shd-power volumio[964]: updateProgress May 28 05:31:49 shd-power volumio[964]: { downloadSpeed: '41.8', May 28 05:31:49 shd-power volumio[964]: eta: '4m', May 28 05:31:49 shd-power volumio[964]: progress: 30, May 28 05:31:49 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:49 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:49 shd-power volumio[964]: updateProgress May 28 05:31:49 shd-power volumio[964]: { downloadSpeed: '41.8', May 28 05:31:49 shd-power volumio[964]: eta: '4m', May 28 05:31:49 shd-power volumio[964]: progress: 30, May 28 05:31:49 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:50 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:50 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:50 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:50 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:50 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:50 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:50 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:50 shd-power volumio[964]: updateProgress May 28 05:31:50 shd-power volumio[964]: { downloadSpeed: '517.0', May 28 05:31:50 shd-power volumio[964]: eta: '4m', May 28 05:31:50 shd-power volumio[964]: progress: 30, May 28 05:31:50 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:50 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:50 shd-power volumio[964]: updateProgress May 28 05:31:50 shd-power volumio[964]: { downloadSpeed: '517.0', May 28 05:31:50 shd-power volumio[964]: eta: '4m', May 28 05:31:50 shd-power volumio[964]: progress: 30, May 28 05:31:50 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:50 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:50 shd-power volumio[964]: updateProgress May 28 05:31:50 shd-power volumio[964]: { downloadSpeed: '517.0', May 28 05:31:50 shd-power volumio[964]: eta: '4m', May 28 05:31:50 shd-power volumio[964]: progress: 30, May 28 05:31:50 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:51 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:51 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:51 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:51 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:51 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:51 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:51 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:51 shd-power volumio[964]: updateProgress May 28 05:31:51 shd-power volumio[964]: { downloadSpeed: '280.6', May 28 05:31:51 shd-power volumio[964]: eta: '4m', May 28 05:31:51 shd-power volumio[964]: progress: 30, May 28 05:31:51 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:51 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:51 shd-power volumio[964]: updateProgress May 28 05:31:51 shd-power volumio[964]: { downloadSpeed: '280.6', May 28 05:31:51 shd-power volumio[964]: eta: '4m', May 28 05:31:51 shd-power volumio[964]: progress: 30, May 28 05:31:51 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:52 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:52 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:52 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:52 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:52 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:52 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:52 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:52 shd-power volumio[964]: updateProgress May 28 05:31:52 shd-power volumio[964]: { downloadSpeed: '1160.9', May 28 05:31:52 shd-power volumio[964]: eta: '4m', May 28 05:31:52 shd-power volumio[964]: progress: 30, May 28 05:31:52 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:52 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:52 shd-power volumio[964]: updateProgress May 28 05:31:52 shd-power volumio[964]: { downloadSpeed: '1160.9', May 28 05:31:52 shd-power volumio[964]: eta: '4m', May 28 05:31:52 shd-power volumio[964]: progress: 30, May 28 05:31:52 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:53 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:53 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:53 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:53 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:53 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:53 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:53 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:53 shd-power volumio[964]: updateProgress May 28 05:31:53 shd-power volumio[964]: { downloadSpeed: '1196.6', May 28 05:31:53 shd-power volumio[964]: eta: '4m', May 28 05:31:53 shd-power volumio[964]: progress: 30, May 28 05:31:53 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:53 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:53 shd-power volumio[964]: updateProgress May 28 05:31:53 shd-power volumio[964]: { downloadSpeed: '1196.6', May 28 05:31:53 shd-power volumio[964]: eta: '4m', May 28 05:31:53 shd-power volumio[964]: progress: 30, May 28 05:31:53 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:53 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 28 05:31:53 shd-power volumio[964]: info: CURURI: music-library/NAS May 28 05:31:53 shd-power volumio[964]: error: Failed LSINFO: Error: [50@0] {} No such directory May 28 05:31:54 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:54 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:54 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:54 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:54 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:54 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:54 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:54 shd-power volumio[964]: updateProgress May 28 05:31:54 shd-power volumio[964]: { downloadSpeed: '1203.8', May 28 05:31:54 shd-power volumio[964]: eta: '4m', May 28 05:31:54 shd-power volumio[964]: progress: 30, May 28 05:31:54 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:54 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:54 shd-power volumio[964]: updateProgress May 28 05:31:54 shd-power volumio[964]: { downloadSpeed: '1203.8', May 28 05:31:54 shd-power volumio[964]: eta: '4m', May 28 05:31:54 shd-power volumio[964]: progress: 30, May 28 05:31:54 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:54 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:54 shd-power volumio[964]: updateProgress May 28 05:31:54 shd-power volumio[964]: { downloadSpeed: '1203.8', May 28 05:31:54 shd-power volumio[964]: eta: '4m', May 28 05:31:54 shd-power volumio[964]: progress: 30, May 28 05:31:54 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:55 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:55 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:55 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:55 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:55 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:55 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:55 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:55 shd-power volumio[964]: updateProgress May 28 05:31:55 shd-power volumio[964]: { downloadSpeed: '1277.3', May 28 05:31:55 shd-power volumio[964]: eta: '4m', May 28 05:31:55 shd-power volumio[964]: progress: 30, May 28 05:31:55 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:55 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:55 shd-power volumio[964]: updateProgress May 28 05:31:55 shd-power volumio[964]: { downloadSpeed: '1277.3', May 28 05:31:55 shd-power volumio[964]: eta: '4m', May 28 05:31:55 shd-power volumio[964]: progress: 30, May 28 05:31:55 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:56 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:56 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:56 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:56 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:56 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:56 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:56 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:56 shd-power volumio[964]: updateProgress May 28 05:31:56 shd-power volumio[964]: { downloadSpeed: '1294.6', May 28 05:31:56 shd-power volumio[964]: eta: '4m', May 28 05:31:56 shd-power volumio[964]: progress: 30, May 28 05:31:56 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:56 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:56 shd-power volumio[964]: updateProgress May 28 05:31:56 shd-power volumio[964]: { downloadSpeed: '1294.6', May 28 05:31:56 shd-power volumio[964]: eta: '4m', May 28 05:31:56 shd-power volumio[964]: progress: 30, May 28 05:31:56 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:57 shd-power volumio-remote-updater[641]: PROGRESS: 30, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:57 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:57 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:57 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:57 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:57 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:57 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:57 shd-power volumio[964]: updateProgress May 28 05:31:57 shd-power volumio[964]: { downloadSpeed: '1188.0', May 28 05:31:57 shd-power volumio[964]: eta: '4m', May 28 05:31:57 shd-power volumio[964]: progress: 31, May 28 05:31:57 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:57 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:57 shd-power volumio[964]: updateProgress May 28 05:31:57 shd-power volumio[964]: { downloadSpeed: '1188.0', May 28 05:31:57 shd-power volumio[964]: eta: '4m', May 28 05:31:57 shd-power volumio[964]: progress: 31, May 28 05:31:57 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:57 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:57 shd-power volumio[964]: updateProgress May 28 05:31:57 shd-power volumio[964]: { downloadSpeed: '1188.0', May 28 05:31:57 shd-power volumio[964]: eta: '4m', May 28 05:31:57 shd-power volumio[964]: progress: 31, May 28 05:31:57 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:58 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:58 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:58 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:58 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:58 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:58 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:58 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:58 shd-power volumio[964]: updateProgress May 28 05:31:58 shd-power volumio[964]: { downloadSpeed: '1270.1', May 28 05:31:58 shd-power volumio[964]: eta: '4m', May 28 05:31:58 shd-power volumio[964]: progress: 31, May 28 05:31:58 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:58 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:58 shd-power volumio[964]: updateProgress May 28 05:31:58 shd-power volumio[964]: { downloadSpeed: '1270.1', May 28 05:31:58 shd-power volumio[964]: eta: '4m', May 28 05:31:58 shd-power volumio[964]: progress: 31, May 28 05:31:58 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:58 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:58 shd-power volumio[964]: updateProgress May 28 05:31:58 shd-power volumio[964]: { downloadSpeed: '1270.1', May 28 05:31:58 shd-power volumio[964]: eta: '4m', May 28 05:31:58 shd-power volumio[964]: progress: 31, May 28 05:31:58 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:59 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:59 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:59 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:59 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:59 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:59 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:59 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:31:59 shd-power volumio[964]: updateProgress May 28 05:31:59 shd-power volumio[964]: { downloadSpeed: '1352.2', May 28 05:31:59 shd-power volumio[964]: eta: '4m', May 28 05:31:59 shd-power volumio[964]: progress: 31, May 28 05:31:59 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:31:59 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:31:59 shd-power volumio[964]: updateProgress May 28 05:31:59 shd-power volumio[964]: { downloadSpeed: '1352.2', May 28 05:31:59 shd-power volumio[964]: eta: '4m', May 28 05:31:59 shd-power volumio[964]: progress: 31, May 28 05:31:59 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:00 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:00 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:00 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:00 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:00 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:00 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:00 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:00 shd-power volumio[964]: updateProgress May 28 05:32:00 shd-power volumio[964]: { downloadSpeed: '1303.2', May 28 05:32:00 shd-power volumio[964]: eta: '4m', May 28 05:32:00 shd-power volumio[964]: progress: 31, May 28 05:32:00 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:00 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:00 shd-power volumio[964]: updateProgress May 28 05:32:00 shd-power volumio[964]: { downloadSpeed: '1303.2', May 28 05:32:00 shd-power volumio[964]: eta: '4m', May 28 05:32:00 shd-power volumio[964]: progress: 31, May 28 05:32:00 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:01 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:01 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:01 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:01 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:01 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:01 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:01 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:01 shd-power volumio[964]: updateProgress May 28 05:32:01 shd-power volumio[964]: { downloadSpeed: '1334.9', May 28 05:32:01 shd-power volumio[964]: eta: '4m', May 28 05:32:01 shd-power volumio[964]: progress: 31, May 28 05:32:01 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:01 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:01 shd-power volumio[964]: updateProgress May 28 05:32:01 shd-power volumio[964]: { downloadSpeed: '1334.9', May 28 05:32:01 shd-power volumio[964]: eta: '4m', May 28 05:32:01 shd-power volumio[964]: progress: 31, May 28 05:32:01 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:01 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:01 shd-power volumio[964]: updateProgress May 28 05:32:01 shd-power volumio[964]: { downloadSpeed: '1334.9', May 28 05:32:01 shd-power volumio[964]: eta: '4m', May 28 05:32:01 shd-power volumio[964]: progress: 31, May 28 05:32:01 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:01 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:01 shd-power volumio[964]: updateProgress May 28 05:32:01 shd-power volumio[964]: { downloadSpeed: '1334.9', May 28 05:32:01 shd-power volumio[964]: eta: '4m', May 28 05:32:01 shd-power volumio[964]: progress: 31, May 28 05:32:01 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:02 shd-power volumio-remote-updater[641]: PROGRESS: 31, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:02 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:02 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:02 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:02 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:02 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:02 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:02 shd-power volumio[964]: updateProgress May 28 05:32:02 shd-power volumio[964]: { downloadSpeed: '1147.7', May 28 05:32:02 shd-power volumio[964]: eta: '4m', May 28 05:32:02 shd-power volumio[964]: progress: 32, May 28 05:32:02 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:02 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:02 shd-power volumio[964]: updateProgress May 28 05:32:02 shd-power volumio[964]: { downloadSpeed: '1147.7', May 28 05:32:02 shd-power volumio[964]: eta: '4m', May 28 05:32:02 shd-power volumio[964]: progress: 32, May 28 05:32:02 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:02 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:02 shd-power volumio[964]: updateProgress May 28 05:32:02 shd-power volumio[964]: { downloadSpeed: '1147.7', May 28 05:32:02 shd-power volumio[964]: eta: '4m', May 28 05:32:02 shd-power volumio[964]: progress: 32, May 28 05:32:02 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:03 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:03 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:03 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:03 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:03 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:03 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:03 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:03 shd-power volumio[964]: updateProgress May 28 05:32:03 shd-power volumio[964]: { downloadSpeed: '1573.9', May 28 05:32:03 shd-power volumio[964]: eta: '4m', May 28 05:32:03 shd-power volumio[964]: progress: 32, May 28 05:32:03 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:03 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:03 shd-power volumio[964]: updateProgress May 28 05:32:03 shd-power volumio[964]: { downloadSpeed: '1573.9', May 28 05:32:03 shd-power volumio[964]: eta: '4m', May 28 05:32:03 shd-power volumio[964]: progress: 32, May 28 05:32:03 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:03 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:03 shd-power volumio[964]: updateProgress May 28 05:32:03 shd-power volumio[964]: { downloadSpeed: '1573.9', May 28 05:32:03 shd-power volumio[964]: eta: '4m', May 28 05:32:03 shd-power volumio[964]: progress: 32, May 28 05:32:03 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:03 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:03 shd-power volumio[964]: updateProgress May 28 05:32:03 shd-power volumio[964]: { downloadSpeed: '1573.9', May 28 05:32:03 shd-power volumio[964]: eta: '4m', May 28 05:32:03 shd-power volumio[964]: progress: 32, May 28 05:32:03 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:04 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:04 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:04 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:04 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:04 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:04 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:04 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:04 shd-power volumio[964]: updateProgress May 28 05:32:04 shd-power volumio[964]: { downloadSpeed: '1532.2', May 28 05:32:04 shd-power volumio[964]: eta: '4m', May 28 05:32:04 shd-power volumio[964]: progress: 32, May 28 05:32:04 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:04 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:04 shd-power volumio[964]: updateProgress May 28 05:32:04 shd-power volumio[964]: { downloadSpeed: '1532.2', May 28 05:32:04 shd-power volumio[964]: eta: '4m', May 28 05:32:04 shd-power volumio[964]: progress: 32, May 28 05:32:04 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:04 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:04 shd-power volumio[964]: updateProgress May 28 05:32:04 shd-power volumio[964]: { downloadSpeed: '1532.2', May 28 05:32:04 shd-power volumio[964]: eta: '4m', May 28 05:32:04 shd-power volumio[964]: progress: 32, May 28 05:32:04 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:05 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:05 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:05 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:05 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:05 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:05 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:05 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:05 shd-power volumio[964]: updateProgress May 28 05:32:05 shd-power volumio[964]: { downloadSpeed: '1327.7', May 28 05:32:05 shd-power volumio[964]: eta: '4m', May 28 05:32:05 shd-power volumio[964]: progress: 32, May 28 05:32:05 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:05 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:05 shd-power volumio[964]: updateProgress May 28 05:32:05 shd-power volumio[964]: { downloadSpeed: '1327.7', May 28 05:32:05 shd-power volumio[964]: eta: '4m', May 28 05:32:05 shd-power volumio[964]: progress: 32, May 28 05:32:05 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:05 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:05 shd-power volumio[964]: updateProgress May 28 05:32:05 shd-power volumio[964]: { downloadSpeed: '1327.7', May 28 05:32:05 shd-power volumio[964]: eta: '4m', May 28 05:32:05 shd-power volumio[964]: progress: 32, May 28 05:32:05 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:05 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 28 05:32:06 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:06 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:06 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:06 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:06 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:06 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:06 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:06 shd-power volumio[964]: updateProgress May 28 05:32:06 shd-power volumio[964]: { downloadSpeed: '1301.8', May 28 05:32:06 shd-power volumio[964]: eta: '4m', May 28 05:32:06 shd-power volumio[964]: progress: 32, May 28 05:32:06 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:06 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:06 shd-power volumio[964]: updateProgress May 28 05:32:06 shd-power volumio[964]: { downloadSpeed: '1301.8', May 28 05:32:06 shd-power volumio[964]: eta: '4m', May 28 05:32:06 shd-power volumio[964]: progress: 32, May 28 05:32:06 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:06 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:06 shd-power volumio[964]: updateProgress May 28 05:32:06 shd-power volumio[964]: { downloadSpeed: '1301.8', May 28 05:32:06 shd-power volumio[964]: eta: '4m', May 28 05:32:06 shd-power volumio[964]: progress: 32, May 28 05:32:06 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:06 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:06 shd-power volumio[964]: updateProgress May 28 05:32:06 shd-power volumio[964]: { downloadSpeed: '1301.8', May 28 05:32:06 shd-power volumio[964]: eta: '4m', May 28 05:32:06 shd-power volumio[964]: progress: 32, May 28 05:32:06 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:07 shd-power volumio-remote-updater[641]: PROGRESS: 32, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:07 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:07 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:07 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:07 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:07 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:07 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:07 shd-power volumio[964]: updateProgress May 28 05:32:07 shd-power volumio[964]: { downloadSpeed: '1147.7', May 28 05:32:07 shd-power volumio[964]: eta: '4m', May 28 05:32:07 shd-power volumio[964]: progress: 33, May 28 05:32:07 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:07 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:07 shd-power volumio[964]: updateProgress May 28 05:32:07 shd-power volumio[964]: { downloadSpeed: '1147.7', May 28 05:32:07 shd-power volumio[964]: eta: '4m', May 28 05:32:07 shd-power volumio[964]: progress: 33, May 28 05:32:07 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:07 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:07 shd-power volumio[964]: updateProgress May 28 05:32:07 shd-power volumio[964]: { downloadSpeed: '1147.7', May 28 05:32:07 shd-power volumio[964]: eta: '4m', May 28 05:32:07 shd-power volumio[964]: progress: 33, May 28 05:32:07 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:07 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:07 shd-power volumio[964]: updateProgress May 28 05:32:07 shd-power volumio[964]: { downloadSpeed: '1147.7', May 28 05:32:07 shd-power volumio[964]: eta: '4m', May 28 05:32:07 shd-power volumio[964]: progress: 33, May 28 05:32:07 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:07 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:07 shd-power volumio[964]: updateProgress May 28 05:32:07 shd-power volumio[964]: { downloadSpeed: '1147.7', May 28 05:32:07 shd-power volumio[964]: eta: '4m', May 28 05:32:07 shd-power volumio[964]: progress: 33, May 28 05:32:07 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:07 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 28 05:32:07 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 28 05:32:07 shd-power volumio[964]: info: Discovery: Getting this device information May 28 05:32:07 shd-power volumio[964]: info: CoreCommandRouter::volumioGetState May 28 05:32:07 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:32:07 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses May 28 05:32:07 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 28 05:32:07 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 28 05:32:08 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:08 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:08 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:08 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:08 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:08 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:08 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:08 shd-power volumio[964]: updateProgress May 28 05:32:08 shd-power volumio[964]: { downloadSpeed: '1147.7', May 28 05:32:08 shd-power volumio[964]: eta: '4m', May 28 05:32:08 shd-power volumio[964]: progress: 33, May 28 05:32:08 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:08 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:08 shd-power volumio[964]: updateProgress May 28 05:32:08 shd-power volumio[964]: { downloadSpeed: '1121.8', May 28 05:32:08 shd-power volumio[964]: eta: '4m', May 28 05:32:08 shd-power volumio[964]: progress: 33, May 28 05:32:08 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:08 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:08 shd-power volumio[964]: updateProgress May 28 05:32:08 shd-power volumio[964]: { downloadSpeed: '1121.8', May 28 05:32:08 shd-power volumio[964]: eta: '4m', May 28 05:32:08 shd-power volumio[964]: progress: 33, May 28 05:32:08 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:08 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 28 05:32:09 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:09 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:09 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:09 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:09 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:09 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:09 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:09 shd-power volumio[964]: updateProgress May 28 05:32:09 shd-power volumio[964]: { downloadSpeed: '943.2', May 28 05:32:09 shd-power volumio[964]: eta: '4m', May 28 05:32:09 shd-power volumio[964]: progress: 33, May 28 05:32:09 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:09 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:09 shd-power volumio[964]: updateProgress May 28 05:32:09 shd-power volumio[964]: { downloadSpeed: '943.2', May 28 05:32:09 shd-power volumio[964]: eta: '4m', May 28 05:32:09 shd-power volumio[964]: progress: 33, May 28 05:32:09 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:10 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:10 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:10 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:10 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:10 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:10 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:10 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:10 shd-power volumio[964]: updateProgress May 28 05:32:10 shd-power volumio[964]: { downloadSpeed: '1003.7', May 28 05:32:10 shd-power volumio[964]: eta: '4m', May 28 05:32:10 shd-power volumio[964]: progress: 33, May 28 05:32:10 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:10 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:10 shd-power volumio[964]: updateProgress May 28 05:32:10 shd-power volumio[964]: { downloadSpeed: '1003.7', May 28 05:32:10 shd-power volumio[964]: eta: '4m', May 28 05:32:10 shd-power volumio[964]: progress: 33, May 28 05:32:10 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:10 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:10 shd-power volumio[964]: updateProgress May 28 05:32:10 shd-power volumio[964]: { downloadSpeed: '1003.7', May 28 05:32:10 shd-power volumio[964]: eta: '4m', May 28 05:32:10 shd-power volumio[964]: progress: 33, May 28 05:32:10 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:10 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:10 shd-power volumio[964]: updateProgress May 28 05:32:10 shd-power volumio[964]: { downloadSpeed: '1003.7', May 28 05:32:10 shd-power volumio[964]: eta: '4m', May 28 05:32:10 shd-power volumio[964]: progress: 33, May 28 05:32:10 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:10 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:10 shd-power volumio[964]: updateProgress May 28 05:32:10 shd-power volumio[964]: { downloadSpeed: '1003.7', May 28 05:32:10 shd-power volumio[964]: eta: '4m', May 28 05:32:10 shd-power volumio[964]: progress: 33, May 28 05:32:10 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:11 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:11 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:11 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:11 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:11 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:11 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:11 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:11 shd-power volumio[964]: updateProgress May 28 05:32:11 shd-power volumio[964]: { downloadSpeed: '444.1', May 28 05:32:11 shd-power volumio[964]: eta: '4m', May 28 05:32:11 shd-power volumio[964]: progress: 33, May 28 05:32:11 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:11 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:11 shd-power volumio[964]: updateProgress May 28 05:32:11 shd-power volumio[964]: { downloadSpeed: '444.1', May 28 05:32:11 shd-power volumio[964]: eta: '4m', May 28 05:32:11 shd-power volumio[964]: progress: 33, May 28 05:32:11 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:11 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:11 shd-power volumio[964]: updateProgress May 28 05:32:11 shd-power volumio[964]: { downloadSpeed: '444.1', May 28 05:32:11 shd-power volumio[964]: eta: '4m', May 28 05:32:11 shd-power volumio[964]: progress: 33, May 28 05:32:11 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:11 shd-power volumio[964]: info: CoreCommandRouter::volumioReplaceandPlayItems May 28 05:32:11 shd-power volumio[964]: info: CoreStateMachine::ClearQueue May 28 05:32:11 shd-power volumio[964]: info: CoreStateMachine::stop May 28 05:32:11 shd-power volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 05:32:11 shd-power volumio[964]: verbose: UNSET VOLATILE May 28 05:32:11 shd-power volumio[964]: info: CorePlayQueue::clearPlayQueue May 28 05:32:11 shd-power volumio[964]: info: CorePlayQueue::saveQueue May 28 05:32:11 shd-power volumio[964]: info: CoreCommandRouter::volumioPushState May 28 05:32:11 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 28 05:32:11 shd-power volumio[964]: info: CoreCommandRouter::volumioPushQueue May 28 05:32:11 shd-power volumio[964]: info: CoreStateMachine::addQueueItems May 28 05:32:11 shd-power volumio[964]: info: CorePlayQueue::addQueueItems May 28 05:32:11 shd-power volumio[964]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99530397 May 28 05:32:11 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 28 05:32:11 shd-power volumio[964]: info: CorePlayQueue::saveQueue May 28 05:32:11 shd-power volumio[964]: info: CoreCommandRouter::volumioPushQueue May 28 05:32:11 shd-power volumio[964]: info: CoreStateMachine::updateTrackBlock May 28 05:32:11 shd-power volumio[964]: info: CorePlayQueue::getTrackBlock May 28 05:32:11 shd-power volumio[964]: info: CoreCommandRouter::volumioPlay May 28 05:32:11 shd-power volumio[964]: verbose: UNSET VOLATILE May 28 05:32:11 shd-power volumio[964]: info: CoreStateMachine::play index 0 May 28 05:32:11 shd-power volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 05:32:11 shd-power volumio[964]: info: CoreStateMachine::stop May 28 05:32:11 shd-power volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 05:32:11 shd-power volumio[964]: verbose: UNSET VOLATILE May 28 05:32:11 shd-power volumio[964]: info: CoreStateMachine::play index undefined May 28 05:32:11 shd-power volumio[964]: info: CoreStateMachine::setConsumeUpdateService undefined May 28 05:32:11 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:32:11 shd-power volumio[964]: info: CoreStateMachine::startPlaybackTimer May 28 05:32:11 shd-power volumio[964]: info: CorePlayQueue::getTrack 0 May 28 05:32:11 shd-power volumio[964]: info: [1748410331512] ControllerWebradio::clearAddPlayTrack May 28 05:32:11 shd-power volumio[964]: verbose: ControllerMpd::sendMpdCommand stop May 28 05:32:11 shd-power volumio[964]: info: sendMpdCommand stop took 20 milliseconds May 28 05:32:11 shd-power volumio[964]: verbose: ControllerMpd::sendMpdCommand clear May 28 05:32:11 shd-power volumio[964]: info: May 28 05:32:11 shd-power volumio[964]: ---------------------------- MPD announces system playlist update May 28 05:32:11 shd-power volumio[964]: info: Ignoring MPD Status Update May 28 05:32:11 shd-power volumio[964]: info: sendMpdCommand clear took 3 milliseconds May 28 05:32:11 shd-power volumio[964]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99530397" May 28 05:32:11 shd-power volumio[964]: error: updateQueue error: null May 28 05:32:11 shd-power volumio[964]: info: ------------------------------ 5ms May 28 05:32:12 shd-power volumio-remote-updater[641]: PROGRESS: 33, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:12 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:12 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:12 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:12 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:12 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:12 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:12 shd-power volumio[964]: updateProgress May 28 05:32:12 shd-power volumio[964]: { downloadSpeed: '389.0', May 28 05:32:12 shd-power volumio[964]: eta: '4m', May 28 05:32:12 shd-power volumio[964]: progress: 34, May 28 05:32:12 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:12 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:12 shd-power volumio[964]: updateProgress May 28 05:32:12 shd-power volumio[964]: { downloadSpeed: '389.0', May 28 05:32:12 shd-power volumio[964]: eta: '4m', May 28 05:32:12 shd-power volumio[964]: progress: 34, May 28 05:32:12 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:13 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:13 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:13 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:13 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:13 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:13 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:13 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:13 shd-power volumio[964]: updateProgress May 28 05:32:13 shd-power volumio[964]: { downloadSpeed: '526.9', May 28 05:32:13 shd-power volumio[964]: eta: '4m', May 28 05:32:13 shd-power volumio[964]: progress: 34, May 28 05:32:13 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:13 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:13 shd-power volumio[964]: updateProgress May 28 05:32:13 shd-power volumio[964]: { downloadSpeed: '526.9', May 28 05:32:13 shd-power volumio[964]: eta: '4m', May 28 05:32:13 shd-power volumio[964]: progress: 34, May 28 05:32:13 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:13 shd-power volumio[964]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage May 28 05:32:13 shd-power volumio[964]: updateProgress May 28 05:32:13 shd-power volumio[964]: { downloadSpeed: '526.9', May 28 05:32:13 shd-power volumio[964]: eta: '4m', May 28 05:32:13 shd-power volumio[964]: progress: 34, May 28 05:32:13 shd-power volumio[964]: status: 'Downloading new update' } May 28 05:32:13 shd-power volumio[964]: info: May 28 05:32:13 shd-power volumio[964]: ---------------------------- MPD announces system playlist update May 28 05:32:13 shd-power volumio[964]: info: Ignoring MPD Status Update May 28 05:32:13 shd-power volumio[964]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99530397" took 1548 milliseconds May 28 05:32:13 shd-power volumio[964]: info: CoreStateMachine::setConsumeUpdateService mpd May 28 05:32:13 shd-power volumio[964]: verbose: ControllerMpd::sendMpdCommand play May 28 05:32:13 shd-power volumio[964]: info: ------------------------------ 5ms May 28 05:32:13 shd-power volumio[964]: info: sendMpdCommand play took 4 milliseconds May 28 05:32:13 shd-power volumio[964]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 28 05:32:13 shd-power volumio[964]: { Error: connect ETIMEDOUT 199.59.148.9:80 May 28 05:32:13 shd-power volumio[964]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1191:14) May 28 05:32:13 shd-power volumio[964]: errno: 'ETIMEDOUT', May 28 05:32:13 shd-power volumio[964]: code: 'ETIMEDOUT', May 28 05:32:13 shd-power volumio[964]: syscall: 'connect', May 28 05:32:13 shd-power volumio[964]: address: '199.59.148.9', May 28 05:32:13 shd-power volumio[964]: port: 80 } May 28 05:32:13 shd-power volumio[964]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 28 05:32:14 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:14 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:14 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:14 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:14 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:14 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:15 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:15 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:15 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:15 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:15 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:15 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:15 shd-power sudo[3956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-28 05:31 May 28 05:32:15 shd-power sudo[3956]: pam_unix(sudo:session): session opened for user root by (uid=0) May 28 05:32:16 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:16 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:16 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:16 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:16 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" May 28 05:32:16 shd-power volumio-remote-updater[641]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="6d9442f761618503268d0366db805a252514dec1" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="minidspshd" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Jul 26 13:26:42 CEST 2022" VOLUMIO_VERSION="1.125" VOLUMIO_HARDWARE="nanopineo2" VOLUMIO_VENDOR="miniDSP" VOLUMIO_MODEL="SHD" VOLUMIO_VENDOR_MODEL="miniDSP SHD" VOLUMIO_HASH="9c17c7c45298f5ca9f5ec80e116295fd"