-- Logs begin at Thu 2025-01-16 08:46:55 CST, end at Thu 2025-01-16 09:22:37 CST. -- Jan 16 09:21:02 volumio volumio[1689]: 90 Jan 16 09:21:02 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:02 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:02 volumio volumio[4762]: info: Jan 16 09:21:02 volumio volumio[4762]: ---------------------------- Client requests Volume 90 Jan 16 09:21:02 volumio volumio[4762]: info: VolumeController::SetAlsaVolume90 Jan 16 09:21:02 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:02 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:02 volumio volumio[1689]: [158B blob data] Jan 16 09:21:02 volumio volumio[1689]: {"time":1736990462379,"response":"volume Success"}90 Jan 16 09:21:02 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:02 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:02 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:02 volumio volumio[1689]: 80 Jan 16 09:21:02 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:02 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:02 volumio volumio[4762]: info: Jan 16 09:21:02 volumio volumio[4762]: ---------------------------- Client requests Volume 80 Jan 16 09:21:02 volumio volumio[4762]: info: VolumeController::SetAlsaVolume80 Jan 16 09:21:02 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:02 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:02 volumio volumio[1689]: [158B blob data] Jan 16 09:21:02 volumio volumio[1689]: {"time":1736990462660,"response":"volume Success"}80 Jan 16 09:21:02 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:02 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:02 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:02 volumio volumio[1689]: 70 Jan 16 09:21:02 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:02 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:02 volumio volumio[4762]: info: Jan 16 09:21:02 volumio volumio[4762]: ---------------------------- Client requests Volume 70 Jan 16 09:21:02 volumio volumio[4762]: info: VolumeController::SetAlsaVolume70 Jan 16 09:21:02 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:02 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:02 volumio volumio[1689]: [158B blob data] Jan 16 09:21:02 volumio volumio[1689]: {"time":1736990462731,"response":"volume Success"}70 Jan 16 09:21:02 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:02 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:02 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:02 volumio volumio[1689]: 60 Jan 16 09:21:02 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:02 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:02 volumio volumio[4762]: info: Jan 16 09:21:02 volumio volumio[4762]: ---------------------------- Client requests Volume 60 Jan 16 09:21:02 volumio volumio[4762]: info: VolumeController::SetAlsaVolume60 Jan 16 09:21:02 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:02 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:02 volumio volumio[1689]: [158B blob data] Jan 16 09:21:02 volumio volumio[1689]: {"time":1736990462840,"response":"volume Success"}60 Jan 16 09:21:02 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:02 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:02 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:02 volumio volumio[1689]: 90 Jan 16 09:21:02 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:02 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:02 volumio volumio[4762]: info: Jan 16 09:21:02 volumio volumio[4762]: ---------------------------- Client requests Volume 90 Jan 16 09:21:02 volumio volumio[4762]: info: VolumeController::SetAlsaVolume90 Jan 16 09:21:02 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:02 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:02 volumio volumio[1689]: [158B blob data] Jan 16 09:21:02 volumio volumio[1689]: {"time":1736990462914,"response":"volume Success"}90 Jan 16 09:21:02 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:02 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:02 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:03 volumio volumio[1689]: 80 Jan 16 09:21:03 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:03 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:03 volumio volumio[4762]: info: Jan 16 09:21:03 volumio volumio[4762]: ---------------------------- Client requests Volume 80 Jan 16 09:21:03 volumio volumio[4762]: info: VolumeController::SetAlsaVolume80 Jan 16 09:21:03 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:03 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:03 volumio volumio[1689]: [158B blob data] Jan 16 09:21:03 volumio volumio[1689]: {"time":1736990463033,"response":"volume Success"}80 Jan 16 09:21:03 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:03 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:03 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:03 volumio volumio[1689]: 70 Jan 16 09:21:03 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:03 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:03 volumio volumio[4762]: info: Jan 16 09:21:03 volumio volumio[4762]: ---------------------------- Client requests Volume 70 Jan 16 09:21:03 volumio volumio[4762]: info: VolumeController::SetAlsaVolume70 Jan 16 09:21:03 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:03 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:03 volumio volumio[1689]: [158B blob data] Jan 16 09:21:03 volumio volumio[1689]: {"time":1736990463162,"response":"volume Success"}70 Jan 16 09:21:03 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:03 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:03 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:03 volumio volumio[1689]: 60 Jan 16 09:21:03 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:03 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:03 volumio volumio[4762]: info: Jan 16 09:21:03 volumio volumio[4762]: ---------------------------- Client requests Volume 60 Jan 16 09:21:03 volumio volumio[4762]: info: VolumeController::SetAlsaVolume60 Jan 16 09:21:03 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:03 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:03 volumio volumio[1689]: [158B blob data] Jan 16 09:21:03 volumio volumio[1689]: {"time":1736990463254,"response":"volume Success"}60 Jan 16 09:21:03 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:03 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:03 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:03 volumio volumio[1689]: 50 Jan 16 09:21:03 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:03 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:03 volumio volumio[4762]: info: Jan 16 09:21:03 volumio volumio[4762]: ---------------------------- Client requests Volume 50 Jan 16 09:21:03 volumio volumio[4762]: info: VolumeController::SetAlsaVolume50 Jan 16 09:21:03 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:03 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:03 volumio volumio[1689]: [158B blob data] Jan 16 09:21:03 volumio volumio[1689]: {"time":1736990463318,"response":"volume Success"}50 Jan 16 09:21:03 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:03 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:03 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:03 volumio volumio[1689]: 40 Jan 16 09:21:03 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:03 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:03 volumio volumio[4762]: info: Jan 16 09:21:03 volumio volumio[4762]: ---------------------------- Client requests Volume 40 Jan 16 09:21:03 volumio volumio[4762]: info: VolumeController::SetAlsaVolume40 Jan 16 09:21:03 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:03 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:03 volumio volumio[1689]: [158B blob data] Jan 16 09:21:03 volumio volumio[1689]: {"time":1736990463402,"response":"volume Success"}40 Jan 16 09:21:03 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:03 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:03 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:03 volumio volumio[1689]: 30 Jan 16 09:21:03 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:03 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:03 volumio volumio[4762]: info: Jan 16 09:21:03 volumio volumio[4762]: ---------------------------- Client requests Volume 30 Jan 16 09:21:03 volumio volumio[4762]: info: VolumeController::SetAlsaVolume30 Jan 16 09:21:03 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:03 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:03 volumio volumio[1689]: [158B blob data] Jan 16 09:21:03 volumio volumio[1689]: {"time":1736990463467,"response":"volume Success"}30 Jan 16 09:21:03 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:03 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:03 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:03 volumio volumio[1689]: 20 Jan 16 09:21:03 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:03 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:03 volumio volumio[4762]: info: Jan 16 09:21:03 volumio volumio[4762]: ---------------------------- Client requests Volume 20 Jan 16 09:21:03 volumio volumio[4762]: info: VolumeController::SetAlsaVolume20 Jan 16 09:21:03 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:03 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:03 volumio volumio[1689]: [158B blob data] Jan 16 09:21:03 volumio volumio[1689]: {"time":1736990463532,"response":"volume Success"}20 Jan 16 09:21:03 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:03 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:03 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:03 volumio volumio[1689]: 10 Jan 16 09:21:03 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:03 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:03 volumio volumio[4762]: info: Jan 16 09:21:03 volumio volumio[4762]: ---------------------------- Client requests Volume 10 Jan 16 09:21:03 volumio volumio[4762]: info: VolumeController::SetAlsaVolume10 Jan 16 09:21:03 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:03 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:03 volumio volumio[1689]: [158B blob data] Jan 16 09:21:03 volumio volumio[1689]: {"time":1736990463595,"response":"volume Success"}10 Jan 16 09:21:03 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:03 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:03 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:03 volumio volumio[1689]: 0 Jan 16 09:21:03 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:03 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:03 volumio volumio[4762]: info: Jan 16 09:21:03 volumio volumio[4762]: ---------------------------- Client requests Volume 1 Jan 16 09:21:03 volumio volumio[4762]: info: VolumeController::SetAlsaVolume1 Jan 16 09:21:03 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:03 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:03 volumio volumio[1689]: [158B blob data] Jan 16 09:21:03 volumio volumio[1689]: {"time":1736990463683,"response":"volume Success"}1 Jan 16 09:21:03 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:03 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:03 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:04 volumio volumio[1689]: 90 Jan 16 09:21:04 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:04 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:04 volumio volumio[4762]: info: Jan 16 09:21:04 volumio volumio[4762]: ---------------------------- Client requests Volume 90 Jan 16 09:21:04 volumio volumio[4762]: info: VolumeController::SetAlsaVolume90 Jan 16 09:21:04 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:04 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:04 volumio volumio[1689]: [158B blob data] Jan 16 09:21:04 volumio volumio[1689]: {"time":1736990464228,"response":"volume Success"}90 Jan 16 09:21:04 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:04 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:04 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:04 volumio volumio[1689]: 80 Jan 16 09:21:04 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:04 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:04 volumio volumio[4762]: info: Jan 16 09:21:04 volumio volumio[4762]: ---------------------------- Client requests Volume 80 Jan 16 09:21:04 volumio volumio[4762]: info: VolumeController::SetAlsaVolume80 Jan 16 09:21:04 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:04 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:04 volumio volumio[1689]: [158B blob data] Jan 16 09:21:04 volumio volumio[1689]: {"time":1736990464495,"response":"volume Success"}80 Jan 16 09:21:04 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:04 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:04 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:04 volumio volumio[1689]: 70 Jan 16 09:21:04 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:04 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:04 volumio volumio[4762]: info: Jan 16 09:21:04 volumio volumio[4762]: ---------------------------- Client requests Volume 70 Jan 16 09:21:04 volumio volumio[4762]: info: VolumeController::SetAlsaVolume70 Jan 16 09:21:04 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:04 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:04 volumio volumio[1689]: [158B blob data] Jan 16 09:21:04 volumio volumio[1689]: {"time":1736990464559,"response":"volume Success"}70 Jan 16 09:21:04 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:04 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:04 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:04 volumio volumio[1689]: 60 Jan 16 09:21:04 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:04 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:04 volumio volumio[4762]: info: Jan 16 09:21:04 volumio volumio[4762]: ---------------------------- Client requests Volume 60 Jan 16 09:21:04 volumio volumio[4762]: info: VolumeController::SetAlsaVolume60 Jan 16 09:21:04 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:04 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:04 volumio volumio[1689]: [158B blob data] Jan 16 09:21:04 volumio volumio[1689]: {"time":1736990464628,"response":"volume Success"}60 Jan 16 09:21:04 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:04 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:04 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:04 volumio volumio[1689]: 50 Jan 16 09:21:04 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:04 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:04 volumio volumio[4762]: info: Jan 16 09:21:04 volumio volumio[4762]: ---------------------------- Client requests Volume 50 Jan 16 09:21:04 volumio volumio[4762]: info: VolumeController::SetAlsaVolume50 Jan 16 09:21:04 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:04 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:04 volumio volumio[1689]: [158B blob data] Jan 16 09:21:04 volumio volumio[1689]: {"time":1736990464698,"response":"volume Success"}50 Jan 16 09:21:04 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:04 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:04 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:04 volumio volumio[1689]: 40 Jan 16 09:21:04 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:04 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:04 volumio volumio[4762]: info: Jan 16 09:21:04 volumio volumio[4762]: ---------------------------- Client requests Volume 40 Jan 16 09:21:04 volumio volumio[4762]: info: VolumeController::SetAlsaVolume40 Jan 16 09:21:04 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:04 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:04 volumio volumio[1689]: [158B blob data] Jan 16 09:21:04 volumio volumio[1689]: {"time":1736990464762,"response":"volume Success"}40 Jan 16 09:21:04 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:04 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:04 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:04 volumio volumio[1689]: 30 Jan 16 09:21:04 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:04 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:04 volumio volumio[4762]: info: Jan 16 09:21:04 volumio volumio[4762]: ---------------------------- Client requests Volume 30 Jan 16 09:21:04 volumio volumio[4762]: info: VolumeController::SetAlsaVolume30 Jan 16 09:21:04 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:04 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:04 volumio volumio[1689]: [158B blob data] Jan 16 09:21:04 volumio volumio[1689]: {"time":1736990464830,"response":"volume Success"}30 Jan 16 09:21:04 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:04 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:04 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:04 volumio volumio[1689]: 20 Jan 16 09:21:04 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:04 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:04 volumio volumio[4762]: info: Jan 16 09:21:04 volumio volumio[4762]: ---------------------------- Client requests Volume 20 Jan 16 09:21:04 volumio volumio[4762]: info: VolumeController::SetAlsaVolume20 Jan 16 09:21:04 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:04 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:04 volumio volumio[1689]: [158B blob data] Jan 16 09:21:04 volumio volumio[1689]: {"time":1736990464912,"response":"volume Success"}20 Jan 16 09:21:04 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:04 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:04 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:04 volumio volumio[1689]: 90 Jan 16 09:21:04 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:04 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:04 volumio volumio[4762]: info: Jan 16 09:21:04 volumio volumio[4762]: ---------------------------- Client requests Volume 90 Jan 16 09:21:04 volumio volumio[4762]: info: VolumeController::SetAlsaVolume90 Jan 16 09:21:04 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:04 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:05 volumio volumio[1689]: [158B blob data] Jan 16 09:21:05 volumio volumio[1689]: {"time":1736990464997,"response":"volume Success"}90 Jan 16 09:21:05 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:05 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:05 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:05 volumio volumio[1689]: 80 Jan 16 09:21:05 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:05 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:05 volumio volumio[4762]: info: Jan 16 09:21:05 volumio volumio[4762]: ---------------------------- Client requests Volume 80 Jan 16 09:21:05 volumio volumio[4762]: info: VolumeController::SetAlsaVolume80 Jan 16 09:21:05 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:05 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:05 volumio volumio[1689]: [158B blob data] Jan 16 09:21:05 volumio volumio[1689]: {"time":1736990465064,"response":"volume Success"}80 Jan 16 09:21:05 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:05 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:05 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:05 volumio volumio[1689]: 70 Jan 16 09:21:05 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:05 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:05 volumio volumio[4762]: info: Jan 16 09:21:05 volumio volumio[4762]: ---------------------------- Client requests Volume 70 Jan 16 09:21:05 volumio volumio[4762]: info: VolumeController::SetAlsaVolume70 Jan 16 09:21:05 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:05 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:05 volumio volumio[1689]: [158B blob data] Jan 16 09:21:05 volumio volumio[1689]: {"time":1736990465130,"response":"volume Success"}70 Jan 16 09:21:05 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:05 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:05 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:05 volumio volumio[1689]: 60 Jan 16 09:21:05 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:05 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:05 volumio volumio[4762]: info: Jan 16 09:21:05 volumio volumio[4762]: ---------------------------- Client requests Volume 60 Jan 16 09:21:05 volumio volumio[4762]: info: VolumeController::SetAlsaVolume60 Jan 16 09:21:05 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:05 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:05 volumio volumio[1689]: [158B blob data] Jan 16 09:21:05 volumio volumio[1689]: {"time":1736990465199,"response":"volume Success"}60 Jan 16 09:21:05 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:05 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:05 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:05 volumio volumio[1689]: 50 Jan 16 09:21:05 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:05 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:05 volumio volumio[4762]: info: Jan 16 09:21:05 volumio volumio[4762]: ---------------------------- Client requests Volume 50 Jan 16 09:21:05 volumio volumio[4762]: info: VolumeController::SetAlsaVolume50 Jan 16 09:21:05 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:05 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:05 volumio volumio[1689]: [158B blob data] Jan 16 09:21:05 volumio volumio[1689]: {"time":1736990465297,"response":"volume Success"}50 Jan 16 09:21:05 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:05 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:05 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:05 volumio volumio[1689]: 40 Jan 16 09:21:05 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:05 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:05 volumio volumio[4762]: info: Jan 16 09:21:05 volumio volumio[4762]: ---------------------------- Client requests Volume 40 Jan 16 09:21:05 volumio volumio[4762]: info: VolumeController::SetAlsaVolume40 Jan 16 09:21:05 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:05 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:05 volumio volumio[1689]: [158B blob data] Jan 16 09:21:05 volumio volumio[1689]: {"time":1736990465362,"response":"volume Success"}40 Jan 16 09:21:05 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:05 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:05 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:05 volumio volumio[1689]: 30 Jan 16 09:21:05 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:05 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:05 volumio volumio[4762]: info: Jan 16 09:21:05 volumio volumio[4762]: ---------------------------- Client requests Volume 30 Jan 16 09:21:05 volumio volumio[4762]: info: VolumeController::SetAlsaVolume30 Jan 16 09:21:05 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:05 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:05 volumio volumio[1689]: [158B blob data] Jan 16 09:21:05 volumio volumio[1689]: {"time":1736990465429,"response":"volume Success"}30 Jan 16 09:21:05 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:05 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:05 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:05 volumio volumio[1689]: 20 Jan 16 09:21:05 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:05 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:05 volumio volumio[4762]: info: Jan 16 09:21:05 volumio volumio[4762]: ---------------------------- Client requests Volume 20 Jan 16 09:21:05 volumio volumio[4762]: info: VolumeController::SetAlsaVolume20 Jan 16 09:21:05 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:05 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:05 volumio volumio[1689]: [158B blob data] Jan 16 09:21:05 volumio volumio[1689]: {"time":1736990465493,"response":"volume Success"}20 Jan 16 09:21:05 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:05 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:05 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:05 volumio volumio[1689]: 10 Jan 16 09:21:05 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:05 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:05 volumio volumio[4762]: info: Jan 16 09:21:05 volumio volumio[4762]: ---------------------------- Client requests Volume 10 Jan 16 09:21:05 volumio volumio[4762]: info: VolumeController::SetAlsaVolume10 Jan 16 09:21:05 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:05 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:05 volumio volumio[1689]: [158B blob data] Jan 16 09:21:05 volumio volumio[1689]: {"time":1736990465573,"response":"volume Success"}10 Jan 16 09:21:05 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:05 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:05 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:05 volumio volumio[1689]: 0 Jan 16 09:21:05 volumio volumio[1689]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 16 09:21:05 volumio volumio[1689]: Dload Upload Total Spent Left Speed Jan 16 09:21:05 volumio volumio[4762]: info: Jan 16 09:21:05 volumio volumio[4762]: ---------------------------- Client requests Volume 1 Jan 16 09:21:05 volumio volumio[4762]: info: VolumeController::SetAlsaVolume1 Jan 16 09:21:05 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:05 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:05 volumio volumio[1689]: [158B blob data] Jan 16 09:21:05 volumio volumio[1689]: {"time":1736990465639,"response":"volume Success"}1 Jan 16 09:21:05 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:05 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:05 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:20 volumio volumio[4762]: info: Jan 16 09:21:20 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:20 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:20 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:20 volumio volumio[4762]: info: Jan 16 09:21:20 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:20 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:20 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:20 volumio volumio[4762]: info: Jan 16 09:21:20 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:20 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:20 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:20 volumio volumio[4762]: info: sendMpdCommand status took 2 milliseconds Jan 16 09:21:20 volumio volumio[4762]: info: sendMpdCommand status took 1 milliseconds Jan 16 09:21:20 volumio volumio[4762]: info: sendMpdCommand status took 1 milliseconds Jan 16 09:21:20 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:20 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:20 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:20 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:20 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:20 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:20 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 16 09:21:20 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 16 09:21:20 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 16 09:21:20 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:20 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:20 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:20 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:20 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:20 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:20 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:20 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:20 volumio volumio[4762]: 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":"Per Un Pugno Di Dollari","artist":"Ennio Morricone","album":"Film Hits","uri":"http://fsandroid.kugou.com/202501160920/bf524b2f0a2daf648ab1b768847ba0e7/v3/3e03861edba56882ddfc8ef5893c98f5/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx117210429_quviper_tape_s1473576860.mp3","trackType":"mp3"} Jan 16 09:21:20 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:20 volumio volumio[4762]: info: CoreStateMachine::syncState stateService stop Jan 16 09:21:20 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:20 volumio volumio[4762]: info: CoreStateMachine::play index undefined Jan 16 09:21:20 volumio volumio[4762]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 16 09:21:20 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:20 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:20 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 16 09:21:20 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:20 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:20 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:20 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:20 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:20 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:20 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:20 volumio volumio[4762]: 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":"Per Un Pugno Di Dollari","artist":"Ennio Morricone","album":"Film Hits","uri":"http://fsandroid.kugou.com/202501160920/bf524b2f0a2daf648ab1b768847ba0e7/v3/3e03861edba56882ddfc8ef5893c98f5/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx117210429_quviper_tape_s1473576860.mp3","trackType":"mp3"} Jan 16 09:21:20 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:20 volumio volumio[4762]: info: CoreStateMachine::syncState stateService stop Jan 16 09:21:20 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus stop Jan 16 09:21:20 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:20 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:20 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:20 volumio volumio[4762]: info: No code Jan 16 09:21:20 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:20 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:20 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:20 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:20 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:20 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:20 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:20 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:20 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:20 volumio volumio[4762]: 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":"Per Un Pugno Di Dollari","artist":"Ennio Morricone","album":"Film Hits","uri":"http://fsandroid.kugou.com/202501160920/bf524b2f0a2daf648ab1b768847ba0e7/v3/3e03861edba56882ddfc8ef5893c98f5/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx117210429_quviper_tape_s1473576860.mp3","trackType":"mp3"} Jan 16 09:21:20 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:20 volumio volumio[4762]: info: CoreStateMachine::syncState stateService stop Jan 16 09:21:20 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus stop Jan 16 09:21:20 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:20 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:20 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:20 volumio volumio[4762]: info: No code Jan 16 09:21:20 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:20 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:20 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:20 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:20 volumio volumio[4762]: info: ------------------------------ 55ms Jan 16 09:21:20 volumio volumio[4762]: info: ------------------------------ 54ms Jan 16 09:21:20 volumio volumio[4762]: info: ------------------------------ 54ms Jan 16 09:21:20 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:20 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:20 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:20 volumio volumio[4762]: info: Clearing queue after UPNP request Jan 16 09:21:20 volumio volumio[4762]: info: CoreStateMachine::ClearQueue Jan 16 09:21:20 volumio volumio[4762]: info: CoreStateMachine::stop Jan 16 09:21:20 volumio volumio[4762]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 16 09:21:20 volumio volumio[4762]: info: CorePlayQueue::clearPlayQueue Jan 16 09:21:20 volumio volumio[4762]: info: CorePlayQueue::saveQueue Jan 16 09:21:20 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:20 volumio volumio[4762]: info: CoreCommandRouter::volumioPushQueue Jan 16 09:21:20 volumio volumio[4762]: info: Jan 16 09:21:20 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:20 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:20 volumio volumio[4762]: info: Jan 16 09:21:20 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:20 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:20 volumio volumio[4762]: info: Jan 16 09:21:20 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:20 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:20 volumio volumio[4762]: error: updateQueue error: null Jan 16 09:21:20 volumio volumio[4762]: error: updateQueue error: null Jan 16 09:21:20 volumio volumio[4762]: info: ------------------------------ 2ms Jan 16 09:21:20 volumio volumio[4762]: info: ------------------------------ 1ms Jan 16 09:21:20 volumio volumio[4762]: info: Starting UPNP Playback Jan 16 09:21:20 volumio volumio[4762]: info: Preparing playback through UPNP Jan 16 09:21:20 volumio volumio[4762]: info: CoreCommandRouter::volumioGetState Jan 16 09:21:20 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:20 volumio volumio[4762]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 16 09:21:21 volumio volumio[4762]: info: Jan 16 09:21:21 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:21 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:21 volumio volumio[4762]: info: Jan 16 09:21:21 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:21 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:21 volumio volumio[4762]: info: Jan 16 09:21:21 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:21 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:21 volumio volumio[4762]: info: ------------------------------ 2ms Jan 16 09:21:21 volumio volumio[4762]: info: ------------------------------ 1ms Jan 16 09:21:21 volumio volumio[4762]: info: Jan 16 09:21:21 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:21 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:21 volumio volumio[4762]: info: Jan 16 09:21:21 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:21 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:21 volumio volumio[4762]: info: Jan 16 09:21:21 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:21 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:21 volumio volumio[4762]: info: ------------------------------ 2ms Jan 16 09:21:21 volumio volumio[4762]: info: ------------------------------ 1ms Jan 16 09:21:21 volumio volumio[4762]: info: Jan 16 09:21:21 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:21 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:21 volumio volumio[4762]: info: Jan 16 09:21:21 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:21 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:21 volumio volumio[4762]: info: Jan 16 09:21:21 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:21 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:21 volumio volumio[4762]: info: ------------------------------ 2ms Jan 16 09:21:21 volumio volumio[4762]: info: ------------------------------ 2ms Jan 16 09:21:21 volumio volumio[4762]: info: ------------------------------ 1ms Jan 16 09:21:21 volumio volumio[4762]: info: Jan 16 09:21:21 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:21 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:21 volumio volumio[4762]: info: Jan 16 09:21:21 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:21 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:21 volumio volumio[4762]: info: Jan 16 09:21:21 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:21 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:21 volumio volumio[4762]: info: ------------------------------ 2ms Jan 16 09:21:21 volumio volumio[4762]: info: ------------------------------ 2ms Jan 16 09:21:21 volumio volumio[4762]: info: ------------------------------ 1ms Jan 16 09:21:21 volumio volumio[4762]: info: Jan 16 09:21:21 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:21 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:21 volumio volumio[4762]: info: Jan 16 09:21:21 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:21 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:21 volumio volumio[4762]: info: Jan 16 09:21:21 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:21 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:21 volumio volumio[4762]: info: ------------------------------ 2ms Jan 16 09:21:21 volumio volumio[4762]: info: ------------------------------ 1ms Jan 16 09:21:21 volumio volumio[4762]: info: ------------------------------ 2ms Jan 16 09:21:21 volumio volumio[4762]: info: Jan 16 09:21:21 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:21 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:21 volumio volumio[4762]: info: Jan 16 09:21:21 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:21 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:21 volumio volumio[4762]: info: Jan 16 09:21:21 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:21 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:21 volumio volumio[4762]: info: ------------------------------ 2ms Jan 16 09:21:21 volumio volumio[4762]: info: ------------------------------ 1ms Jan 16 09:21:22 volumio volumio[4762]: info: Jan 16 09:21:22 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:22 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:22 volumio volumio[4762]: info: Jan 16 09:21:22 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:22 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:22 volumio volumio[4762]: info: Jan 16 09:21:22 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:22 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:22 volumio volumio[4762]: info: sendMpdCommand status took 5 milliseconds Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:22 volumio volumio[4762]: info: Jan 16 09:21:22 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:22 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:22 volumio volumio[4762]: info: sendMpdCommand status took 5 milliseconds Jan 16 09:21:22 volumio volumio[4762]: info: sendMpdCommand status took 4 milliseconds Jan 16 09:21:22 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:22 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:22 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:22 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":177,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"蒋小雨 - 美酒加咖啡","artist":"蒋小雨","album":null,"uri":"http://fsandroid.kugou.com/202501160921/01cae976b5e1be65a76e0b93d81b8b65/v3/dfa42dc03fc24ff6ac35c92750a96690/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx620887980_quviper_tape_s1155007337.mp3","trackType":"mp3"} Jan 16 09:21:22 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus stop Jan 16 09:21:22 volumio volumio[4762]: info: ------------------------------ 13ms Jan 16 09:21:22 volumio volumio[4762]: info: Jan 16 09:21:22 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:22 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:22 volumio volumio[4762]: info: Jan 16 09:21:22 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:22 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:22 volumio volumio[4762]: info: sendMpdCommand status took 10 milliseconds Jan 16 09:21:22 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 10 milliseconds Jan 16 09:21:22 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 10 milliseconds Jan 16 09:21:22 volumio volumio[4762]: info: sendMpdCommand status took 3 milliseconds Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:22 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:22 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:22 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":177,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"蒋小雨 - 美酒加咖啡","artist":"蒋小雨","album":null,"uri":"http://fsandroid.kugou.com/202501160921/01cae976b5e1be65a76e0b93d81b8b65/v3/dfa42dc03fc24ff6ac35c92750a96690/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx620887980_quviper_tape_s1155007337.mp3","trackType":"mp3"} Jan 16 09:21:22 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:22 volumio volumio[4762]: info: Received an update from plugin. extracting info from payload Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:22 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:22 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:22 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":177,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"蒋小雨 - 美酒加咖啡","artist":"蒋小雨","album":null,"uri":"http://fsandroid.kugou.com/202501160921/01cae976b5e1be65a76e0b93d81b8b65/v3/dfa42dc03fc24ff6ac35c92750a96690/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx620887980_quviper_tape_s1155007337.mp3","trackType":"mp3"} Jan 16 09:21:22 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:22 volumio volumio[4762]: info: Received an update from plugin. extracting info from payload Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:22 volumio volumio[4762]: info: ------------------------------ 68ms Jan 16 09:21:22 volumio volumio[4762]: info: ------------------------------ 67ms Jan 16 09:21:22 volumio volumio[4762]: info: Jan 16 09:21:22 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:22 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:22 volumio volumio[4762]: info: Jan 16 09:21:22 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:22 volumio volumio[4762]: info: sendMpdCommand status took 56 milliseconds Jan 16 09:21:22 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 54 milliseconds Jan 16 09:21:22 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:22 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 53 milliseconds Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:22 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:22 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:22 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":177,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"蒋小雨 - 美酒加咖啡","artist":"蒋小雨","album":null,"uri":"http://fsandroid.kugou.com/202501160921/01cae976b5e1be65a76e0b93d81b8b65/v3/dfa42dc03fc24ff6ac35c92750a96690/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx620887980_quviper_tape_s1155007337.mp3","trackType":"mp3"} Jan 16 09:21:22 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:22 volumio volumio[4762]: info: Received an update from plugin. extracting info from payload Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:22 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:22 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:22 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":177,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"美酒加咖啡","artist":"蒋小雨","album":"夜空的风","uri":"http://fsandroid.kugou.com/202501160921/01cae976b5e1be65a76e0b93d81b8b65/v3/dfa42dc03fc24ff6ac35c92750a96690/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx620887980_quviper_tape_s1155007337.mp3","trackType":"mp3"} Jan 16 09:21:22 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:22 volumio volumio[4762]: info: Received an update from plugin. extracting info from payload Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:22 volumio volumio[4762]: info: ------------------------------ 103ms Jan 16 09:21:22 volumio volumio[4762]: info: ------------------------------ 95ms Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:22 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:22 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:22 volumio volumio[4762]: info: Jan 16 09:21:22 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:22 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:22 volumio volumio[4762]: info: Jan 16 09:21:22 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:22 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:22 volumio volumio[4762]: info: Jan 16 09:21:22 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:22 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:22 volumio volumio[4762]: info: Jan 16 09:21:22 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:22 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:22 volumio volumio[4762]: info: ------------------------------ 63ms Jan 16 09:21:22 volumio volumio[4762]: info: sendMpdCommand status took 61 milliseconds Jan 16 09:21:22 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 61 milliseconds Jan 16 09:21:22 volumio volumio[4762]: info: ------------------------------ 6ms Jan 16 09:21:22 volumio volumio[4762]: info: sendMpdCommand status took 5 milliseconds Jan 16 09:21:22 volumio volumio[4762]: info: ------------------------------ 4ms Jan 16 09:21:22 volumio volumio[4762]: info: sendMpdCommand status took 3 milliseconds Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:22 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:22 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:22 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":177,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"美酒加咖啡","artist":"蒋小雨","album":"夜空的风","uri":"http://fsandroid.kugou.com/202501160921/01cae976b5e1be65a76e0b93d81b8b65/v3/dfa42dc03fc24ff6ac35c92750a96690/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx620887980_quviper_tape_s1155007337.mp3","trackType":"mp3"} Jan 16 09:21:22 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:22 volumio volumio[4762]: info: Received an update from plugin. extracting info from payload Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:22 volumio volumio[4762]: info: ------------------------------ 141ms Jan 16 09:21:22 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 23 milliseconds Jan 16 09:21:22 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 23 milliseconds Jan 16 09:21:22 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 23 milliseconds Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:22 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:22 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:22 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:22 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":177,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"美酒加咖啡","artist":"蒋小雨","album":"夜空的风","uri":"http://fsandroid.kugou.com/202501160921/01cae976b5e1be65a76e0b93d81b8b65/v3/dfa42dc03fc24ff6ac35c92750a96690/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx620887980_quviper_tape_s1155007337.mp3","trackType":"mp3"} Jan 16 09:21:22 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:22 volumio volumio[4762]: info: Received an update from plugin. extracting info from payload Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:22 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:22 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:22 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":177,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"美酒加咖啡","artist":"蒋小雨","album":"夜空的风","uri":"http://fsandroid.kugou.com/202501160921/01cae976b5e1be65a76e0b93d81b8b65/v3/dfa42dc03fc24ff6ac35c92750a96690/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx620887980_quviper_tape_s1155007337.mp3","trackType":"mp3"} Jan 16 09:21:22 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:22 volumio volumio[4762]: info: Received an update from plugin. extracting info from payload Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:22 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:22 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:22 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":819,"duration":177,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"美酒加咖啡","artist":"蒋小雨","album":"夜空的风","uri":"http://fsandroid.kugou.com/202501160921/01cae976b5e1be65a76e0b93d81b8b65/v3/dfa42dc03fc24ff6ac35c92750a96690/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx620887980_quviper_tape_s1155007337.mp3","trackType":"mp3"} Jan 16 09:21:22 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:22 volumio volumio[4762]: info: Received an update from plugin. extracting info from payload Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:22 volumio volumio[4762]: info: ------------------------------ 131ms Jan 16 09:21:22 volumio volumio[4762]: info: ------------------------------ 74ms Jan 16 09:21:22 volumio volumio[4762]: info: ------------------------------ 73ms Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:22 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:22 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:22 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:22 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:22 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:22 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:22 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:22 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:22 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:22 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:46 volumio volumio[4762]: info: Jan 16 09:21:46 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:46 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:46 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:46 volumio volumio[4762]: info: Jan 16 09:21:46 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:46 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:46 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:46 volumio volumio[4762]: info: Jan 16 09:21:46 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:46 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:46 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:46 volumio volumio[4762]: info: sendMpdCommand status took 1 milliseconds Jan 16 09:21:46 volumio volumio[4762]: info: sendMpdCommand status took 2 milliseconds Jan 16 09:21:46 volumio volumio[4762]: info: sendMpdCommand status took 1 milliseconds Jan 16 09:21:46 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:46 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:46 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:46 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:46 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:46 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:46 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 16 09:21:46 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 16 09:21:46 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 16 09:21:46 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:46 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:46 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:46 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:46 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:46 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:46 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:46 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:46 volumio volumio[4762]: 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":"蒋小雨","album":"夜空的风","uri":"http://fsandroid.kugou.com/202501160921/01cae976b5e1be65a76e0b93d81b8b65/v3/dfa42dc03fc24ff6ac35c92750a96690/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx620887980_quviper_tape_s1155007337.mp3","trackType":"mp3"} Jan 16 09:21:46 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:46 volumio volumio[4762]: info: CoreStateMachine::syncState stateService stop Jan 16 09:21:46 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:46 volumio volumio[4762]: info: CoreStateMachine::play index undefined Jan 16 09:21:46 volumio volumio[4762]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 16 09:21:46 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:46 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:46 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 16 09:21:46 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:46 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:46 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:46 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:46 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:46 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:46 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:46 volumio volumio[4762]: 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":"蒋小雨","album":"夜空的风","uri":"http://fsandroid.kugou.com/202501160921/01cae976b5e1be65a76e0b93d81b8b65/v3/dfa42dc03fc24ff6ac35c92750a96690/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx620887980_quviper_tape_s1155007337.mp3","trackType":"mp3"} Jan 16 09:21:46 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:46 volumio volumio[4762]: info: CoreStateMachine::syncState stateService stop Jan 16 09:21:46 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus stop Jan 16 09:21:46 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:46 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:46 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:46 volumio volumio[4762]: info: No code Jan 16 09:21:46 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:46 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:46 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:46 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:46 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:46 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:46 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:46 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:46 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:46 volumio volumio[4762]: 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":"蒋小雨","album":"夜空的风","uri":"http://fsandroid.kugou.com/202501160921/01cae976b5e1be65a76e0b93d81b8b65/v3/dfa42dc03fc24ff6ac35c92750a96690/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx620887980_quviper_tape_s1155007337.mp3","trackType":"mp3"} Jan 16 09:21:46 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:46 volumio volumio[4762]: info: CoreStateMachine::syncState stateService stop Jan 16 09:21:46 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus stop Jan 16 09:21:46 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:46 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:46 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:46 volumio volumio[4762]: info: No code Jan 16 09:21:46 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:46 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:46 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:46 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:46 volumio volumio[4762]: info: ------------------------------ 48ms Jan 16 09:21:46 volumio volumio[4762]: info: ------------------------------ 47ms Jan 16 09:21:46 volumio volumio[4762]: info: ------------------------------ 47ms Jan 16 09:21:46 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:46 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:46 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:46 volumio volumio[4762]: info: Clearing queue after UPNP request Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::ClearQueue Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::stop Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 16 09:21:47 volumio volumio[4762]: info: CorePlayQueue::clearPlayQueue Jan 16 09:21:47 volumio volumio[4762]: info: CorePlayQueue::saveQueue Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::volumioPushQueue Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:47 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:47 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:47 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:47 volumio volumio[4762]: error: updateQueue error: null Jan 16 09:21:47 volumio volumio[4762]: error: updateQueue error: null Jan 16 09:21:47 volumio volumio[4762]: error: updateQueue error: null Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 4ms Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 3ms Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 2ms Jan 16 09:21:47 volumio volumio[4762]: info: Starting UPNP Playback Jan 16 09:21:47 volumio volumio[4762]: info: Preparing playback through UPNP Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::volumioGetState Jan 16 09:21:47 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:47 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:47 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:47 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 4ms Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 3ms Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 2ms Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:47 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:47 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:47 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 7ms Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 6ms Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 5ms Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:47 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:47 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:47 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 5ms Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 3ms Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 2ms Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:47 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:47 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:47 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 4ms Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 3ms Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 3ms Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:47 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:47 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:47 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 4ms Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 3ms Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 2ms Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:47 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:47 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:47 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 4ms Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 3ms Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 2ms Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:47 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:47 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:47 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:47 volumio volumio[4762]: info: sendMpdCommand status took 7 milliseconds Jan 16 09:21:47 volumio volumio[4762]: info: sendMpdCommand status took 6 milliseconds Jan 16 09:21:47 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:47 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:47 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:47 volumio volumio[4762]: info: sendMpdCommand status took 11 milliseconds Jan 16 09:21:47 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:47 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:47 volumio volumio[4762]: info: sendMpdCommand status took 6 milliseconds Jan 16 09:21:47 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 16 09:21:47 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 16 09:21:47 volumio volumio[4762]: info: sendMpdCommand status took 4 milliseconds Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 4ms Jan 16 09:21:47 volumio volumio[4762]: info: sendMpdCommand status took 3 milliseconds Jan 16 09:21:47 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:47 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:47 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:47 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Sound of Silence","artist":"The Ghost of Johnny Cash","album":"The Sound of Silence","uri":"http://fsandroid.kugou.com/202501160921/764bb862282b0a1ae0b72d36050dbc43/v3/aeb8f63cba9f17f65e9d837a66bf3cdb/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx334493485_quviper_tape_s1298743386.mp3","trackType":"mp3"} Jan 16 09:21:47 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus stop Jan 16 09:21:47 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:47 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:47 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Sound of Silence","artist":"The Ghost of Johnny Cash","album":"The Sound of Silence","uri":"http://fsandroid.kugou.com/202501160921/764bb862282b0a1ae0b72d36050dbc43/v3/aeb8f63cba9f17f65e9d837a66bf3cdb/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx334493485_quviper_tape_s1298743386.mp3","trackType":"mp3"} Jan 16 09:21:47 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:47 volumio volumio[4762]: info: Received an update from plugin. extracting info from payload Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:47 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:47 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:47 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Sound of Silence","artist":"The Ghost of Johnny Cash","album":"The Sound of Silence","uri":"http://fsandroid.kugou.com/202501160921/764bb862282b0a1ae0b72d36050dbc43/v3/aeb8f63cba9f17f65e9d837a66bf3cdb/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx334493485_quviper_tape_s1298743386.mp3","trackType":"mp3"} Jan 16 09:21:47 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:47 volumio volumio[4762]: info: Received an update from plugin. extracting info from payload Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 29ms Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 43ms Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 43ms Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:47 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:47 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:47 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:47 volumio volumio[4762]: info: Jan 16 09:21:47 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:47 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:47 volumio volumio[4762]: info: sendMpdCommand status took 33 milliseconds Jan 16 09:21:47 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 31 milliseconds Jan 16 09:21:47 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 31 milliseconds Jan 16 09:21:47 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 30 milliseconds Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 3ms Jan 16 09:21:47 volumio volumio[4762]: info: sendMpdCommand status took 3 milliseconds Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 3ms Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:47 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:47 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:47 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:47 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":213,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"The Sound of Silence","artist":"The Ghost of Johnny Cash","album":"The Sound of Silence","uri":"http://fsandroid.kugou.com/202501160921/764bb862282b0a1ae0b72d36050dbc43/v3/aeb8f63cba9f17f65e9d837a66bf3cdb/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx334493485_quviper_tape_s1298743386.mp3","trackType":"mp3"} Jan 16 09:21:47 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:47 volumio volumio[4762]: info: Received an update from plugin. extracting info from payload Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:47 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:47 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:47 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":213,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"The Sound of Silence","artist":"The Ghost of Johnny Cash","album":"The Sound of Silence","uri":"http://fsandroid.kugou.com/202501160921/764bb862282b0a1ae0b72d36050dbc43/v3/aeb8f63cba9f17f65e9d837a66bf3cdb/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx334493485_quviper_tape_s1298743386.mp3","trackType":"mp3"} Jan 16 09:21:47 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:47 volumio volumio[4762]: info: Received an update from plugin. extracting info from payload Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:47 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:47 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:47 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":213,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"The Sound of Silence","artist":"The Ghost of Johnny Cash","album":"The Sound of Silence","uri":"http://fsandroid.kugou.com/202501160921/764bb862282b0a1ae0b72d36050dbc43/v3/aeb8f63cba9f17f65e9d837a66bf3cdb/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx334493485_quviper_tape_s1298743386.mp3","trackType":"mp3"} Jan 16 09:21:47 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:47 volumio volumio[4762]: info: Received an update from plugin. extracting info from payload Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:47 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:47 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 85ms Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 81ms Jan 16 09:21:47 volumio volumio[4762]: info: ------------------------------ 80ms Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: sendMpdCommand status took 73 milliseconds Jan 16 09:21:48 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 71 milliseconds Jan 16 09:21:48 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 71 milliseconds Jan 16 09:21:48 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:48 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:48 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:48 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:48 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:48 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:48 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":213,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"The Sound of Silence","artist":"The Ghost of Johnny Cash","album":"The Sound of Silence","uri":"http://fsandroid.kugou.com/202501160921/764bb862282b0a1ae0b72d36050dbc43/v3/aeb8f63cba9f17f65e9d837a66bf3cdb/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx334493485_quviper_tape_s1298743386.mp3","trackType":"mp3"} Jan 16 09:21:48 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:48 volumio volumio[4762]: info: Received an update from plugin. extracting info from payload Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:48 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:48 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:48 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":213,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"The Sound of Silence","artist":"The Ghost of Johnny Cash","album":"The Sound of Silence","uri":"http://fsandroid.kugou.com/202501160921/764bb862282b0a1ae0b72d36050dbc43/v3/aeb8f63cba9f17f65e9d837a66bf3cdb/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx334493485_quviper_tape_s1298743386.mp3","trackType":"mp3"} Jan 16 09:21:48 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:48 volumio volumio[4762]: info: Received an update from plugin. extracting info from payload Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:48 volumio volumio[4762]: info: ------------------------------ 133ms Jan 16 09:21:48 volumio volumio[4762]: info: ------------------------------ 102ms Jan 16 09:21:48 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 27 milliseconds Jan 16 09:21:48 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:48 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:48 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:48 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":213,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"The Sound of Silence","artist":"The Ghost of Johnny Cash","album":"The Sound of Silence","uri":"http://fsandroid.kugou.com/202501160921/764bb862282b0a1ae0b72d36050dbc43/v3/aeb8f63cba9f17f65e9d837a66bf3cdb/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx334493485_quviper_tape_s1298743386.mp3","trackType":"mp3"} Jan 16 09:21:48 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:48 volumio volumio[4762]: info: Received an update from plugin. extracting info from payload Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:48 volumio volumio[4762]: info: ------------------------------ 115ms Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:48 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:48 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:56 volumio volumio[4762]: info: Jan 16 09:21:56 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:56 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:56 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:56 volumio volumio[4762]: info: Jan 16 09:21:56 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:56 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:56 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:56 volumio volumio[4762]: info: Jan 16 09:21:56 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:56 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:56 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:56 volumio volumio[4762]: info: sendMpdCommand status took 2 milliseconds Jan 16 09:21:56 volumio volumio[4762]: info: sendMpdCommand status took 1 milliseconds Jan 16 09:21:56 volumio volumio[4762]: info: sendMpdCommand status took 2 milliseconds Jan 16 09:21:56 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:56 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:56 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:56 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:56 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:56 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:56 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 16 09:21:56 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 16 09:21:56 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 16 09:21:56 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:56 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:56 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:56 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:56 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:56 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:56 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:56 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:56 volumio volumio[4762]: 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":"The Sound of Silence","artist":"The Ghost of Johnny Cash","album":"The Sound of Silence","uri":"http://fsandroid.kugou.com/202501160921/764bb862282b0a1ae0b72d36050dbc43/v3/aeb8f63cba9f17f65e9d837a66bf3cdb/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx334493485_quviper_tape_s1298743386.mp3","trackType":"mp3"} Jan 16 09:21:56 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:56 volumio volumio[4762]: info: CoreStateMachine::syncState stateService stop Jan 16 09:21:56 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:56 volumio volumio[4762]: info: CoreStateMachine::play index undefined Jan 16 09:21:56 volumio volumio[4762]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 16 09:21:56 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:56 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:56 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 16 09:21:56 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:56 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:56 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:56 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:56 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:56 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:56 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:56 volumio volumio[4762]: 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":"The Sound of Silence","artist":"The Ghost of Johnny Cash","album":"The Sound of Silence","uri":"http://fsandroid.kugou.com/202501160921/764bb862282b0a1ae0b72d36050dbc43/v3/aeb8f63cba9f17f65e9d837a66bf3cdb/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx334493485_quviper_tape_s1298743386.mp3","trackType":"mp3"} Jan 16 09:21:56 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:56 volumio volumio[4762]: info: CoreStateMachine::syncState stateService stop Jan 16 09:21:56 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus stop Jan 16 09:21:56 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:56 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:56 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:56 volumio volumio[4762]: info: No code Jan 16 09:21:56 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:56 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:56 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:56 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:56 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:56 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:56 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:56 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:56 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:56 volumio volumio[4762]: 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":"The Sound of Silence","artist":"The Ghost of Johnny Cash","album":"The Sound of Silence","uri":"http://fsandroid.kugou.com/202501160921/764bb862282b0a1ae0b72d36050dbc43/v3/aeb8f63cba9f17f65e9d837a66bf3cdb/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx334493485_quviper_tape_s1298743386.mp3","trackType":"mp3"} Jan 16 09:21:56 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:56 volumio volumio[4762]: info: CoreStateMachine::syncState stateService stop Jan 16 09:21:56 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus stop Jan 16 09:21:56 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:56 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:56 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:56 volumio volumio[4762]: info: No code Jan 16 09:21:56 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:56 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:56 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:56 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:56 volumio volumio[4762]: info: ------------------------------ 52ms Jan 16 09:21:56 volumio volumio[4762]: info: ------------------------------ 53ms Jan 16 09:21:56 volumio volumio[4762]: info: ------------------------------ 52ms Jan 16 09:21:56 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:56 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:56 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:56 volumio volumio[4762]: info: Clearing queue after UPNP request Jan 16 09:21:56 volumio volumio[4762]: info: CoreStateMachine::ClearQueue Jan 16 09:21:56 volumio volumio[4762]: info: CoreStateMachine::stop Jan 16 09:21:56 volumio volumio[4762]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 16 09:21:56 volumio volumio[4762]: info: CorePlayQueue::clearPlayQueue Jan 16 09:21:56 volumio volumio[4762]: info: CorePlayQueue::saveQueue Jan 16 09:21:56 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:56 volumio volumio[4762]: info: CoreCommandRouter::volumioPushQueue Jan 16 09:21:56 volumio volumio[4762]: info: Jan 16 09:21:56 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:56 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:56 volumio volumio[4762]: info: Jan 16 09:21:56 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:56 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:56 volumio volumio[4762]: info: Jan 16 09:21:56 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:56 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:56 volumio volumio[4762]: error: updateQueue error: null Jan 16 09:21:56 volumio volumio[4762]: error: updateQueue error: null Jan 16 09:21:56 volumio volumio[4762]: error: updateQueue error: null Jan 16 09:21:56 volumio volumio[4762]: info: ------------------------------ 11ms Jan 16 09:21:56 volumio volumio[4762]: info: ------------------------------ 4ms Jan 16 09:21:56 volumio volumio[4762]: info: ------------------------------ 3ms Jan 16 09:21:56 volumio volumio[4762]: info: Starting UPNP Playback Jan 16 09:21:56 volumio volumio[4762]: info: Preparing playback through UPNP Jan 16 09:21:56 volumio volumio[4762]: info: CoreCommandRouter::volumioGetState Jan 16 09:21:56 volumio volumio[4762]: info: CorePlayQueue::getTrack 0 Jan 16 09:21:56 volumio volumio[4762]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:57 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:57 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:57 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 8ms Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 22ms Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 20ms Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:57 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:57 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:57 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 11ms Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 10ms Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 7ms Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:57 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:57 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:57 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 7ms Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 5ms Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 4ms Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:57 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:57 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:57 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 6ms Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 4ms Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 2ms Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:57 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:57 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:57 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 4ms Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 4ms Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 2ms Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:57 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:57 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:57 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 4ms Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 3ms Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 2ms Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:57 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:57 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:57 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:57 volumio volumio[4762]: info: sendMpdCommand status took 7 milliseconds Jan 16 09:21:57 volumio volumio[4762]: info: sendMpdCommand status took 6 milliseconds Jan 16 09:21:57 volumio volumio[4762]: info: sendMpdCommand status took 5 milliseconds Jan 16 09:21:57 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:57 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:57 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:57 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:57 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:57 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:57 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:57 volumio volumio[4762]: info: sendMpdCommand status took 12 milliseconds Jan 16 09:21:57 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 10 milliseconds Jan 16 09:21:57 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 9 milliseconds Jan 16 09:21:57 volumio volumio[4762]: info: sendMpdCommand status took 8 milliseconds Jan 16 09:21:57 volumio volumio[4762]: info: sendMpdCommand status took 7 milliseconds Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 4ms Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:57 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:57 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:57 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":218,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"阿佤人民唱新歌","artist":"好薇","album":"赞歌","uri":"http://fsandroid.kugou.com/202501160921/9a5703eae405715cafcd8ebe0bdacbf4/v3/1cbd8940ec5262329f5b09d684653eb4/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx379451668_quviper_tape_s3810849613.mp3","trackType":"mp3"} Jan 16 09:21:57 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus stop Jan 16 09:21:57 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:57 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:57 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":218,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"阿佤人民唱新歌","artist":"好薇","album":"赞歌","uri":"http://fsandroid.kugou.com/202501160921/9a5703eae405715cafcd8ebe0bdacbf4/v3/1cbd8940ec5262329f5b09d684653eb4/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx379451668_quviper_tape_s3810849613.mp3","trackType":"mp3"} Jan 16 09:21:57 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:57 volumio volumio[4762]: info: Received an update from plugin. extracting info from payload Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:57 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:57 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:57 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":218,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"阿佤人民唱新歌","artist":"好薇","album":"赞歌","uri":"http://fsandroid.kugou.com/202501160921/9a5703eae405715cafcd8ebe0bdacbf4/v3/1cbd8940ec5262329f5b09d684653eb4/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx379451668_quviper_tape_s3810849613.mp3","trackType":"mp3"} Jan 16 09:21:57 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:57 volumio volumio[4762]: info: Received an update from plugin. extracting info from payload Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 36ms Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 51ms Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 50ms Jan 16 09:21:57 volumio volumio[4762]: info: sendMpdCommand status took 36 milliseconds Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 36ms Jan 16 09:21:57 volumio volumio[4762]: info: sendMpdCommand status took 33 milliseconds Jan 16 09:21:57 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 32 milliseconds Jan 16 09:21:57 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 32 milliseconds Jan 16 09:21:57 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 32 milliseconds Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:57 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:57 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:57 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":218,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"阿佤人民唱新歌","artist":"好薇","album":"赞歌","uri":"http://fsandroid.kugou.com/202501160921/9a5703eae405715cafcd8ebe0bdacbf4/v3/1cbd8940ec5262329f5b09d684653eb4/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx379451668_quviper_tape_s3810849613.mp3","trackType":"mp3"} Jan 16 09:21:57 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:57 volumio volumio[4762]: info: Received an update from plugin. extracting info from payload Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:57 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:57 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:57 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":218,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"阿佤人民唱新歌","artist":"好薇","album":"赞歌","uri":"http://fsandroid.kugou.com/202501160921/9a5703eae405715cafcd8ebe0bdacbf4/v3/1cbd8940ec5262329f5b09d684653eb4/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx379451668_quviper_tape_s3810849613.mp3","trackType":"mp3"} Jan 16 09:21:57 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:57 volumio volumio[4762]: info: Received an update from plugin. extracting info from payload Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:57 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:57 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:57 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":218,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"阿佤人民唱新歌","artist":"好薇","album":"赞歌","uri":"http://fsandroid.kugou.com/202501160921/9a5703eae405715cafcd8ebe0bdacbf4/v3/1cbd8940ec5262329f5b09d684653eb4/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx379451668_quviper_tape_s3810849613.mp3","trackType":"mp3"} Jan 16 09:21:57 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:57 volumio volumio[4762]: info: Received an update from plugin. extracting info from payload Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 85ms Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 80ms Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 79ms Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces system playlist update Jan 16 09:21:57 volumio volumio[4762]: info: Ignoring MPD Status Update Jan 16 09:21:57 volumio volumio[4762]: info: Jan 16 09:21:57 volumio volumio[4762]: ---------------------------- MPD announces state update: player Jan 16 09:21:57 volumio volumio[4762]: info: ControllerMpd::getState Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand status Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 68 milliseconds Jan 16 09:21:57 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 68 milliseconds Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 29ms Jan 16 09:21:57 volumio volumio[4762]: info: sendMpdCommand status took 29 milliseconds Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::parseState Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 16 09:21:57 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:57 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:57 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":218,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"阿佤人民唱新歌","artist":"好薇","album":"赞歌","uri":"http://fsandroid.kugou.com/202501160921/9a5703eae405715cafcd8ebe0bdacbf4/v3/1cbd8940ec5262329f5b09d684653eb4/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx379451668_quviper_tape_s3810849613.mp3","trackType":"mp3"} Jan 16 09:21:57 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:57 volumio volumio[4762]: info: Received an update from plugin. extracting info from payload Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:57 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:57 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:57 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":218,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"阿佤人民唱新歌","artist":"好薇","album":"赞歌","uri":"http://fsandroid.kugou.com/202501160921/9a5703eae405715cafcd8ebe0bdacbf4/v3/1cbd8940ec5262329f5b09d684653eb4/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx379451668_quviper_tape_s3810849613.mp3","trackType":"mp3"} Jan 16 09:21:57 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:57 volumio volumio[4762]: info: Received an update from plugin. extracting info from payload Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 127ms Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 126ms Jan 16 09:21:57 volumio volumio[4762]: info: sendMpdCommand playlistinfo took 22 milliseconds Jan 16 09:21:57 volumio volumio[4762]: verbose: ControllerMpd::parseTrackInfo Jan 16 09:21:57 volumio volumio[4762]: info: ControllerMpd::pushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::servicePushState Jan 16 09:21:57 volumio volumio[4762]: verbose: In UPNP mode Jan 16 09:21:57 volumio volumio[4762]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":218,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"阿佤人民唱新歌","artist":"好薇","album":"赞歌","uri":"http://fsandroid.kugou.com/202501160921/9a5703eae405715cafcd8ebe0bdacbf4/v3/1cbd8940ec5262329f5b09d684653eb4/yp/full/ap1005_us1195258712_df10ybri3b3bmg4d7wuj4r6zyk_pi2_mx379451668_quviper_tape_s3810849613.mp3","trackType":"mp3"} Jan 16 09:21:57 volumio volumio[4762]: verbose: CURRENT POSITION 0 Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::syncState stateService play Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::syncState currentStatus play Jan 16 09:21:57 volumio volumio[4762]: info: Received an update from plugin. extracting info from payload Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::pushState Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioPushState Jan 16 09:21:57 volumio volumio[4762]: info: ------------------------------ 66ms Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreCommandRouter::volumioGetQueue Jan 16 09:21:57 volumio volumio[4762]: info: CoreStateMachine::getQueue Jan 16 09:21:57 volumio volumio[4762]: info: CorePlayQueue::getQueue Jan 16 09:22:37 volumio volumio[4762]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 16 09:22:37 volumio volumio[4762]: Error: connect ETIMEDOUT 69.63.187.12:443 Jan 16 09:22:37 volumio volumio[4762]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jan 16 09:22:37 volumio volumio[4762]: errno: -110, Jan 16 09:22:37 volumio volumio[4762]: code: 'ETIMEDOUT', Jan 16 09:22:37 volumio volumio[4762]: syscall: 'connect', Jan 16 09:22:37 volumio volumio[4762]: address: '69.63.187.12', Jan 16 09:22:37 volumio volumio[4762]: port: 443 Jan 16 09:22:37 volumio volumio[4762]: } Jan 16 09:22:37 volumio volumio[4762]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 16 09:22:37 volumio sudo[9399]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-16 09:21 Jan 16 09:22:37 volumio sudo[9399]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:42:03 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="c434411fe8754b648dc7feb1d8f43761"