Feb 11 16:41:00 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:00 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:00 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:00 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:00 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:00 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:00 volumio volumio[3907]: info: Clearing queue after UPNP request Feb 11 16:41:01 volumio volumio[3907]: info: CoreStateMachine::ClearQueue Feb 11 16:41:01 volumio volumio[3907]: info: CoreStateMachine::stop Feb 11 16:41:01 volumio volumio[3907]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 16:41:01 volumio volumio[3907]: info: CorePlayQueue::clearPlayQueue Feb 11 16:41:01 volumio volumio[3907]: info: CorePlayQueue::saveQueue Feb 11 16:41:01 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:01 volumio volumio[3907]: info: CoreCommandRouter::volumioPushQueue Feb 11 16:41:01 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:01 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:01 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:01 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:01 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:01 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:01 volumio volumio[3907]: info: Feb 11 16:41:01 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:01 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:01 volumio volumio[3907]: info: Feb 11 16:41:01 volumio volumio[3907]: ---------------------------- MPD announces state update: player Feb 11 16:41:01 volumio volumio[3907]: info: ControllerMpd::getState Feb 11 16:41:01 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand status Feb 11 16:41:01 volumio volumio[3907]: info: Feb 11 16:41:01 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:01 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:01 volumio volumio[3907]: info: Feb 11 16:41:01 volumio volumio[3907]: ---------------------------- MPD announces state update: player Feb 11 16:41:01 volumio volumio[3907]: info: ControllerMpd::getState Feb 11 16:41:01 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand status Feb 11 16:41:01 volumio volumio[3907]: info: Feb 11 16:41:01 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:01 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:01 volumio volumio[3907]: info: Feb 11 16:41:01 volumio volumio[3907]: ---------------------------- MPD announces state update: player Feb 11 16:41:01 volumio volumio[3907]: error: updateQueue error: null Feb 11 16:41:01 volumio volumio[3907]: error: updateQueue error: null Feb 11 16:41:01 volumio volumio[3907]: info: ControllerMpd::getState Feb 11 16:41:01 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand status Feb 11 16:41:01 volumio volumio[3907]: info: ------------------------------ 5ms Feb 11 16:41:01 volumio volumio[3907]: info: sendMpdCommand status took 4 milliseconds Feb 11 16:41:01 volumio volumio[3907]: info: ------------------------------ 3ms Feb 11 16:41:01 volumio volumio[3907]: info: sendMpdCommand status took 3 milliseconds Feb 11 16:41:01 volumio volumio[3907]: verbose: ControllerMpd::parseState Feb 11 16:41:01 volumio volumio[3907]: verbose: ControllerMpd::parseState Feb 11 16:41:01 volumio volumio[3907]: info: ControllerMpd::pushState Feb 11 16:41:01 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:01 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:01 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:01 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 16:41:01 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:01 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:01 volumio volumio[3907]: 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} Feb 11 16:41:01 volumio volumio[3907]: verbose: CURRENT POSITION 0 Feb 11 16:41:01 volumio volumio[3907]: info: CoreStateMachine::syncState stateService stop Feb 11 16:41:01 volumio volumio[3907]: info: CoreStateMachine::syncState currentStatus stop Feb 11 16:41:01 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:01 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:01 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:01 volumio volumio[3907]: info: No code Feb 11 16:41:01 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:01 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:01 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:01 volumio volumio[3907]: info: ControllerMpd::pushState Feb 11 16:41:01 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:01 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:01 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:01 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:01 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:01 volumio volumio[3907]: 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} Feb 11 16:41:01 volumio volumio[3907]: verbose: CURRENT POSITION 0 Feb 11 16:41:01 volumio volumio[3907]: info: CoreStateMachine::syncState stateService stop Feb 11 16:41:01 volumio volumio[3907]: info: CoreStateMachine::syncState currentStatus stop Feb 11 16:41:01 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:01 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:01 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:01 volumio volumio[3907]: info: No code Feb 11 16:41:01 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:01 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:01 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:01 volumio volumio[3907]: info: ------------------------------ 28ms Feb 11 16:41:01 volumio volumio[3907]: info: ------------------------------ 27ms Feb 11 16:41:01 volumio volumio[3907]: error: updateQueue error: null Feb 11 16:41:01 volumio volumio[3907]: info: ------------------------------ 28ms Feb 11 16:41:01 volumio volumio[3907]: info: sendMpdCommand status took 26 milliseconds Feb 11 16:41:01 volumio volumio[3907]: verbose: ControllerMpd::parseState Feb 11 16:41:01 volumio volumio[3907]: info: ControllerMpd::pushState Feb 11 16:41:01 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:01 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:01 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:01 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:01 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:01 volumio volumio[3907]: 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} Feb 11 16:41:01 volumio volumio[3907]: verbose: CURRENT POSITION 0 Feb 11 16:41:01 volumio volumio[3907]: info: CoreStateMachine::syncState stateService stop Feb 11 16:41:01 volumio volumio[3907]: info: CoreStateMachine::syncState currentStatus stop Feb 11 16:41:01 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:01 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:01 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:01 volumio volumio[3907]: info: No code Feb 11 16:41:01 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:01 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:01 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:01 volumio volumio[3907]: info: ------------------------------ 38ms Feb 11 16:41:01 volumio volumio[3907]: info: Clearing queue after UPNP request Feb 11 16:41:02 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:02 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:02 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:02 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:02 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:02 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:02 volumio volumio[3907]: info: CoreStateMachine::ClearQueue Feb 11 16:41:02 volumio volumio[3907]: info: CoreStateMachine::stop Feb 11 16:41:02 volumio volumio[3907]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 16:41:02 volumio volumio[3907]: info: CorePlayQueue::clearPlayQueue Feb 11 16:41:02 volumio volumio[3907]: info: CorePlayQueue::saveQueue Feb 11 16:41:02 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:02 volumio volumio[3907]: info: CoreCommandRouter::volumioPushQueue Feb 11 16:41:02 volumio volumio[3907]: info: Feb 11 16:41:02 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:02 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:02 volumio volumio[3907]: info: Feb 11 16:41:02 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:02 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:02 volumio volumio[3907]: info: Feb 11 16:41:02 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:02 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:02 volumio volumio[3907]: error: updateQueue error: null Feb 11 16:41:02 volumio volumio[3907]: error: updateQueue error: null Feb 11 16:41:02 volumio volumio[3907]: info: ------------------------------ 3ms Feb 11 16:41:02 volumio volumio[3907]: info: ------------------------------ 2ms Feb 11 16:41:02 volumio volumio[3907]: error: updateQueue error: null Feb 11 16:41:02 volumio volumio[3907]: info: ------------------------------ 3ms Feb 11 16:41:02 volumio volumio[3907]: info: Starting UPNP Playback Feb 11 16:41:02 volumio volumio[3907]: info: Preparing playback through UPNP Feb 11 16:41:02 volumio volumio[3907]: info: CoreCommandRouter::volumioGetState Feb 11 16:41:02 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:02 volumio volumio[3907]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 11 16:41:02 volumio volumio[3907]: info: Clearing queue after UPNP request Feb 11 16:41:03 volumio volumio[3907]: info: CoreStateMachine::ClearQueue Feb 11 16:41:03 volumio volumio[3907]: info: CoreStateMachine::stop Feb 11 16:41:03 volumio volumio[3907]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 16:41:03 volumio volumio[3907]: info: CorePlayQueue::clearPlayQueue Feb 11 16:41:03 volumio volumio[3907]: info: CorePlayQueue::saveQueue Feb 11 16:41:03 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:03 volumio volumio[3907]: info: CoreCommandRouter::volumioPushQueue Feb 11 16:41:03 volumio volumio[3907]: info: Feb 11 16:41:03 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:03 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:03 volumio volumio[3907]: info: Feb 11 16:41:03 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:03 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:03 volumio volumio[3907]: info: Feb 11 16:41:03 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:03 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:03 volumio volumio[3907]: error: updateQueue error: null Feb 11 16:41:03 volumio volumio[3907]: error: updateQueue error: null Feb 11 16:41:03 volumio volumio[3907]: info: ------------------------------ 2ms Feb 11 16:41:03 volumio volumio[3907]: info: ------------------------------ 2ms Feb 11 16:41:03 volumio volumio[3907]: error: updateQueue error: null Feb 11 16:41:03 volumio volumio[3907]: info: ------------------------------ 2ms Feb 11 16:41:03 volumio volumio[3907]: info: Starting UPNP Playback Feb 11 16:41:03 volumio volumio[3907]: info: Preparing playback through UPNP Feb 11 16:41:03 volumio volumio[3907]: info: CoreCommandRouter::volumioGetState Feb 11 16:41:03 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:03 volumio volumio[3907]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 11 16:41:03 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:03 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:03 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:03 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:03 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:03 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:03 volumio volumio[3907]: info: Clearing queue after UPNP request Feb 11 16:41:03 volumio volumio[3907]: info: CoreStateMachine::ClearQueue Feb 11 16:41:03 volumio volumio[3907]: info: CoreStateMachine::stop Feb 11 16:41:03 volumio volumio[3907]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 16:41:03 volumio volumio[3907]: info: CorePlayQueue::clearPlayQueue Feb 11 16:41:03 volumio volumio[3907]: info: CorePlayQueue::saveQueue Feb 11 16:41:03 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:03 volumio volumio[3907]: info: CoreCommandRouter::volumioPushQueue Feb 11 16:41:03 volumio volumio[3907]: info: Feb 11 16:41:03 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:03 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:03 volumio volumio[3907]: info: Feb 11 16:41:03 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:03 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:03 volumio volumio[3907]: info: Feb 11 16:41:03 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:03 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:03 volumio volumio[3907]: error: updateQueue error: null Feb 11 16:41:03 volumio volumio[3907]: error: updateQueue error: null Feb 11 16:41:03 volumio volumio[3907]: info: ------------------------------ 3ms Feb 11 16:41:03 volumio volumio[3907]: info: ------------------------------ 2ms Feb 11 16:41:03 volumio volumio[3907]: error: updateQueue error: null Feb 11 16:41:03 volumio volumio[3907]: info: ------------------------------ 2ms Feb 11 16:41:03 volumio volumio[3907]: info: Starting UPNP Playback Feb 11 16:41:03 volumio volumio[3907]: info: Preparing playback through UPNP Feb 11 16:41:03 volumio volumio[3907]: info: CoreCommandRouter::volumioGetState Feb 11 16:41:03 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:03 volumio volumio[3907]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 11 16:41:04 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:04 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:04 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:04 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:04 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:04 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:04 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:04 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:04 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 2ms Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 2ms Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:04 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:04 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:04 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 5ms Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 3ms Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 2ms Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 2ms Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:04 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:04 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:04 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 3ms Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 2ms Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:04 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:04 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:04 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 5ms Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 3ms Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 2ms Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 2ms Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:04 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:04 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:04 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 3ms Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 2ms Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:04 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:04 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:04 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 4ms Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 2ms Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 1ms Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 2ms Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces state update: player Feb 11 16:41:04 volumio volumio[3907]: info: ControllerMpd::getState Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand status Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces state update: player Feb 11 16:41:04 volumio volumio[3907]: info: ControllerMpd::getState Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand status Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces state update: player Feb 11 16:41:04 volumio volumio[3907]: info: ControllerMpd::getState Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand status Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces state update: player Feb 11 16:41:04 volumio volumio[3907]: info: sendMpdCommand status took 3 milliseconds Feb 11 16:41:04 volumio volumio[3907]: info: ControllerMpd::getState Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand status Feb 11 16:41:04 volumio volumio[3907]: info: sendMpdCommand status took 3 milliseconds Feb 11 16:41:04 volumio volumio[3907]: info: sendMpdCommand status took 2 milliseconds Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::parseState Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::parseState Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::parseState Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces state update: player Feb 11 16:41:04 volumio volumio[3907]: info: ControllerMpd::getState Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand status Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces state update: player Feb 11 16:41:04 volumio volumio[3907]: info: ControllerMpd::getState Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand status Feb 11 16:41:04 volumio volumio[3907]: info: sendMpdCommand status took 5 milliseconds Feb 11 16:41:04 volumio volumio[3907]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 11 16:41:04 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:41:04 volumio volumio[3907]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 11 16:41:04 volumio volumio[3907]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 11 16:41:04 volumio volumio[3907]: info: sendMpdCommand status took 2 milliseconds Feb 11 16:41:04 volumio volumio[3907]: info: sendMpdCommand status took 2 milliseconds Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::parseState Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::parseTrackInfo Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::parseTrackInfo Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::parseTrackInfo Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::parseState Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::parseState Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 16:41:04 volumio volumio[3907]: info: ControllerMpd::pushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:04 volumio volumio[3907]: verbose: In UPNP mode Feb 11 16:41:04 volumio volumio[3907]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"淡淡的 (把生活来过)","artist":null,"album":"淡淡的（把生活来过）","uri":"http://ws.stream.qqmusic.qq.com/F000004fs3700lsT7V.flac?guid=78B564D9E1EF4E788AF360CDFBF79CB3&vkey=6CAFCD36CC6E145BDEB49C8DC0F1C46D98752E3D0A538654FD1A8DF6069BC686A13AA0FA02FC7FA14780D15CFD8C727FA0AEC45FD55E6D38__v2b9ab929&uin=263021112&redirect=1&fromtag=101114","trackType":""} Feb 11 16:41:04 volumio volumio[3907]: verbose: CURRENT POSITION 0 Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::syncState stateService play Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::syncState currentStatus stop Feb 11 16:41:04 volumio volumio[3907]: info: ControllerMpd::pushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:04 volumio volumio[3907]: verbose: In UPNP mode Feb 11 16:41:04 volumio volumio[3907]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"淡淡的 (把生活来过)","artist":null,"album":"淡淡的（把生活来过）","uri":"http://ws.stream.qqmusic.qq.com/F000004fs3700lsT7V.flac?guid=78B564D9E1EF4E788AF360CDFBF79CB3&vkey=6CAFCD36CC6E145BDEB49C8DC0F1C46D98752E3D0A538654FD1A8DF6069BC686A13AA0FA02FC7FA14780D15CFD8C727FA0AEC45FD55E6D38__v2b9ab929&uin=263021112&redirect=1&fromtag=101114","trackType":""} Feb 11 16:41:04 volumio volumio[3907]: verbose: CURRENT POSITION 0 Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::syncState stateService play Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::syncState currentStatus play Feb 11 16:41:04 volumio volumio[3907]: info: Received an update from plugin. extracting info from payload Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:04 volumio volumio[3907]: info: ControllerMpd::pushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:04 volumio volumio[3907]: verbose: In UPNP mode Feb 11 16:41:04 volumio volumio[3907]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"淡淡的 (把生活来过)","artist":null,"album":"淡淡的（把生活来过）","uri":"http://ws.stream.qqmusic.qq.com/F000004fs3700lsT7V.flac?guid=78B564D9E1EF4E788AF360CDFBF79CB3&vkey=6CAFCD36CC6E145BDEB49C8DC0F1C46D98752E3D0A538654FD1A8DF6069BC686A13AA0FA02FC7FA14780D15CFD8C727FA0AEC45FD55E6D38__v2b9ab929&uin=263021112&redirect=1&fromtag=101114","trackType":""} Feb 11 16:41:04 volumio volumio[3907]: verbose: CURRENT POSITION 0 Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::syncState stateService play Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::syncState currentStatus play Feb 11 16:41:04 volumio volumio[3907]: info: Received an update from plugin. extracting info from payload Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 23ms Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 32ms Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 32ms Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:04 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces state update: player Feb 11 16:41:04 volumio volumio[3907]: info: sendMpdCommand playlistinfo took 23 milliseconds Feb 11 16:41:04 volumio volumio[3907]: info: sendMpdCommand playlistinfo took 23 milliseconds Feb 11 16:41:04 volumio volumio[3907]: info: ControllerMpd::getState Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand status Feb 11 16:41:04 volumio volumio[3907]: info: sendMpdCommand playlistinfo took 23 milliseconds Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::parseTrackInfo Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::parseTrackInfo Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::parseTrackInfo Feb 11 16:41:04 volumio volumio[3907]: info: ControllerMpd::pushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:04 volumio volumio[3907]: verbose: In UPNP mode Feb 11 16:41:04 volumio volumio[3907]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"淡淡的 (把生活来过)","artist":null,"album":"淡淡的（把生活来过）","uri":"http://ws.stream.qqmusic.qq.com/F000004fs3700lsT7V.flac?guid=78B564D9E1EF4E788AF360CDFBF79CB3&vkey=6CAFCD36CC6E145BDEB49C8DC0F1C46D98752E3D0A538654FD1A8DF6069BC686A13AA0FA02FC7FA14780D15CFD8C727FA0AEC45FD55E6D38__v2b9ab929&uin=263021112&redirect=1&fromtag=101114","trackType":""} Feb 11 16:41:04 volumio volumio[3907]: verbose: CURRENT POSITION 0 Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::syncState stateService play Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::syncState currentStatus play Feb 11 16:41:04 volumio volumio[3907]: info: Received an update from plugin. extracting info from payload Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:04 volumio volumio[3907]: info: ControllerMpd::pushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:04 volumio volumio[3907]: verbose: In UPNP mode Feb 11 16:41:04 volumio volumio[3907]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"淡淡的 (把生活来过)","artist":null,"album":"淡淡的（把生活来过）","uri":"http://ws.stream.qqmusic.qq.com/F000004fs3700lsT7V.flac?guid=78B564D9E1EF4E788AF360CDFBF79CB3&vkey=6CAFCD36CC6E145BDEB49C8DC0F1C46D98752E3D0A538654FD1A8DF6069BC686A13AA0FA02FC7FA14780D15CFD8C727FA0AEC45FD55E6D38__v2b9ab929&uin=263021112&redirect=1&fromtag=101114","trackType":""} Feb 11 16:41:04 volumio volumio[3907]: verbose: CURRENT POSITION 0 Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::syncState stateService play Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::syncState currentStatus play Feb 11 16:41:04 volumio volumio[3907]: info: Received an update from plugin. extracting info from payload Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:04 volumio volumio[3907]: info: ControllerMpd::pushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:04 volumio volumio[3907]: verbose: In UPNP mode Feb 11 16:41:04 volumio volumio[3907]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"淡淡的 (把生活来过)","artist":"gkuank","album":"淡淡的（把生活来过）","uri":"http://ws.stream.qqmusic.qq.com/F000004fs3700lsT7V.flac?guid=78B564D9E1EF4E788AF360CDFBF79CB3&vkey=6CAFCD36CC6E145BDEB49C8DC0F1C46D98752E3D0A538654FD1A8DF6069BC686A13AA0FA02FC7FA14780D15CFD8C727FA0AEC45FD55E6D38__v2b9ab929&uin=263021112&redirect=1&fromtag=101114","trackType":""} Feb 11 16:41:04 volumio volumio[3907]: verbose: CURRENT POSITION 0 Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::syncState stateService play Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::syncState currentStatus play Feb 11 16:41:04 volumio volumio[3907]: info: Received an update from plugin. extracting info from payload Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 58ms Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 54ms Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 54ms Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::volumioGetQueue Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::getQueue Feb 11 16:41:04 volumio volumio[3907]: info: CorePlayQueue::getQueue Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::volumioGetQueue Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::getQueue Feb 11 16:41:04 volumio volumio[3907]: info: CorePlayQueue::getQueue Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:04 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces state update: player Feb 11 16:41:04 volumio volumio[3907]: info: ControllerMpd::getState Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand status Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:04 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:04 volumio volumio[3907]: info: Feb 11 16:41:04 volumio volumio[3907]: ---------------------------- MPD announces state update: player Feb 11 16:41:04 volumio volumio[3907]: info: ControllerMpd::getState Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand status Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 55ms Feb 11 16:41:04 volumio volumio[3907]: info: sendMpdCommand status took 55 milliseconds Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 4ms Feb 11 16:41:04 volumio volumio[3907]: info: sendMpdCommand status took 3 milliseconds Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 3ms Feb 11 16:41:04 volumio volumio[3907]: info: sendMpdCommand status took 3 milliseconds Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::parseState Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::parseState Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::parseState Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 16:41:04 volumio volumio[3907]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 11 16:41:04 volumio volumio[3907]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 11 16:41:04 volumio volumio[3907]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::parseTrackInfo Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::parseTrackInfo Feb 11 16:41:04 volumio volumio[3907]: verbose: ControllerMpd::parseTrackInfo Feb 11 16:41:04 volumio volumio[3907]: info: ControllerMpd::pushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:04 volumio volumio[3907]: verbose: In UPNP mode Feb 11 16:41:04 volumio volumio[3907]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"747 Kbps","isStreaming":false,"title":"淡淡的 (把生活来过)","artist":"gkuank","album":"淡淡的（把生活来过）","uri":"http://ws.stream.qqmusic.qq.com/F000004fs3700lsT7V.flac?guid=78B564D9E1EF4E788AF360CDFBF79CB3&vkey=6CAFCD36CC6E145BDEB49C8DC0F1C46D98752E3D0A538654FD1A8DF6069BC686A13AA0FA02FC7FA14780D15CFD8C727FA0AEC45FD55E6D38__v2b9ab929&uin=263021112&redirect=1&fromtag=101114","trackType":""} Feb 11 16:41:04 volumio volumio[3907]: verbose: CURRENT POSITION 0 Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::syncState stateService play Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::syncState currentStatus play Feb 11 16:41:04 volumio volumio[3907]: info: Received an update from plugin. extracting info from payload Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:04 volumio volumio[3907]: info: ControllerMpd::pushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:04 volumio volumio[3907]: verbose: In UPNP mode Feb 11 16:41:04 volumio volumio[3907]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"785 Kbps","isStreaming":false,"title":"淡淡的 (把生活来过)","artist":"gkuank","album":"淡淡的（把生活来过）","uri":"http://ws.stream.qqmusic.qq.com/F000004fs3700lsT7V.flac?guid=78B564D9E1EF4E788AF360CDFBF79CB3&vkey=6CAFCD36CC6E145BDEB49C8DC0F1C46D98752E3D0A538654FD1A8DF6069BC686A13AA0FA02FC7FA14780D15CFD8C727FA0AEC45FD55E6D38__v2b9ab929&uin=263021112&redirect=1&fromtag=101114","trackType":""} Feb 11 16:41:04 volumio volumio[3907]: verbose: CURRENT POSITION 0 Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::syncState stateService play Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::syncState currentStatus play Feb 11 16:41:04 volumio volumio[3907]: info: Received an update from plugin. extracting info from payload Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:04 volumio volumio[3907]: info: ControllerMpd::pushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:04 volumio volumio[3907]: verbose: In UPNP mode Feb 11 16:41:04 volumio volumio[3907]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"785 Kbps","isStreaming":false,"title":"淡淡的 (把生活来过)","artist":"gkuank","album":"淡淡的（把生活来过）","uri":"http://ws.stream.qqmusic.qq.com/F000004fs3700lsT7V.flac?guid=78B564D9E1EF4E788AF360CDFBF79CB3&vkey=6CAFCD36CC6E145BDEB49C8DC0F1C46D98752E3D0A538654FD1A8DF6069BC686A13AA0FA02FC7FA14780D15CFD8C727FA0AEC45FD55E6D38__v2b9ab929&uin=263021112&redirect=1&fromtag=101114","trackType":""} Feb 11 16:41:04 volumio volumio[3907]: verbose: CURRENT POSITION 0 Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::syncState stateService play Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::syncState currentStatus play Feb 11 16:41:04 volumio volumio[3907]: info: Received an update from plugin. extracting info from payload Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 92ms Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 40ms Feb 11 16:41:04 volumio volumio[3907]: info: ------------------------------ 39ms Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::volumioGetQueue Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::getQueue Feb 11 16:41:04 volumio volumio[3907]: info: CorePlayQueue::getQueue Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::volumioGetQueue Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::getQueue Feb 11 16:41:04 volumio volumio[3907]: info: CorePlayQueue::getQueue Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::volumioGetQueue Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::getQueue Feb 11 16:41:04 volumio volumio[3907]: info: CorePlayQueue::getQueue Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::volumioGetQueue Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::getQueue Feb 11 16:41:04 volumio volumio[3907]: info: CorePlayQueue::getQueue Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::volumioGetQueue Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::getQueue Feb 11 16:41:04 volumio volumio[3907]: info: CorePlayQueue::getQueue Feb 11 16:41:04 volumio volumio[3907]: info: CoreCommandRouter::volumioGetQueue Feb 11 16:41:04 volumio volumio[3907]: info: CoreStateMachine::getQueue Feb 11 16:41:04 volumio volumio[3907]: info: CorePlayQueue::getQueue Feb 11 16:41:05 volumio shairport-sync[4133]: warning: alsa: error -16 ("Device or resource busy") opening alsa device "volumio". Feb 11 16:41:05 volumio volumio[3907]: info: Airplay started streaming, receiving metadatas Feb 11 16:41:05 volumio volumio[3907]: info: CoreCommandRouter::volumioStop Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::stop Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::stPlaybackTimer Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::updateTrackBlock Feb 11 16:41:05 volumio volumio[3907]: info: CorePlayQueue::getTrackBlock Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:05 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:05 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 16:41:05 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::serviceStop Feb 11 16:41:05 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:05 volumio volumio[3907]: info: ControllerMpd::stop Feb 11 16:41:05 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 16:41:05 volumio volumio[3907]: info: Airplay started streaming, receiving metadatas Feb 11 16:41:05 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:05 volumio volumio[3907]: info: CoreCommandRouter::volumioStop Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::stop Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 16:41:05 volumio volumio[3907]: info: Airplay started streaming, receiving metadatas Feb 11 16:41:05 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:05 volumio volumio[3907]: info: CoreCommandRouter::volumioStop Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::stop Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 16:41:05 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:41:05 volumio volumio[3907]: info: sendMpdCommand stop took 15 milliseconds Feb 11 16:41:05 volumio volumio[3907]: info: Feb 11 16:41:05 volumio volumio[3907]: ---------------------------- MPD announces state update: player Feb 11 16:41:05 volumio volumio[3907]: info: ControllerMpd::getState Feb 11 16:41:05 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand status Feb 11 16:41:05 volumio volumio[3907]: info: Feb 11 16:41:05 volumio volumio[3907]: ---------------------------- MPD announces state update: player Feb 11 16:41:05 volumio volumio[3907]: info: ControllerMpd::getState Feb 11 16:41:05 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand status Feb 11 16:41:05 volumio volumio[3907]: info: Feb 11 16:41:05 volumio volumio[3907]: ---------------------------- MPD announces state update: player Feb 11 16:41:05 volumio volumio[3907]: info: ControllerMpd::getState Feb 11 16:41:05 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand status Feb 11 16:41:05 volumio volumio[3907]: info: sendMpdCommand status took 3 milliseconds Feb 11 16:41:05 volumio volumio[3907]: info: sendMpdCommand status took 2 milliseconds Feb 11 16:41:05 volumio volumio[3907]: info: sendMpdCommand status took 1 milliseconds Feb 11 16:41:05 volumio volumio[3907]: verbose: ControllerMpd::parseState Feb 11 16:41:05 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 16:41:05 volumio volumio[3907]: verbose: ControllerMpd::parseState Feb 11 16:41:05 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 16:41:05 volumio volumio[3907]: verbose: ControllerMpd::parseState Feb 11 16:41:05 volumio volumio[3907]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 16:41:05 volumio volumio[3907]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 11 16:41:05 volumio volumio[3907]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 11 16:41:05 volumio volumio[3907]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 11 16:41:05 volumio volumio[3907]: verbose: ControllerMpd::parseTrackInfo Feb 11 16:41:05 volumio volumio[3907]: verbose: ControllerMpd::parseTrackInfo Feb 11 16:41:05 volumio volumio[3907]: verbose: ControllerMpd::parseTrackInfo Feb 11 16:41:05 volumio volumio[3907]: info: ControllerMpd::pushState Feb 11 16:41:05 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:05 volumio shairport-sync[4546]: % Total % Received % Xferd Average Speed Time Time Time Current Feb 11 16:41:05 volumio shairport-sync[4546]: Dload Upload Total Spent Left Speed Feb 11 16:41:05 volumio shairport-sync[4546]: [79B blob data] Feb 11 16:41:05 volumio shairport-sync[4551]: % Total % Received % Xferd Average Speed Time Time Time Current Feb 11 16:41:05 volumio shairport-sync[4551]: Dload Upload Total Spent Left Speed Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:05 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:05 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:05 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:05 volumio volumio[3907]: 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":"淡淡的 (把生活来过)","artist":"gkuank","album":"淡淡的（把生活来过）","uri":"http://ws.stream.qqmusic.qq.com/F000004fs3700lsT7V.flac?guid=78B564D9E1EF4E788AF360CDFBF79CB3&vkey=6CAFCD36CC6E145BDEB49C8DC0F1C46D98752E3D0A538654FD1A8DF6069BC686A13AA0FA02FC7FA14780D15CFD8C727FA0AEC45FD55E6D38__v2b9ab929&uin=263021112&redirect=1&fromtag=101114","trackType":""} Feb 11 16:41:05 volumio volumio[3907]: verbose: CURRENT POSITION 0 Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::syncState stateService stop Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::syncState currentStatus stop Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:05 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:05 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:05 volumio volumio[3907]: info: No code Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:05 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:05 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:05 volumio volumio[3907]: info: ControllerMpd::pushState Feb 11 16:41:05 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:05 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:05 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:05 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:05 volumio volumio[3907]: 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":"淡淡的 (把生活来过)","artist":"gkuank","album":"淡淡的（把生活来过）","uri":"http://ws.stream.qqmusic.qq.com/F000004fs3700lsT7V.flac?guid=78B564D9E1EF4E788AF360CDFBF79CB3&vkey=6CAFCD36CC6E145BDEB49C8DC0F1C46D98752E3D0A538654FD1A8DF6069BC686A13AA0FA02FC7FA14780D15CFD8C727FA0AEC45FD55E6D38__v2b9ab929&uin=263021112&redirect=1&fromtag=101114","trackType":""} Feb 11 16:41:05 volumio volumio[3907]: verbose: CURRENT POSITION 0 Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::syncState stateService stop Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::syncState currentStatus stop Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:05 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:05 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:05 volumio volumio[3907]: info: No code Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:05 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:05 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:05 volumio volumio[3907]: info: ControllerMpd::pushState Feb 11 16:41:05 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:05 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:05 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:05 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:05 volumio volumio[3907]: 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":"淡淡的 (把生活来过)","artist":"gkuank","album":"淡淡的（把生活来过）","uri":"http://ws.stream.qqmusic.qq.com/F000004fs3700lsT7V.flac?guid=78B564D9E1EF4E788AF360CDFBF79CB3&vkey=6CAFCD36CC6E145BDEB49C8DC0F1C46D98752E3D0A538654FD1A8DF6069BC686A13AA0FA02FC7FA14780D15CFD8C727FA0AEC45FD55E6D38__v2b9ab929&uin=263021112&redirect=1&fromtag=101114","trackType":""} Feb 11 16:41:05 volumio volumio[3907]: verbose: CURRENT POSITION 0 Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::syncState stateService stop Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::syncState currentStatus stop Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:05 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:05 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:05 volumio volumio[3907]: info: No code Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:05 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:05 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:05 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:41:05 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:41:05 volumio volumio[3907]: info: ------------------------------ 49ms Feb 11 16:41:05 volumio volumio[3907]: info: ------------------------------ 49ms Feb 11 16:41:05 volumio volumio[3907]: info: ------------------------------ 48ms Feb 11 16:41:05 volumio volumio[3907]: info: Updating volume from AirPlay: -20; 33% Feb 11 16:41:05 volumio volumio[3907]: info: VolumeController::SetAlsaVolume33 Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:05 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:05 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 16:41:05 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:05 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:41:05 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Feb 11 16:41:05 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:41:05 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Feb 11 16:41:05 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Feb 11 16:41:05 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Feb 11 16:41:05 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Feb 11 16:41:05 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:41:05 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Feb 11 16:41:05 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Feb 11 16:41:05 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Feb 11 16:41:05 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:41:05 volumio volumio[3907]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Invalid command! Feb 11 16:41:05 volumio volumio[3907]: info: Feb 11 16:41:05 volumio volumio[3907]: ---------------------------- Client requests AirplayActive Feb 11 16:41:05 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , setAirplayActive Feb 11 16:41:05 volumio shairport-sync[4551]: [79B blob data] Feb 11 16:41:05 volumio shairport-sync[4546]: [79B blob data] Feb 11 16:41:05 volumio volumio[3907]: info: Feb 11 16:41:05 volumio volumio[3907]: ---------------------------- Client requests Start Airplay PlaybackRoutine Feb 11 16:41:05 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Feb 11 16:41:05 volumio volumio[3907]: info: Airplay playback start Feb 11 16:41:05 volumio volumio[3907]: info: CorePlayQueue::getTrack 0 Feb 11 16:41:05 volumio volumio[3907]: info: CoreCommandRouter::volumioStop Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::stop Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 16:41:05 volumio shairport-sync[4546]: {"time":1770799265333,"response":"airplayActive Success"} Feb 11 16:41:05 volumio shairport-sync[4551]: [79B blob data] Feb 11 16:41:05 volumio volumio[3907]: info: Clearing queue after UPNP request Feb 11 16:41:05 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:05 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:05 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:05 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:05 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:05 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::ClearQueue Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::stop Feb 11 16:41:05 volumio volumio[3907]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 16:41:05 volumio volumio[3907]: info: CorePlayQueue::clearPlayQueue Feb 11 16:41:05 volumio volumio[3907]: info: CorePlayQueue::saveQueue Feb 11 16:41:05 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:05 volumio volumio[3907]: info: CoreCommandRouter::volumioPushQueue Feb 11 16:41:05 volumio volumio[3907]: info: Feb 11 16:41:05 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:05 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:05 volumio volumio[3907]: info: Feb 11 16:41:05 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:05 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:05 volumio volumio[3907]: info: Feb 11 16:41:05 volumio volumio[3907]: ---------------------------- MPD announces system playlist update Feb 11 16:41:05 volumio volumio[3907]: info: Ignoring MPD Status Update Feb 11 16:41:05 volumio volumio[3907]: error: updateQueue error: null Feb 11 16:41:05 volumio volumio[3907]: error: updateQueue error: null Feb 11 16:41:05 volumio volumio[3907]: info: ------------------------------ 2ms Feb 11 16:41:05 volumio volumio[3907]: info: ------------------------------ 2ms Feb 11 16:41:05 volumio volumio[3907]: error: updateQueue error: null Feb 11 16:41:05 volumio volumio[3907]: info: ------------------------------ 2ms Feb 11 16:41:06 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:06 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:06 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:06 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:06 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:06 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:06 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:06 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:06 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 16:41:06 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:06 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:06 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:06 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:06 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:06 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:06 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:06 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:06 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:06 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:07 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:07 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:07 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:07 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:07 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:07 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:08 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:08 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:08 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:08 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:08 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:08 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:09 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:09 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:09 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:09 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:09 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:09 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:10 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:10 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:10 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:10 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:10 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:10 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:11 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:11 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:11 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:11 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:11 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:11 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:12 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:12 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:12 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:12 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:12 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:12 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:13 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:13 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:13 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:13 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:13 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:13 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:14 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:14 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:14 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:14 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:14 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:14 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:15 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:15 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:15 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:15 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:15 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:15 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:16 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:16 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:16 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:16 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:16 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:16 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:17 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:17 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:17 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:17 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:17 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:17 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:18 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:18 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:18 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:18 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:18 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:18 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:19 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:19 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:19 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:19 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:19 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:19 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:20 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:20 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:20 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:20 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:20 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:20 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:20 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:20 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:20 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:20 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:41:20 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:20 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:20 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:20 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:20 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:20 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:20 volumio shairport-sync[4551]: {"time":1770799265338,"response":"startAirplayPlayback Success"} Feb 11 16:41:20 volumio shairport-sync[4642]: % Total % Received % Xferd Average Speed Time Time Time Current Feb 11 16:41:20 volumio shairport-sync[4642]: Dload Upload Total Spent Left Speed Feb 11 16:41:20 volumio volumio[3907]: info: Feb 11 16:41:20 volumio volumio[3907]: ---------------------------- Client requests Stop Airplay Playback Feb 11 16:41:20 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback Feb 11 16:41:20 volumio volumio[3907]: info: Airplay playback stop Feb 11 16:41:20 volumio volumio[3907]: info: Airplay Playback Stopped, clearing state Feb 11 16:41:20 volumio volumio[3907]: info: CoreStateMachine::resetVolumioState Feb 11 16:41:20 volumio volumio[3907]: info: CoreStateMachine::getcurrentVolume Feb 11 16:41:20 volumio volumio[3907]: info: CoreCommandRouter::volumioRetrievevolume Feb 11 16:41:20 volumio shairport-sync[4642]: [158B blob data] Feb 11 16:41:20 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:41:20 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Feb 11 16:41:20 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:41:20 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Feb 11 16:41:20 volumio volumio[3907]: info: VolumeController:: Volume=76 Mute =true Feb 11 16:41:20 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:20 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 16:41:20 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:20 volumio volumio[3907]: info: CoreStateMachine::updateTrackBlock Feb 11 16:41:20 volumio volumio[3907]: info: CorePlayQueue::getTrackBlock Feb 11 16:41:20 volumio volumio[3907]: info: CoreCommandRouter::volumioRetrievevolume Feb 11 16:41:20 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:41:20 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Feb 11 16:41:20 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:41:20 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Feb 11 16:41:20 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:41:20 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Feb 11 16:41:20 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:41:20 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Feb 11 16:41:20 volumio volumio[3907]: info: VolumeController:: Volume=76 Mute =true Feb 11 16:41:20 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:20 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:20 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:41:20 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Feb 11 16:41:20 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:41:20 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Feb 11 16:41:21 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:21 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:21 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:21 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:21 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:21 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:22 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:22 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:22 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:22 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:22 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:22 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:23 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:23 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:23 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:23 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:23 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:23 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:24 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:24 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:24 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:24 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:24 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:24 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:25 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:25 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:25 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:25 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:25 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:25 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:26 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:26 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:26 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:26 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:26 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:26 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:27 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:27 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:27 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:27 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:27 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:27 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:28 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:28 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:28 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:28 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:28 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:28 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:29 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:29 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:29 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:29 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:29 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:29 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:30 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:30 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:30 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:30 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:30 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:30 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:30 volumio shairport-sync[4642]: {"time":1770799280915,"response":"stopAirplayPlayback Success"} Feb 11 16:41:30 volumio shairport-sync[4663]: % Total % Received % Xferd Average Speed Time Time Time Current Feb 11 16:41:30 volumio shairport-sync[4663]: Dload Upload Total Spent Left Speed Feb 11 16:41:30 volumio volumio[3907]: info: Feb 11 16:41:30 volumio volumio[3907]: ---------------------------- Client requests AirplayInactive Feb 11 16:41:30 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , setAirplayInctive Feb 11 16:41:30 volumio shairport-sync[4663]: [158B blob data] Feb 11 16:41:31 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:31 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:31 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:31 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:31 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:31 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:31 volumio volumio[3907]: info: Airplay started streaming, receiving metadatas Feb 11 16:41:31 volumio volumio[3907]: info: Airplay started streaming, receiving metadatas Feb 11 16:41:31 volumio volumio[3907]: info: Airplay started streaming, receiving metadatas Feb 11 16:41:31 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:41:31 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:41:31 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:41:31 volumio shairport-sync[4663]: {"time":1770799290919,"response":"airplayInactive Success"} Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: % Feb 11 16:41:31 volumio shairport-sync[4671]: % Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: T Feb 11 16:41:31 volumio shairport-sync[4671]: T Feb 11 16:41:31 volumio shairport-sync[4674]: o Feb 11 16:41:31 volumio shairport-sync[4671]: o Feb 11 16:41:31 volumio shairport-sync[4674]: t Feb 11 16:41:31 volumio shairport-sync[4671]: t Feb 11 16:41:31 volumio shairport-sync[4674]: a Feb 11 16:41:31 volumio shairport-sync[4671]: a Feb 11 16:41:31 volumio shairport-sync[4674]: l Feb 11 16:41:31 volumio shairport-sync[4671]: l Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: % Feb 11 16:41:31 volumio shairport-sync[4671]: % Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: R Feb 11 16:41:31 volumio shairport-sync[4671]: R Feb 11 16:41:31 volumio shairport-sync[4674]: e Feb 11 16:41:31 volumio shairport-sync[4671]: e Feb 11 16:41:31 volumio volumio[3907]: info: Feb 11 16:41:31 volumio volumio[3907]: ---------------------------- Client requests Start Airplay PlaybackRoutine Feb 11 16:41:31 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Feb 11 16:41:31 volumio volumio[3907]: info: Airplay playback start Feb 11 16:41:31 volumio shairport-sync[4674]: c Feb 11 16:41:31 volumio shairport-sync[4671]: c Feb 11 16:41:31 volumio shairport-sync[4674]: e Feb 11 16:41:31 volumio volumio[3907]: info: Feb 11 16:41:31 volumio volumio[3907]: ---------------------------- Client requests AirplayActive Feb 11 16:41:31 volumio shairport-sync[4671]: e Feb 11 16:41:31 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , setAirplayActive Feb 11 16:41:31 volumio shairport-sync[4674]: i Feb 11 16:41:31 volumio shairport-sync[4671]: i Feb 11 16:41:31 volumio shairport-sync[4674]: v Feb 11 16:41:31 volumio shairport-sync[4671]: v Feb 11 16:41:31 volumio shairport-sync[4674]: e Feb 11 16:41:31 volumio shairport-sync[4671]: e Feb 11 16:41:31 volumio shairport-sync[4674]: d Feb 11 16:41:31 volumio shairport-sync[4671]: d Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: % Feb 11 16:41:31 volumio shairport-sync[4671]: % Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: X Feb 11 16:41:31 volumio shairport-sync[4671]: X Feb 11 16:41:31 volumio shairport-sync[4674]: f Feb 11 16:41:31 volumio shairport-sync[4671]: f Feb 11 16:41:31 volumio shairport-sync[4674]: e Feb 11 16:41:31 volumio shairport-sync[4671]: e Feb 11 16:41:31 volumio shairport-sync[4674]: r Feb 11 16:41:31 volumio shairport-sync[4671]: r Feb 11 16:41:31 volumio shairport-sync[4674]: d Feb 11 16:41:31 volumio shairport-sync[4671]: d Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: A Feb 11 16:41:31 volumio shairport-sync[4671]: A Feb 11 16:41:31 volumio shairport-sync[4674]: v Feb 11 16:41:31 volumio shairport-sync[4671]: v Feb 11 16:41:31 volumio shairport-sync[4674]: e Feb 11 16:41:31 volumio shairport-sync[4671]: e Feb 11 16:41:31 volumio shairport-sync[4674]: r Feb 11 16:41:31 volumio shairport-sync[4671]: r Feb 11 16:41:31 volumio shairport-sync[4674]: a Feb 11 16:41:31 volumio shairport-sync[4671]: a Feb 11 16:41:31 volumio shairport-sync[4674]: g Feb 11 16:41:31 volumio shairport-sync[4671]: g Feb 11 16:41:31 volumio shairport-sync[4674]: e Feb 11 16:41:31 volumio shairport-sync[4671]: e Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:41:31 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:41:31 volumio shairport-sync[4674]: S Feb 11 16:41:31 volumio shairport-sync[4671]: S Feb 11 16:41:31 volumio shairport-sync[4674]: p Feb 11 16:41:31 volumio shairport-sync[4671]: p Feb 11 16:41:31 volumio shairport-sync[4674]: e Feb 11 16:41:31 volumio shairport-sync[4671]: e Feb 11 16:41:31 volumio shairport-sync[4674]: ed Feb 11 16:41:31 volumio shairport-sync[4671]: e Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: d Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: T Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: i Feb 11 16:41:31 volumio shairport-sync[4671]: T Feb 11 16:41:31 volumio shairport-sync[4674]: m Feb 11 16:41:31 volumio shairport-sync[4671]: i Feb 11 16:41:31 volumio shairport-sync[4674]: e Feb 11 16:41:31 volumio shairport-sync[4671]: m Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: e Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: T Feb 11 16:41:31 volumio shairport-sync[4671]: T Feb 11 16:41:31 volumio shairport-sync[4674]: i Feb 11 16:41:31 volumio shairport-sync[4671]: i Feb 11 16:41:31 volumio shairport-sync[4674]: m Feb 11 16:41:31 volumio shairport-sync[4671]: m Feb 11 16:41:31 volumio shairport-sync[4674]: e Feb 11 16:41:31 volumio shairport-sync[4671]: e Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: T Feb 11 16:41:31 volumio shairport-sync[4671]: T Feb 11 16:41:31 volumio shairport-sync[4674]: i Feb 11 16:41:31 volumio shairport-sync[4671]: i Feb 11 16:41:31 volumio shairport-sync[4674]: m Feb 11 16:41:31 volumio shairport-sync[4671]: m Feb 11 16:41:31 volumio shairport-sync[4674]: e Feb 11 16:41:31 volumio shairport-sync[4671]: e Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: C Feb 11 16:41:31 volumio shairport-sync[4671]: C Feb 11 16:41:31 volumio shairport-sync[4674]: u Feb 11 16:41:31 volumio shairport-sync[4671]: u Feb 11 16:41:31 volumio shairport-sync[4674]: r Feb 11 16:41:31 volumio shairport-sync[4671]: r Feb 11 16:41:31 volumio shairport-sync[4674]: r Feb 11 16:41:31 volumio shairport-sync[4671]: r Feb 11 16:41:31 volumio shairport-sync[4674]: e Feb 11 16:41:31 volumio shairport-sync[4671]: en Feb 11 16:41:31 volumio shairport-sync[4674]: n Feb 11 16:41:31 volumio shairport-sync[4671]: t Feb 11 16:41:31 volumio shairport-sync[4674]: t Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: D Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: l Feb 11 16:41:31 volumio shairport-sync[4674]: D Feb 11 16:41:31 volumio shairport-sync[4671]: o Feb 11 16:41:31 volumio shairport-sync[4674]: l Feb 11 16:41:31 volumio shairport-sync[4671]: a Feb 11 16:41:31 volumio shairport-sync[4674]: o Feb 11 16:41:31 volumio shairport-sync[4671]: d Feb 11 16:41:31 volumio shairport-sync[4674]: a Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: d Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: U Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: p Feb 11 16:41:31 volumio shairport-sync[4674]: U Feb 11 16:41:31 volumio shairport-sync[4671]: l Feb 11 16:41:31 volumio shairport-sync[4674]: p Feb 11 16:41:31 volumio shairport-sync[4671]: o Feb 11 16:41:31 volumio shairport-sync[4674]: l Feb 11 16:41:31 volumio shairport-sync[4671]: a Feb 11 16:41:31 volumio shairport-sync[4674]: o Feb 11 16:41:31 volumio shairport-sync[4671]: d Feb 11 16:41:31 volumio shairport-sync[4674]: a Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: d Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: T Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: o Feb 11 16:41:31 volumio shairport-sync[4674]: T Feb 11 16:41:31 volumio shairport-sync[4671]: t Feb 11 16:41:31 volumio shairport-sync[4674]: o Feb 11 16:41:31 volumio shairport-sync[4671]: a Feb 11 16:41:31 volumio shairport-sync[4674]: t Feb 11 16:41:31 volumio shairport-sync[4671]: l Feb 11 16:41:31 volumio shairport-sync[4674]: a Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: l Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Sp Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: e Feb 11 16:41:31 volumio shairport-sync[4674]: S Feb 11 16:41:31 volumio shairport-sync[4671]: n Feb 11 16:41:31 volumio shairport-sync[4674]: p Feb 11 16:41:31 volumio shairport-sync[4671]: t Feb 11 16:41:31 volumio shairport-sync[4674]: e Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: n Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: t Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: L Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: e Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: f Feb 11 16:41:31 volumio shairport-sync[4674]: L Feb 11 16:41:31 volumio shairport-sync[4671]: t Feb 11 16:41:31 volumio shairport-sync[4674]: e Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: f Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: t Feb 11 16:41:31 volumio shairport-sync[4671]: S Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: p Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: e Feb 11 16:41:31 volumio shairport-sync[4674]: S Feb 11 16:41:31 volumio shairport-sync[4671]: e Feb 11 16:41:31 volumio shairport-sync[4674]: p Feb 11 16:41:31 volumio shairport-sync[4671]: d Feb 11 16:41:31 volumio shairport-sync[4674]: e Feb 11 16:41:31 volumio shairport-sync[4674]: ed Feb 11 16:41:31 volumio shairport-sync[4671]: [2B blob data] Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: 0 Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: 0 Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: 0 Feb 11 16:41:31 volumio shairport-sync[4671]: 0 Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: 0 Feb 11 16:41:31 volumio shairport-sync[4671]: 0 Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: 0 Feb 11 16:41:31 volumio shairport-sync[4674]: 0 Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: 0 Feb 11 16:41:31 volumio shairport-sync[4674]: 0 Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: 0 Feb 11 16:41:31 volumio shairport-sync[4671]: 0 Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: 0 Feb 11 16:41:31 volumio shairport-sync[4674]: 0 Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: 0 Feb 11 16:41:31 volumio shairport-sync[4674]: 0 Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: - Feb 11 16:41:31 volumio shairport-sync[4674]: - Feb 11 16:41:31 volumio shairport-sync[4671]: - Feb 11 16:41:31 volumio shairport-sync[4674]: - Feb 11 16:41:31 volumio shairport-sync[4671]: : Feb 11 16:41:31 volumio shairport-sync[4674]: : Feb 11 16:41:31 volumio shairport-sync[4671]: - Feb 11 16:41:31 volumio shairport-sync[4674]: -- Feb 11 16:41:31 volumio shairport-sync[4671]: - Feb 11 16:41:31 volumio shairport-sync[4674]: : Feb 11 16:41:31 volumio shairport-sync[4671]: :- Feb 11 16:41:31 volumio shairport-sync[4674]: - Feb 11 16:41:31 volumio shairport-sync[4671]: - Feb 11 16:41:31 volumio shairport-sync[4674]: - Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: - Feb 11 16:41:31 volumio shairport-sync[4671]: - Feb 11 16:41:31 volumio shairport-sync[4674]: - Feb 11 16:41:31 volumio shairport-sync[4671]: - Feb 11 16:41:31 volumio shairport-sync[4674]: : Feb 11 16:41:31 volumio shairport-sync[4671]: : Feb 11 16:41:31 volumio shairport-sync[4674]: - Feb 11 16:41:31 volumio shairport-sync[4671]: - Feb 11 16:41:31 volumio shairport-sync[4674]: - Feb 11 16:41:31 volumio shairport-sync[4671]: - Feb 11 16:41:31 volumio shairport-sync[4674]: : Feb 11 16:41:31 volumio shairport-sync[4671]: :- Feb 11 16:41:31 volumio shairport-sync[4674]: - Feb 11 16:41:31 volumio shairport-sync[4671]: - Feb 11 16:41:31 volumio shairport-sync[4674]: - Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: - Feb 11 16:41:31 volumio shairport-sync[4674]: - Feb 11 16:41:31 volumio shairport-sync[4671]: - Feb 11 16:41:31 volumio shairport-sync[4674]: - Feb 11 16:41:31 volumio shairport-sync[4671]: : Feb 11 16:41:31 volumio shairport-sync[4674]: : Feb 11 16:41:31 volumio shairport-sync[4671]: - Feb 11 16:41:31 volumio shairport-sync[4674]: - Feb 11 16:41:31 volumio shairport-sync[4671]: - Feb 11 16:41:31 volumio shairport-sync[4674]: - Feb 11 16:41:31 volumio shairport-sync[4671]: : Feb 11 16:41:31 volumio shairport-sync[4674]: : Feb 11 16:41:31 volumio shairport-sync[4671]: - Feb 11 16:41:31 volumio shairport-sync[4674]: -- Feb 11 16:41:31 volumio shairport-sync[4671]: - Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: Feb 11 16:41:31 volumio shairport-sync[4671]: Feb 11 16:41:31 volumio shairport-sync[4674]: 0 Feb 11 16:41:31 volumio shairport-sync[4671]: 0 Feb 11 16:41:31 volumio shairport-sync[4674]: [79B blob data] Feb 11 16:41:31 volumio shairport-sync[4674]: {"time":1770799291791,"response":"startAirplayPlayback Success"} Feb 11 16:41:31 volumio shairport-sync[4671]: [79B blob data] Feb 11 16:41:32 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:32 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:32 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:32 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:32 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:32 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:32 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:32 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:32 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 16:41:32 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:32 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:32 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:32 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:32 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:32 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:32 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:32 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:32 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:32 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:33 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:33 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:33 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:33 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:33 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:33 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:33 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:33 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:33 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 16:41:33 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:33 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:33 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:33 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:33 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:33 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:33 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:33 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:33 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:33 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 16:41:33 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:33 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:33 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:33 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:33 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:41:33 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:41:33 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:41:33 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:41:33 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:41:34 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:34 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:34 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:34 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:34 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:34 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:35 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:35 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:35 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:35 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:35 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:35 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:36 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:36 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:36 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:36 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:36 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:36 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:37 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:37 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:37 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:37 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:37 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:37 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:38 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:38 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:38 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:38 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:38 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:38 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:39 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:39 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:39 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:39 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:39 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:39 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:40 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:40 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:40 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:40 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:40 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:40 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:41 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:41 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:41 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:41 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:41 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:41 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:42 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:42 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:42 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:42 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:42 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:42 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:43 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:43 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:43 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:43 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:43 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:43 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:44 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:44 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:44 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:44 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:44 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:44 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:45 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:45 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:45 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:45 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:45 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:45 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:46 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:46 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:46 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:46 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:46 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:46 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:47 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:47 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:47 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:47 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:47 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:47 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:48 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:48 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:48 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:48 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:48 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:48 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:49 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:49 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:49 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:49 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:49 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:49 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:50 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:50 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:50 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:50 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:50 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:50 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:51 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:51 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:51 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:51 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:51 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:51 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:52 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:52 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:52 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:52 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:52 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:52 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:53 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:53 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:53 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:53 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:53 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:53 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:54 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:54 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:54 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:54 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:54 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:54 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:55 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:55 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:55 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:55 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:55 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:55 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:56 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:56 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:56 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:56 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:56 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:56 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:57 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:57 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:57 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:57 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:57 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:57 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:58 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:58 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:58 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:58 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:58 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:58 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:59 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:59 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:59 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:59 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:59 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:41:59 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:00 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:00 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:00 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:00 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:00 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:00 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:01 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:01 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:01 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:01 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:01 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:01 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:02 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:02 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:02 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:02 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:02 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:02 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:03 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:03 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:03 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:03 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:03 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:03 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:04 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:04 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:04 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:04 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:04 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:04 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:04 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 16:42:04 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:04 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:05 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:05 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:05 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:05 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:05 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:05 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:05 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:05 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:05 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 16:42:05 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:05 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:05 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:05 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:05 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:05 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:05 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:05 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:05 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:05 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 16:42:05 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:05 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:05 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:05 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:05 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:05 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:05 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:06 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:06 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:06 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:06 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:06 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:06 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:06 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:06 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:06 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:06 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 16:42:06 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:06 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:06 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:06 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:06 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:06 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:06 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:06 volumio shairport-sync[4671]: {"time":1770799291793,"response":"airplayActive Success"} Feb 11 16:42:06 volumio shairport-sync[4733]: % Total % Received % Xferd Average Speed Time Time Time Current Feb 11 16:42:06 volumio shairport-sync[4733]: Dload Upload Total Spent Left Speed Feb 11 16:42:06 volumio volumio[3907]: info: Feb 11 16:42:06 volumio volumio[3907]: ---------------------------- Client requests Stop Airplay Playback Feb 11 16:42:06 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback Feb 11 16:42:06 volumio volumio[3907]: info: Airplay playback stop Feb 11 16:42:06 volumio volumio[3907]: info: Airplay Playback Stopped, clearing state Feb 11 16:42:06 volumio volumio[3907]: info: CoreStateMachine::resetVolumioState Feb 11 16:42:06 volumio volumio[3907]: info: CoreStateMachine::getcurrentVolume Feb 11 16:42:06 volumio volumio[3907]: info: CoreCommandRouter::volumioRetrievevolume Feb 11 16:42:06 volumio shairport-sync[4733]: [158B blob data] Feb 11 16:42:07 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:07 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Feb 11 16:42:07 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:07 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Feb 11 16:42:07 volumio volumio[3907]: info: VolumeController:: Volume=76 Mute =true Feb 11 16:42:07 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:07 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:07 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:07 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Feb 11 16:42:07 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:07 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Feb 11 16:42:07 volumio volumio[3907]: info: CoreStateMachine::updateTrackBlock Feb 11 16:42:07 volumio volumio[3907]: info: CorePlayQueue::getTrackBlock Feb 11 16:42:07 volumio volumio[3907]: info: CoreCommandRouter::volumioRetrievevolume Feb 11 16:42:07 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:07 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Feb 11 16:42:07 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:07 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Feb 11 16:42:07 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:07 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Feb 11 16:42:07 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:07 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Feb 11 16:42:07 volumio volumio[3907]: info: VolumeController:: Volume=76 Mute =true Feb 11 16:42:07 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:07 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:07 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:07 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:07 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:07 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:07 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:07 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:08 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:08 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:08 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:08 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:08 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:08 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:09 volumio volumio[3907]: info: Airplay started streaming, receiving metadatas Feb 11 16:42:09 volumio volumio[3907]: info: Airplay started streaming, receiving metadatas Feb 11 16:42:09 volumio volumio[3907]: info: Airplay started streaming, receiving metadatas Feb 11 16:42:09 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:09 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:09 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:09 volumio shairport-sync[4733]: {"time":1770799326988,"response":"stopAirplayPlayback Success"} Feb 11 16:42:09 volumio shairport-sync[4746]: % Total % Received % Xferd Average Speed Time Time Time Current Feb 11 16:42:09 volumio shairport-sync[4746]: Dload Upload Total Spent Left Speed Feb 11 16:42:09 volumio volumio[3907]: info: Feb 11 16:42:09 volumio volumio[3907]: ---------------------------- Client requests Start Airplay PlaybackRoutine Feb 11 16:42:09 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Feb 11 16:42:09 volumio volumio[3907]: info: Airplay playback start Feb 11 16:42:09 volumio shairport-sync[4746]: [158B blob data] Feb 11 16:42:09 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:09 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:09 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:09 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:09 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:09 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:10 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 16:42:10 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:10 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:10 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:10 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:10 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:10 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:10 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:10 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 16:42:10 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:10 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:10 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:10 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 16:42:10 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:10 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:11 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:11 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:11 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:11 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:11 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:11 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:12 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:12 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:12 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:12 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:12 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:12 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:13 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:13 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:13 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:13 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:13 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:13 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:14 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:14 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:14 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:14 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:14 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:14 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:15 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:15 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:15 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:15 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:15 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:15 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:16 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:16 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:16 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:16 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:16 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:16 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:17 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:17 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:17 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:17 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:17 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:17 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:18 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:18 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:18 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:18 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:18 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:18 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:19 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:19 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:19 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:19 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:19 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:19 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:20 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:20 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:20 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:20 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:20 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:20 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:21 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:21 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:21 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:21 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:21 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:21 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:22 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:22 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:22 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:22 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:22 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:22 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:23 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:23 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:23 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:23 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:23 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:23 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:24 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:24 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:24 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:24 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:24 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:24 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:25 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:25 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:25 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:25 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:25 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:25 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:26 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:26 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:26 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:26 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:26 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:26 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:26 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:26 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:26 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:26 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:26 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:26 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 16:42:26 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:26 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:26 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:26 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:26 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:26 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:26 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:26 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:26 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:26 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:26 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:26 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:26 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:27 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:27 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:27 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:27 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:27 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:27 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:28 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:28 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:28 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:28 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:28 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:28 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:28 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:28 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:28 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 16:42:28 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:28 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:28 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:28 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:28 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:28 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:28 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:28 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:28 volumio shairport-sync[4746]: {"time":1770799329053,"response":"startAirplayPlayback Success"} Feb 11 16:42:28 volumio shairport-sync[4777]: % Total % Received % Xferd Average Speed Time Time Time Current Feb 11 16:42:28 volumio shairport-sync[4777]: Dload Upload Total Spent Left Speed Feb 11 16:42:28 volumio volumio[3907]: info: Feb 11 16:42:28 volumio volumio[3907]: ---------------------------- Client requests Stop Airplay Playback Feb 11 16:42:28 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback Feb 11 16:42:28 volumio volumio[3907]: info: Airplay playback stop Feb 11 16:42:28 volumio volumio[3907]: info: Airplay Playback Stopped, clearing state Feb 11 16:42:28 volumio volumio[3907]: info: CoreStateMachine::resetVolumioState Feb 11 16:42:28 volumio volumio[3907]: info: CoreStateMachine::getcurrentVolume Feb 11 16:42:28 volumio volumio[3907]: info: CoreCommandRouter::volumioRetrievevolume Feb 11 16:42:28 volumio shairport-sync[4777]: [158B blob data] Feb 11 16:42:28 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:28 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Feb 11 16:42:28 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:28 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Feb 11 16:42:28 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:28 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Feb 11 16:42:28 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:28 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Feb 11 16:42:28 volumio volumio[3907]: info: VolumeController:: Volume=76 Mute =true Feb 11 16:42:28 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:28 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 16:42:28 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:28 volumio volumio[3907]: info: CoreStateMachine::updateTrackBlock Feb 11 16:42:28 volumio volumio[3907]: info: CorePlayQueue::getTrackBlock Feb 11 16:42:28 volumio volumio[3907]: info: CoreCommandRouter::volumioRetrievevolume Feb 11 16:42:28 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:28 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Feb 11 16:42:28 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:28 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Feb 11 16:42:28 volumio volumio[3907]: info: VolumeController:: Volume=76 Mute =true Feb 11 16:42:28 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:28 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:28 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:28 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Feb 11 16:42:28 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:28 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000022] -121 Feb 11 16:42:30 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:30 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:30 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:30 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:30 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:30 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:31 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:31 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:31 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:31 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:31 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:31 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:32 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:32 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:32 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:32 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:32 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:32 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:33 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:33 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:33 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:33 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:33 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:33 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:34 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:34 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:34 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:34 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:34 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:34 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:35 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:35 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:35 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:35 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:35 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:35 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:36 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:36 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:36 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:36 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:36 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:36 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:37 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:37 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:37 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:37 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:37 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:37 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:37 volumio volumio[3907]: info: Airplay started streaming, receiving metadatas Feb 11 16:42:37 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:37 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:37 volumio volumio[3907]: info: Airplay started streaming, receiving metadatas Feb 11 16:42:37 volumio volumio[3907]: info: Airplay started streaming, receiving metadatas Feb 11 16:42:37 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:37 volumio shairport-sync[4777]: {"time":1770799348580,"response":"stopAirplayPlayback Success"} Feb 11 16:42:37 volumio shairport-sync[4805]: % Total % Received % Xferd Average Speed Time Time Time Current Feb 11 16:42:37 volumio shairport-sync[4805]: Dload Upload Total Spent Left Speed Feb 11 16:42:37 volumio volumio[3907]: info: Feb 11 16:42:37 volumio volumio[3907]: ---------------------------- Client requests Start Airplay PlaybackRoutine Feb 11 16:42:37 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Feb 11 16:42:37 volumio volumio[3907]: info: Airplay playback start Feb 11 16:42:37 volumio shairport-sync[4805]: [158B blob data] Feb 11 16:42:37 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:37 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:37 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:38 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:38 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:38 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:38 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:38 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:38 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:38 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:38 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:38 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:38 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:38 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:38 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:38 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:38 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:38 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:38 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:38 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:38 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:39 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:39 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:39 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:39 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:39 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:39 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:39 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:39 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:39 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 16:42:39 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:39 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:39 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:39 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:39 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:39 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:39 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:39 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:39 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:39 volumio volumio[3907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 16:42:39 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:39 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:39 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:39 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:39 volumio volumio[3907]: info: CoreCommandRouter::servicePushState Feb 11 16:42:39 volumio volumio[3907]: info: CoreStateMachine::pushState Feb 11 16:42:39 volumio volumio[3907]: info: CoreCommandRouter::volumioPushState Feb 11 16:42:39 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:39 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Feb 11 16:42:40 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:40 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:40 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:40 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:40 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:40 volumio volumio-remote-updater[789]: PROGRESS: 34, STATUS: "Downloading new update", ETA: "4m" Feb 11 16:42:40 volumio volumio[3907]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 11 16:42:40 volumio volumio[3907]: Error: connect ECONNREFUSED 103.42.176.244:443 Feb 11 16:42:40 volumio volumio[3907]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Feb 11 16:42:40 volumio volumio[3907]: errno: -111, Feb 11 16:42:40 volumio volumio[3907]: code: 'ECONNREFUSED', Feb 11 16:42:40 volumio volumio[3907]: syscall: 'connect', Feb 11 16:42:40 volumio volumio[3907]: address: '103.42.176.244', Feb 11 16:42:40 volumio volumio[3907]: port: 443 Feb 11 16:42:40 volumio volumio[3907]: } Feb 11 16:42:40 volumio volumio[3907]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 11 16:42:41 volumio sudo[4820]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-11 16:41' Feb 11 16:42:41 volumio sudo[4820]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"