-- Logs begin at Mon 2024-04-22 11:37:46 UTC, end at Mon 2024-04-22 13:48:00 UTC. -- Apr 22 13:47:05 volumio volumio[4953]: info: Clearing queue after UPNP request Apr 22 13:47:05 volumio volumio[4953]: info: CoreStateMachine::ClearQueue Apr 22 13:47:05 volumio volumio[4953]: info: CoreStateMachine::stop Apr 22 13:47:05 volumio volumio[4953]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 22 13:47:05 volumio volumio[4953]: UNSET VOLATILE Apr 22 13:47:05 volumio volumio[4953]: info: CorePlayQueue::clearPlayQueue Apr 22 13:47:05 volumio volumio[4953]: info: CorePlayQueue::saveQueue Apr 22 13:47:05 volumio volumio[4953]: info: CoreCommandRouter::volumioPushState Apr 22 13:47:05 volumio volumio[4953]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 13:47:05 volumio volumio[4953]: info: CoreCommandRouter::volumioPushQueue Apr 22 13:47:05 volumio volumio[4953]: info: Apr 22 13:47:05 volumio volumio[4953]: ---------------------------- MPD announces system playlist update Apr 22 13:47:05 volumio volumio[4953]: info: Ignoring MPD Status Update Apr 22 13:47:05 volumio volumio[4953]: error: updateQueue error: null Apr 22 13:47:05 volumio volumio[4953]: info: ------------------------------ 1ms Apr 22 13:47:05 volumio volumio[4953]: info: Starting UPNP Playback Apr 22 13:47:05 volumio volumio[4953]: info: Preparing playback through UPNP Apr 22 13:47:05 volumio volumio[4953]: info: CoreCommandRouter::volumioGetState Apr 22 13:47:05 volumio volumio[4953]: info: CorePlayQueue::getTrack 0 Apr 22 13:47:05 volumio volumio[4953]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 22 13:47:06 volumio volumio[4953]: info: Apr 22 13:47:06 volumio volumio[4953]: ---------------------------- MPD announces system playlist update Apr 22 13:47:06 volumio volumio[4953]: info: Ignoring MPD Status Update Apr 22 13:47:06 volumio volumio[4953]: info: ------------------------------ 5ms Apr 22 13:47:06 volumio volumio[4953]: info: Apr 22 13:47:06 volumio volumio[4953]: ---------------------------- MPD announces system playlist update Apr 22 13:47:06 volumio volumio[4953]: info: Ignoring MPD Status Update Apr 22 13:47:06 volumio volumio[4953]: info: ------------------------------ 6ms Apr 22 13:47:06 volumio volumio[4953]: info: Apr 22 13:47:06 volumio volumio[4953]: ---------------------------- MPD announces system playlist update Apr 22 13:47:06 volumio volumio[4953]: info: Ignoring MPD Status Update Apr 22 13:47:06 volumio volumio[4953]: info: ------------------------------ 2ms Apr 22 13:47:06 volumio volumio[4953]: info: Apr 22 13:47:06 volumio volumio[4953]: ---------------------------- MPD announces system playlist update Apr 22 13:47:06 volumio volumio[4953]: info: Ignoring MPD Status Update Apr 22 13:47:06 volumio volumio[4953]: info: Apr 22 13:47:06 volumio volumio[4953]: ---------------------------- MPD announces system playlist update Apr 22 13:47:06 volumio volumio[4953]: info: Ignoring MPD Status Update Apr 22 13:47:06 volumio volumio[4953]: info: ------------------------------ 3ms Apr 22 13:47:06 volumio volumio[4953]: info: ------------------------------ 2ms Apr 22 13:47:06 volumio volumio[4953]: info: Apr 22 13:47:06 volumio volumio[4953]: ---------------------------- MPD announces system playlist update Apr 22 13:47:06 volumio volumio[4953]: info: Ignoring MPD Status Update Apr 22 13:47:06 volumio volumio[4953]: info: ------------------------------ 1ms Apr 22 13:47:06 volumio volumio[4953]: info: Apr 22 13:47:06 volumio volumio[4953]: ---------------------------- MPD announces state update: player Apr 22 13:47:06 volumio volumio[4953]: info: ControllerMpd::getState Apr 22 13:47:06 volumio volumio[4953]: verbose: ControllerMpd::sendMpdCommand status Apr 22 13:47:06 volumio volumio[4953]: info: Apr 22 13:47:06 volumio volumio[4953]: ---------------------------- MPD announces state update: player Apr 22 13:47:06 volumio volumio[4953]: info: ControllerMpd::getState Apr 22 13:47:06 volumio volumio[4953]: verbose: ControllerMpd::sendMpdCommand status Apr 22 13:47:06 volumio volumio[4953]: verbose: ControllerMpd::parseState Apr 22 13:47:06 volumio volumio[4953]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 13:47:06 volumio volumio[4953]: info: Apr 22 13:47:06 volumio volumio[4953]: ---------------------------- MPD announces system playlist update Apr 22 13:47:06 volumio volumio[4953]: info: Ignoring MPD Status Update Apr 22 13:47:06 volumio volumio[4953]: info: ------------------------------ 6ms Apr 22 13:47:06 volumio volumio[4953]: verbose: ControllerMpd::parseState Apr 22 13:47:06 volumio volumio[4953]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 13:47:06 volumio volumio[4953]: verbose: ControllerMpd::parseTrackInfo Apr 22 13:47:06 volumio volumio[4953]: info: ControllerMpd::pushState Apr 22 13:47:06 volumio volumio[4953]: info: CoreCommandRouter::servicePushState Apr 22 13:47:06 volumio volumio[4953]: In UPNP mode Apr 22 13:47:06 volumio volumio[4953]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":243,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"爱情傀儡","artist":"巫启贤","album":"爱情傀儡","uri":"http://sjy6.stream.qqmusic.qq.com/M500001gACj71cHfWZ.mp3?guid=000000001c1332050000018d6777c597&vkey=2508AA4C7518282AFC9A12883BC52E7181533B0DB57AADBDE8B93392FD0D9B6A29F26C80669BFFBCEF2406A3CB0EE62927AFF449C4BEA7CE&uin=1152921505067435511&redirect=1&fromtag=111042","trackType":""} Apr 22 13:47:06 volumio volumio[4953]: verbose: CURRENT POSITION 0 Apr 22 13:47:06 volumio volumio[4953]: info: CoreStateMachine::syncState stateService play Apr 22 13:47:06 volumio volumio[4953]: info: CoreStateMachine::syncState currentStatus stop Apr 22 13:47:06 volumio volumio[4953]: info: CoreStateMachine::pushState Apr 22 13:47:06 volumio volumio[4953]: info: CoreCommandRouter::volumioPushState Apr 22 13:47:06 volumio volumio[4953]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 13:47:06 volumio volumio[4953]: info: ------------------------------ 23ms Apr 22 13:47:06 volumio volumio[4953]: verbose: ControllerMpd::parseTrackInfo Apr 22 13:47:06 volumio volumio[4953]: info: ControllerMpd::pushState Apr 22 13:47:06 volumio volumio[4953]: info: CoreCommandRouter::servicePushState Apr 22 13:47:06 volumio volumio[4953]: In UPNP mode Apr 22 13:47:06 volumio volumio[4953]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":243,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"爱情傀儡","artist":"巫启贤","album":"爱情傀儡","uri":"http://sjy6.stream.qqmusic.qq.com/M500001gACj71cHfWZ.mp3?guid=000000001c1332050000018d6777c597&vkey=2508AA4C7518282AFC9A12883BC52E7181533B0DB57AADBDE8B93392FD0D9B6A29F26C80669BFFBCEF2406A3CB0EE62927AFF449C4BEA7CE&uin=1152921505067435511&redirect=1&fromtag=111042","trackType":""} Apr 22 13:47:06 volumio volumio[4953]: verbose: CURRENT POSITION 0 Apr 22 13:47:06 volumio volumio[4953]: info: CoreStateMachine::syncState stateService play Apr 22 13:47:06 volumio volumio[4953]: info: CoreStateMachine::syncState currentStatus play Apr 22 13:47:06 volumio volumio[4953]: info: Received an update from plugin. extracting info from payload Apr 22 13:47:06 volumio volumio[4953]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 22 13:47:06 volumio volumio[4953]: info: CoreStateMachine::pushState Apr 22 13:47:06 volumio volumio[4953]: info: CoreCommandRouter::volumioPushState Apr 22 13:47:06 volumio volumio[4953]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 13:47:06 volumio volumio[4953]: info: CoreStateMachine::pushState Apr 22 13:47:06 volumio volumio[4953]: info: CoreCommandRouter::volumioPushState Apr 22 13:47:06 volumio volumio[4953]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 13:47:06 volumio volumio[4953]: info: ------------------------------ 46ms Apr 22 13:47:06 volumio volumio[4953]: info: CoreCommandRouter::volumioGetQueue Apr 22 13:47:06 volumio volumio[4953]: info: CoreStateMachine::getQueue Apr 22 13:47:06 volumio volumio[4953]: info: CorePlayQueue::getQueue Apr 22 13:47:06 volumio volumio[4953]: info: CoreCommandRouter::volumioGetQueue Apr 22 13:47:06 volumio volumio[4953]: info: CoreStateMachine::getQueue Apr 22 13:47:06 volumio volumio[4953]: info: CorePlayQueue::getQueue Apr 22 13:47:09 volumio volumio[4953]: info: CoreCommandRouter::volumioGetState Apr 22 13:47:12 volumio volumio[5141]: 30 Apr 22 13:47:12 volumio volumio[5141]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 22 13:47:12 volumio volumio[5141]: Dload Upload Total Spent Left Speed Apr 22 13:47:12 volumio volumio[4953]: info: Apr 22 13:47:12 volumio volumio[4953]: ---------------------------- Client requests Volume 30 Apr 22 13:47:12 volumio volumio[4953]: info: VolumeController::SetAlsaVolume30 Apr 22 13:47:12 volumio volumio[4953]: info: CoreStateMachine::pushState Apr 22 13:47:12 volumio volumio[4953]: info: CoreCommandRouter::volumioPushState Apr 22 13:47:12 volumio volumio[4953]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 13:47:12 volumio volumio[5141]: [155B blob data] Apr 22 13:47:12 volumio volumio[4953]: info: CoreCommandRouter::volumioGetQueue Apr 22 13:47:12 volumio volumio[4953]: info: CoreStateMachine::getQueue Apr 22 13:47:12 volumio volumio[4953]: info: CorePlayQueue::getQueue Apr 22 13:47:12 volumio volumio[4953]: info: VolumeController::SetAlsaVolume20 Apr 22 13:47:12 volumio volumio[5141]: {"time":1713793632649,"response":"volume Success"}30 Apr 22 13:47:12 volumio volumio[4953]: info: CoreStateMachine::pushState Apr 22 13:47:12 volumio volumio[4953]: info: CoreCommandRouter::volumioPushState Apr 22 13:47:12 volumio volumio[4953]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 13:47:12 volumio volumio[4953]: info: Apr 22 13:47:12 volumio volumio[4953]: ---------------------------- MPD announces state update: mixer Apr 22 13:47:12 volumio volumio[4953]: info: ControllerMpd::getState Apr 22 13:47:12 volumio volumio[4953]: verbose: ControllerMpd::sendMpdCommand status Apr 22 13:47:12 volumio volumio[4953]: info: CoreCommandRouter::volumioGetQueue Apr 22 13:47:12 volumio volumio[4953]: info: CoreStateMachine::getQueue Apr 22 13:47:12 volumio volumio[4953]: info: CorePlayQueue::getQueue Apr 22 13:47:12 volumio volumio[4953]: verbose: ControllerMpd::parseState Apr 22 13:47:12 volumio volumio[4953]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 13:47:12 volumio volumio[4953]: verbose: ControllerMpd::parseTrackInfo Apr 22 13:47:12 volumio volumio[4953]: info: ControllerMpd::pushState Apr 22 13:47:12 volumio volumio[4953]: info: CoreCommandRouter::servicePushState Apr 22 13:47:12 volumio volumio[4953]: In UPNP mode Apr 22 13:47:12 volumio volumio[4953]: verbose: STATE SERVICE {"status":"play","position":0,"seek":6478,"duration":243,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"爱情傀儡","artist":"巫启贤","album":"爱情傀儡","uri":"http://sjy6.stream.qqmusic.qq.com/M500001gACj71cHfWZ.mp3?guid=000000001c1332050000018d6777c597&vkey=2508AA4C7518282AFC9A12883BC52E7181533B0DB57AADBDE8B93392FD0D9B6A29F26C80669BFFBCEF2406A3CB0EE62927AFF449C4BEA7CE&uin=1152921505067435511&redirect=1&fromtag=111042","trackType":""} Apr 22 13:47:12 volumio volumio[4953]: verbose: CURRENT POSITION 0 Apr 22 13:47:12 volumio volumio[4953]: info: CoreStateMachine::syncState stateService play Apr 22 13:47:12 volumio volumio[4953]: info: CoreStateMachine::syncState currentStatus play Apr 22 13:47:12 volumio volumio[4953]: info: Received an update from plugin. extracting info from payload Apr 22 13:47:12 volumio volumio[4953]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 22 13:47:12 volumio volumio[4953]: info: CoreStateMachine::pushState Apr 22 13:47:12 volumio volumio[4953]: info: CoreCommandRouter::volumioPushState Apr 22 13:47:12 volumio volumio[4953]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 13:47:12 volumio volumio[4953]: info: CoreStateMachine::pushState Apr 22 13:47:12 volumio volumio[4953]: info: CoreCommandRouter::volumioPushState Apr 22 13:47:12 volumio volumio[4953]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 13:47:12 volumio volumio[4953]: info: ------------------------------ 35ms Apr 22 13:47:12 volumio volumio[4953]: info: Apr 22 13:47:12 volumio volumio[4953]: ---------------------------- MPD announces state update: mixer Apr 22 13:47:12 volumio volumio[4953]: info: ControllerMpd::getState Apr 22 13:47:12 volumio volumio[4953]: verbose: ControllerMpd::sendMpdCommand status Apr 22 13:47:12 volumio volumio[4953]: info: CoreCommandRouter::volumioGetQueue Apr 22 13:47:12 volumio volumio[4953]: info: CoreStateMachine::getQueue Apr 22 13:47:12 volumio volumio[4953]: info: CorePlayQueue::getQueue Apr 22 13:47:12 volumio volumio[4953]: info: CoreCommandRouter::volumioGetQueue Apr 22 13:47:12 volumio volumio[4953]: info: CoreStateMachine::getQueue Apr 22 13:47:12 volumio volumio[4953]: info: CorePlayQueue::getQueue Apr 22 13:47:12 volumio volumio[4953]: verbose: ControllerMpd::parseState Apr 22 13:47:12 volumio volumio[4953]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 13:47:12 volumio volumio[4953]: verbose: ControllerMpd::parseTrackInfo Apr 22 13:47:12 volumio volumio[4953]: info: ControllerMpd::pushState Apr 22 13:47:12 volumio volumio[4953]: info: CoreCommandRouter::servicePushState Apr 22 13:47:12 volumio volumio[4953]: In UPNP mode Apr 22 13:47:12 volumio volumio[4953]: verbose: STATE SERVICE {"status":"play","position":0,"seek":6478,"duration":243,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"爱情傀儡","artist":"巫启贤","album":"爱情傀儡","uri":"http://sjy6.stream.qqmusic.qq.com/M500001gACj71cHfWZ.mp3?guid=000000001c1332050000018d6777c597&vkey=2508AA4C7518282AFC9A12883BC52E7181533B0DB57AADBDE8B93392FD0D9B6A29F26C80669BFFBCEF2406A3CB0EE62927AFF449C4BEA7CE&uin=1152921505067435511&redirect=1&fromtag=111042","trackType":""} Apr 22 13:47:12 volumio volumio[4953]: verbose: CURRENT POSITION 0 Apr 22 13:47:12 volumio volumio[4953]: info: CoreStateMachine::syncState stateService play Apr 22 13:47:12 volumio volumio[4953]: info: CoreStateMachine::syncState currentStatus play Apr 22 13:47:12 volumio volumio[4953]: info: Received an update from plugin. extracting info from payload Apr 22 13:47:12 volumio volumio[4953]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 22 13:47:12 volumio volumio[4953]: info: CoreStateMachine::pushState Apr 22 13:47:12 volumio volumio[4953]: info: CoreCommandRouter::volumioPushState Apr 22 13:47:12 volumio volumio[4953]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 13:47:12 volumio volumio[4953]: info: CoreStateMachine::pushState Apr 22 13:47:12 volumio volumio[4953]: info: CoreCommandRouter::volumioPushState Apr 22 13:47:12 volumio volumio[4953]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 13:47:12 volumio volumio[4953]: info: ------------------------------ 38ms Apr 22 13:47:12 volumio volumio[4953]: info: CoreCommandRouter::volumioGetQueue Apr 22 13:47:12 volumio volumio[4953]: info: CoreStateMachine::getQueue Apr 22 13:47:12 volumio volumio[4953]: info: CorePlayQueue::getQueue Apr 22 13:47:12 volumio volumio[4953]: info: CoreCommandRouter::volumioGetQueue Apr 22 13:47:12 volumio volumio[4953]: info: CoreStateMachine::getQueue Apr 22 13:47:12 volumio volumio[4953]: info: CorePlayQueue::getQueue Apr 22 13:47:13 volumio volumio[5141]: 40 Apr 22 13:47:13 volumio volumio[5141]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 22 13:47:13 volumio volumio[5141]: Dload Upload Total Spent Left Speed Apr 22 13:47:13 volumio volumio[4953]: info: Apr 22 13:47:13 volumio volumio[4953]: ---------------------------- Client requests Volume 40 Apr 22 13:47:13 volumio volumio[4953]: info: VolumeController::SetAlsaVolume40 Apr 22 13:47:13 volumio volumio[4953]: info: CoreStateMachine::pushState Apr 22 13:47:13 volumio volumio[4953]: info: CoreCommandRouter::volumioPushState Apr 22 13:47:13 volumio volumio[4953]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 13:47:13 volumio volumio[5141]: [155B blob data] Apr 22 13:47:13 volumio volumio[5141]: {"time":1713793633377,"response":"volume Success"}40 Apr 22 13:47:13 volumio volumio[4953]: info: CoreCommandRouter::volumioGetQueue Apr 22 13:47:13 volumio volumio[4953]: info: CoreStateMachine::getQueue Apr 22 13:47:13 volumio volumio[4953]: info: CorePlayQueue::getQueue Apr 22 13:47:13 volumio volumio[4953]: info: Apr 22 13:47:13 volumio volumio[4953]: ---------------------------- MPD announces state update: mixer Apr 22 13:47:13 volumio volumio[4953]: info: ControllerMpd::getState Apr 22 13:47:13 volumio volumio[4953]: verbose: ControllerMpd::sendMpdCommand status Apr 22 13:47:13 volumio volumio[4953]: verbose: ControllerMpd::parseState Apr 22 13:47:13 volumio volumio[4953]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 13:47:13 volumio volumio[4953]: verbose: ControllerMpd::parseTrackInfo Apr 22 13:47:13 volumio volumio[4953]: info: ControllerMpd::pushState Apr 22 13:47:13 volumio volumio[4953]: info: CoreCommandRouter::servicePushState Apr 22 13:47:13 volumio volumio[4953]: In UPNP mode Apr 22 13:47:13 volumio volumio[4953]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7105,"duration":243,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"爱情傀儡","artist":"巫启贤","album":"爱情傀儡","uri":"http://sjy6.stream.qqmusic.qq.com/M500001gACj71cHfWZ.mp3?guid=000000001c1332050000018d6777c597&vkey=2508AA4C7518282AFC9A12883BC52E7181533B0DB57AADBDE8B93392FD0D9B6A29F26C80669BFFBCEF2406A3CB0EE62927AFF449C4BEA7CE&uin=1152921505067435511&redirect=1&fromtag=111042","trackType":""} Apr 22 13:47:13 volumio volumio[4953]: verbose: CURRENT POSITION 0 Apr 22 13:47:13 volumio volumio[4953]: info: CoreStateMachine::syncState stateService play Apr 22 13:47:13 volumio volumio[4953]: info: CoreStateMachine::syncState currentStatus play Apr 22 13:47:13 volumio volumio[4953]: info: Received an update from plugin. extracting info from payload Apr 22 13:47:13 volumio volumio[4953]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 22 13:47:13 volumio volumio[4953]: info: CoreStateMachine::pushState Apr 22 13:47:13 volumio volumio[4953]: info: CoreCommandRouter::volumioPushState Apr 22 13:47:13 volumio volumio[4953]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 13:47:13 volumio volumio[4953]: info: CoreStateMachine::pushState Apr 22 13:47:13 volumio volumio[4953]: info: CoreCommandRouter::volumioPushState Apr 22 13:47:13 volumio volumio[4953]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 13:47:13 volumio volumio[4953]: info: ------------------------------ 23ms Apr 22 13:47:13 volumio volumio[4953]: info: CoreCommandRouter::volumioGetQueue Apr 22 13:47:13 volumio volumio[4953]: info: CoreStateMachine::getQueue Apr 22 13:47:13 volumio volumio[4953]: info: CorePlayQueue::getQueue Apr 22 13:47:13 volumio volumio[4953]: info: CoreCommandRouter::volumioGetQueue Apr 22 13:47:13 volumio volumio[4953]: info: CoreStateMachine::getQueue Apr 22 13:47:13 volumio volumio[4953]: info: CorePlayQueue::getQueue Apr 22 13:47:13 volumio volumio[5141]: 50 Apr 22 13:47:13 volumio volumio[5141]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 22 13:47:13 volumio volumio[5141]: Dload Upload Total Spent Left Speed Apr 22 13:47:13 volumio volumio[4953]: info: Apr 22 13:47:13 volumio volumio[4953]: ---------------------------- Client requests Volume 50 Apr 22 13:47:13 volumio volumio[4953]: info: VolumeController::SetAlsaVolume50 Apr 22 13:47:13 volumio volumio[4953]: info: CoreStateMachine::pushState Apr 22 13:47:13 volumio volumio[4953]: info: CoreCommandRouter::volumioPushState Apr 22 13:47:13 volumio volumio[4953]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 13:47:13 volumio volumio[5141]: [155B blob data] Apr 22 13:47:13 volumio volumio[5141]: {"time":1713793633763,"response":"volume Success"}50 Apr 22 13:47:13 volumio volumio[4953]: info: CoreCommandRouter::volumioGetQueue Apr 22 13:47:13 volumio volumio[4953]: info: CoreStateMachine::getQueue Apr 22 13:47:13 volumio volumio[4953]: info: CorePlayQueue::getQueue Apr 22 13:47:13 volumio volumio[4953]: info: Apr 22 13:47:13 volumio volumio[4953]: ---------------------------- MPD announces state update: mixer Apr 22 13:47:13 volumio volumio[4953]: info: ControllerMpd::getState Apr 22 13:47:13 volumio volumio[4953]: verbose: ControllerMpd::sendMpdCommand status Apr 22 13:47:13 volumio volumio[4953]: verbose: ControllerMpd::parseState Apr 22 13:47:13 volumio volumio[4953]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 13:47:13 volumio volumio[4953]: verbose: ControllerMpd::parseTrackInfo Apr 22 13:47:13 volumio volumio[4953]: info: ControllerMpd::pushState Apr 22 13:47:13 volumio volumio[4953]: info: CoreCommandRouter::servicePushState Apr 22 13:47:13 volumio volumio[4953]: In UPNP mode Apr 22 13:47:13 volumio volumio[4953]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7604,"duration":243,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"爱情傀儡","artist":"巫启贤","album":"爱情傀儡","uri":"http://sjy6.stream.qqmusic.qq.com/M500001gACj71cHfWZ.mp3?guid=000000001c1332050000018d6777c597&vkey=2508AA4C7518282AFC9A12883BC52E7181533B0DB57AADBDE8B93392FD0D9B6A29F26C80669BFFBCEF2406A3CB0EE62927AFF449C4BEA7CE&uin=1152921505067435511&redirect=1&fromtag=111042","trackType":""} Apr 22 13:47:13 volumio volumio[4953]: verbose: CURRENT POSITION 0 Apr 22 13:47:13 volumio volumio[4953]: info: CoreStateMachine::syncState stateService play Apr 22 13:47:13 volumio volumio[4953]: info: CoreStateMachine::syncState currentStatus play Apr 22 13:47:13 volumio volumio[4953]: info: Received an update from plugin. extracting info from payload Apr 22 13:47:13 volumio volumio[4953]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 22 13:47:13 volumio volumio[4953]: info: CoreStateMachine::pushState Apr 22 13:47:13 volumio volumio[4953]: info: CoreCommandRouter::volumioPushState Apr 22 13:47:13 volumio volumio[4953]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 13:47:13 volumio volumio[4953]: info: CoreStateMachine::pushState Apr 22 13:47:13 volumio volumio[4953]: info: CoreCommandRouter::volumioPushState Apr 22 13:47:13 volumio volumio[4953]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 13:47:13 volumio volumio[4953]: info: ------------------------------ 19ms Apr 22 13:47:13 volumio volumio[4953]: info: CoreCommandRouter::volumioGetQueue Apr 22 13:47:13 volumio volumio[4953]: info: CoreStateMachine::getQueue Apr 22 13:47:13 volumio volumio[4953]: info: CorePlayQueue::getQueue Apr 22 13:47:13 volumio volumio[4953]: info: CoreCommandRouter::volumioGetQueue Apr 22 13:47:13 volumio volumio[4953]: info: CoreStateMachine::getQueue Apr 22 13:47:13 volumio volumio[4953]: info: CorePlayQueue::getQueue Apr 22 13:47:19 volumio volumio[4953]: info: CoreCommandRouter::volumioGetState Apr 22 13:47:19 volumio volumio[4953]: info: Listing playlists Apr 22 13:47:19 volumio volumio[4953]: info: Listing playlists Apr 22 13:47:29 volumio volumio[4953]: info: CoreCommandRouter::volumioGetState Apr 22 13:47:29 volumio volumio[5141]: 40 Apr 22 13:47:29 volumio volumio[5141]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 22 13:47:29 volumio volumio[5141]: Dload Upload Total Spent Left Speed Apr 22 13:47:29 volumio volumio[4953]: info: Apr 22 13:47:29 volumio volumio[4953]: ---------------------------- Client requests Volume 40 Apr 22 13:47:29 volumio volumio[4953]: info: VolumeController::SetAlsaVolume40 Apr 22 13:47:30 volumio volumio[4953]: info: CoreStateMachine::pushState Apr 22 13:47:30 volumio volumio[4953]: info: CoreCommandRouter::volumioPushState Apr 22 13:47:30 volumio volumio[4953]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 13:47:30 volumio volumio[5141]: [155B blob data] Apr 22 13:47:30 volumio volumio[5141]: {"time":1713793649988,"response":"volume Success"}40 Apr 22 13:47:30 volumio volumio[4953]: info: CoreCommandRouter::volumioGetQueue Apr 22 13:47:30 volumio volumio[4953]: info: CoreStateMachine::getQueue Apr 22 13:47:30 volumio volumio[4953]: info: CorePlayQueue::getQueue Apr 22 13:47:30 volumio volumio[4953]: info: Apr 22 13:47:30 volumio volumio[4953]: ---------------------------- MPD announces state update: mixer Apr 22 13:47:30 volumio volumio[4953]: info: ControllerMpd::getState Apr 22 13:47:30 volumio volumio[4953]: verbose: ControllerMpd::sendMpdCommand status Apr 22 13:47:30 volumio volumio[4953]: verbose: ControllerMpd::parseState Apr 22 13:47:30 volumio volumio[4953]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 22 13:47:30 volumio volumio[4953]: verbose: ControllerMpd::parseTrackInfo Apr 22 13:47:30 volumio volumio[4953]: info: ControllerMpd::pushState Apr 22 13:47:30 volumio volumio[4953]: info: CoreCommandRouter::servicePushState Apr 22 13:47:30 volumio volumio[4953]: In UPNP mode Apr 22 13:47:30 volumio volumio[4953]: verbose: STATE SERVICE {"status":"play","position":0,"seek":23730,"duration":243,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"爱情傀儡","artist":"巫启贤","album":"爱情傀儡","uri":"http://sjy6.stream.qqmusic.qq.com/M500001gACj71cHfWZ.mp3?guid=000000001c1332050000018d6777c597&vkey=2508AA4C7518282AFC9A12883BC52E7181533B0DB57AADBDE8B93392FD0D9B6A29F26C80669BFFBCEF2406A3CB0EE62927AFF449C4BEA7CE&uin=1152921505067435511&redirect=1&fromtag=111042","trackType":""} Apr 22 13:47:30 volumio volumio[4953]: verbose: CURRENT POSITION 0 Apr 22 13:47:30 volumio volumio[4953]: info: CoreStateMachine::syncState stateService play Apr 22 13:47:30 volumio volumio[4953]: info: CoreStateMachine::syncState currentStatus play Apr 22 13:47:30 volumio volumio[4953]: info: Received an update from plugin. extracting info from payload Apr 22 13:47:30 volumio volumio[4953]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 22 13:47:30 volumio volumio[4953]: info: CoreStateMachine::pushState Apr 22 13:47:30 volumio volumio[4953]: info: CoreCommandRouter::volumioPushState Apr 22 13:47:30 volumio volumio[4953]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 13:47:30 volumio volumio[4953]: info: CoreStateMachine::pushState Apr 22 13:47:30 volumio volumio[4953]: info: CoreCommandRouter::volumioPushState Apr 22 13:47:30 volumio volumio[4953]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 13:47:30 volumio volumio[4953]: info: ------------------------------ 18ms Apr 22 13:47:30 volumio volumio[4953]: info: CoreCommandRouter::volumioGetQueue Apr 22 13:47:30 volumio volumio[4953]: info: CoreStateMachine::getQueue Apr 22 13:47:30 volumio volumio[4953]: info: CorePlayQueue::getQueue Apr 22 13:47:30 volumio volumio[4953]: info: CoreCommandRouter::volumioGetQueue Apr 22 13:47:30 volumio volumio[4953]: info: CoreStateMachine::getQueue Apr 22 13:47:30 volumio volumio[4953]: info: CorePlayQueue::getQueue Apr 22 13:47:39 volumio volumio[4953]: info: CoreCommandRouter::volumioGetState Apr 22 13:47:39 volumio volumio[4953]: info: Listing playlists Apr 22 13:47:39 volumio volumio[4953]: info: Listing playlists Apr 22 13:47:49 volumio volumio[4953]: info: CoreCommandRouter::volumioGetState Apr 22 13:47:59 volumio volumio[4953]: info: CoreCommandRouter::volumioGetState Apr 22 13:47:59 volumio volumio[4953]: info: Listing playlists Apr 22 13:47:59 volumio volumio[4953]: info: Listing playlists Apr 22 13:47:59 volumio volumio[4953]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 22 13:47:59 volumio volumio[4953]: { Error: connect ETIMEDOUT 104.244.43.248:80 Apr 22 13:47:59 volumio volumio[4953]: at Object._errnoException (util.js:1022:11) Apr 22 13:47:59 volumio volumio[4953]: at _exceptionWithHostPort (util.js:1044:20) Apr 22 13:47:59 volumio volumio[4953]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Apr 22 13:47:59 volumio volumio[4953]: code: 'ETIMEDOUT', Apr 22 13:47:59 volumio volumio[4953]: errno: 'ETIMEDOUT', Apr 22 13:47:59 volumio volumio[4953]: syscall: 'connect', Apr 22 13:47:59 volumio volumio[4953]: address: '104.244.43.248', Apr 22 13:47:59 volumio volumio[4953]: port: 80 } Apr 22 13:47:59 volumio volumio[4953]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 22 13:48:00 volumio sudo[32719]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-22 13:47 Apr 22 13:48:00 volumio sudo[32719]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="168ba7444df98cd868db72f24faec0b6346489cc" VOLUMIO_FE_VERSION="847a48ecf32d35cc502a0053d585d1a69236e391" VOLUMIO_BE_VERSION="99dfb342fe07851f1e26bd1d8046d0234eda91dd" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 11 15:53:56 CET 2020" VOLUMIO_VERSION="2.857" VOLUMIO_HARDWARE="aml9xxxarmv7" VOLUMIO_HASH="5e595833ee6075a27fef1ba35f928abb"