-- Logs begin at Thu 2019-02-14 15:41:58 IST, end at Wed 2025-04-30 10:35:21 IST. -- Apr 30 10:34:02 volumio volumio[989]: info: Clearing queue after UPNP request Apr 30 10:34:02 volumio volumio[989]: info: CoreStateMachine::ClearQueue Apr 30 10:34:02 volumio volumio[989]: info: CoreStateMachine::stop Apr 30 10:34:02 volumio volumio[989]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 10:34:02 volumio volumio[989]: info: CorePlayQueue::clearPlayQueue Apr 30 10:34:02 volumio volumio[989]: info: CorePlayQueue::saveQueue Apr 30 10:34:02 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:02 volumio volumio[989]: info: CoreCommandRouter::volumioPushQueue Apr 30 10:34:02 volumio volumio[989]: error: Upnp client error: Error: This socket has been ended by the other party Apr 30 10:34:04 volumio volumio[989]: info: Clearing queue after UPNP request Apr 30 10:34:04 volumio volumio[989]: info: CoreStateMachine::ClearQueue Apr 30 10:34:04 volumio volumio[989]: info: CoreStateMachine::stop Apr 30 10:34:04 volumio volumio[989]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 10:34:04 volumio volumio[989]: info: CorePlayQueue::clearPlayQueue Apr 30 10:34:04 volumio volumio[989]: info: CorePlayQueue::saveQueue Apr 30 10:34:04 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:04 volumio volumio[989]: info: CoreCommandRouter::volumioPushQueue Apr 30 10:34:04 volumio volumio[989]: info: Apr 30 10:34:04 volumio volumio[989]: ---------------------------- MPD announces system playlist update Apr 30 10:34:04 volumio volumio[989]: info: Ignoring MPD Status Update Apr 30 10:34:04 volumio volumio[989]: error: updateQueue error: null Apr 30 10:34:04 volumio volumio[989]: info: ------------------------------ 1ms Apr 30 10:34:05 volumio volumio[989]: info: Starting UPNP Playback Apr 30 10:34:05 volumio volumio[989]: info: Preparing playback through UPNP Apr 30 10:34:05 volumio volumio[989]: info: CoreCommandRouter::volumioGetState Apr 30 10:34:05 volumio volumio[989]: info: CorePlayQueue::getTrack 0 Apr 30 10:34:05 volumio volumio[989]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 30 10:34:05 volumio volumio[989]: info: Apr 30 10:34:05 volumio volumio[989]: ---------------------------- MPD announces system playlist update Apr 30 10:34:05 volumio volumio[989]: info: Ignoring MPD Status Update Apr 30 10:34:05 volumio volumio[989]: info: Apr 30 10:34:05 volumio volumio[989]: ---------------------------- MPD announces system playlist update Apr 30 10:34:05 volumio volumio[989]: info: Ignoring MPD Status Update Apr 30 10:34:05 volumio volumio[989]: info: ------------------------------ 2ms Apr 30 10:34:05 volumio volumio[989]: info: ------------------------------ 1ms Apr 30 10:34:05 volumio volumio[989]: info: Apr 30 10:34:05 volumio volumio[989]: ---------------------------- MPD announces system playlist update Apr 30 10:34:05 volumio volumio[989]: info: Ignoring MPD Status Update Apr 30 10:34:05 volumio volumio[989]: info: ------------------------------ 1ms Apr 30 10:34:05 volumio volumio[989]: info: Apr 30 10:34:05 volumio volumio[989]: ---------------------------- MPD announces system playlist update Apr 30 10:34:05 volumio volumio[989]: info: Ignoring MPD Status Update Apr 30 10:34:05 volumio volumio[989]: info: ------------------------------ 1ms Apr 30 10:34:05 volumio volumio[989]: info: Apr 30 10:34:05 volumio volumio[989]: ---------------------------- MPD announces system playlist update Apr 30 10:34:05 volumio volumio[989]: info: Ignoring MPD Status Update Apr 30 10:34:05 volumio volumio[989]: info: ------------------------------ 1ms Apr 30 10:34:05 volumio volumio[989]: info: Apr 30 10:34:05 volumio volumio[989]: ---------------------------- MPD announces system playlist update Apr 30 10:34:05 volumio volumio[989]: info: Ignoring MPD Status Update Apr 30 10:34:05 volumio volumio[989]: info: ------------------------------ 1ms Apr 30 10:34:05 volumio volumio[989]: info: Apr 30 10:34:05 volumio volumio[989]: ---------------------------- MPD announces state update: player Apr 30 10:34:05 volumio volumio[989]: info: ControllerMpd::getState Apr 30 10:34:05 volumio volumio[989]: verbose: ControllerMpd::sendMpdCommand status Apr 30 10:34:05 volumio volumio[989]: info: Apr 30 10:34:05 volumio volumio[989]: ---------------------------- MPD announces state update: player Apr 30 10:34:05 volumio volumio[989]: info: sendMpdCommand status took 16 milliseconds Apr 30 10:34:05 volumio volumio[989]: info: ControllerMpd::getState Apr 30 10:34:05 volumio volumio[989]: verbose: ControllerMpd::sendMpdCommand status Apr 30 10:34:05 volumio volumio[989]: verbose: ControllerMpd::parseState Apr 30 10:34:05 volumio volumio[989]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 10:34:05 volumio volumio[989]: info: sendMpdCommand status took 1 milliseconds Apr 30 10:34:05 volumio volumio[989]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 30 10:34:05 volumio volumio[989]: verbose: ControllerMpd::parseState Apr 30 10:34:05 volumio volumio[989]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 10:34:05 volumio volumio[989]: verbose: ControllerMpd::parseTrackInfo Apr 30 10:34:05 volumio volumio[989]: info: ControllerMpd::pushState Apr 30 10:34:05 volumio volumio[989]: info: CoreCommandRouter::servicePushState Apr 30 10:34:05 volumio volumio[989]: verbose: In UPNP mode Apr 30 10:34:05 volumio volumio[989]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":12174,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"foobar2000 audio stream","artist":null,"album":null,"uri":"http://192.168.29.102:57969/9/stream.wav","trackType":"wav"} Apr 30 10:34:05 volumio volumio[989]: verbose: CURRENT POSITION 0 Apr 30 10:34:05 volumio volumio[989]: info: CoreStateMachine::syncState stateService play Apr 30 10:34:05 volumio volumio[989]: info: CoreStateMachine::syncState currentStatus stop Apr 30 10:34:05 volumio volumio[989]: info: ------------------------------ 20ms Apr 30 10:34:05 volumio volumio[989]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 30 10:34:05 volumio volumio[989]: verbose: ControllerMpd::parseTrackInfo Apr 30 10:34:05 volumio volumio[989]: info: ControllerMpd::pushState Apr 30 10:34:05 volumio volumio[989]: info: CoreCommandRouter::servicePushState Apr 30 10:34:05 volumio volumio[989]: verbose: In UPNP mode Apr 30 10:34:05 volumio volumio[989]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":12174,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"foobar2000 audio stream","artist":null,"album":null,"uri":"http://192.168.29.102:57969/9/stream.wav","trackType":"wav"} Apr 30 10:34:05 volumio volumio[989]: verbose: CURRENT POSITION 0 Apr 30 10:34:05 volumio volumio[989]: info: CoreStateMachine::syncState stateService play Apr 30 10:34:05 volumio volumio[989]: info: CoreStateMachine::syncState currentStatus play Apr 30 10:34:05 volumio volumio[989]: info: Received an update from plugin. extracting info from payload Apr 30 10:34:05 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:05 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:05 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:05 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:05 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:05 volumio volumio[989]: info: ------------------------------ 15ms Apr 30 10:34:05 volumio volumio[989]: info: Clearing queue after UPNP request Apr 30 10:34:06 volumio volumio[989]: info: CoreStateMachine::ClearQueue Apr 30 10:34:06 volumio volumio[989]: info: CoreStateMachine::stop Apr 30 10:34:06 volumio volumio[989]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 10:34:06 volumio volumio[989]: info: CoreStateMachine::stPlaybackTimer Apr 30 10:34:06 volumio volumio[989]: info: CoreStateMachine::updateTrackBlock Apr 30 10:34:06 volumio volumio[989]: info: CorePlayQueue::getTrackBlock Apr 30 10:34:06 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:06 volumio volumio[989]: info: CorePlayQueue::getTrack 0 Apr 30 10:34:06 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:06 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:06 volumio volumio[989]: info: CoreStateMachine::serviceStop Apr 30 10:34:06 volumio volumio[989]: info: CorePlayQueue::getTrack 0 Apr 30 10:34:06 volumio volumio[989]: info: ControllerMpd::stop Apr 30 10:34:06 volumio volumio[989]: verbose: ControllerMpd::sendMpdCommand stop Apr 30 10:34:06 volumio volumio[989]: info: CorePlayQueue::clearPlayQueue Apr 30 10:34:06 volumio volumio[989]: info: CorePlayQueue::saveQueue Apr 30 10:34:06 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:06 volumio volumio[989]: info: CoreCommandRouter::volumioPushQueue Apr 30 10:34:06 volumio volumio[989]: info: Apr 30 10:34:06 volumio volumio[989]: ---------------------------- MPD announces state update: player Apr 30 10:34:06 volumio volumio[989]: info: sendMpdCommand stop took 13 milliseconds Apr 30 10:34:06 volumio volumio[989]: info: ControllerMpd::getState Apr 30 10:34:06 volumio volumio[989]: verbose: ControllerMpd::sendMpdCommand status Apr 30 10:34:06 volumio volumio[989]: info: Apr 30 10:34:06 volumio volumio[989]: ---------------------------- MPD announces system playlist update Apr 30 10:34:06 volumio volumio[989]: info: Ignoring MPD Status Update Apr 30 10:34:06 volumio volumio[989]: info: sendMpdCommand status took 4 milliseconds Apr 30 10:34:06 volumio volumio[989]: verbose: ControllerMpd::parseState Apr 30 10:34:06 volumio volumio[989]: info: ControllerMpd::pushState Apr 30 10:34:06 volumio volumio[989]: info: CoreCommandRouter::servicePushState Apr 30 10:34:06 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:06 volumio volumio[989]: info: CorePlayQueue::getTrack 0 Apr 30 10:34:06 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:06 volumio volumio[989]: info: CorePlayQueue::getTrack 0 Apr 30 10:34:06 volumio volumio[989]: 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} Apr 30 10:34:06 volumio volumio[989]: verbose: CURRENT POSITION 0 Apr 30 10:34:06 volumio volumio[989]: info: CoreStateMachine::syncState stateService stop Apr 30 10:34:06 volumio volumio[989]: info: CoreStateMachine::syncState currentStatus stop Apr 30 10:34:06 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:06 volumio volumio[989]: info: CorePlayQueue::getTrack 0 Apr 30 10:34:06 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:06 volumio volumio[989]: info: No code Apr 30 10:34:06 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:06 volumio volumio[989]: info: CorePlayQueue::getTrack 0 Apr 30 10:34:06 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:06 volumio volumio[989]: info: ------------------------------ 24ms Apr 30 10:34:06 volumio volumio[989]: error: updateQueue error: null Apr 30 10:34:06 volumio volumio[989]: info: ------------------------------ 25ms Apr 30 10:34:12 volumio volumio[989]: info: Clearing queue after UPNP request Apr 30 10:34:13 volumio volumio[989]: info: CoreStateMachine::ClearQueue Apr 30 10:34:13 volumio volumio[989]: info: CoreStateMachine::stop Apr 30 10:34:13 volumio volumio[989]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 10:34:13 volumio volumio[989]: info: CorePlayQueue::clearPlayQueue Apr 30 10:34:13 volumio volumio[989]: info: CorePlayQueue::saveQueue Apr 30 10:34:13 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:13 volumio volumio[989]: info: CoreCommandRouter::volumioPushQueue Apr 30 10:34:13 volumio volumio[989]: info: Apr 30 10:34:13 volumio volumio[989]: ---------------------------- MPD announces system playlist update Apr 30 10:34:13 volumio volumio[989]: info: Ignoring MPD Status Update Apr 30 10:34:13 volumio volumio[989]: info: Clearing queue after UPNP request Apr 30 10:34:13 volumio volumio[989]: error: updateQueue error: null Apr 30 10:34:13 volumio volumio[989]: info: ------------------------------ 1ms Apr 30 10:34:13 volumio volumio[989]: info: CoreStateMachine::ClearQueue Apr 30 10:34:13 volumio volumio[989]: info: CoreStateMachine::stop Apr 30 10:34:13 volumio volumio[989]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 10:34:13 volumio volumio[989]: info: CorePlayQueue::clearPlayQueue Apr 30 10:34:13 volumio volumio[989]: info: CorePlayQueue::saveQueue Apr 30 10:34:13 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:13 volumio volumio[989]: info: CoreCommandRouter::volumioPushQueue Apr 30 10:34:13 volumio volumio[989]: info: Apr 30 10:34:13 volumio volumio[989]: ---------------------------- MPD announces system playlist update Apr 30 10:34:13 volumio volumio[989]: info: Ignoring MPD Status Update Apr 30 10:34:13 volumio volumio[989]: error: updateQueue error: null Apr 30 10:34:13 volumio volumio[989]: info: ------------------------------ 1ms Apr 30 10:34:13 volumio volumio[989]: info: Starting UPNP Playback Apr 30 10:34:13 volumio volumio[989]: info: Preparing playback through UPNP Apr 30 10:34:13 volumio volumio[989]: info: CoreCommandRouter::volumioGetState Apr 30 10:34:13 volumio volumio[989]: info: CorePlayQueue::getTrack 0 Apr 30 10:34:13 volumio volumio[989]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 30 10:34:14 volumio volumio[989]: info: Apr 30 10:34:14 volumio volumio[989]: ---------------------------- MPD announces system playlist update Apr 30 10:34:14 volumio volumio[989]: info: Ignoring MPD Status Update Apr 30 10:34:14 volumio volumio[989]: info: Apr 30 10:34:14 volumio volumio[989]: ---------------------------- MPD announces system playlist update Apr 30 10:34:14 volumio volumio[989]: info: Ignoring MPD Status Update Apr 30 10:34:14 volumio volumio[989]: info: ------------------------------ 1ms Apr 30 10:34:14 volumio volumio[989]: info: ------------------------------ 1ms Apr 30 10:34:14 volumio volumio[989]: info: Apr 30 10:34:14 volumio volumio[989]: ---------------------------- MPD announces system playlist update Apr 30 10:34:14 volumio volumio[989]: info: Ignoring MPD Status Update Apr 30 10:34:14 volumio volumio[989]: info: ------------------------------ 1ms Apr 30 10:34:14 volumio volumio[989]: info: Apr 30 10:34:14 volumio volumio[989]: ---------------------------- MPD announces system playlist update Apr 30 10:34:14 volumio volumio[989]: info: Ignoring MPD Status Update Apr 30 10:34:14 volumio volumio[989]: info: ------------------------------ 1ms Apr 30 10:34:14 volumio volumio[989]: info: Apr 30 10:34:14 volumio volumio[989]: ---------------------------- MPD announces system playlist update Apr 30 10:34:14 volumio volumio[989]: info: Ignoring MPD Status Update Apr 30 10:34:14 volumio volumio[989]: info: ------------------------------ 1ms Apr 30 10:34:14 volumio volumio[989]: info: Apr 30 10:34:14 volumio volumio[989]: ---------------------------- MPD announces system playlist update Apr 30 10:34:14 volumio volumio[989]: info: Ignoring MPD Status Update Apr 30 10:34:14 volumio volumio[989]: info: ------------------------------ 1ms Apr 30 10:34:14 volumio volumio[989]: info: Apr 30 10:34:14 volumio volumio[989]: ---------------------------- MPD announces state update: player Apr 30 10:34:14 volumio volumio[989]: info: ControllerMpd::getState Apr 30 10:34:14 volumio volumio[989]: verbose: ControllerMpd::sendMpdCommand status Apr 30 10:34:14 volumio volumio[989]: info: Apr 30 10:34:14 volumio volumio[989]: ---------------------------- MPD announces state update: player Apr 30 10:34:14 volumio volumio[989]: info: sendMpdCommand status took 12 milliseconds Apr 30 10:34:14 volumio volumio[989]: info: ControllerMpd::getState Apr 30 10:34:14 volumio volumio[989]: verbose: ControllerMpd::sendMpdCommand status Apr 30 10:34:14 volumio volumio[989]: verbose: ControllerMpd::parseState Apr 30 10:34:14 volumio volumio[989]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 10:34:14 volumio volumio[989]: info: sendMpdCommand status took 1 milliseconds Apr 30 10:34:14 volumio volumio[989]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 30 10:34:14 volumio volumio[989]: verbose: ControllerMpd::parseState Apr 30 10:34:14 volumio volumio[989]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 10:34:14 volumio volumio[989]: verbose: ControllerMpd::parseTrackInfo Apr 30 10:34:14 volumio volumio[989]: info: ControllerMpd::pushState Apr 30 10:34:14 volumio volumio[989]: info: CoreCommandRouter::servicePushState Apr 30 10:34:14 volumio volumio[989]: verbose: In UPNP mode Apr 30 10:34:14 volumio volumio[989]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":12174,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"foobar2000 audio stream","artist":null,"album":null,"uri":"http://192.168.29.102:57969/10/stream.wav","trackType":"wav"} Apr 30 10:34:14 volumio volumio[989]: verbose: CURRENT POSITION 0 Apr 30 10:34:14 volumio volumio[989]: info: CoreStateMachine::syncState stateService play Apr 30 10:34:14 volumio volumio[989]: info: CoreStateMachine::syncState currentStatus stop Apr 30 10:34:14 volumio volumio[989]: info: ------------------------------ 15ms Apr 30 10:34:14 volumio volumio[989]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 30 10:34:14 volumio volumio[989]: verbose: ControllerMpd::parseTrackInfo Apr 30 10:34:14 volumio volumio[989]: info: ControllerMpd::pushState Apr 30 10:34:14 volumio volumio[989]: info: CoreCommandRouter::servicePushState Apr 30 10:34:14 volumio volumio[989]: verbose: In UPNP mode Apr 30 10:34:14 volumio volumio[989]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":12174,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"foobar2000 audio stream","artist":null,"album":null,"uri":"http://192.168.29.102:57969/10/stream.wav","trackType":"wav"} Apr 30 10:34:14 volumio volumio[989]: verbose: CURRENT POSITION 0 Apr 30 10:34:14 volumio volumio[989]: info: CoreStateMachine::syncState stateService play Apr 30 10:34:14 volumio volumio[989]: info: CoreStateMachine::syncState currentStatus play Apr 30 10:34:14 volumio volumio[989]: info: Received an update from plugin. extracting info from payload Apr 30 10:34:14 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:14 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:14 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:14 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:14 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:14 volumio volumio[989]: info: ------------------------------ 15ms Apr 30 10:34:23 volumio volumio[1235]: 30 Apr 30 10:34:23 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:23 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:23 volumio volumio[989]: info: Apr 30 10:34:23 volumio volumio[989]: ---------------------------- Client requests Volume 30 Apr 30 10:34:23 volumio volumio[989]: info: VolumeController::SetAlsaVolume30 Apr 30 10:34:23 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:23 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:23 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:23 volumio volumio[1235]: [158B blob data] Apr 30 10:34:23 volumio volumio[1235]: {"time":1745989463289,"response":"volume Success"}30 Apr 30 10:34:23 volumio volumio[1235]: 29 Apr 30 10:34:23 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:23 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:23 volumio volumio[989]: info: Apr 30 10:34:23 volumio volumio[989]: ---------------------------- Client requests Volume 29 Apr 30 10:34:23 volumio volumio[989]: info: VolumeController::SetAlsaVolume29 Apr 30 10:34:23 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:23 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:23 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:23 volumio volumio[1235]: [158B blob data] Apr 30 10:34:23 volumio volumio[1235]: {"time":1745989463476,"response":"volume Success"}29 Apr 30 10:34:23 volumio volumio[1235]: 28 Apr 30 10:34:23 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:23 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:23 volumio volumio[989]: info: Apr 30 10:34:23 volumio volumio[989]: ---------------------------- Client requests Volume 28 Apr 30 10:34:23 volumio volumio[989]: info: VolumeController::SetAlsaVolume28 Apr 30 10:34:23 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:23 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:23 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:23 volumio volumio[1235]: [158B blob data] Apr 30 10:34:23 volumio volumio[1235]: {"time":1745989463660,"response":"volume Success"}28 Apr 30 10:34:23 volumio volumio[1235]: 27 Apr 30 10:34:23 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:23 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:23 volumio volumio[989]: info: Apr 30 10:34:23 volumio volumio[989]: ---------------------------- Client requests Volume 27 Apr 30 10:34:23 volumio volumio[989]: info: VolumeController::SetAlsaVolume27 Apr 30 10:34:23 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:23 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:23 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:23 volumio volumio[1235]: [158B blob data] Apr 30 10:34:23 volumio volumio[1235]: {"time":1745989463852,"response":"volume Success"}27 Apr 30 10:34:24 volumio volumio[1235]: 26 Apr 30 10:34:24 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:24 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:24 volumio volumio[989]: info: Apr 30 10:34:24 volumio volumio[989]: ---------------------------- Client requests Volume 26 Apr 30 10:34:24 volumio volumio[989]: info: VolumeController::SetAlsaVolume26 Apr 30 10:34:24 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:24 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:24 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:24 volumio volumio[1235]: [158B blob data] Apr 30 10:34:24 volumio volumio[1235]: {"time":1745989464031,"response":"volume Success"}26 Apr 30 10:34:24 volumio volumio[1235]: 25 Apr 30 10:34:24 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:24 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:24 volumio volumio[989]: info: Apr 30 10:34:24 volumio volumio[989]: ---------------------------- Client requests Volume 25 Apr 30 10:34:24 volumio volumio[989]: info: VolumeController::SetAlsaVolume25 Apr 30 10:34:24 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:24 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:24 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:24 volumio volumio[1235]: [158B blob data] Apr 30 10:34:24 volumio volumio[1235]: {"time":1745989464194,"response":"volume Success"}25 Apr 30 10:34:24 volumio volumio[1235]: 24 Apr 30 10:34:24 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:24 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:24 volumio volumio[989]: info: Apr 30 10:34:24 volumio volumio[989]: ---------------------------- Client requests Volume 24 Apr 30 10:34:24 volumio volumio[989]: info: VolumeController::SetAlsaVolume24 Apr 30 10:34:24 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:24 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:24 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:24 volumio volumio[1235]: [158B blob data] Apr 30 10:34:24 volumio volumio[1235]: {"time":1745989464325,"response":"volume Success"}24 Apr 30 10:34:24 volumio volumio[1235]: 23 Apr 30 10:34:24 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:24 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:24 volumio volumio[989]: info: Apr 30 10:34:24 volumio volumio[989]: ---------------------------- Client requests Volume 23 Apr 30 10:34:24 volumio volumio[989]: info: VolumeController::SetAlsaVolume23 Apr 30 10:34:24 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:24 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:24 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:24 volumio volumio[1235]: [158B blob data] Apr 30 10:34:24 volumio volumio[1235]: {"time":1745989464580,"response":"volume Success"}23 Apr 30 10:34:24 volumio volumio[1235]: 22 Apr 30 10:34:24 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:24 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:24 volumio volumio[989]: info: Apr 30 10:34:24 volumio volumio[989]: ---------------------------- Client requests Volume 22 Apr 30 10:34:24 volumio volumio[989]: info: VolumeController::SetAlsaVolume22 Apr 30 10:34:24 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:24 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:24 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:25 volumio volumio[1235]: [158B blob data] Apr 30 10:34:25 volumio volumio[1235]: {"time":1745989464978,"response":"volume Success"}22 Apr 30 10:34:25 volumio volumio[1235]: 21 Apr 30 10:34:25 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:25 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:25 volumio volumio[989]: info: Apr 30 10:34:25 volumio volumio[989]: ---------------------------- Client requests Volume 21 Apr 30 10:34:25 volumio volumio[989]: info: VolumeController::SetAlsaVolume21 Apr 30 10:34:25 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:25 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:25 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:25 volumio volumio[1235]: [158B blob data] Apr 30 10:34:25 volumio volumio[1235]: {"time":1745989465159,"response":"volume Success"}21 Apr 30 10:34:25 volumio volumio[1235]: 20 Apr 30 10:34:25 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:25 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:25 volumio volumio[989]: info: Apr 30 10:34:25 volumio volumio[989]: ---------------------------- Client requests Volume 20 Apr 30 10:34:25 volumio volumio[989]: info: VolumeController::SetAlsaVolume20 Apr 30 10:34:25 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:25 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:25 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:25 volumio volumio[1235]: [158B blob data] Apr 30 10:34:25 volumio volumio[1235]: {"time":1745989465330,"response":"volume Success"}20 Apr 30 10:34:25 volumio volumio[1235]: 19 Apr 30 10:34:25 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:25 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:25 volumio volumio[989]: info: Apr 30 10:34:25 volumio volumio[989]: ---------------------------- Client requests Volume 19 Apr 30 10:34:25 volumio volumio[989]: info: VolumeController::SetAlsaVolume19 Apr 30 10:34:25 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:25 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:25 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:25 volumio volumio[1235]: [158B blob data] Apr 30 10:34:25 volumio volumio[1235]: {"time":1745989465501,"response":"volume Success"}19 Apr 30 10:34:25 volumio volumio[1235]: 18 Apr 30 10:34:25 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:25 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:25 volumio volumio[989]: info: Apr 30 10:34:25 volumio volumio[989]: ---------------------------- Client requests Volume 18 Apr 30 10:34:25 volumio volumio[989]: info: VolumeController::SetAlsaVolume18 Apr 30 10:34:25 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:25 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:25 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:25 volumio volumio[1235]: [158B blob data] Apr 30 10:34:25 volumio volumio[1235]: {"time":1745989465679,"response":"volume Success"}18 Apr 30 10:34:25 volumio volumio[1235]: 17 Apr 30 10:34:25 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:25 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:25 volumio volumio[989]: info: Apr 30 10:34:25 volumio volumio[989]: ---------------------------- Client requests Volume 17 Apr 30 10:34:25 volumio volumio[989]: info: VolumeController::SetAlsaVolume17 Apr 30 10:34:25 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:25 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:25 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:25 volumio volumio[1235]: [158B blob data] Apr 30 10:34:25 volumio volumio[1235]: {"time":1745989465865,"response":"volume Success"}17 Apr 30 10:34:26 volumio volumio[1235]: 16 Apr 30 10:34:26 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:26 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:26 volumio volumio[989]: info: Apr 30 10:34:26 volumio volumio[989]: ---------------------------- Client requests Volume 16 Apr 30 10:34:26 volumio volumio[989]: info: VolumeController::SetAlsaVolume16 Apr 30 10:34:26 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:26 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:26 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:26 volumio volumio[1235]: [158B blob data] Apr 30 10:34:26 volumio volumio[1235]: {"time":1745989466046,"response":"volume Success"}16 Apr 30 10:34:26 volumio volumio[1235]: 15 Apr 30 10:34:26 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:26 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:26 volumio volumio[989]: info: Apr 30 10:34:26 volumio volumio[989]: ---------------------------- Client requests Volume 15 Apr 30 10:34:26 volumio volumio[989]: info: VolumeController::SetAlsaVolume15 Apr 30 10:34:26 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:26 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:26 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:26 volumio volumio[1235]: [158B blob data] Apr 30 10:34:26 volumio volumio[1235]: {"time":1745989466245,"response":"volume Success"}15 Apr 30 10:34:26 volumio volumio[1235]: 14 Apr 30 10:34:26 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:26 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:26 volumio volumio[989]: info: Apr 30 10:34:26 volumio volumio[989]: ---------------------------- Client requests Volume 14 Apr 30 10:34:26 volumio volumio[989]: info: VolumeController::SetAlsaVolume14 Apr 30 10:34:26 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:26 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:26 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:26 volumio volumio[1235]: [158B blob data] Apr 30 10:34:26 volumio volumio[1235]: {"time":1745989466427,"response":"volume Success"}14 Apr 30 10:34:26 volumio volumio[1235]: 13 Apr 30 10:34:26 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:26 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:26 volumio volumio[989]: info: Apr 30 10:34:26 volumio volumio[989]: ---------------------------- Client requests Volume 13 Apr 30 10:34:26 volumio volumio[989]: info: VolumeController::SetAlsaVolume13 Apr 30 10:34:26 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:26 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:26 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:26 volumio volumio[1235]: [158B blob data] Apr 30 10:34:26 volumio volumio[1235]: {"time":1745989466618,"response":"volume Success"}13 Apr 30 10:34:26 volumio volumio[1235]: 12 Apr 30 10:34:26 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:26 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:26 volumio volumio[989]: info: Apr 30 10:34:26 volumio volumio[989]: ---------------------------- Client requests Volume 12 Apr 30 10:34:26 volumio volumio[989]: info: VolumeController::SetAlsaVolume12 Apr 30 10:34:26 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:26 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:26 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:26 volumio volumio[1235]: [158B blob data] Apr 30 10:34:26 volumio volumio[1235]: {"time":1745989466814,"response":"volume Success"}12 Apr 30 10:34:26 volumio volumio[1235]: 11 Apr 30 10:34:26 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:26 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:26 volumio volumio[989]: info: Apr 30 10:34:26 volumio volumio[989]: ---------------------------- Client requests Volume 11 Apr 30 10:34:26 volumio volumio[989]: info: VolumeController::SetAlsaVolume11 Apr 30 10:34:27 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:27 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:27 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:27 volumio volumio[1235]: [158B blob data] Apr 30 10:34:27 volumio volumio[1235]: {"time":1745989466986,"response":"volume Success"}11 Apr 30 10:34:27 volumio volumio[1235]: 10 Apr 30 10:34:27 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:27 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:27 volumio volumio[989]: info: Apr 30 10:34:27 volumio volumio[989]: ---------------------------- Client requests Volume 10 Apr 30 10:34:27 volumio volumio[989]: info: VolumeController::SetAlsaVolume10 Apr 30 10:34:27 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:27 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:27 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:27 volumio volumio[1235]: [158B blob data] Apr 30 10:34:27 volumio volumio[1235]: {"time":1745989467174,"response":"volume Success"}10 Apr 30 10:34:27 volumio volumio[1235]: 9 Apr 30 10:34:27 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:27 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:27 volumio volumio[989]: info: Apr 30 10:34:27 volumio volumio[989]: ---------------------------- Client requests Volume 9 Apr 30 10:34:27 volumio volumio[989]: info: VolumeController::SetAlsaVolume9 Apr 30 10:34:27 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:27 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:27 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:27 volumio volumio[1235]: [158B blob data] Apr 30 10:34:27 volumio volumio[1235]: {"time":1745989467355,"response":"volume Success"}9 Apr 30 10:34:27 volumio volumio[1235]: 8 Apr 30 10:34:27 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:27 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:27 volumio volumio[989]: info: Apr 30 10:34:27 volumio volumio[989]: ---------------------------- Client requests Volume 8 Apr 30 10:34:27 volumio volumio[989]: info: VolumeController::SetAlsaVolume8 Apr 30 10:34:27 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:27 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:27 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:27 volumio volumio[1235]: [158B blob data] Apr 30 10:34:27 volumio volumio[1235]: {"time":1745989467553,"response":"volume Success"}8 Apr 30 10:34:27 volumio volumio[1235]: 7 Apr 30 10:34:27 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:27 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:27 volumio volumio[989]: info: Apr 30 10:34:27 volumio volumio[989]: ---------------------------- Client requests Volume 7 Apr 30 10:34:27 volumio volumio[989]: info: VolumeController::SetAlsaVolume7 Apr 30 10:34:27 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:27 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:27 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:27 volumio volumio[1235]: [158B blob data] Apr 30 10:34:27 volumio volumio[1235]: {"time":1745989467748,"response":"volume Success"}7 Apr 30 10:34:27 volumio volumio[1235]: 6 Apr 30 10:34:27 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:27 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:27 volumio volumio[989]: info: Apr 30 10:34:27 volumio volumio[989]: ---------------------------- Client requests Volume 6 Apr 30 10:34:27 volumio volumio[989]: info: VolumeController::SetAlsaVolume6 Apr 30 10:34:27 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:27 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:27 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:27 volumio volumio[1235]: [158B blob data] Apr 30 10:34:27 volumio volumio[1235]: {"time":1745989467884,"response":"volume Success"}6 Apr 30 10:34:28 volumio volumio[1235]: 5 Apr 30 10:34:28 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:28 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:28 volumio volumio[989]: info: Apr 30 10:34:28 volumio volumio[989]: ---------------------------- Client requests Volume 5 Apr 30 10:34:28 volumio volumio[989]: info: VolumeController::SetAlsaVolume5 Apr 30 10:34:28 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:28 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:28 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:28 volumio volumio[1235]: [158B blob data] Apr 30 10:34:28 volumio volumio[1235]: {"time":1745989468212,"response":"volume Success"}5 Apr 30 10:34:28 volumio volumio[1235]: 4 Apr 30 10:34:28 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:28 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:28 volumio volumio[989]: info: Apr 30 10:34:28 volumio volumio[989]: ---------------------------- Client requests Volume 4 Apr 30 10:34:28 volumio volumio[989]: info: VolumeController::SetAlsaVolume4 Apr 30 10:34:28 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:28 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:28 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:28 volumio volumio[1235]: [237B blob data] Apr 30 10:34:28 volumio volumio[1235]: {"time":1745989468395,"response":"volume Success"}4 Apr 30 10:34:28 volumio volumio[1235]: 3 Apr 30 10:34:28 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:28 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:28 volumio volumio[989]: info: Apr 30 10:34:28 volumio volumio[989]: ---------------------------- Client requests Volume 3 Apr 30 10:34:28 volumio volumio[989]: info: VolumeController::SetAlsaVolume3 Apr 30 10:34:28 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:28 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:28 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:28 volumio volumio[1235]: [158B blob data] Apr 30 10:34:28 volumio volumio[1235]: {"time":1745989468524,"response":"volume Success"}3 Apr 30 10:34:28 volumio volumio[1235]: 2 Apr 30 10:34:28 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:28 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:28 volumio volumio[989]: info: Apr 30 10:34:28 volumio volumio[989]: ---------------------------- Client requests Volume 2 Apr 30 10:34:28 volumio volumio[989]: info: VolumeController::SetAlsaVolume2 Apr 30 10:34:28 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:28 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:28 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:28 volumio volumio[1235]: [158B blob data] Apr 30 10:34:28 volumio volumio[1235]: {"time":1745989468679,"response":"volume Success"}2 Apr 30 10:34:28 volumio volumio[1235]: 1 Apr 30 10:34:28 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:28 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:28 volumio volumio[989]: info: Apr 30 10:34:28 volumio volumio[989]: ---------------------------- Client requests Volume 1 Apr 30 10:34:28 volumio volumio[989]: info: VolumeController::SetAlsaVolume1 Apr 30 10:34:28 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:28 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:28 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:28 volumio volumio[1235]: [158B blob data] Apr 30 10:34:28 volumio volumio[1235]: {"time":1745989468821,"response":"volume Success"}1 Apr 30 10:34:28 volumio volumio[1235]: 0 Apr 30 10:34:28 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:28 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:28 volumio volumio[989]: info: Apr 30 10:34:28 volumio volumio[989]: ---------------------------- Client requests Volume 1 Apr 30 10:34:28 volumio volumio[989]: info: VolumeController::SetAlsaVolume1 Apr 30 10:34:28 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:28 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:29 volumio volumio[1235]: [158B blob data] Apr 30 10:34:29 volumio volumio[1235]: {"time":1745989468985,"response":"volume Success"}1 Apr 30 10:34:30 volumio volumio[1235]: 1 Apr 30 10:34:30 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:30 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:30 volumio volumio[989]: info: Apr 30 10:34:30 volumio volumio[989]: ---------------------------- Client requests Volume 1 Apr 30 10:34:30 volumio volumio[989]: info: VolumeController::SetAlsaVolume1 Apr 30 10:34:30 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:30 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:30 volumio volumio[1235]: [158B blob data] Apr 30 10:34:30 volumio volumio[1235]: {"time":1745989470339,"response":"volume Success"}1 Apr 30 10:34:30 volumio volumio[1235]: 2 Apr 30 10:34:30 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:30 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:30 volumio volumio[989]: info: Apr 30 10:34:30 volumio volumio[989]: ---------------------------- Client requests Volume 2 Apr 30 10:34:30 volumio volumio[989]: info: VolumeController::SetAlsaVolume2 Apr 30 10:34:30 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:30 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:30 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:30 volumio volumio[1235]: [158B blob data] Apr 30 10:34:30 volumio volumio[1235]: {"time":1745989470484,"response":"volume Success"}2 Apr 30 10:34:30 volumio volumio[1235]: 3 Apr 30 10:34:30 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:30 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:30 volumio volumio[989]: info: Apr 30 10:34:30 volumio volumio[989]: ---------------------------- Client requests Volume 3 Apr 30 10:34:30 volumio volumio[989]: info: VolumeController::SetAlsaVolume3 Apr 30 10:34:30 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:30 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:30 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:30 volumio volumio[1235]: [158B blob data] Apr 30 10:34:30 volumio volumio[1235]: {"time":1745989470651,"response":"volume Success"}3 Apr 30 10:34:30 volumio volumio[1235]: 4 Apr 30 10:34:30 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:30 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:30 volumio volumio[989]: info: Apr 30 10:34:30 volumio volumio[989]: ---------------------------- Client requests Volume 4 Apr 30 10:34:30 volumio volumio[989]: info: VolumeController::SetAlsaVolume4 Apr 30 10:34:30 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:30 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:30 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:30 volumio volumio[1235]: [158B blob data] Apr 30 10:34:30 volumio volumio[1235]: {"time":1745989470815,"response":"volume Success"}4 Apr 30 10:34:30 volumio volumio[1235]: 5 Apr 30 10:34:30 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:30 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:30 volumio volumio[989]: info: Apr 30 10:34:30 volumio volumio[989]: ---------------------------- Client requests Volume 5 Apr 30 10:34:30 volumio volumio[989]: info: VolumeController::SetAlsaVolume5 Apr 30 10:34:30 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:30 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:30 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:31 volumio volumio[1235]: [158B blob data] Apr 30 10:34:31 volumio volumio[1235]: {"time":1745989470983,"response":"volume Success"}5 Apr 30 10:34:31 volumio volumio[1235]: 6 Apr 30 10:34:31 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:31 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:31 volumio volumio[989]: info: Apr 30 10:34:31 volumio volumio[989]: ---------------------------- Client requests Volume 6 Apr 30 10:34:31 volumio volumio[989]: info: VolumeController::SetAlsaVolume6 Apr 30 10:34:31 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:31 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:31 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:31 volumio volumio[1235]: [158B blob data] Apr 30 10:34:31 volumio volumio[1235]: {"time":1745989471148,"response":"volume Success"}6 Apr 30 10:34:31 volumio volumio[1235]: 7 Apr 30 10:34:31 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:31 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:31 volumio volumio[989]: info: Apr 30 10:34:31 volumio volumio[989]: ---------------------------- Client requests Volume 7 Apr 30 10:34:31 volumio volumio[989]: info: VolumeController::SetAlsaVolume7 Apr 30 10:34:31 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:31 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:31 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:31 volumio volumio[1235]: [158B blob data] Apr 30 10:34:31 volumio volumio[1235]: {"time":1745989471327,"response":"volume Success"}7 Apr 30 10:34:31 volumio volumio[1235]: 8 Apr 30 10:34:31 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:31 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:31 volumio volumio[989]: info: Apr 30 10:34:31 volumio volumio[989]: ---------------------------- Client requests Volume 8 Apr 30 10:34:31 volumio volumio[989]: info: VolumeController::SetAlsaVolume8 Apr 30 10:34:31 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:31 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:31 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:31 volumio volumio[1235]: [158B blob data] Apr 30 10:34:31 volumio volumio[1235]: {"time":1745989471520,"response":"volume Success"}8 Apr 30 10:34:31 volumio volumio[1235]: 9 Apr 30 10:34:31 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:31 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:31 volumio volumio[989]: info: Apr 30 10:34:31 volumio volumio[989]: ---------------------------- Client requests Volume 9 Apr 30 10:34:31 volumio volumio[989]: info: VolumeController::SetAlsaVolume9 Apr 30 10:34:31 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:31 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:31 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:31 volumio volumio[1235]: [158B blob data] Apr 30 10:34:31 volumio volumio[1235]: {"time":1745989471692,"response":"volume Success"}9 Apr 30 10:34:31 volumio volumio[1235]: 10 Apr 30 10:34:31 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:31 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:31 volumio volumio[989]: info: Apr 30 10:34:31 volumio volumio[989]: ---------------------------- Client requests Volume 10 Apr 30 10:34:31 volumio volumio[989]: info: VolumeController::SetAlsaVolume10 Apr 30 10:34:31 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:31 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:31 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:31 volumio volumio[1235]: [158B blob data] Apr 30 10:34:31 volumio volumio[1235]: {"time":1745989471876,"response":"volume Success"}10 Apr 30 10:34:32 volumio volumio[1235]: 11 Apr 30 10:34:32 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:32 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:32 volumio volumio[989]: info: Apr 30 10:34:32 volumio volumio[989]: ---------------------------- Client requests Volume 11 Apr 30 10:34:32 volumio volumio[989]: info: VolumeController::SetAlsaVolume11 Apr 30 10:34:32 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:32 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:32 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:32 volumio volumio[1235]: [158B blob data] Apr 30 10:34:32 volumio volumio[1235]: {"time":1745989472066,"response":"volume Success"}11 Apr 30 10:34:32 volumio volumio[1235]: 12 Apr 30 10:34:32 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:32 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:32 volumio volumio[989]: info: Apr 30 10:34:32 volumio volumio[989]: ---------------------------- Client requests Volume 12 Apr 30 10:34:32 volumio volumio[989]: info: VolumeController::SetAlsaVolume12 Apr 30 10:34:32 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:32 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:32 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:32 volumio volumio[1235]: [158B blob data] Apr 30 10:34:32 volumio volumio[1235]: {"time":1745989472251,"response":"volume Success"}12 Apr 30 10:34:32 volumio volumio[1235]: 13 Apr 30 10:34:32 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:32 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:32 volumio volumio[989]: info: Apr 30 10:34:32 volumio volumio[989]: ---------------------------- Client requests Volume 13 Apr 30 10:34:32 volumio volumio[989]: info: VolumeController::SetAlsaVolume13 Apr 30 10:34:32 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:32 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:32 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:32 volumio volumio[1235]: [158B blob data] Apr 30 10:34:32 volumio volumio[1235]: {"time":1745989472434,"response":"volume Success"}13 Apr 30 10:34:32 volumio volumio[1235]: 14 Apr 30 10:34:32 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:32 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:32 volumio volumio[989]: info: Apr 30 10:34:32 volumio volumio[989]: ---------------------------- Client requests Volume 14 Apr 30 10:34:32 volumio volumio[989]: info: VolumeController::SetAlsaVolume14 Apr 30 10:34:32 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:32 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:32 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:32 volumio volumio[1235]: [158B blob data] Apr 30 10:34:32 volumio volumio[1235]: {"time":1745989472614,"response":"volume Success"}14 Apr 30 10:34:32 volumio volumio[1235]: 15 Apr 30 10:34:32 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:32 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:32 volumio volumio[989]: info: Apr 30 10:34:32 volumio volumio[989]: ---------------------------- Client requests Volume 15 Apr 30 10:34:32 volumio volumio[989]: info: VolumeController::SetAlsaVolume15 Apr 30 10:34:32 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:32 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:32 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:32 volumio volumio[1235]: [158B blob data] Apr 30 10:34:32 volumio volumio[1235]: {"time":1745989472806,"response":"volume Success"}15 Apr 30 10:34:32 volumio volumio[1235]: 16 Apr 30 10:34:33 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:33 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:33 volumio volumio[989]: info: Apr 30 10:34:33 volumio volumio[989]: ---------------------------- Client requests Volume 16 Apr 30 10:34:33 volumio volumio[989]: info: VolumeController::SetAlsaVolume16 Apr 30 10:34:33 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:33 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:33 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:33 volumio volumio[1235]: [158B blob data] Apr 30 10:34:33 volumio volumio[1235]: {"time":1745989473018,"response":"volume Success"}16 Apr 30 10:34:33 volumio volumio[1235]: 17 Apr 30 10:34:33 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:33 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:33 volumio volumio[989]: info: Apr 30 10:34:33 volumio volumio[989]: ---------------------------- Client requests Volume 17 Apr 30 10:34:33 volumio volumio[989]: info: VolumeController::SetAlsaVolume17 Apr 30 10:34:33 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:33 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:33 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:33 volumio volumio[1235]: [158B blob data] Apr 30 10:34:33 volumio volumio[1235]: {"time":1745989473197,"response":"volume Success"}17 Apr 30 10:34:33 volumio volumio[1235]: 18 Apr 30 10:34:33 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:33 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:33 volumio volumio[989]: info: Apr 30 10:34:33 volumio volumio[989]: ---------------------------- Client requests Volume 18 Apr 30 10:34:33 volumio volumio[989]: info: VolumeController::SetAlsaVolume18 Apr 30 10:34:33 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:33 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:33 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:33 volumio volumio[1235]: [237B blob data] Apr 30 10:34:33 volumio volumio[1235]: {"time":1745989473390,"response":"volume Success"}18 Apr 30 10:34:33 volumio volumio[1235]: 19 Apr 30 10:34:33 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:33 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:33 volumio volumio[989]: info: Apr 30 10:34:33 volumio volumio[989]: ---------------------------- Client requests Volume 19 Apr 30 10:34:33 volumio volumio[989]: info: VolumeController::SetAlsaVolume19 Apr 30 10:34:33 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:33 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:33 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:33 volumio volumio[1235]: [158B blob data] Apr 30 10:34:33 volumio volumio[1235]: {"time":1745989473588,"response":"volume Success"}19 Apr 30 10:34:33 volumio volumio[1235]: 20 Apr 30 10:34:33 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:33 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:33 volumio volumio[989]: info: Apr 30 10:34:33 volumio volumio[989]: ---------------------------- Client requests Volume 20 Apr 30 10:34:33 volumio volumio[989]: info: VolumeController::SetAlsaVolume20 Apr 30 10:34:33 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:33 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:33 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:33 volumio volumio[1235]: [158B blob data] Apr 30 10:34:33 volumio volumio[1235]: {"time":1745989473798,"response":"volume Success"}20 Apr 30 10:34:33 volumio volumio[1235]: 21 Apr 30 10:34:33 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:33 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:34 volumio volumio[989]: info: Apr 30 10:34:34 volumio volumio[989]: ---------------------------- Client requests Volume 21 Apr 30 10:34:34 volumio volumio[989]: info: VolumeController::SetAlsaVolume21 Apr 30 10:34:34 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:34 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:34 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:34 volumio volumio[1235]: [158B blob data] Apr 30 10:34:34 volumio volumio[1235]: {"time":1745989473995,"response":"volume Success"}21 Apr 30 10:34:34 volumio volumio[1235]: 22 Apr 30 10:34:34 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:34 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:34 volumio volumio[989]: info: Apr 30 10:34:34 volumio volumio[989]: ---------------------------- Client requests Volume 22 Apr 30 10:34:34 volumio volumio[989]: info: VolumeController::SetAlsaVolume22 Apr 30 10:34:34 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:34 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:34 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:34 volumio volumio[1235]: [158B blob data] Apr 30 10:34:34 volumio volumio[1235]: {"time":1745989474192,"response":"volume Success"}22 Apr 30 10:34:34 volumio volumio[1235]: 23 Apr 30 10:34:34 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:34 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:34 volumio volumio[989]: info: Apr 30 10:34:34 volumio volumio[989]: ---------------------------- Client requests Volume 23 Apr 30 10:34:34 volumio volumio[989]: info: VolumeController::SetAlsaVolume23 Apr 30 10:34:34 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:34 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:34 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:34 volumio volumio[1235]: [158B blob data] Apr 30 10:34:34 volumio volumio[1235]: {"time":1745989474373,"response":"volume Success"}23 Apr 30 10:34:34 volumio volumio[1235]: 24 Apr 30 10:34:34 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:34 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:34 volumio volumio[989]: info: Apr 30 10:34:34 volumio volumio[989]: ---------------------------- Client requests Volume 24 Apr 30 10:34:34 volumio volumio[989]: info: VolumeController::SetAlsaVolume24 Apr 30 10:34:34 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:34 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:34 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:34 volumio volumio[1235]: [158B blob data] Apr 30 10:34:34 volumio volumio[1235]: {"time":1745989474566,"response":"volume Success"}24 Apr 30 10:34:34 volumio volumio[1235]: 25 Apr 30 10:34:34 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:34 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:34 volumio volumio[989]: info: Apr 30 10:34:34 volumio volumio[989]: ---------------------------- Client requests Volume 25 Apr 30 10:34:34 volumio volumio[989]: info: VolumeController::SetAlsaVolume25 Apr 30 10:34:34 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:34 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:34 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:34 volumio volumio[1235]: [158B blob data] Apr 30 10:34:34 volumio volumio[1235]: {"time":1745989474760,"response":"volume Success"}25 Apr 30 10:34:34 volumio volumio[1235]: 26 Apr 30 10:34:34 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:34 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:34 volumio volumio[989]: info: Apr 30 10:34:34 volumio volumio[989]: ---------------------------- Client requests Volume 26 Apr 30 10:34:34 volumio volumio[989]: info: VolumeController::SetAlsaVolume26 Apr 30 10:34:34 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:34 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:34 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:34 volumio volumio[1235]: [158B blob data] Apr 30 10:34:34 volumio volumio[1235]: {"time":1745989474972,"response":"volume Success"}26 Apr 30 10:34:35 volumio volumio[1235]: 27 Apr 30 10:34:35 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:35 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:35 volumio volumio[989]: info: Apr 30 10:34:35 volumio volumio[989]: ---------------------------- Client requests Volume 27 Apr 30 10:34:35 volumio volumio[989]: info: VolumeController::SetAlsaVolume27 Apr 30 10:34:35 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:35 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:35 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:35 volumio volumio[1235]: [158B blob data] Apr 30 10:34:35 volumio volumio[1235]: {"time":1745989475175,"response":"volume Success"}27 Apr 30 10:34:35 volumio volumio[1235]: 28 Apr 30 10:34:35 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:35 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:35 volumio volumio[989]: info: Apr 30 10:34:35 volumio volumio[989]: ---------------------------- Client requests Volume 28 Apr 30 10:34:35 volumio volumio[989]: info: VolumeController::SetAlsaVolume28 Apr 30 10:34:35 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:35 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:35 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:35 volumio volumio[1235]: [158B blob data] Apr 30 10:34:35 volumio volumio[1235]: {"time":1745989475357,"response":"volume Success"}28 Apr 30 10:34:35 volumio volumio[1235]: 29 Apr 30 10:34:35 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:35 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:35 volumio volumio[989]: info: Apr 30 10:34:35 volumio volumio[989]: ---------------------------- Client requests Volume 29 Apr 30 10:34:35 volumio volumio[989]: info: VolumeController::SetAlsaVolume29 Apr 30 10:34:35 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:35 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:35 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:35 volumio volumio[1235]: [158B blob data] Apr 30 10:34:35 volumio volumio[1235]: {"time":1745989475537,"response":"volume Success"}29 Apr 30 10:34:35 volumio volumio[1235]: 30 Apr 30 10:34:35 volumio volumio[1235]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 30 10:34:35 volumio volumio[1235]: Dload Upload Total Spent Left Speed Apr 30 10:34:35 volumio volumio[989]: info: Apr 30 10:34:35 volumio volumio[989]: ---------------------------- Client requests Volume 30 Apr 30 10:34:35 volumio volumio[989]: info: VolumeController::SetAlsaVolume30 Apr 30 10:34:35 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:35 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:35 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:35 volumio volumio[1235]: [158B blob data] Apr 30 10:34:35 volumio volumio[1235]: {"time":1745989475706,"response":"volume Success"}30 Apr 30 10:34:42 volumio volumio[989]: info: VolumeController::SetAlsaVolume14 Apr 30 10:34:42 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:42 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:42 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:44 volumio volumio[989]: info: VolumeController::SetAlsaVolume74 Apr 30 10:34:44 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:44 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:44 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:45 volumio volumio[989]: info: VolumeController::SetAlsaVolume100 Apr 30 10:34:45 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:45 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:45 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:57 volumio volumio[989]: info: Clearing queue after UPNP request Apr 30 10:34:57 volumio volumio[989]: info: Apr 30 10:34:57 volumio volumio[989]: ---------------------------- MPD announces state update: player Apr 30 10:34:57 volumio volumio[989]: info: ControllerMpd::getState Apr 30 10:34:57 volumio volumio[989]: verbose: ControllerMpd::sendMpdCommand status Apr 30 10:34:57 volumio volumio[989]: info: sendMpdCommand status took 0 milliseconds Apr 30 10:34:57 volumio volumio[989]: verbose: ControllerMpd::parseState Apr 30 10:34:57 volumio volumio[989]: info: ControllerMpd::pushState Apr 30 10:34:57 volumio volumio[989]: info: CoreCommandRouter::servicePushState Apr 30 10:34:57 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:57 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:57 volumio volumio[989]: info: CorePlayQueue::getTrack 0 Apr 30 10:34:57 volumio volumio[989]: 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} Apr 30 10:34:57 volumio volumio[989]: verbose: CURRENT POSITION 0 Apr 30 10:34:57 volumio volumio[989]: info: CoreStateMachine::syncState stateService stop Apr 30 10:34:57 volumio volumio[989]: info: CoreStateMachine::syncState currentStatus play Apr 30 10:34:57 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:57 volumio volumio[989]: info: CoreStateMachine::stPlaybackTimer Apr 30 10:34:57 volumio volumio[989]: info: ------------------------------ 11ms Apr 30 10:34:57 volumio volumio[989]: info: CoreStateMachine::ClearQueue Apr 30 10:34:57 volumio volumio[989]: info: CoreStateMachine::stop Apr 30 10:34:57 volumio volumio[989]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 10:34:57 volumio volumio[989]: info: CorePlayQueue::clearPlayQueue Apr 30 10:34:57 volumio volumio[989]: info: CorePlayQueue::saveQueue Apr 30 10:34:57 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:57 volumio volumio[989]: info: CoreCommandRouter::volumioPushQueue Apr 30 10:34:57 volumio volumio[989]: info: Apr 30 10:34:57 volumio volumio[989]: ---------------------------- MPD announces system playlist update Apr 30 10:34:57 volumio volumio[989]: info: Ignoring MPD Status Update Apr 30 10:34:57 volumio volumio[989]: info: Clearing queue after UPNP request Apr 30 10:34:57 volumio volumio[989]: error: updateQueue error: null Apr 30 10:34:57 volumio volumio[989]: info: ------------------------------ 1ms Apr 30 10:34:58 volumio volumio[989]: info: CoreStateMachine::ClearQueue Apr 30 10:34:58 volumio volumio[989]: info: CoreStateMachine::stop Apr 30 10:34:58 volumio volumio[989]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 30 10:34:58 volumio volumio[989]: info: CorePlayQueue::clearPlayQueue Apr 30 10:34:58 volumio volumio[989]: info: CorePlayQueue::saveQueue Apr 30 10:34:58 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:58 volumio volumio[989]: info: CoreCommandRouter::volumioPushQueue Apr 30 10:34:58 volumio volumio[989]: info: Apr 30 10:34:58 volumio volumio[989]: ---------------------------- MPD announces system playlist update Apr 30 10:34:58 volumio volumio[989]: info: Ignoring MPD Status Update Apr 30 10:34:58 volumio volumio[989]: error: updateQueue error: null Apr 30 10:34:58 volumio volumio[989]: info: ------------------------------ 1ms Apr 30 10:34:58 volumio volumio[989]: info: Starting UPNP Playback Apr 30 10:34:58 volumio volumio[989]: info: Preparing playback through UPNP Apr 30 10:34:58 volumio volumio[989]: info: CoreCommandRouter::volumioGetState Apr 30 10:34:58 volumio volumio[989]: info: CorePlayQueue::getTrack 0 Apr 30 10:34:58 volumio volumio[989]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 30 10:34:58 volumio volumio[989]: info: Apr 30 10:34:58 volumio volumio[989]: ---------------------------- MPD announces system playlist update Apr 30 10:34:58 volumio volumio[989]: info: Ignoring MPD Status Update Apr 30 10:34:58 volumio volumio[989]: info: Apr 30 10:34:58 volumio volumio[989]: ---------------------------- MPD announces system playlist update Apr 30 10:34:58 volumio volumio[989]: info: Ignoring MPD Status Update Apr 30 10:34:58 volumio volumio[989]: info: ------------------------------ 1ms Apr 30 10:34:58 volumio volumio[989]: info: Apr 30 10:34:58 volumio volumio[989]: ---------------------------- MPD announces system playlist update Apr 30 10:34:58 volumio volumio[989]: info: Ignoring MPD Status Update Apr 30 10:34:58 volumio volumio[989]: info: ------------------------------ 1ms Apr 30 10:34:58 volumio volumio[989]: info: ------------------------------ 1ms Apr 30 10:34:58 volumio volumio[989]: info: Apr 30 10:34:58 volumio volumio[989]: ---------------------------- MPD announces system playlist update Apr 30 10:34:58 volumio volumio[989]: info: Ignoring MPD Status Update Apr 30 10:34:58 volumio volumio[989]: info: Apr 30 10:34:58 volumio volumio[989]: ---------------------------- MPD announces system playlist update Apr 30 10:34:58 volumio volumio[989]: info: Ignoring MPD Status Update Apr 30 10:34:58 volumio volumio[989]: info: ------------------------------ 1ms Apr 30 10:34:58 volumio volumio[989]: info: ------------------------------ 1ms Apr 30 10:34:58 volumio volumio[989]: info: Apr 30 10:34:58 volumio volumio[989]: ---------------------------- MPD announces system playlist update Apr 30 10:34:58 volumio volumio[989]: info: Ignoring MPD Status Update Apr 30 10:34:58 volumio volumio[989]: info: ------------------------------ 1ms Apr 30 10:34:58 volumio volumio[989]: info: Apr 30 10:34:58 volumio volumio[989]: ---------------------------- MPD announces state update: player Apr 30 10:34:58 volumio volumio[989]: info: ControllerMpd::getState Apr 30 10:34:58 volumio volumio[989]: verbose: ControllerMpd::sendMpdCommand status Apr 30 10:34:58 volumio volumio[989]: info: Apr 30 10:34:58 volumio volumio[989]: ---------------------------- MPD announces state update: player Apr 30 10:34:58 volumio volumio[989]: info: sendMpdCommand status took 15 milliseconds Apr 30 10:34:58 volumio volumio[989]: info: ControllerMpd::getState Apr 30 10:34:58 volumio volumio[989]: verbose: ControllerMpd::sendMpdCommand status Apr 30 10:34:58 volumio volumio[989]: verbose: ControllerMpd::parseState Apr 30 10:34:58 volumio volumio[989]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 10:34:58 volumio volumio[989]: info: sendMpdCommand status took 1 milliseconds Apr 30 10:34:58 volumio volumio[989]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 30 10:34:58 volumio volumio[989]: verbose: ControllerMpd::parseState Apr 30 10:34:58 volumio volumio[989]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 10:34:58 volumio volumio[989]: verbose: ControllerMpd::parseTrackInfo Apr 30 10:34:58 volumio volumio[989]: info: ControllerMpd::pushState Apr 30 10:34:58 volumio volumio[989]: info: CoreCommandRouter::servicePushState Apr 30 10:34:58 volumio volumio[989]: verbose: In UPNP mode Apr 30 10:34:58 volumio volumio[989]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":12174,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"foobar2000 audio stream","artist":null,"album":null,"uri":"http://192.168.29.102:57969/11/stream.wav","trackType":"wav"} Apr 30 10:34:58 volumio volumio[989]: verbose: CURRENT POSITION 0 Apr 30 10:34:58 volumio volumio[989]: info: CoreStateMachine::syncState stateService play Apr 30 10:34:58 volumio volumio[989]: info: CoreStateMachine::syncState currentStatus stop Apr 30 10:34:58 volumio volumio[989]: info: ------------------------------ 19ms Apr 30 10:34:58 volumio volumio[989]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 30 10:34:58 volumio volumio[989]: verbose: ControllerMpd::parseTrackInfo Apr 30 10:34:58 volumio volumio[989]: info: ControllerMpd::pushState Apr 30 10:34:58 volumio volumio[989]: info: CoreCommandRouter::servicePushState Apr 30 10:34:58 volumio volumio[989]: verbose: In UPNP mode Apr 30 10:34:58 volumio volumio[989]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":12174,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"foobar2000 audio stream","artist":null,"album":null,"uri":"http://192.168.29.102:57969/11/stream.wav","trackType":"wav"} Apr 30 10:34:58 volumio volumio[989]: verbose: CURRENT POSITION 0 Apr 30 10:34:58 volumio volumio[989]: info: CoreStateMachine::syncState stateService play Apr 30 10:34:58 volumio volumio[989]: info: CoreStateMachine::syncState currentStatus play Apr 30 10:34:58 volumio volumio[989]: info: Received an update from plugin. extracting info from payload Apr 30 10:34:58 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:58 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 30 10:34:58 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:58 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:34:58 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:34:58 volumio volumio[989]: info: ------------------------------ 13ms Apr 30 10:35:01 volumio volumio[989]: info: Apr 30 10:35:01 volumio volumio[989]: ---------------------------- MPD announces state update: player Apr 30 10:35:01 volumio volumio[989]: info: ControllerMpd::getState Apr 30 10:35:01 volumio volumio[989]: verbose: ControllerMpd::sendMpdCommand status Apr 30 10:35:01 volumio volumio[989]: info: sendMpdCommand status took 1 milliseconds Apr 30 10:35:01 volumio volumio[989]: verbose: ControllerMpd::parseState Apr 30 10:35:01 volumio volumio[989]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 30 10:35:01 volumio volumio[989]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 30 10:35:01 volumio volumio[989]: verbose: ControllerMpd::parseTrackInfo Apr 30 10:35:01 volumio volumio[989]: info: ControllerMpd::pushState Apr 30 10:35:01 volumio volumio[989]: info: CoreCommandRouter::servicePushState Apr 30 10:35:01 volumio volumio[989]: info: CoreStateMachine::pushState Apr 30 10:35:01 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:35:01 volumio volumio[989]: info: CorePlayQueue::getTrack 0 Apr 30 10:35:01 volumio volumio[989]: 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":"foobar2000 audio stream","artist":null,"album":null,"uri":"http://192.168.29.102:57969/11/stream.wav","trackType":"wav"} Apr 30 10:35:01 volumio volumio[989]: verbose: CURRENT POSITION 0 Apr 30 10:35:01 volumio volumio[989]: info: CoreStateMachine::syncState stateService stop Apr 30 10:35:01 volumio volumio[989]: info: CoreStateMachine::syncState currentStatus play Apr 30 10:35:01 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 30 10:35:01 volumio volumio[989]: info: CoreStateMachine::stPlaybackTimer Apr 30 10:35:01 volumio volumio[989]: info: ------------------------------ 11ms Apr 30 10:35:04 volumio volumio[989]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 30 10:35:04 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 30 10:35:04 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 30 10:35:04 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 30 10:35:04 volumio volumio[989]: info: Getting Alsa Cards List without I2S DAC Apr 30 10:35:04 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Apr 30 10:35:04 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 30 10:35:04 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 30 10:35:04 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 30 10:35:04 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 30 10:35:04 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 30 10:35:04 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 30 10:35:04 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 30 10:35:04 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 30 10:35:04 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 30 10:35:04 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 30 10:35:11 volumio volumio[989]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 30 10:35:11 volumio volumio[989]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 30 10:35:11 volumio volumio[989]: info: Retrieving Cloud Streaming UI Apr 30 10:35:11 volumio volumio[989]: info: Getting Tidal Cloud Configuration Apr 30 10:35:11 volumio volumio[989]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 30 10:35:11 volumio volumio[989]: info: Getting Qobuz Cloud Configuration Apr 30 10:35:11 volumio volumio[989]: info: Asking plugin for UI Config Apr 30 10:35:11 volumio volumio[989]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 30 10:35:11 volumio volumio[989]: info: Getting Spotify Cloud Configuration Apr 30 10:35:11 volumio volumio[989]: info: Asking plugin for UI Config Apr 30 10:35:11 volumio volumio[989]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 30 10:35:11 volumio volumio[989]: info: Saving Spotify Acccount Apr 30 10:35:11 volumio volumio[989]: info: Got Tidal Cloud Configuration Apr 30 10:35:11 volumio volumio[989]: info: Got it Apr 30 10:35:11 volumio volumio[989]: info: Got it Apr 30 10:35:11 volumio volumio[989]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 30 10:35:11 volumio volumio[989]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 30 10:35:11 volumio volumio[989]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Apr 30 10:35:11 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 30 10:35:11 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 30 10:35:11 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 30 10:35:11 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 30 10:35:11 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 30 10:35:11 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 30 10:35:11 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 30 10:35:11 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 30 10:35:11 volumio volumio[989]: info: CoreCommandRouter::volumioGetBrowseSources Apr 30 10:35:11 volumio volumio[989]: info: CoreCommandRouter::volumioGetBrowseSources Apr 30 10:35:11 volumio volumio[989]: info: CoreCommandRouter::volumioGetBrowseSources Apr 30 10:35:11 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 30 10:35:11 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 30 10:35:14 volumio volumio[989]: info: Disabling MyMusic plugin upnp Apr 30 10:35:14 volumio sudo[3185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Apr 30 10:35:14 volumio sudo[3185]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 30 10:35:14 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Apr 30 10:35:14 volumio volumio[989]: error: Upnp client error: Error: This socket has been ended by the other party Apr 30 10:35:15 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 30 10:35:19 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 30 10:35:20 volumio volumio[989]: info: Enabling MyMusic plugin upnp Apr 30 10:35:20 volumio volumio[989]: info: Enabling plugin upnp Apr 30 10:35:20 volumio volumio[989]: info: Loading plugin "upnp"... Apr 30 10:35:20 volumio volumio[989]: info: [1745989520934] Starting Upmpd Daemon Apr 30 10:35:20 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 30 10:35:20 volumio volumio[989]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 30 10:35:20 volumio volumio[989]: Error: listen EADDRINUSE: address already in use :::6599 Apr 30 10:35:20 volumio volumio[989]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Apr 30 10:35:20 volumio volumio[989]: at listenInCluster (net.js:1366:12) Apr 30 10:35:20 volumio volumio[989]: at Server.listen (net.js:1452:7) Apr 30 10:35:20 volumio volumio[989]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Apr 30 10:35:20 volumio volumio[989]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Apr 30 10:35:20 volumio volumio[989]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Apr 30 10:35:20 volumio volumio[989]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 30 10:35:20 volumio volumio[989]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Apr 30 10:35:20 volumio volumio[989]: code: 'EADDRINUSE', Apr 30 10:35:20 volumio volumio[989]: errno: -98, Apr 30 10:35:20 volumio volumio[989]: syscall: 'listen', Apr 30 10:35:20 volumio volumio[989]: address: '::', Apr 30 10:35:20 volumio volumio[989]: port: 6599 Apr 30 10:35:20 volumio volumio[989]: } Apr 30 10:35:20 volumio volumio[989]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 30 10:35:21 volumio sudo[3202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-30 10:34 Apr 30 10:35:21 volumio sudo[3202]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 06:54:47 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="436f3f84f6d0b4ffc344f0bc132a32e8"