-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Fri 2026-10-16 08:00:30 UTC. -- Oct 16 07:59:23 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: webradio , addMyWebRadio Oct 16 07:59:23 volumio volumio[850]: info: {"name":"stream","uri":"http://192.168.2.103:8080/mic.mp3"} Oct 16 07:59:23 volumio volumio[850]: info: Saving local item my-web-radio Oct 16 07:59:26 volumio volumio[850]: info: Preload queue cleared Oct 16 07:59:26 volumio volumio[850]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::ClearQueue Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::stop Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::stPlaybackTimer Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::updateTrackBlock Oct 16 07:59:26 volumio volumio[850]: info: CorePlayQueue::getTrackBlock Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 07:59:26 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 07:59:26 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 07:59:26 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::serviceStop Oct 16 07:59:26 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 07:59:26 volumio volumio[850]: info: CoreCommandRouter::serviceStop Oct 16 07:59:26 volumio volumio[850]: info: [1792137566046] ControllerWebradio::stop Oct 16 07:59:26 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 07:59:26 volumio volumio[850]: info: CorePlayQueue::clearPlayQueue Oct 16 07:59:26 volumio volumio[850]: info: CorePlayQueue::saveQueue Oct 16 07:59:26 volumio volumio[850]: info: CoreCommandRouter::volumioPushQueue Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::addQueueItems Oct 16 07:59:26 volumio volumio[850]: info: CorePlayQueue::addQueueItems Oct 16 07:59:26 volumio volumio[850]: info: Preload queue cleared Oct 16 07:59:26 volumio volumio[850]: info: Adding Item to queue: http://192.168.2.103:8080/mic.mp3 Oct 16 07:59:26 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Oct 16 07:59:26 volumio volumio[850]: info: CoreCommandRouter::volumioPushQueue Oct 16 07:59:26 volumio volumio[850]: info: CorePlayQueue::saveQueue Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::updateTrackBlock Oct 16 07:59:26 volumio volumio[850]: info: CorePlayQueue::getTrackBlock Oct 16 07:59:26 volumio volumio[850]: info: CoreCommandRouter::volumioPlay Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::play index 0 Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::stop Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::play index undefined Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 07:59:26 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::startPlaybackTimer Oct 16 07:59:26 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 07:59:26 volumio volumio[850]: info: [1792137566067] ControllerWebradio::clearAddPlayTrack Oct 16 07:59:26 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 07:59:26 volumio volumio[850]: info: Oct 16 07:59:26 volumio volumio[850]: ---------------------------- MPD announces state update: player Oct 16 07:59:26 volumio volumio[850]: info: sendMpdCommand stop took 30 milliseconds Oct 16 07:59:26 volumio volumio[850]: info: ControllerMpd::getState Oct 16 07:59:26 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand status Oct 16 07:59:26 volumio volumio[850]: info: sendMpdCommand stop took 9 milliseconds Oct 16 07:59:26 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 07:59:26 volumio volumio[850]: info: Oct 16 07:59:26 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 07:59:26 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 07:59:26 volumio volumio[850]: info: sendMpdCommand status took 3 milliseconds Oct 16 07:59:26 volumio volumio[850]: info: sendMpdCommand clear took 2 milliseconds Oct 16 07:59:26 volumio volumio[850]: verbose: ControllerMpd::parseState Oct 16 07:59:26 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 07:59:26 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.2.103:8080/mic.mp3" Oct 16 07:59:26 volumio volumio[850]: info: Oct 16 07:59:26 volumio volumio[850]: ---------------------------- MPD announces state update: player Oct 16 07:59:26 volumio volumio[850]: info: ControllerMpd::getState Oct 16 07:59:26 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand status Oct 16 07:59:26 volumio volumio[850]: info: Oct 16 07:59:26 volumio volumio[850]: ---------------------------- MPD announces state update: player Oct 16 07:59:26 volumio volumio[850]: info: ControllerMpd::getState Oct 16 07:59:26 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand status Oct 16 07:59:26 volumio volumio[850]: error: updateQueue error: null Oct 16 07:59:26 volumio volumio[850]: info: ------------------------------ 10ms Oct 16 07:59:26 volumio volumio[850]: error: ControllerMpd::pushError: Error: [2@0] {playlistinfo} Bad song index Oct 16 07:59:26 volumio volumio[850]: info: ------------------------------ 13ms Oct 16 07:59:26 volumio volumio[850]: info: An error occurred saving queue to disk: Error: ENOSPC: no space left on device, write Oct 16 07:59:26 volumio volumio[850]: info: An error occurred saving queue to disk: Error: ENOSPC: no space left on device, write Oct 16 07:59:26 volumio volumio[850]: info: Preload queue cleared Oct 16 07:59:26 volumio volumio[850]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::ClearQueue Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::stop Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 07:59:26 volumio volumio[850]: info: CorePlayQueue::clearPlayQueue Oct 16 07:59:26 volumio volumio[850]: info: CorePlayQueue::saveQueue Oct 16 07:59:26 volumio volumio[850]: info: CoreCommandRouter::volumioPushQueue Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::addQueueItems Oct 16 07:59:26 volumio volumio[850]: info: CorePlayQueue::addQueueItems Oct 16 07:59:26 volumio volumio[850]: info: Preload queue cleared Oct 16 07:59:26 volumio volumio[850]: info: Adding Item to queue: http://192.168.2.103:8080/mic.mp3 Oct 16 07:59:26 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Oct 16 07:59:26 volumio volumio[850]: info: CoreCommandRouter::volumioPushQueue Oct 16 07:59:26 volumio volumio[850]: info: CorePlayQueue::saveQueue Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::updateTrackBlock Oct 16 07:59:26 volumio volumio[850]: info: CorePlayQueue::getTrackBlock Oct 16 07:59:26 volumio volumio[850]: info: CoreCommandRouter::volumioPlay Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::play index 0 Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::stop Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::play index undefined Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 07:59:26 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 07:59:26 volumio volumio[850]: info: CoreStateMachine::startPlaybackTimer Oct 16 07:59:26 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 07:59:26 volumio volumio[850]: info: [1792137566937] ControllerWebradio::clearAddPlayTrack Oct 16 07:59:26 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 07:59:26 volumio volumio[850]: info: An error occurred saving queue to disk: Error: ENOSPC: no space left on device, write Oct 16 07:59:26 volumio volumio[850]: info: An error occurred saving queue to disk: Error: ENOSPC: no space left on device, write Oct 16 07:59:27 volumio volumio[850]: info: Preload queue cleared Oct 16 07:59:27 volumio volumio[850]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::ClearQueue Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::stop Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 07:59:27 volumio volumio[850]: info: CorePlayQueue::clearPlayQueue Oct 16 07:59:27 volumio volumio[850]: info: CorePlayQueue::saveQueue Oct 16 07:59:27 volumio volumio[850]: info: CoreCommandRouter::volumioPushQueue Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::addQueueItems Oct 16 07:59:27 volumio volumio[850]: info: CorePlayQueue::addQueueItems Oct 16 07:59:27 volumio volumio[850]: info: Preload queue cleared Oct 16 07:59:27 volumio volumio[850]: info: Adding Item to queue: http://192.168.2.103:8080/mic.mp3 Oct 16 07:59:27 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Oct 16 07:59:27 volumio volumio[850]: info: CoreCommandRouter::volumioPushQueue Oct 16 07:59:27 volumio volumio[850]: info: CorePlayQueue::saveQueue Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::updateTrackBlock Oct 16 07:59:27 volumio volumio[850]: info: CorePlayQueue::getTrackBlock Oct 16 07:59:27 volumio volumio[850]: info: CoreCommandRouter::volumioPlay Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::play index 0 Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::stop Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::play index undefined Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 07:59:27 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::startPlaybackTimer Oct 16 07:59:27 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 07:59:27 volumio volumio[850]: info: [1792137567148] ControllerWebradio::clearAddPlayTrack Oct 16 07:59:27 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 07:59:27 volumio volumio[850]: info: An error occurred saving queue to disk: Error: ENOSPC: no space left on device, write Oct 16 07:59:27 volumio volumio[850]: info: An error occurred saving queue to disk: Error: ENOSPC: no space left on device, write Oct 16 07:59:27 volumio volumio[850]: info: Preload queue cleared Oct 16 07:59:27 volumio volumio[850]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::ClearQueue Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::stop Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 07:59:27 volumio volumio[850]: info: CorePlayQueue::clearPlayQueue Oct 16 07:59:27 volumio volumio[850]: info: CorePlayQueue::saveQueue Oct 16 07:59:27 volumio volumio[850]: info: CoreCommandRouter::volumioPushQueue Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::addQueueItems Oct 16 07:59:27 volumio volumio[850]: info: CorePlayQueue::addQueueItems Oct 16 07:59:27 volumio volumio[850]: info: Preload queue cleared Oct 16 07:59:27 volumio volumio[850]: info: Adding Item to queue: http://192.168.2.103:8080/mic.mp3 Oct 16 07:59:27 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Oct 16 07:59:27 volumio volumio[850]: info: CoreCommandRouter::volumioPushQueue Oct 16 07:59:27 volumio volumio[850]: info: CorePlayQueue::saveQueue Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::updateTrackBlock Oct 16 07:59:27 volumio volumio[850]: info: CorePlayQueue::getTrackBlock Oct 16 07:59:27 volumio volumio[850]: info: CoreCommandRouter::volumioPlay Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::play index 0 Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::stop Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::play index undefined Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 07:59:27 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::startPlaybackTimer Oct 16 07:59:27 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 07:59:27 volumio volumio[850]: info: [1792137567362] ControllerWebradio::clearAddPlayTrack Oct 16 07:59:27 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 07:59:27 volumio volumio[850]: info: An error occurred saving queue to disk: Error: ENOSPC: no space left on device, write Oct 16 07:59:27 volumio volumio[850]: info: An error occurred saving queue to disk: Error: ENOSPC: no space left on device, write Oct 16 07:59:27 volumio volumio[850]: info: Preload queue cleared Oct 16 07:59:27 volumio volumio[850]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::ClearQueue Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::stop Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 07:59:27 volumio volumio[850]: info: CorePlayQueue::clearPlayQueue Oct 16 07:59:27 volumio volumio[850]: info: CorePlayQueue::saveQueue Oct 16 07:59:27 volumio volumio[850]: info: CoreCommandRouter::volumioPushQueue Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::addQueueItems Oct 16 07:59:27 volumio volumio[850]: info: CorePlayQueue::addQueueItems Oct 16 07:59:27 volumio volumio[850]: info: Preload queue cleared Oct 16 07:59:27 volumio volumio[850]: info: Adding Item to queue: http://192.168.2.103:8080/mic.mp3 Oct 16 07:59:27 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Oct 16 07:59:27 volumio volumio[850]: info: CoreCommandRouter::volumioPushQueue Oct 16 07:59:27 volumio volumio[850]: info: CorePlayQueue::saveQueue Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::updateTrackBlock Oct 16 07:59:27 volumio volumio[850]: info: CorePlayQueue::getTrackBlock Oct 16 07:59:27 volumio volumio[850]: info: CoreCommandRouter::volumioPlay Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::play index 0 Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::stop Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::play index undefined Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 07:59:27 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 07:59:27 volumio volumio[850]: info: CoreStateMachine::startPlaybackTimer Oct 16 07:59:27 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 07:59:27 volumio volumio[850]: info: [1792137567589] ControllerWebradio::clearAddPlayTrack Oct 16 07:59:27 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 07:59:27 volumio volumio[850]: info: An error occurred saving queue to disk: Error: ENOSPC: no space left on device, write Oct 16 07:59:27 volumio volumio[850]: info: An error occurred saving queue to disk: Error: ENOSPC: no space left on device, write Oct 16 07:59:29 volumio volumio[850]: info: Preload queue cleared Oct 16 07:59:31 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 16 07:59:31 volumio volumio[850]: info: CURURI: playlists Oct 16 07:59:31 volumio volumio[850]: info: Listing playlists Oct 16 07:59:31 volumio volumio[850]: info: Preload queue cleared Oct 16 07:59:32 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 16 07:59:32 volumio volumio[850]: info: CURURI: music-library Oct 16 07:59:33 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 16 07:59:33 volumio volumio[850]: info: CURURI: artists:// Oct 16 07:59:34 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 16 07:59:34 volumio volumio[850]: info: CURURI: albums:// Oct 16 07:59:34 volumio volumio[850]: info: listAlbums - loading Albums from cache Oct 16 07:59:34 volumio volumio[850]: info: Preload queue cleared Oct 16 07:59:36 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.2.103:8080/mic.mp3" Oct 16 07:59:36 volumio volumio[850]: Upnp client error: Error: This socket has been ended by the other party Oct 16 07:59:36 volumio volumio[850]: Upnp client error: Error: This socket has been ended by the other party Oct 16 07:59:36 volumio volumio[850]: info: Oct 16 07:59:36 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 07:59:36 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 07:59:36 volumio volumio[850]: info: Oct 16 07:59:36 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 07:59:36 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 07:59:36 volumio volumio[850]: info: Oct 16 07:59:36 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 07:59:36 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 07:59:36 volumio volumio[850]: info: sendMpdCommand status took 10201 milliseconds Oct 16 07:59:36 volumio volumio[850]: info: sendMpdCommand status took 10199 milliseconds Oct 16 07:59:36 volumio volumio[850]: info: sendMpdCommand stop took 9348 milliseconds Oct 16 07:59:36 volumio volumio[850]: info: sendMpdCommand stop took 9136 milliseconds Oct 16 07:59:36 volumio volumio[850]: info: sendMpdCommand stop took 8923 milliseconds Oct 16 07:59:36 volumio volumio[850]: info: sendMpdCommand stop took 8696 milliseconds Oct 16 07:59:36 volumio volumio[850]: info: sendMpdCommand add "http://192.168.2.103:8080/mic.mp3" took 38 milliseconds Oct 16 07:59:36 volumio volumio[850]: info: ------------------------------ 31ms Oct 16 07:59:36 volumio volumio[850]: info: ------------------------------ 29ms Oct 16 07:59:36 volumio volumio[850]: verbose: ControllerMpd::parseState Oct 16 07:59:36 volumio volumio[850]: verbose: ControllerMpd::parseState Oct 16 07:59:36 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 07:59:36 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 07:59:36 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 07:59:36 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 07:59:36 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 16 07:59:36 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand play Oct 16 07:59:36 volumio volumio[850]: info: ControllerMpd::pushState Oct 16 07:59:36 volumio volumio[850]: info: CoreCommandRouter::servicePushState Oct 16 07:59:36 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 07:59:36 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 07:59:36 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 07:59:36 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 07:59:36 volumio volumio[850]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 16 07:59:36 volumio volumio[850]: verbose: CURRENT POSITION 0 Oct 16 07:59:36 volumio volumio[850]: info: CoreStateMachine::syncState stateService stop Oct 16 07:59:36 volumio volumio[850]: info: CoreStateMachine::syncState currentStatus stop Oct 16 07:59:36 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 07:59:36 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 07:59:36 volumio volumio[850]: info: No code Oct 16 07:59:36 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 07:59:36 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 07:59:36 volumio volumio[850]: info: ControllerMpd::pushState Oct 16 07:59:36 volumio volumio[850]: info: CoreCommandRouter::servicePushState Oct 16 07:59:36 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 07:59:36 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 07:59:36 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 07:59:36 volumio volumio[850]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 16 07:59:36 volumio volumio[850]: verbose: CURRENT POSITION 0 Oct 16 07:59:36 volumio volumio[850]: info: CoreStateMachine::syncState stateService stop Oct 16 07:59:36 volumio volumio[850]: info: CoreStateMachine::syncState currentStatus stop Oct 16 07:59:36 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 07:59:36 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 07:59:36 volumio volumio[850]: info: No code Oct 16 07:59:36 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 07:59:36 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 07:59:36 volumio volumio[850]: info: ------------------------------ 10345ms Oct 16 07:59:36 volumio volumio[850]: info: ------------------------------ 10343ms Oct 16 07:59:36 volumio volumio[850]: Upnp client error: Error: This socket has been ended by the other party Oct 16 07:59:36 volumio volumio[850]: info: Preload queue cleared Oct 16 07:59:36 volumio volumio[850]: info: Preload queue cleared Oct 16 07:59:36 volumio volumio[850]: info: Oct 16 07:59:36 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 07:59:36 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 07:59:36 volumio volumio[850]: info: Oct 16 07:59:36 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 07:59:36 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 07:59:36 volumio volumio[850]: info: Oct 16 07:59:36 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 07:59:36 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 07:59:36 volumio volumio[850]: info: Oct 16 07:59:36 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 07:59:36 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 07:59:36 volumio volumio[850]: info: Oct 16 07:59:36 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 07:59:36 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 07:59:36 volumio volumio[850]: info: Oct 16 07:59:36 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 07:59:36 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 07:59:36 volumio volumio[850]: error: updateQueue error: null Oct 16 07:59:36 volumio volumio[850]: error: updateQueue error: null Oct 16 07:59:36 volumio volumio[850]: info: ------------------------------ 160ms Oct 16 07:59:36 volumio volumio[850]: info: sendMpdCommand clear took 155 milliseconds Oct 16 07:59:36 volumio volumio[850]: info: sendMpdCommand clear took 155 milliseconds Oct 16 07:59:36 volumio volumio[850]: info: sendMpdCommand clear took 155 milliseconds Oct 16 07:59:36 volumio volumio[850]: info: sendMpdCommand clear took 155 milliseconds Oct 16 07:59:36 volumio volumio[850]: info: sendMpdCommand play took 154 milliseconds Oct 16 07:59:36 volumio volumio[850]: info: ------------------------------ 7ms Oct 16 07:59:36 volumio volumio[850]: info: ------------------------------ 6ms Oct 16 07:59:36 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.2.103:8080/mic.mp3" Oct 16 07:59:36 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.2.103:8080/mic.mp3" Oct 16 07:59:36 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.2.103:8080/mic.mp3" Oct 16 07:59:36 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.2.103:8080/mic.mp3" Oct 16 07:59:36 volumio volumio[850]: info: Oct 16 07:59:36 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 07:59:36 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 07:59:36 volumio volumio[850]: info: Oct 16 07:59:36 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 07:59:36 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 07:59:36 volumio volumio[850]: error: updateQueue error: null Oct 16 07:59:36 volumio volumio[850]: error: updateQueue error: null Oct 16 07:59:36 volumio volumio[850]: error: updateQueue error: null Oct 16 07:59:36 volumio volumio[850]: error: updateQueue error: null Oct 16 07:59:36 volumio volumio[850]: info: ------------------------------ 41ms Oct 16 07:59:36 volumio volumio[850]: info: ------------------------------ 40ms Oct 16 07:59:36 volumio volumio[850]: info: ------------------------------ 40ms Oct 16 07:59:36 volumio volumio[850]: info: ------------------------------ 40ms Oct 16 07:59:36 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 16 07:59:36 volumio volumio[850]: info: CURURI: artists://02 Oct 16 07:59:38 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 16 07:59:38 volumio volumio[850]: info: CURURI: artists://10CC Oct 16 07:59:39 volumio volumio[850]: info: Preload queue cleared Oct 16 07:59:39 volumio volumio[850]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 16 07:59:39 volumio volumio[850]: info: CoreStateMachine::ClearQueue Oct 16 07:59:39 volumio volumio[850]: info: CoreStateMachine::stop Oct 16 07:59:39 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 07:59:39 volumio volumio[850]: info: CorePlayQueue::clearPlayQueue Oct 16 07:59:39 volumio volumio[850]: info: CorePlayQueue::saveQueue Oct 16 07:59:39 volumio volumio[850]: info: CoreCommandRouter::volumioPushQueue Oct 16 07:59:39 volumio volumio[850]: info: CoreStateMachine::addQueueItems Oct 16 07:59:39 volumio volumio[850]: info: CorePlayQueue::addQueueItems Oct 16 07:59:39 volumio volumio[850]: info: Preload queue cleared Oct 16 07:59:39 volumio volumio[850]: info: Adding Item to queue: artists://10CC Oct 16 07:59:39 volumio volumio[850]: info: Exploding uri artists://10CC in service mpd Oct 16 07:59:39 volumio volumio[850]: info: An error occurred saving queue to disk: Error: ENOSPC: no space left on device, write Oct 16 07:59:40 volumio volumio[850]: info: Preload queue cleared Oct 16 07:59:40 volumio volumio[850]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 16 07:59:40 volumio volumio[850]: info: CoreStateMachine::ClearQueue Oct 16 07:59:40 volumio volumio[850]: info: CoreStateMachine::stop Oct 16 07:59:40 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 07:59:40 volumio volumio[850]: info: CorePlayQueue::clearPlayQueue Oct 16 07:59:40 volumio volumio[850]: info: CorePlayQueue::saveQueue Oct 16 07:59:40 volumio volumio[850]: info: CoreCommandRouter::volumioPushQueue Oct 16 07:59:40 volumio volumio[850]: info: CoreStateMachine::addQueueItems Oct 16 07:59:40 volumio volumio[850]: info: CorePlayQueue::addQueueItems Oct 16 07:59:40 volumio volumio[850]: info: Preload queue cleared Oct 16 07:59:40 volumio volumio[850]: info: Adding Item to queue: artists://10CC Oct 16 07:59:40 volumio volumio[850]: info: Exploding uri artists://10CC in service mpd Oct 16 07:59:40 volumio volumio[850]: info: An error occurred saving queue to disk: Error: ENOSPC: no space left on device, write Oct 16 07:59:40 volumio volumio[850]: info: Preload queue cleared Oct 16 07:59:40 volumio volumio[850]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 16 07:59:40 volumio volumio[850]: info: CoreStateMachine::ClearQueue Oct 16 07:59:40 volumio volumio[850]: info: CoreStateMachine::stop Oct 16 07:59:40 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 07:59:40 volumio volumio[850]: info: CorePlayQueue::clearPlayQueue Oct 16 07:59:40 volumio volumio[850]: info: CorePlayQueue::saveQueue Oct 16 07:59:40 volumio volumio[850]: info: CoreCommandRouter::volumioPushQueue Oct 16 07:59:40 volumio volumio[850]: info: CoreStateMachine::addQueueItems Oct 16 07:59:40 volumio volumio[850]: info: CorePlayQueue::addQueueItems Oct 16 07:59:40 volumio volumio[850]: info: Preload queue cleared Oct 16 07:59:40 volumio volumio[850]: info: Adding Item to queue: artists://10CC Oct 16 07:59:40 volumio volumio[850]: info: Exploding uri artists://10CC in service mpd Oct 16 07:59:40 volumio volumio[850]: info: An error occurred saving queue to disk: Error: ENOSPC: no space left on device, write Oct 16 07:59:40 volumio volumio[850]: info: Preload queue cleared Oct 16 07:59:40 volumio volumio[850]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 16 07:59:40 volumio volumio[850]: info: CoreStateMachine::ClearQueue Oct 16 07:59:40 volumio volumio[850]: info: CoreStateMachine::stop Oct 16 07:59:41 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 07:59:41 volumio volumio[850]: info: CorePlayQueue::clearPlayQueue Oct 16 07:59:41 volumio volumio[850]: info: CorePlayQueue::saveQueue Oct 16 07:59:41 volumio volumio[850]: info: CoreCommandRouter::volumioPushQueue Oct 16 07:59:41 volumio volumio[850]: info: CoreStateMachine::addQueueItems Oct 16 07:59:41 volumio volumio[850]: info: CorePlayQueue::addQueueItems Oct 16 07:59:41 volumio volumio[850]: info: Preload queue cleared Oct 16 07:59:41 volumio volumio[850]: info: Adding Item to queue: artists://10CC Oct 16 07:59:41 volumio volumio[850]: info: Exploding uri artists://10CC in service mpd Oct 16 07:59:41 volumio volumio[850]: info: An error occurred saving queue to disk: Error: ENOSPC: no space left on device, write Oct 16 07:59:47 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.2.103:8080/mic.mp3" Oct 16 08:00:20 volumio volumio[850]: Upnp client error: Error: This socket has been ended by the other party Oct 16 08:00:20 volumio volumio[850]: Upnp client error: Error: This socket has been ended by the other party Oct 16 08:00:20 volumio volumio[850]: error: updateQueue error: null Oct 16 08:00:20 volumio volumio[850]: error: updateQueue error: null Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 08:00:20 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.2.103:8080/mic.mp3" Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.2.103:8080/mic.mp3" Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.2.103:8080/mic.mp3" Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 43797ms Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 43794ms Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand add "http://192.168.2.103:8080/mic.mp3" took 33026 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand play Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPushQueue Oct 16 08:00:20 volumio volumio[850]: info: CorePlayQueue::saveQueue Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPushQueue Oct 16 08:00:20 volumio volumio[850]: info: CorePlayQueue::saveQueue Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPushQueue Oct 16 08:00:20 volumio volumio[850]: info: CorePlayQueue::saveQueue Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPushQueue Oct 16 08:00:20 volumio volumio[850]: info: CorePlayQueue::saveQueue Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::updateTrackBlock Oct 16 08:00:20 volumio volumio[850]: info: CorePlayQueue::getTrackBlock Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::updateTrackBlock Oct 16 08:00:20 volumio volumio[850]: info: CorePlayQueue::getTrackBlock Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::updateTrackBlock Oct 16 08:00:20 volumio volumio[850]: info: CorePlayQueue::getTrackBlock Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::updateTrackBlock Oct 16 08:00:20 volumio volumio[850]: info: CorePlayQueue::getTrackBlock Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPlay Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::play index 0 Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPlay Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::play index 0 Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPlay Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::play index 0 Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPlay Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::play index 0 Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::stop Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::stop Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::stop Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::stop Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::play index undefined Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::play index undefined Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::play index undefined Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::play index undefined Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 08:00:20 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::startPlaybackTimer Oct 16 08:00:20 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::clearAddPlayTracks USB/MUSIK/Musik/KUSCHELROCK/KUSCHELROCK VOL. 01 - CD2/15 10CC - I'm Not In Love.wav Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 08:00:20 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::startPlaybackTimer Oct 16 08:00:20 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::clearAddPlayTracks USB/MUSIK/Musik/KUSCHELROCK/KUSCHELROCK VOL. 01 - CD2/15 10CC - I'm Not In Love.wav Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 08:00:20 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::startPlaybackTimer Oct 16 08:00:20 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::clearAddPlayTracks USB/MUSIK/Musik/KUSCHELROCK/KUSCHELROCK VOL. 01 - CD2/15 10CC - I'm Not In Love.wav Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 08:00:20 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::startPlaybackTimer Oct 16 08:00:20 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::clearAddPlayTracks USB/MUSIK/Musik/KUSCHELROCK/KUSCHELROCK VOL. 01 - CD2/15 10CC - I'm Not In Love.wav Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 08:00:20 volumio volumio[850]: Upnp client error: Error: This socket has been ended by the other party Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 08:00:20 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 08:00:20 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 08:00:20 volumio volumio[850]: Upnp client error: Error: This socket has been ended by the other party Oct 16 08:00:20 volumio volumio[850]: Upnp client error: Error: This socket has been ended by the other party Oct 16 08:00:20 volumio volumio[850]: Upnp client error: Error: This socket has been ended by the other party Oct 16 08:00:20 volumio volumio[850]: Upnp client error: Error: This socket has been ended by the other party Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 08:00:20 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 08:00:20 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 08:00:20 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces state update: player Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand add "http://192.168.2.103:8080/mic.mp3" took 50 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand add "http://192.168.2.103:8080/mic.mp3" took 50 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand add "http://192.168.2.103:8080/mic.mp3" took 49 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 52ms Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand play took 43 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand stop took 14 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: ControllerMpd::getState Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand stop took 13 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand stop took 12 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand stop took 16 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 14ms Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 13ms Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand play Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand play Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand play Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 08:00:20 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces state update: player Oct 16 08:00:20 volumio volumio[850]: info: ControllerMpd::getState Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 08:00:20 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces state update: player Oct 16 08:00:20 volumio volumio[850]: info: ControllerMpd::getState Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:00:20 volumio volumio[850]: info: Preload queue cleared Oct 16 08:00:20 volumio volumio[850]: info: Preload queue cleared Oct 16 08:00:20 volumio volumio[850]: info: Preloading song: music-library/USB/MUSIK/Musik/Ca Ira CD 1(Roger Waters)/02 02 - Overture.wav Oct 16 08:00:20 volumio volumio[850]: info: Preloading song: music-library/USB/MUSIK/Musik/christmas songs/02 02 - White Christmas - Bing Crosby.wav Oct 16 08:00:20 volumio volumio[850]: info: Preloading song: music-library/USB/MUSIK/Musik/Dire Straits & Mark Knopfler/dire straits + mark knopfler/01 Sweet Dreams.wav Oct 16 08:00:20 volumio volumio[850]: info: Preloading song: music-library/USB/MUSIK/Musik/Incentive Care (Robby Williams)/02 02 - Tripping.wav Oct 16 08:00:20 volumio volumio[850]: info: Preloading song: music-library/USB/MUSIK/Musik/Not Too Late (Norah Jones)/02 - Sinkin' Soon.wav Oct 16 08:00:20 volumio volumio[850]: info: Preloading song: music-library/USB/MUSIK/Musik/picture of blues/04 blunt - You're Beautiful.wav Oct 16 08:00:20 volumio volumio[850]: info: Preload queue cleared Oct 16 08:00:20 volumio volumio[850]: info: Preload queue cleared Oct 16 08:00:20 volumio volumio[850]: info: Preloading song: music-library/USB/MUSIK/Musik/KUSCHELROCK/KUSCHELROCK VOL. 01 - CD2/15 10CC - I'm Not In Love.wav Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 08:00:20 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces state update: player Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 08:00:20 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 08:00:20 volumio volumio[850]: error: updateQueue error: null Oct 16 08:00:20 volumio volumio[850]: error: updateQueue error: null Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 33ms Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 32ms Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 32ms Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand status took 30 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand play took 23 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand play took 23 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand play took 23 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand clear took 23 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: ControllerMpd::getState Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand clear took 23 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand clear took 23 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand clear took 23 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 21ms Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand status took 21 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 20ms Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand status took 19 milliseconds Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::parseState Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand add "USB/MUSIK/Musik/KUSCHELROCK/KUSCHELROCK VOL. 01 - CD2/15 10CC - I'm Not In Love.wav" Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand add "USB/MUSIK/Musik/KUSCHELROCK/KUSCHELROCK VOL. 01 - CD2/15 10CC - I'm Not In Love.wav" Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand add "USB/MUSIK/Musik/KUSCHELROCK/KUSCHELROCK VOL. 01 - CD2/15 10CC - I'm Not In Love.wav" Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand add "USB/MUSIK/Musik/KUSCHELROCK/KUSCHELROCK VOL. 01 - CD2/15 10CC - I'm Not In Love.wav" Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::parseState Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::parseState Oct 16 08:00:20 volumio volumio[850]: info: ControllerMpd::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::servicePushState Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 08:00:20 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 08:00:20 volumio volumio[850]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 16 08:00:20 volumio volumio[850]: verbose: CURRENT POSITION 0 Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::syncState stateService stop Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 08:00:20 volumio volumio[850]: info: No code Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 08:00:20 volumio volumio[850]: info: ControllerMpd::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::servicePushState Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 08:00:20 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 08:00:20 volumio volumio[850]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 16 08:00:20 volumio volumio[850]: verbose: CURRENT POSITION 0 Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::syncState stateService stop Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 08:00:20 volumio volumio[850]: info: No code Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 70ms Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 69ms Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 08:00:20 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces state update: player Oct 16 08:00:20 volumio volumio[850]: info: ControllerMpd::getState Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 08:00:20 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces state update: player Oct 16 08:00:20 volumio volumio[850]: info: ControllerMpd::getState Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:00:20 volumio volumio[850]: info: Exploding uri music-library/USB/MUSIK/Musik/KUSCHELROCK/KUSCHELROCK VOL. 01 - CD2/15 10CC - I'm Not In Love.wav in service mpd Oct 16 08:00:20 volumio volumio[850]: error: updateQueue error: null Oct 16 08:00:20 volumio volumio[850]: error: updateQueue error: null Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 08:00:20 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 08:00:20 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 08:00:20 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 08:00:20 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 08:00:20 volumio volumio[850]: info: ALBUMART /albumart?cacheid=415&web=10CC/Kuschelrock%20Vol.01/extralarge&path=%2Fmnt%2FUSB%2FMUSIK%2FMusik%2FKUSCHELROCK%2FKUSCHELROCK%20VOL.%2001%20-%20CD2%2F15%2010CC%20-%20I'm%20Not%20In%20Love.wav&metadata=false Oct 16 08:00:20 volumio volumio[850]: info: URI /mnt/USB/MUSIK/Musik/KUSCHELROCK/KUSCHELROCK VOL. 01 - CD2/15 10CC - I'm Not In Love.wav Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 72ms Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand status took 69 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 72ms Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand playlistinfo took 66 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand add "USB/MUSIK/Musik/KUSCHELROCK/KUSCHELROCK VOL. 01 - CD2/15 10CC - I'm Not In Love.wav" took 66 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand add "USB/MUSIK/Musik/KUSCHELROCK/KUSCHELROCK VOL. 01 - CD2/15 10CC - I'm Not In Love.wav" took 65 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand add "USB/MUSIK/Musik/KUSCHELROCK/KUSCHELROCK VOL. 01 - CD2/15 10CC - I'm Not In Love.wav" took 66 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand add "USB/MUSIK/Musik/KUSCHELROCK/KUSCHELROCK VOL. 01 - CD2/15 10CC - I'm Not In Love.wav" took 66 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 18ms Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand status took 17 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 17ms Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand status took 16 milliseconds Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::parseState Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::parseTrackInfo Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand play Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand play Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand play Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand play Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::parseState Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::parseState Oct 16 08:00:20 volumio volumio[850]: info: ControllerMpd::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::servicePushState Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 08:00:20 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 08:00:20 volumio volumio[850]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 16 08:00:20 volumio volumio[850]: verbose: CURRENT POSITION 0 Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::syncState stateService stop Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 08:00:20 volumio volumio[850]: info: No code Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 08:00:20 volumio volumio[850]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 16 08:00:20 volumio volumio[850]: info: ControllerMpd::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::servicePushState Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 08:00:20 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Oct 16 08:00:20 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 08:00:20 volumio volumio[850]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 16 08:00:20 volumio volumio[850]: verbose: CURRENT POSITION 0 Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::syncState stateService stop Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 08:00:20 volumio volumio[850]: info: No code Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 08:00:20 volumio volumio[850]: info: ControllerMpd::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::servicePushState Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 08:00:20 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 08:00:20 volumio volumio[850]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 16 08:00:20 volumio volumio[850]: verbose: CURRENT POSITION 0 Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::syncState stateService stop Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 08:00:20 volumio volumio[850]: info: No code Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 172ms Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 202ms Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 118ms Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 117ms Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 08:00:20 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces system playlist update Oct 16 08:00:20 volumio volumio[850]: info: Ignoring MPD Status Update Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces state update: player Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces state update: player Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 158ms Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 158ms Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 158ms Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 158ms Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand play took 149 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand play took 149 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand play took 148 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand play took 148 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: ControllerMpd::getState Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 50ms Oct 16 08:00:20 volumio volumio[850]: info: ControllerMpd::getState Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 49ms Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces state update: player Oct 16 08:00:20 volumio volumio[850]: info: ControllerMpd::getState Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:00:20 volumio volumio[850]: info: Oct 16 08:00:20 volumio volumio[850]: ---------------------------- MPD announces state update: player Oct 16 08:00:20 volumio volumio[850]: info: ControllerMpd::getState Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand status Oct 16 08:00:20 volumio volumio[850]: info: An error occurred saving queue to disk: Error: ENOSPC: no space left on device, write Oct 16 08:00:20 volumio volumio[850]: info: An error occurred saving queue to disk: Error: ENOSPC: no space left on device, write Oct 16 08:00:20 volumio volumio[850]: info: An error occurred saving queue to disk: Error: ENOSPC: no space left on device, write Oct 16 08:00:20 volumio volumio[850]: info: An error occurred saving queue to disk: Error: ENOSPC: no space left on device, write Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand status took 24 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand status took 24 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand status took 23 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand status took 22 milliseconds Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::parseState Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::parseState Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::parseState Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::parseState Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 16 08:00:20 volumio volumio[850]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::parseTrackInfo Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::parseTrackInfo Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::parseTrackInfo Oct 16 08:00:20 volumio volumio[850]: verbose: ControllerMpd::parseTrackInfo Oct 16 08:00:20 volumio volumio[850]: info: ControllerMpd::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::servicePushState Oct 16 08:00:20 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 08:00:20 volumio volumio[850]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":356,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I'm Not In Love","artist":"10CC","album":"Kuschelrock Vol.01","uri":"USB/MUSIK/Musik/KUSCHELROCK/KUSCHELROCK VOL. 01 - CD2/15 10CC - I'm Not In Love.wav","trackType":"wav"} Oct 16 08:00:20 volumio volumio[850]: verbose: CURRENT POSITION 0 Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::syncState stateService play Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::syncState currentStatus stop Oct 16 08:00:20 volumio volumio[850]: info: ControllerMpd::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::servicePushState Oct 16 08:00:20 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 08:00:20 volumio volumio[850]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":356,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I'm Not In Love","artist":"10CC","album":"Kuschelrock Vol.01","uri":"USB/MUSIK/Musik/KUSCHELROCK/KUSCHELROCK VOL. 01 - CD2/15 10CC - I'm Not In Love.wav","trackType":"wav"} Oct 16 08:00:20 volumio volumio[850]: verbose: CURRENT POSITION 0 Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::syncState stateService play Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::syncState currentStatus play Oct 16 08:00:20 volumio volumio[850]: info: Received an update from plugin. extracting info from payload Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 08:00:20 volumio volumio[850]: info: ControllerMpd::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::servicePushState Oct 16 08:00:20 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 08:00:20 volumio volumio[850]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":356,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I'm Not In Love","artist":"10CC","album":"Kuschelrock Vol.01","uri":"USB/MUSIK/Musik/KUSCHELROCK/KUSCHELROCK VOL. 01 - CD2/15 10CC - I'm Not In Love.wav","trackType":"wav"} Oct 16 08:00:20 volumio volumio[850]: verbose: CURRENT POSITION 0 Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::syncState stateService play Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::syncState currentStatus play Oct 16 08:00:20 volumio volumio[850]: info: Received an update from plugin. extracting info from payload Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 08:00:20 volumio volumio[850]: info: ControllerMpd::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::servicePushState Oct 16 08:00:20 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Oct 16 08:00:20 volumio volumio[850]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":356,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I'm Not In Love","artist":"10CC","album":"Kuschelrock Vol.01","uri":"USB/MUSIK/Musik/KUSCHELROCK/KUSCHELROCK VOL. 01 - CD2/15 10CC - I'm Not In Love.wav","trackType":"wav"} Oct 16 08:00:20 volumio volumio[850]: verbose: CURRENT POSITION 0 Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::syncState stateService play Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::syncState currentStatus play Oct 16 08:00:20 volumio volumio[850]: info: Received an update from plugin. extracting info from payload Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 08:00:20 volumio volumio[850]: info: CoreStateMachine::pushState Oct 16 08:00:20 volumio volumio[850]: info: CoreCommandRouter::volumioPushState Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 58ms Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 84ms Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 82ms Oct 16 08:00:20 volumio volumio[850]: info: ------------------------------ 81ms Oct 16 08:00:20 volumio volumio[850]: Upnp client error: Error: This socket has been ended by the other party Oct 16 08:00:20 volumio volumio[850]: Error saving last played file: Error: ENOSPC: no space left on device, write Oct 16 08:00:20 volumio volumio[850]: Upnp client error: Error: This socket has been ended by the other party Oct 16 08:00:21 volumio volumio[850]: Upnp client error: Error: This socket has been ended by the other party Oct 16 08:00:23 volumio volumio[850]: Upnp client error: Error: This socket has been ended by the other party Oct 16 08:00:27 volumio volumio[850]: Upnp client error: Error: This socket has been ended by the other party Oct 16 08:00:28 volumio volumio[850]: Upnp client error: Error: This socket has been ended by the other party Oct 16 08:00:29 volumio volumio[850]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 08:00:29 volumio volumio[850]: [Error: ENOSPC: no space left on device, write] { Oct 16 08:00:29 volumio volumio[850]: errno: -28, Oct 16 08:00:29 volumio volumio[850]: code: 'ENOSPC', Oct 16 08:00:29 volumio volumio[850]: syscall: 'write' Oct 16 08:00:29 volumio volumio[850]: } Oct 16 08:00:29 volumio volumio[850]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 08:00:30 volumio sudo[1695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-16 07:59 Oct 16 08:00:30 volumio sudo[1695]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="f8baf7ad070f376535a93fcc6590774528ddb153" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="0e3cf2fcfe1906c5090fab62b4cc2a5ff0069fd8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 30 Jan 2024 03:58:37 PM CET" VOLUMIO_VERSION="3.611" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="1d6379ebb89c40061afa8aee78176887"