-- Logs begin at Wed 2024-10-16 09:25:46 CEST, end at Wed 2024-10-16 10:55:14 CEST. -- Oct 16 10:54:00 raspdac volumio[999]: info: CoreCommandRouter::volumioPrevious Oct 16 10:54:00 raspdac volumio[999]: info: CoreStateMachine::previous Oct 16 10:54:00 raspdac volumio[999]: info: CorePlayQueue::getTrack 9724 Oct 16 10:54:00 raspdac volumio[999]: info: CoreStateMachine::stop Oct 16 10:54:00 raspdac volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 10:54:00 raspdac volumio[999]: info: CoreStateMachine::stPlaybackTimer Oct 16 10:54:00 raspdac volumio[999]: info: CoreStateMachine::updateTrackBlock Oct 16 10:54:00 raspdac volumio[999]: info: CorePlayQueue::getTrackBlock Oct 16 10:54:00 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:00 raspdac volumio[999]: info: CorePlayQueue::getTrack 9724 Oct 16 10:54:00 raspdac volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 10:54:00 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:00 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:00 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:00 raspdac volumio[999]: info: CoreStateMachine::serviceStop Oct 16 10:54:00 raspdac volumio[999]: info: CorePlayQueue::getTrack 9724 Oct 16 10:54:00 raspdac volumio[999]: info: CoreCommandRouter::serviceStop Oct 16 10:54:00 raspdac volumio[999]: info: ControllerMpd::stop Oct 16 10:54:00 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 10:54:00 raspdac volumio[999]: info: Oct 16 10:54:00 raspdac volumio[999]: ---------------------------- MPD announces state update: player Oct 16 10:54:00 raspdac volumio[999]: info: sendMpdCommand stop took 9 milliseconds Oct 16 10:54:00 raspdac volumio[999]: info: ControllerMpd::getState Oct 16 10:54:00 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand status Oct 16 10:54:00 raspdac volumio[999]: info: sendMpdCommand status took 1 milliseconds Oct 16 10:54:00 raspdac volumio[999]: verbose: ControllerMpd::parseState Oct 16 10:54:00 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 10:54:00 raspdac volumio[999]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 16 10:54:00 raspdac volumio[999]: verbose: ControllerMpd::parseTrackInfo Oct 16 10:54:00 raspdac volumio[999]: info: ControllerMpd::pushState Oct 16 10:54:00 raspdac volumio[999]: info: CoreCommandRouter::servicePushState Oct 16 10:54:00 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:00 raspdac volumio[999]: info: CorePlayQueue::getTrack 9724 Oct 16 10:54:00 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:00 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:00 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:00 raspdac volumio[999]: info: CorePlayQueue::getTrack 9724 Oct 16 10:54:00 raspdac volumio[999]: 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":"T.Z.","artist":"Stiller Has","album":"Moudi","uri":"USB/KINGSTON/music/Stiller Has/Moudi/11 Stiller Has T.Z..flac","trackType":"flac"} Oct 16 10:54:00 raspdac volumio[999]: verbose: CURRENT POSITION 9724 Oct 16 10:54:00 raspdac volumio[999]: info: CoreStateMachine::syncState stateService stop Oct 16 10:54:00 raspdac volumio[999]: info: CoreStateMachine::syncState currentStatus stop Oct 16 10:54:00 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:00 raspdac volumio[999]: info: CorePlayQueue::getTrack 9724 Oct 16 10:54:00 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:00 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:00 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:00 raspdac volumio[999]: info: No code Oct 16 10:54:00 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:00 raspdac volumio[999]: info: CorePlayQueue::getTrack 9724 Oct 16 10:54:00 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:00 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:00 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:00 raspdac volumio[999]: info: ------------------------------ 16ms Oct 16 10:54:00 raspdac volumio[999]: info: CoreStateMachine::play index undefined Oct 16 10:54:00 raspdac volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 10:54:00 raspdac volumio[999]: info: CorePlayQueue::getTrack 9723 Oct 16 10:54:00 raspdac volumio[999]: info: CoreStateMachine::startPlaybackTimer Oct 16 10:54:00 raspdac volumio[999]: info: CorePlayQueue::getTrack 9723 Oct 16 10:54:00 raspdac volumio[999]: verbose: ControllerMpd::clearAddPlayTracks USB/KINGSTON/music/Stiller Has/Moudi/10 Stiller Has Ängle.flac Oct 16 10:54:00 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 10:54:00 raspdac volumio[999]: info: sendMpdCommand stop took 1 milliseconds Oct 16 10:54:00 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 10:54:00 raspdac volumio[999]: info: Oct 16 10:54:00 raspdac volumio[999]: ---------------------------- MPD announces system playlist update Oct 16 10:54:00 raspdac volumio[999]: info: Ignoring MPD Status Update Oct 16 10:54:00 raspdac volumio[999]: info: sendMpdCommand clear took 1 milliseconds Oct 16 10:54:00 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand add "USB/KINGSTON/music/Stiller Has/Moudi/10 Stiller Has Ängle.flac" Oct 16 10:54:00 raspdac volumio[999]: error: updateQueue error: null Oct 16 10:54:00 raspdac volumio[999]: info: Oct 16 10:54:00 raspdac volumio[999]: ---------------------------- MPD announces system playlist update Oct 16 10:54:00 raspdac volumio[999]: info: Ignoring MPD Status Update Oct 16 10:54:00 raspdac volumio[999]: info: ------------------------------ 3ms Oct 16 10:54:00 raspdac volumio[999]: info: sendMpdCommand add "USB/KINGSTON/music/Stiller Has/Moudi/10 Stiller Has Ängle.flac" took 2 milliseconds Oct 16 10:54:00 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand play Oct 16 10:54:00 raspdac volumio[999]: info: ------------------------------ 3ms Oct 16 10:54:00 raspdac volumio[999]: info: sendMpdCommand play took 2 milliseconds Oct 16 10:54:00 raspdac volumio[999]: info: Oct 16 10:54:00 raspdac volumio[999]: ---------------------------- MPD announces state update: player Oct 16 10:54:00 raspdac volumio[999]: info: ControllerMpd::getState Oct 16 10:54:00 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand status Oct 16 10:54:00 raspdac volumio[999]: info: Oct 16 10:54:00 raspdac volumio[999]: ---------------------------- MPD announces state update: player Oct 16 10:54:00 raspdac volumio[999]: info: sendMpdCommand status took 39 milliseconds Oct 16 10:54:00 raspdac volumio[999]: info: ControllerMpd::getState Oct 16 10:54:00 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand status Oct 16 10:54:00 raspdac volumio[999]: verbose: ControllerMpd::parseState Oct 16 10:54:00 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 10:54:00 raspdac volumio[999]: info: sendMpdCommand status took 1 milliseconds Oct 16 10:54:00 raspdac volumio[999]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 10:54:00 raspdac volumio[999]: verbose: ControllerMpd::parseState Oct 16 10:54:00 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 10:54:00 raspdac volumio[999]: verbose: ControllerMpd::parseTrackInfo Oct 16 10:54:00 raspdac volumio[999]: info: ControllerMpd::pushState Oct 16 10:54:00 raspdac volumio[999]: info: CoreCommandRouter::servicePushState Oct 16 10:54:00 raspdac volumio[999]: info: CorePlayQueue::getTrack 9723 Oct 16 10:54:00 raspdac volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ängle","artist":"Stiller Has","album":"Moudi","uri":"USB/KINGSTON/music/Stiller Has/Moudi/10 Stiller Has Ängle.flac","trackType":"flac"} Oct 16 10:54:00 raspdac volumio[999]: verbose: CURRENT POSITION 9723 Oct 16 10:54:00 raspdac volumio[999]: info: CoreStateMachine::syncState stateService play Oct 16 10:54:00 raspdac volumio[999]: info: CoreStateMachine::syncState currentStatus stop Oct 16 10:54:00 raspdac volumio[999]: info: ------------------------------ 43ms Oct 16 10:54:00 raspdac volumio[999]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 10:54:00 raspdac volumio[999]: verbose: ControllerMpd::parseTrackInfo Oct 16 10:54:00 raspdac volumio[999]: info: ControllerMpd::pushState Oct 16 10:54:00 raspdac volumio[999]: info: CoreCommandRouter::servicePushState Oct 16 10:54:00 raspdac volumio[999]: info: CorePlayQueue::getTrack 9723 Oct 16 10:54:00 raspdac volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":411,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"736 Kbps","isStreaming":false,"title":"Ängle","artist":"Stiller Has","album":"Moudi","uri":"USB/KINGSTON/music/Stiller Has/Moudi/10 Stiller Has Ängle.flac","trackType":"flac"} Oct 16 10:54:00 raspdac volumio[999]: verbose: CURRENT POSITION 9723 Oct 16 10:54:00 raspdac volumio[999]: info: CoreStateMachine::syncState stateService play Oct 16 10:54:00 raspdac volumio[999]: info: CoreStateMachine::syncState currentStatus play Oct 16 10:54:00 raspdac volumio[999]: info: Received an update from plugin. extracting info from payload Oct 16 10:54:00 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:00 raspdac volumio[999]: info: CorePlayQueue::getTrack 9723 Oct 16 10:54:00 raspdac volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 10:54:00 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:00 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:00 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:00 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:00 raspdac volumio[999]: info: CorePlayQueue::getTrack 9723 Oct 16 10:54:00 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:00 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:00 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:00 raspdac volumio[999]: info: ------------------------------ 25ms Oct 16 10:54:01 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:01 raspdac volumio[999]: info: CorePlayQueue::getTrack 9723 Oct 16 10:54:01 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:01 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:01 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:01 raspdac volumio[999]: info: CoreCommandRouter::volumioPrevious Oct 16 10:54:01 raspdac volumio[999]: info: CoreStateMachine::previous Oct 16 10:54:01 raspdac volumio[999]: info: CorePlayQueue::getTrack 9723 Oct 16 10:54:01 raspdac volumio[999]: info: CoreStateMachine::stop Oct 16 10:54:01 raspdac volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 10:54:01 raspdac volumio[999]: info: CoreStateMachine::stPlaybackTimer Oct 16 10:54:01 raspdac volumio[999]: info: CoreStateMachine::updateTrackBlock Oct 16 10:54:01 raspdac volumio[999]: info: CorePlayQueue::getTrackBlock Oct 16 10:54:01 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:01 raspdac volumio[999]: info: CorePlayQueue::getTrack 9723 Oct 16 10:54:01 raspdac volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 10:54:01 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:01 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:01 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:01 raspdac volumio[999]: info: CoreStateMachine::serviceStop Oct 16 10:54:01 raspdac volumio[999]: info: CorePlayQueue::getTrack 9723 Oct 16 10:54:01 raspdac volumio[999]: info: CoreCommandRouter::serviceStop Oct 16 10:54:01 raspdac volumio[999]: info: ControllerMpd::stop Oct 16 10:54:01 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 10:54:01 raspdac volumio[999]: info: Oct 16 10:54:01 raspdac volumio[999]: ---------------------------- MPD announces state update: player Oct 16 10:54:01 raspdac volumio[999]: info: sendMpdCommand stop took 13 milliseconds Oct 16 10:54:01 raspdac volumio[999]: info: ControllerMpd::getState Oct 16 10:54:01 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand status Oct 16 10:54:01 raspdac volumio[999]: info: sendMpdCommand status took 1 milliseconds Oct 16 10:54:01 raspdac volumio[999]: verbose: ControllerMpd::parseState Oct 16 10:54:01 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 10:54:01 raspdac volumio[999]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 10:54:01 raspdac volumio[999]: verbose: ControllerMpd::parseTrackInfo Oct 16 10:54:01 raspdac volumio[999]: info: ControllerMpd::pushState Oct 16 10:54:01 raspdac volumio[999]: info: CoreCommandRouter::servicePushState Oct 16 10:54:01 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:01 raspdac volumio[999]: info: CorePlayQueue::getTrack 9723 Oct 16 10:54:01 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:01 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:01 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:01 raspdac volumio[999]: info: CorePlayQueue::getTrack 9723 Oct 16 10:54:01 raspdac volumio[999]: 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":"Ängle","artist":"Stiller Has","album":"Moudi","uri":"USB/KINGSTON/music/Stiller Has/Moudi/10 Stiller Has Ängle.flac","trackType":"flac"} Oct 16 10:54:01 raspdac volumio[999]: verbose: CURRENT POSITION 9723 Oct 16 10:54:01 raspdac volumio[999]: info: CoreStateMachine::syncState stateService stop Oct 16 10:54:01 raspdac volumio[999]: info: CoreStateMachine::syncState currentStatus stop Oct 16 10:54:01 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:01 raspdac volumio[999]: info: CorePlayQueue::getTrack 9723 Oct 16 10:54:01 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:01 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:01 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:01 raspdac volumio[999]: info: No code Oct 16 10:54:01 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:01 raspdac volumio[999]: info: CorePlayQueue::getTrack 9723 Oct 16 10:54:01 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:01 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:01 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:01 raspdac volumio[999]: info: ------------------------------ 19ms Oct 16 10:54:02 raspdac volumio[999]: info: CoreStateMachine::play index undefined Oct 16 10:54:02 raspdac volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 10:54:02 raspdac volumio[999]: info: CorePlayQueue::getTrack 9722 Oct 16 10:54:02 raspdac volumio[999]: info: CoreStateMachine::startPlaybackTimer Oct 16 10:54:02 raspdac volumio[999]: info: CorePlayQueue::getTrack 9722 Oct 16 10:54:02 raspdac volumio[999]: verbose: ControllerMpd::clearAddPlayTracks USB/KINGSTON/music/Stiller Has/Moudi/09 Stiller Has Mannli.flac Oct 16 10:54:02 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 10:54:02 raspdac volumio[999]: info: sendMpdCommand stop took 1 milliseconds Oct 16 10:54:02 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 10:54:02 raspdac volumio[999]: info: Oct 16 10:54:02 raspdac volumio[999]: ---------------------------- MPD announces system playlist update Oct 16 10:54:02 raspdac volumio[999]: info: Ignoring MPD Status Update Oct 16 10:54:02 raspdac volumio[999]: info: sendMpdCommand clear took 1 milliseconds Oct 16 10:54:02 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand add "USB/KINGSTON/music/Stiller Has/Moudi/09 Stiller Has Mannli.flac" Oct 16 10:54:02 raspdac volumio[999]: error: updateQueue error: null Oct 16 10:54:02 raspdac volumio[999]: info: ------------------------------ 1ms Oct 16 10:54:02 raspdac volumio[999]: info: Oct 16 10:54:02 raspdac volumio[999]: ---------------------------- MPD announces system playlist update Oct 16 10:54:02 raspdac volumio[999]: info: Ignoring MPD Status Update Oct 16 10:54:02 raspdac volumio[999]: info: sendMpdCommand add "USB/KINGSTON/music/Stiller Has/Moudi/09 Stiller Has Mannli.flac" took 1 milliseconds Oct 16 10:54:02 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand play Oct 16 10:54:02 raspdac volumio[999]: info: ------------------------------ 1ms Oct 16 10:54:02 raspdac volumio[999]: info: sendMpdCommand play took 2 milliseconds Oct 16 10:54:02 raspdac volumio[999]: info: Oct 16 10:54:02 raspdac volumio[999]: ---------------------------- MPD announces state update: player Oct 16 10:54:02 raspdac volumio[999]: info: ControllerMpd::getState Oct 16 10:54:02 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand status Oct 16 10:54:02 raspdac volumio[999]: info: Oct 16 10:54:02 raspdac volumio[999]: ---------------------------- MPD announces state update: player Oct 16 10:54:02 raspdac volumio[999]: info: sendMpdCommand status took 3 milliseconds Oct 16 10:54:02 raspdac volumio[999]: info: ControllerMpd::getState Oct 16 10:54:02 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand status Oct 16 10:54:02 raspdac volumio[999]: verbose: ControllerMpd::parseState Oct 16 10:54:02 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 10:54:02 raspdac volumio[999]: info: sendMpdCommand status took 12 milliseconds Oct 16 10:54:02 raspdac volumio[999]: info: sendMpdCommand playlistinfo took 12 milliseconds Oct 16 10:54:02 raspdac volumio[999]: verbose: ControllerMpd::parseState Oct 16 10:54:02 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 10:54:02 raspdac volumio[999]: verbose: ControllerMpd::parseTrackInfo Oct 16 10:54:02 raspdac volumio[999]: info: ControllerMpd::pushState Oct 16 10:54:02 raspdac volumio[999]: info: CoreCommandRouter::servicePushState Oct 16 10:54:02 raspdac volumio[999]: info: CorePlayQueue::getTrack 9722 Oct 16 10:54:02 raspdac volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":177,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Mannli","artist":"Stiller Has","album":"Moudi","uri":"USB/KINGSTON/music/Stiller Has/Moudi/09 Stiller Has Mannli.flac","trackType":"flac"} Oct 16 10:54:02 raspdac volumio[999]: verbose: CURRENT POSITION 9722 Oct 16 10:54:02 raspdac volumio[999]: info: CoreStateMachine::syncState stateService play Oct 16 10:54:02 raspdac volumio[999]: info: CoreStateMachine::syncState currentStatus stop Oct 16 10:54:02 raspdac volumio[999]: info: ------------------------------ 18ms Oct 16 10:54:02 raspdac volumio[999]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 10:54:02 raspdac volumio[999]: verbose: ControllerMpd::parseTrackInfo Oct 16 10:54:02 raspdac volumio[999]: info: ControllerMpd::pushState Oct 16 10:54:02 raspdac volumio[999]: info: CoreCommandRouter::servicePushState Oct 16 10:54:02 raspdac volumio[999]: info: CorePlayQueue::getTrack 9722 Oct 16 10:54:02 raspdac volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":114,"duration":177,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"559 Kbps","isStreaming":false,"title":"Mannli","artist":"Stiller Has","album":"Moudi","uri":"USB/KINGSTON/music/Stiller Has/Moudi/09 Stiller Has Mannli.flac","trackType":"flac"} Oct 16 10:54:02 raspdac volumio[999]: verbose: CURRENT POSITION 9722 Oct 16 10:54:02 raspdac volumio[999]: info: CoreStateMachine::syncState stateService play Oct 16 10:54:02 raspdac volumio[999]: info: CoreStateMachine::syncState currentStatus play Oct 16 10:54:02 raspdac volumio[999]: info: Received an update from plugin. extracting info from payload Oct 16 10:54:02 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:02 raspdac volumio[999]: info: CorePlayQueue::getTrack 9722 Oct 16 10:54:02 raspdac volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 10:54:02 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:02 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:02 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:02 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:02 raspdac volumio[999]: info: CorePlayQueue::getTrack 9722 Oct 16 10:54:02 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:02 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:02 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:02 raspdac volumio[999]: info: ------------------------------ 35ms Oct 16 10:54:02 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:02 raspdac volumio[999]: info: CorePlayQueue::getTrack 9722 Oct 16 10:54:02 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:02 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:02 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:02 raspdac volumio[999]: info: CoreCommandRouter::volumioPrevious Oct 16 10:54:02 raspdac volumio[999]: info: CoreStateMachine::previous Oct 16 10:54:02 raspdac volumio[999]: info: CorePlayQueue::getTrack 9722 Oct 16 10:54:02 raspdac volumio[999]: info: CoreStateMachine::stop Oct 16 10:54:02 raspdac volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 10:54:02 raspdac volumio[999]: info: CoreStateMachine::stPlaybackTimer Oct 16 10:54:02 raspdac volumio[999]: info: CoreStateMachine::updateTrackBlock Oct 16 10:54:02 raspdac volumio[999]: info: CorePlayQueue::getTrackBlock Oct 16 10:54:02 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:02 raspdac volumio[999]: info: CorePlayQueue::getTrack 9722 Oct 16 10:54:02 raspdac volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 10:54:02 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:02 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:02 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:02 raspdac volumio[999]: info: CoreStateMachine::serviceStop Oct 16 10:54:02 raspdac volumio[999]: info: CorePlayQueue::getTrack 9722 Oct 16 10:54:02 raspdac volumio[999]: info: CoreCommandRouter::serviceStop Oct 16 10:54:02 raspdac volumio[999]: info: ControllerMpd::stop Oct 16 10:54:02 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 10:54:02 raspdac volumio[999]: info: Oct 16 10:54:02 raspdac volumio[999]: ---------------------------- MPD announces state update: player Oct 16 10:54:02 raspdac volumio[999]: info: sendMpdCommand stop took 16 milliseconds Oct 16 10:54:02 raspdac volumio[999]: info: ControllerMpd::getState Oct 16 10:54:02 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand status Oct 16 10:54:02 raspdac volumio[999]: info: sendMpdCommand status took 1 milliseconds Oct 16 10:54:02 raspdac volumio[999]: verbose: ControllerMpd::parseState Oct 16 10:54:02 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 10:54:02 raspdac volumio[999]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 16 10:54:02 raspdac volumio[999]: verbose: ControllerMpd::parseTrackInfo Oct 16 10:54:02 raspdac volumio[999]: info: ControllerMpd::pushState Oct 16 10:54:02 raspdac volumio[999]: info: CoreCommandRouter::servicePushState Oct 16 10:54:02 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:02 raspdac volumio[999]: info: CorePlayQueue::getTrack 9722 Oct 16 10:54:02 raspdac volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 10:54:02 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:02 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:02 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:02 raspdac volumio[999]: info: CorePlayQueue::getTrack 9722 Oct 16 10:54:02 raspdac volumio[999]: 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":"Mannli","artist":"Stiller Has","album":"Moudi","uri":"USB/KINGSTON/music/Stiller Has/Moudi/09 Stiller Has Mannli.flac","trackType":"flac"} Oct 16 10:54:02 raspdac volumio[999]: verbose: CURRENT POSITION 9722 Oct 16 10:54:02 raspdac volumio[999]: info: CoreStateMachine::syncState stateService stop Oct 16 10:54:02 raspdac volumio[999]: info: CoreStateMachine::syncState currentStatus stop Oct 16 10:54:02 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:02 raspdac volumio[999]: info: CorePlayQueue::getTrack 9722 Oct 16 10:54:02 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:02 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:02 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:02 raspdac volumio[999]: info: No code Oct 16 10:54:02 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:02 raspdac volumio[999]: info: CorePlayQueue::getTrack 9722 Oct 16 10:54:02 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:02 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:02 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:02 raspdac volumio[999]: info: ------------------------------ 18ms Oct 16 10:54:03 raspdac volumio[999]: info: CoreStateMachine::play index undefined Oct 16 10:54:03 raspdac volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 10:54:03 raspdac volumio[999]: info: CorePlayQueue::getTrack 9721 Oct 16 10:54:03 raspdac volumio[999]: info: CoreStateMachine::startPlaybackTimer Oct 16 10:54:03 raspdac volumio[999]: info: CorePlayQueue::getTrack 9721 Oct 16 10:54:03 raspdac volumio[999]: verbose: ControllerMpd::clearAddPlayTracks USB/KINGSTON/music/Stiller Has/Moudi/08 Stiller Has Wilde Has.flac Oct 16 10:54:03 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 10:54:03 raspdac volumio[999]: info: sendMpdCommand stop took 0 milliseconds Oct 16 10:54:03 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 10:54:03 raspdac volumio[999]: info: Oct 16 10:54:03 raspdac volumio[999]: ---------------------------- MPD announces system playlist update Oct 16 10:54:03 raspdac volumio[999]: info: Ignoring MPD Status Update Oct 16 10:54:03 raspdac volumio[999]: info: sendMpdCommand clear took 1 milliseconds Oct 16 10:54:03 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand add "USB/KINGSTON/music/Stiller Has/Moudi/08 Stiller Has Wilde Has.flac" Oct 16 10:54:03 raspdac volumio[999]: error: updateQueue error: null Oct 16 10:54:03 raspdac volumio[999]: info: Oct 16 10:54:03 raspdac volumio[999]: ---------------------------- MPD announces system playlist update Oct 16 10:54:03 raspdac volumio[999]: info: Ignoring MPD Status Update Oct 16 10:54:03 raspdac volumio[999]: info: ------------------------------ 1ms Oct 16 10:54:03 raspdac volumio[999]: info: sendMpdCommand add "USB/KINGSTON/music/Stiller Has/Moudi/08 Stiller Has Wilde Has.flac" took 1 milliseconds Oct 16 10:54:03 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand play Oct 16 10:54:03 raspdac volumio[999]: info: ------------------------------ 1ms Oct 16 10:54:03 raspdac volumio[999]: info: sendMpdCommand play took 1 milliseconds Oct 16 10:54:03 raspdac volumio[999]: info: Oct 16 10:54:03 raspdac volumio[999]: ---------------------------- MPD announces state update: player Oct 16 10:54:03 raspdac volumio[999]: info: ControllerMpd::getState Oct 16 10:54:03 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand status Oct 16 10:54:03 raspdac volumio[999]: info: Oct 16 10:54:03 raspdac volumio[999]: ---------------------------- MPD announces state update: player Oct 16 10:54:03 raspdac volumio[999]: info: sendMpdCommand status took 2 milliseconds Oct 16 10:54:03 raspdac volumio[999]: info: ControllerMpd::getState Oct 16 10:54:03 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand status Oct 16 10:54:03 raspdac volumio[999]: verbose: ControllerMpd::parseState Oct 16 10:54:03 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 10:54:03 raspdac volumio[999]: info: sendMpdCommand status took 1 milliseconds Oct 16 10:54:03 raspdac volumio[999]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 10:54:03 raspdac volumio[999]: verbose: ControllerMpd::parseState Oct 16 10:54:03 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 10:54:03 raspdac volumio[999]: verbose: ControllerMpd::parseTrackInfo Oct 16 10:54:03 raspdac volumio[999]: info: ControllerMpd::pushState Oct 16 10:54:03 raspdac volumio[999]: info: CoreCommandRouter::servicePushState Oct 16 10:54:03 raspdac volumio[999]: info: CorePlayQueue::getTrack 9721 Oct 16 10:54:03 raspdac volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":189,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Wilde Has","artist":"Stiller Has","album":"Moudi","uri":"USB/KINGSTON/music/Stiller Has/Moudi/08 Stiller Has Wilde Has.flac","trackType":"flac"} Oct 16 10:54:03 raspdac volumio[999]: verbose: CURRENT POSITION 9721 Oct 16 10:54:03 raspdac volumio[999]: info: CoreStateMachine::syncState stateService play Oct 16 10:54:03 raspdac volumio[999]: info: CoreStateMachine::syncState currentStatus stop Oct 16 10:54:03 raspdac volumio[999]: info: ------------------------------ 6ms Oct 16 10:54:03 raspdac volumio[999]: info: sendMpdCommand playlistinfo took 9 milliseconds Oct 16 10:54:03 raspdac volumio[999]: verbose: ControllerMpd::parseTrackInfo Oct 16 10:54:03 raspdac volumio[999]: info: ControllerMpd::pushState Oct 16 10:54:03 raspdac volumio[999]: info: CoreCommandRouter::servicePushState Oct 16 10:54:03 raspdac volumio[999]: info: CorePlayQueue::getTrack 9721 Oct 16 10:54:03 raspdac volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":189,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Wilde Has","artist":"Stiller Has","album":"Moudi","uri":"USB/KINGSTON/music/Stiller Has/Moudi/08 Stiller Has Wilde Has.flac","trackType":"flac"} Oct 16 10:54:03 raspdac volumio[999]: verbose: CURRENT POSITION 9721 Oct 16 10:54:03 raspdac volumio[999]: info: CoreStateMachine::syncState stateService play Oct 16 10:54:03 raspdac volumio[999]: info: CoreStateMachine::syncState currentStatus play Oct 16 10:54:03 raspdac volumio[999]: info: Received an update from plugin. extracting info from payload Oct 16 10:54:03 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:03 raspdac volumio[999]: info: CorePlayQueue::getTrack 9721 Oct 16 10:54:03 raspdac volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 10:54:03 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:03 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:03 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:03 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:03 raspdac volumio[999]: info: CorePlayQueue::getTrack 9721 Oct 16 10:54:03 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:03 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:03 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:03 raspdac volumio[999]: info: ------------------------------ 27ms Oct 16 10:54:03 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:03 raspdac volumio[999]: info: CorePlayQueue::getTrack 9721 Oct 16 10:54:03 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:03 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:03 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:03 raspdac volumio[999]: info: CoreCommandRouter::volumioPrevious Oct 16 10:54:03 raspdac volumio[999]: info: CoreStateMachine::previous Oct 16 10:54:03 raspdac volumio[999]: info: CorePlayQueue::getTrack 9721 Oct 16 10:54:03 raspdac volumio[999]: info: ControllerMpd::seek Oct 16 10:54:03 raspdac volumio[999]: error: null Oct 16 10:54:03 raspdac volumio[999]: info: Oct 16 10:54:03 raspdac volumio[999]: ---------------------------- MPD announces state update: player Oct 16 10:54:03 raspdac volumio[999]: info: ControllerMpd::getState Oct 16 10:54:03 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand status Oct 16 10:54:03 raspdac volumio[999]: info: sendMpdCommand status took 1 milliseconds Oct 16 10:54:03 raspdac volumio[999]: verbose: ControllerMpd::parseState Oct 16 10:54:03 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 10:54:03 raspdac volumio[999]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 10:54:03 raspdac volumio[999]: verbose: ControllerMpd::parseTrackInfo Oct 16 10:54:03 raspdac volumio[999]: info: ControllerMpd::pushState Oct 16 10:54:03 raspdac volumio[999]: info: CoreCommandRouter::servicePushState Oct 16 10:54:03 raspdac volumio[999]: info: CorePlayQueue::getTrack 9721 Oct 16 10:54:03 raspdac volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":411,"duration":189,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"838 Kbps","isStreaming":false,"title":"Wilde Has","artist":"Stiller Has","album":"Moudi","uri":"USB/KINGSTON/music/Stiller Has/Moudi/08 Stiller Has Wilde Has.flac","trackType":"flac"} Oct 16 10:54:03 raspdac volumio[999]: verbose: CURRENT POSITION 9721 Oct 16 10:54:03 raspdac volumio[999]: info: CoreStateMachine::syncState stateService play Oct 16 10:54:03 raspdac volumio[999]: info: CoreStateMachine::syncState currentStatus play Oct 16 10:54:03 raspdac volumio[999]: info: Received an update from plugin. extracting info from payload Oct 16 10:54:03 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:03 raspdac volumio[999]: info: CorePlayQueue::getTrack 9721 Oct 16 10:54:03 raspdac volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 10:54:03 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:03 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:03 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:03 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:03 raspdac volumio[999]: info: CorePlayQueue::getTrack 9721 Oct 16 10:54:03 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:03 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:03 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:04 raspdac volumio[999]: info: ------------------------------ 40ms Oct 16 10:54:04 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:04 raspdac volumio[999]: info: CorePlayQueue::getTrack 9721 Oct 16 10:54:04 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:04 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:04 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:05 raspdac volumio[999]: info: CoreCommandRouter::volumioPrevious Oct 16 10:54:05 raspdac volumio[999]: info: CoreStateMachine::previous Oct 16 10:54:05 raspdac volumio[999]: info: CorePlayQueue::getTrack 9721 Oct 16 10:54:05 raspdac volumio[999]: info: CoreStateMachine::stop Oct 16 10:54:05 raspdac volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 10:54:05 raspdac volumio[999]: info: CoreStateMachine::stPlaybackTimer Oct 16 10:54:05 raspdac volumio[999]: info: CoreStateMachine::updateTrackBlock Oct 16 10:54:05 raspdac volumio[999]: info: CorePlayQueue::getTrackBlock Oct 16 10:54:05 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:05 raspdac volumio[999]: info: CorePlayQueue::getTrack 9721 Oct 16 10:54:05 raspdac volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 10:54:05 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:05 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:05 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:05 raspdac volumio[999]: info: CoreStateMachine::serviceStop Oct 16 10:54:05 raspdac volumio[999]: info: CorePlayQueue::getTrack 9721 Oct 16 10:54:05 raspdac volumio[999]: info: CoreCommandRouter::serviceStop Oct 16 10:54:05 raspdac volumio[999]: info: ControllerMpd::stop Oct 16 10:54:05 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 10:54:05 raspdac volumio[999]: info: Oct 16 10:54:05 raspdac volumio[999]: ---------------------------- MPD announces state update: player Oct 16 10:54:05 raspdac volumio[999]: info: sendMpdCommand stop took 9 milliseconds Oct 16 10:54:05 raspdac volumio[999]: info: ControllerMpd::getState Oct 16 10:54:05 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand status Oct 16 10:54:05 raspdac volumio[999]: info: sendMpdCommand status took 0 milliseconds Oct 16 10:54:05 raspdac volumio[999]: verbose: ControllerMpd::parseState Oct 16 10:54:05 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 10:54:05 raspdac volumio[999]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 16 10:54:05 raspdac volumio[999]: verbose: ControllerMpd::parseTrackInfo Oct 16 10:54:05 raspdac volumio[999]: info: ControllerMpd::pushState Oct 16 10:54:05 raspdac volumio[999]: info: CoreCommandRouter::servicePushState Oct 16 10:54:05 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:05 raspdac volumio[999]: info: CorePlayQueue::getTrack 9721 Oct 16 10:54:05 raspdac volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 10:54:05 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:05 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:05 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:05 raspdac volumio[999]: info: CorePlayQueue::getTrack 9721 Oct 16 10:54:05 raspdac volumio[999]: 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":"Wilde Has","artist":"Stiller Has","album":"Moudi","uri":"USB/KINGSTON/music/Stiller Has/Moudi/08 Stiller Has Wilde Has.flac","trackType":"flac"} Oct 16 10:54:05 raspdac volumio[999]: verbose: CURRENT POSITION 9721 Oct 16 10:54:05 raspdac volumio[999]: info: CoreStateMachine::syncState stateService stop Oct 16 10:54:05 raspdac volumio[999]: info: CoreStateMachine::syncState currentStatus stop Oct 16 10:54:05 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:05 raspdac volumio[999]: info: CorePlayQueue::getTrack 9721 Oct 16 10:54:05 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:05 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:05 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:05 raspdac volumio[999]: info: No code Oct 16 10:54:05 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:05 raspdac volumio[999]: info: CorePlayQueue::getTrack 9721 Oct 16 10:54:05 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:05 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:05 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:05 raspdac volumio[999]: info: ------------------------------ 20ms Oct 16 10:54:05 raspdac volumio[999]: info: CoreStateMachine::play index undefined Oct 16 10:54:05 raspdac volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 10:54:05 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:05 raspdac volumio[999]: info: CoreStateMachine::startPlaybackTimer Oct 16 10:54:05 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:05 raspdac volumio[999]: verbose: ControllerMpd::clearAddPlayTracks USB/KINGSTON/music/Stiller Has/Moudi/07 Stiller Has Moudi.flac Oct 16 10:54:05 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 10:54:05 raspdac volumio[999]: info: sendMpdCommand stop took 5 milliseconds Oct 16 10:54:05 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 10:54:05 raspdac volumio[999]: info: Oct 16 10:54:05 raspdac volumio[999]: ---------------------------- MPD announces system playlist update Oct 16 10:54:05 raspdac volumio[999]: info: Ignoring MPD Status Update Oct 16 10:54:05 raspdac volumio[999]: info: sendMpdCommand clear took 1 milliseconds Oct 16 10:54:05 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand add "USB/KINGSTON/music/Stiller Has/Moudi/07 Stiller Has Moudi.flac" Oct 16 10:54:05 raspdac volumio[999]: error: updateQueue error: null Oct 16 10:54:05 raspdac volumio[999]: info: ------------------------------ 2ms Oct 16 10:54:05 raspdac volumio[999]: info: Oct 16 10:54:05 raspdac volumio[999]: ---------------------------- MPD announces system playlist update Oct 16 10:54:05 raspdac volumio[999]: info: Ignoring MPD Status Update Oct 16 10:54:05 raspdac volumio[999]: info: sendMpdCommand add "USB/KINGSTON/music/Stiller Has/Moudi/07 Stiller Has Moudi.flac" took 2 milliseconds Oct 16 10:54:05 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand play Oct 16 10:54:05 raspdac volumio[999]: info: ------------------------------ 1ms Oct 16 10:54:05 raspdac volumio[999]: info: sendMpdCommand play took 1 milliseconds Oct 16 10:54:05 raspdac volumio[999]: info: Oct 16 10:54:05 raspdac volumio[999]: ---------------------------- MPD announces state update: player Oct 16 10:54:05 raspdac volumio[999]: info: ControllerMpd::getState Oct 16 10:54:05 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand status Oct 16 10:54:05 raspdac volumio[999]: info: Oct 16 10:54:05 raspdac volumio[999]: ---------------------------- MPD announces state update: player Oct 16 10:54:05 raspdac volumio[999]: info: sendMpdCommand status took 3 milliseconds Oct 16 10:54:05 raspdac volumio[999]: info: ControllerMpd::getState Oct 16 10:54:05 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand status Oct 16 10:54:05 raspdac volumio[999]: verbose: ControllerMpd::parseState Oct 16 10:54:05 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 10:54:05 raspdac volumio[999]: info: sendMpdCommand status took 2 milliseconds Oct 16 10:54:05 raspdac volumio[999]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 16 10:54:05 raspdac volumio[999]: verbose: ControllerMpd::parseState Oct 16 10:54:05 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 10:54:05 raspdac volumio[999]: verbose: ControllerMpd::parseTrackInfo Oct 16 10:54:05 raspdac volumio[999]: info: ControllerMpd::pushState Oct 16 10:54:05 raspdac volumio[999]: info: CoreCommandRouter::servicePushState Oct 16 10:54:05 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:05 raspdac volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":262,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Moudi","artist":"Stiller Has","album":"Moudi","uri":"USB/KINGSTON/music/Stiller Has/Moudi/07 Stiller Has Moudi.flac","trackType":"flac"} Oct 16 10:54:05 raspdac volumio[999]: verbose: CURRENT POSITION 9720 Oct 16 10:54:05 raspdac volumio[999]: info: CoreStateMachine::syncState stateService play Oct 16 10:54:05 raspdac volumio[999]: info: CoreStateMachine::syncState currentStatus stop Oct 16 10:54:05 raspdac volumio[999]: info: ------------------------------ 8ms Oct 16 10:54:05 raspdac volumio[999]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 16 10:54:05 raspdac volumio[999]: verbose: ControllerMpd::parseTrackInfo Oct 16 10:54:05 raspdac volumio[999]: info: ControllerMpd::pushState Oct 16 10:54:05 raspdac volumio[999]: info: CoreCommandRouter::servicePushState Oct 16 10:54:05 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:05 raspdac volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":262,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Moudi","artist":"Stiller Has","album":"Moudi","uri":"USB/KINGSTON/music/Stiller Has/Moudi/07 Stiller Has Moudi.flac","trackType":"flac"} Oct 16 10:54:05 raspdac volumio[999]: verbose: CURRENT POSITION 9720 Oct 16 10:54:05 raspdac volumio[999]: info: CoreStateMachine::syncState stateService play Oct 16 10:54:05 raspdac volumio[999]: info: CoreStateMachine::syncState currentStatus play Oct 16 10:54:05 raspdac volumio[999]: info: Received an update from plugin. extracting info from payload Oct 16 10:54:05 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:05 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:05 raspdac volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 10:54:05 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:05 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:05 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:05 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:05 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:05 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:05 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:05 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:05 raspdac volumio[999]: info: ------------------------------ 18ms Oct 16 10:54:05 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:05 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:05 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:05 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:05 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:06 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:06 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:06 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:06 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:06 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:07 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:07 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:07 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:07 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:07 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:08 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:08 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:08 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:08 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:08 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:09 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:09 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:09 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:09 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:09 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:10 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:10 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:10 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:10 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:10 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:11 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:11 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:11 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:11 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:11 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:12 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:12 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:12 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:12 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:12 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:13 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:13 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:13 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:13 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:13 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:14 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:14 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:14 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:14 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:14 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:15 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:15 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:15 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:15 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:15 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:16 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:16 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:16 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:16 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:16 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:17 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:17 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:17 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:17 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:17 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:18 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:18 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:18 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:18 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:18 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:19 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:19 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:19 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:19 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:19 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:20 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:20 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:20 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:20 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:20 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:21 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:21 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:21 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:21 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:21 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:22 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:22 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:22 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:22 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:22 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:23 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:23 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:23 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:23 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:23 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:24 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:24 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:24 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:24 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:24 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:25 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:25 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:25 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:25 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:25 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:26 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:26 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:26 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:26 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:26 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:27 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:27 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:27 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:27 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:27 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:28 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:28 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:28 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:28 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:28 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:29 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:29 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:29 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:29 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:29 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:30 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:30 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:30 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:30 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:30 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:30 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:30 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:31 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:31 raspdac kernel: I/O error, dev mmcblk0, sector 3849984 op 0x0:(READ) flags 0x80700 phys_seg 2 prio class 2 Oct 16 10:54:31 raspdac kernel: I/O error, dev mmcblk0, sector 3849984 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Oct 16 10:54:31 raspdac kernel: I/O error, dev loop0, sector 909052 op 0x0:(READ) flags 0x800 phys_seg 28 prio class 2 Oct 16 10:54:31 raspdac kernel: SQUASHFS error: Failed to read block 0x1bbdfb85: -5 Oct 16 10:54:31 raspdac kernel: SQUASHFS error: Unable to read fragment cache entry [1bbdfb85] Oct 16 10:54:31 raspdac kernel: SQUASHFS error: Unable to read fragment cache entry [1bbdfb85] Oct 16 10:54:31 raspdac kernel: SQUASHFS error: Unable to read page, block 1bbdfb85, size 1a743 Oct 16 10:54:31 raspdac volumio[999]: An internal error occurred while serving an albumart. Details: Error: EIO: i/o error, read Oct 16 10:54:31 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:31 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:31 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:31 raspdac kernel: I/O error, dev mmcblk0, sector 3849216 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Oct 16 10:54:31 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:31 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:31 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:31 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:31 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:31 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:31 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:31 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:31 raspdac kernel: I/O error, dev mmcblk0, sector 3849216 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Oct 16 10:54:31 raspdac kernel: I/O error, dev loop0, sector 908290 op 0x0:(READ) flags 0x800 phys_seg 18 prio class 2 Oct 16 10:54:31 raspdac kernel: SQUASHFS error: Failed to read block 0x1bb8057e: -5 Oct 16 10:54:31 raspdac kernel: SQUASHFS error: Unable to read fragment cache entry [1bb8057e] Oct 16 10:54:31 raspdac kernel: SQUASHFS error: Unable to read fragment cache entry [1bb8057e] Oct 16 10:54:31 raspdac kernel: SQUASHFS error: Unable to read page, block 1bb8057e, size 10b0c Oct 16 10:54:31 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:31 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:31 raspdac kernel: I/O error, dev mmcblk0, sector 3849528 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Oct 16 10:54:31 raspdac volumio[999]: An internal error occurred while serving an albumart. Details: Error: EIO: i/o error, read Oct 16 10:54:31 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:31 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:31 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:31 raspdac kernel: I/O error, dev mmcblk0, sector 3849528 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Oct 16 10:54:31 raspdac kernel: I/O error, dev loop0, sector 908602 op 0x0:(READ) flags 0x800 phys_seg 26 prio class 2 Oct 16 10:54:31 raspdac volumio[999]: An internal error occurred while serving an albumart. Details: Error: EIO: i/o error, read Oct 16 10:54:31 raspdac kernel: SQUASHFS error: Failed to read block 0x1bba7677: -5 Oct 16 10:54:31 raspdac kernel: SQUASHFS error: Unable to read fragment cache entry [1bba7677] Oct 16 10:54:31 raspdac kernel: SQUASHFS error: Unable to read fragment cache entry [1bba7677] Oct 16 10:54:31 raspdac kernel: SQUASHFS error: Unable to read page, block 1bba7677, size 18c7c Oct 16 10:54:32 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:32 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:32 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:32 raspdac kernel: I/O error, dev mmcblk0, sector 3829024 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Oct 16 10:54:32 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:32 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:32 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:32 raspdac kernel: SQUASHFS error: Failed to read block 0x1b19b75b: -5 Oct 16 10:54:32 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:32 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:32 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:32 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:32 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:32 raspdac kernel: SQUASHFS error: Failed to read block 0x1b1bb75b: -5 Oct 16 10:54:32 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:32 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:32 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:32 raspdac kernel: SQUASHFS error: Failed to read block 0x1b19b75b: -5 Oct 16 10:54:32 raspdac kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Oct 16 10:54:32 raspdac kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Oct 16 10:54:32 raspdac kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Oct 16 10:54:32 raspdac kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Oct 16 10:54:32 raspdac volumio[999]: Error: EIO: i/o error, read Oct 16 10:54:32 raspdac volumio[999]: Error: EIO: i/o error, read Oct 16 10:54:32 raspdac kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Oct 16 10:54:32 raspdac kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Oct 16 10:54:32 raspdac volumio[999]: Error: EIO: i/o error, read Oct 16 10:54:32 raspdac kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Oct 16 10:54:32 raspdac kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Oct 16 10:54:32 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:32 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:32 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:32 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:32 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:32 raspdac volumio[999]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 16 10:54:32 raspdac volumio[999]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 16 10:54:32 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:32 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:32 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:33 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:33 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:33 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:33 raspdac kernel: SQUASHFS error: Failed to read block 0x1e02749e: -5 Oct 16 10:54:33 raspdac kernel: SQUASHFS error: Unable to read metadata cache entry [1e02749e] Oct 16 10:54:33 raspdac kernel: SQUASHFS error: Unable to read inode 0x7c1251d18 Oct 16 10:54:33 raspdac volumio[999]: info: ERROR LOADING JSON Error: EIO: i/o error, open '/volumio/app/plugins/system_controller/system/UIConfig.json' Oct 16 10:54:33 raspdac volumio[999]: error: Error Oct 16 10:54:33 raspdac kernel: SQUASHFS error: Unable to read metadata cache entry [1e02749e] Oct 16 10:54:33 raspdac kernel: SQUASHFS error: Unable to read inode 0x7dea91f04 Oct 16 10:54:33 raspdac volumio[999]: Error: EIO: i/o error, stat '/volumio/http/www3/index.html' Oct 16 10:54:33 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:33 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:33 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:33 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:33 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:34 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:34 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:34 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:34 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:34 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:35 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:35 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:35 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:35 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:35 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:36 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:36 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:36 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:36 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:36 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:37 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:37 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:37 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:37 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:37 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:38 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:38 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:38 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:38 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:38 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:39 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:39 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:39 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:39 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:39 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:40 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:40 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:40 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:40 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:40 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:41 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:41 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:41 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:41 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:41 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:42 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:42 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:42 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:42 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:42 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:43 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:43 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:43 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:43 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:43 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:44 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:44 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:44 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:44 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:44 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:45 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:45 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:45 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:45 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:45 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:46 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:46 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:46 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:46 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:46 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:47 raspdac volumio[999]: info: CoreCommandRouter::volumioGetState Oct 16 10:54:47 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:47 raspdac volumio[999]: info: CoreCommandRouter::volumioGetQueue Oct 16 10:54:47 raspdac volumio[999]: info: CoreStateMachine::getQueue Oct 16 10:54:47 raspdac volumio[999]: info: CorePlayQueue::getQueue Oct 16 10:54:48 raspdac volumio[999]: info: CoreCommandRouter::volumioPause Oct 16 10:54:48 raspdac volumio[999]: info: CoreStateMachine::pause Oct 16 10:54:48 raspdac volumio[999]: info: CoreStateMachine::stPlaybackTimer Oct 16 10:54:48 raspdac volumio[999]: info: CoreStateMachine::servicePause Oct 16 10:54:48 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:48 raspdac volumio[999]: info: CoreCommandRouter::servicePause Oct 16 10:54:48 raspdac volumio[999]: info: ControllerMpd::pause Oct 16 10:54:48 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand pause Oct 16 10:54:48 raspdac volumio[999]: info: Oct 16 10:54:48 raspdac volumio[999]: ---------------------------- MPD announces state update: player Oct 16 10:54:48 raspdac volumio[999]: info: sendMpdCommand pause took 4 milliseconds Oct 16 10:54:48 raspdac volumio[999]: info: ControllerMpd::getState Oct 16 10:54:48 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand status Oct 16 10:54:48 raspdac volumio[999]: info: sendMpdCommand status took 1 milliseconds Oct 16 10:54:48 raspdac volumio[999]: verbose: ControllerMpd::parseState Oct 16 10:54:48 raspdac volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 10:54:48 raspdac volumio[999]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 16 10:54:48 raspdac volumio[999]: verbose: ControllerMpd::parseTrackInfo Oct 16 10:54:48 raspdac volumio[999]: info: ControllerMpd::pushState Oct 16 10:54:48 raspdac volumio[999]: info: CoreCommandRouter::servicePushState Oct 16 10:54:48 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:48 raspdac volumio[999]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":42991,"duration":262,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"835 Kbps","isStreaming":false,"title":"Moudi","artist":"Stiller Has","album":"Moudi","uri":"USB/KINGSTON/music/Stiller Has/Moudi/07 Stiller Has Moudi.flac","trackType":"flac"} Oct 16 10:54:48 raspdac volumio[999]: verbose: CURRENT POSITION 9720 Oct 16 10:54:48 raspdac volumio[999]: info: CoreStateMachine::syncState stateService pause Oct 16 10:54:48 raspdac volumio[999]: info: CoreStateMachine::syncState currentStatus pause Oct 16 10:54:48 raspdac volumio[999]: info: CoreStateMachine::pushState Oct 16 10:54:48 raspdac volumio[999]: info: CorePlayQueue::getTrack 9720 Oct 16 10:54:48 raspdac volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 10:54:48 raspdac volumio[999]: info: CoreCommandRouter::volumioPushState Oct 16 10:54:48 raspdac volumio[999]: info: MRS: Pushing multiroomSync output update for this device Oct 16 10:54:48 raspdac volumio[999]: info: MRS: Pushing multiroomSync output Oct 16 10:54:48 raspdac volumio[999]: info: CoreStateMachine::stPlaybackTimer Oct 16 10:54:48 raspdac volumio[999]: info: ------------------------------ 21ms Oct 16 10:54:49 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:49 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:49 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:49 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:49 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:50 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:50 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:50 raspdac kernel: blk_print_req_error: 10 callbacks suppressed Oct 16 10:54:50 raspdac kernel: I/O error, dev mmcblk0, sector 5468744 op 0x0:(READ) flags 0x80700 phys_seg 4 prio class 2 Oct 16 10:54:50 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:54:50 raspdac kernel: I/O error, dev mmcblk0, sector 5468792 op 0x0:(READ) flags 0x80700 phys_seg 9 prio class 2 Oct 16 10:54:50 raspdac volumio[999]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 10:54:50 raspdac volumio[999]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 16 10:54:51 raspdac volumio[999]: An internal error occurred while serving an albumart. Details: Error: EIO: i/o error, read Oct 16 10:54:51 raspdac volumio[999]: An internal error occurred while serving an albumart. Details: Error: EIO: i/o error, read Oct 16 10:54:51 raspdac volumio[999]: An internal error occurred while serving an albumart. Details: Error: EIO: i/o error, read Oct 16 10:54:51 raspdac kernel: SQUASHFS error: Unable to read fragment cache entry [1bb8057e] Oct 16 10:54:51 raspdac kernel: SQUASHFS error: Unable to read page, block 1bb8057e, size 10b0c Oct 16 10:54:51 raspdac kernel: SQUASHFS error: Unable to read fragment cache entry [1bba7677] Oct 16 10:54:51 raspdac kernel: SQUASHFS error: Unable to read page, block 1bba7677, size 18c7c Oct 16 10:54:51 raspdac kernel: SQUASHFS error: Unable to read fragment cache entry [1bbdfb85] Oct 16 10:54:51 raspdac kernel: SQUASHFS error: Unable to read page, block 1bbdfb85, size 1a743 Oct 16 10:54:51 raspdac kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Oct 16 10:54:51 raspdac kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Oct 16 10:54:51 raspdac kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Oct 16 10:54:51 raspdac kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Oct 16 10:54:51 raspdac volumio[999]: Error: EIO: i/o error, read Oct 16 10:54:51 raspdac volumio[999]: Error: EIO: i/o error, read Oct 16 10:54:51 raspdac volumio[999]: Error: EIO: i/o error, read Oct 16 10:54:51 raspdac kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Oct 16 10:54:51 raspdac kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Oct 16 10:54:51 raspdac kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Oct 16 10:54:51 raspdac kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Oct 16 10:54:51 raspdac kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Oct 16 10:54:51 raspdac kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Oct 16 10:54:51 raspdac kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Oct 16 10:54:51 raspdac kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Oct 16 10:54:51 raspdac kernel: SQUASHFS error: Unable to read data cache entry [1b19b75b] Oct 16 10:54:51 raspdac kernel: SQUASHFS error: Unable to read page, block 1b19b75b, size 1020000 Oct 16 10:54:54 raspdac volumio[999]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 16 10:54:54 raspdac volumio[999]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 16 10:54:54 raspdac volumio[999]: info: ERROR LOADING JSON Error: EIO: i/o error, open '/volumio/app/plugins/system_controller/system/UIConfig.json' Oct 16 10:54:54 raspdac volumio[999]: error: Error Oct 16 10:54:54 raspdac kernel: SQUASHFS error: Unable to read metadata cache entry [1e02749e] Oct 16 10:54:54 raspdac kernel: SQUASHFS error: Unable to read inode 0x7c1251d18 Oct 16 10:54:54 raspdac volumio[999]: Error: EIO: i/o error, stat '/volumio/http/www3/index.html' Oct 16 10:54:54 raspdac kernel: SQUASHFS error: Unable to read metadata cache entry [1e02749e] Oct 16 10:54:54 raspdac kernel: SQUASHFS error: Unable to read inode 0x7dea91f04 Oct 16 10:55:09 raspdac volumio[999]: info: ___________ PLUGINS: Run Shutdown Tasks ___________ Oct 16 10:55:09 raspdac volumio[999]: info: PLUGIN onShutdown : networkfs Oct 16 10:55:09 raspdac sudo[943]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl poweroff Oct 16 10:55:09 raspdac sudo[943]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 10:55:09 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:55:10 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:55:10 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:55:10 raspdac kernel: I/O error, dev mmcblk0, sector 5468744 op 0x0:(READ) flags 0x80700 phys_seg 2 prio class 2 Oct 16 10:55:10 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:55:10 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:55:10 raspdac kernel: I/O error, dev mmcblk0, sector 5468792 op 0x0:(READ) flags 0x80700 phys_seg 9 prio class 2 Oct 16 10:55:10 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:55:10 raspdac systemd-logind[661]: Unit poweroff.target is not-found, refusing operation. Oct 16 10:55:10 raspdac kernel: I/O error, dev mmcblk0, sector 287368 op 0x0:(READ) flags 0x0 phys_seg 1 prio class 2 Oct 16 10:55:10 raspdac kernel: I/O error, dev loop0, sector 983354 op 0x0:(READ) flags 0x800 phys_seg 1 prio class 2 Oct 16 10:55:10 raspdac kernel: SQUASHFS error: Failed to read block 0x1e02749e: -5 Oct 16 10:55:10 raspdac kernel: SQUASHFS error: Unable to read metadata cache entry [1e02749e] Oct 16 10:55:10 raspdac kernel: SQUASHFS error: Unable to read inode 0x1da21088a Oct 16 10:55:10 raspdac sudo[943]: pam_unix(sudo:session): session closed for user root Oct 16 10:55:10 raspdac kernel: SQUASHFS error: Unable to read metadata cache entry [1e02749e] Oct 16 10:55:10 raspdac kernel: SQUASHFS error: Unable to read inode 0x1da21088a Oct 16 10:55:10 raspdac volumio[999]: info: Command failed: /usr/bin/sudo systemctl poweroff Oct 16 10:55:10 raspdac volumio[999]: Failed to power off system via logind: Access denied Oct 16 10:55:10 raspdac volumio[999]: Failed to start poweroff.target: Unit poweroff.target not found. Oct 16 10:55:10 raspdac volumio[999]: {"killed":false,"code":5,"signal":null,"cmd":"/usr/bin/sudo systemctl poweroff"} Oct 16 10:55:10 raspdac volumio[999]: info: Shutting Down Oct 16 10:55:13 raspdac kernel: SQUASHFS error: Unable to read metadata cache entry [1e02749e] Oct 16 10:55:13 raspdac kernel: SQUASHFS error: Unable to read inode 0x353940079 Oct 16 10:55:13 raspdac kernel: SQUASHFS error: Unable to read metadata cache entry [1e02749e] Oct 16 10:55:13 raspdac kernel: SQUASHFS error: Unable to read inode 0x353940079 Oct 16 10:55:13 raspdac kernel: SQUASHFS error: Unable to read metadata cache entry [1e02749e] Oct 16 10:55:13 raspdac kernel: SQUASHFS error: Unable to read inode 0x353940079 Oct 16 10:55:13 raspdac kernel: mmc0: Got data interrupt 0x00000002 even though no data operation was in progress. Oct 16 10:55:13 raspdac kernel: SQUASHFS error: Unable to read metadata cache entry [1e02749e] Oct 16 10:55:13 raspdac kernel: SQUASHFS error: Unable to read inode 0x7660804c8 Oct 16 10:55:13 raspdac sudo[975]: pam_unix(sudo:auth): conversation failed Oct 16 10:55:13 raspdac sudo[975]: pam_unix(sudo:auth): auth could not identify password for [volumio] Oct 16 10:55:13 raspdac volumio[999]: We trust you have received the usual lecture from the local System Oct 16 10:55:13 raspdac volumio[999]: Administrator. It usually boils down to these three things: Oct 16 10:55:13 raspdac volumio[999]: #1) Respect the privacy of others. Oct 16 10:55:13 raspdac volumio[999]: #2) Think before you type. Oct 16 10:55:13 raspdac volumio[999]: #3) With great power comes great responsibility. Oct 16 10:55:13 raspdac volumio[999]: sudo: no tty present and no askpass program specified Oct 16 10:55:13 raspdac volumio[999]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 10:55:13 raspdac volumio[999]: Error: Command failed: /usr/bin/sudo /sbin/shutdown -h now Oct 16 10:55:13 raspdac volumio[999]: We trust you have received the usual lecture from the local System Oct 16 10:55:13 raspdac volumio[999]: Administrator. It usually boils down to these three things: Oct 16 10:55:13 raspdac volumio[999]: #1) Respect the privacy of others. Oct 16 10:55:13 raspdac volumio[999]: #2) Think before you type. Oct 16 10:55:13 raspdac volumio[999]: #3) With great power comes great responsibility. Oct 16 10:55:13 raspdac volumio[999]: sudo: no tty present and no askpass program specified Oct 16 10:55:13 raspdac volumio[999]: at checkExecSyncError (child_process.js:616:11) Oct 16 10:55:13 raspdac volumio[999]: at execSync (child_process.js:652:15) Oct 16 10:55:13 raspdac volumio[999]: at Timeout._onTimeout (/volumio/app/platformSpecific.js:24:7) Oct 16 10:55:13 raspdac volumio[999]: at listOnTimeout (internal/timers.js:554:17) Oct 16 10:55:13 raspdac volumio[999]: at processTimers (internal/timers.js:497:7) { Oct 16 10:55:13 raspdac volumio[999]: status: 1, Oct 16 10:55:13 raspdac volumio[999]: signal: null, Oct 16 10:55:13 raspdac volumio[999]: output: [ Oct 16 10:55:13 raspdac volumio[999]: null, Oct 16 10:55:13 raspdac volumio[999]: , Oct 16 10:55:13 raspdac volumio[999]: Oct 16 10:55:13 raspdac volumio[999]: ], Oct 16 10:55:13 raspdac volumio[999]: pid: 974, Oct 16 10:55:13 raspdac volumio[999]: stdout: , Oct 16 10:55:13 raspdac volumio[999]: stderr: Oct 16 10:55:13 raspdac volumio[999]: } Oct 16 10:55:13 raspdac volumio[999]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 10:55:14 raspdac sudo[985]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-16 10:54 Oct 16 10:55:14 raspdac sudo[985]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"