-- Logs begin at Fri 2024-02-09 06:26:57 UTC, end at Sat 2024-07-13 07:01:30 UTC. -- Jul 13 07:00:07 volumio volumio[1135]: 78 Jul 13 07:00:07 volumio volumio[1135]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 13 07:00:07 volumio volumio[1135]: Dload Upload Total Spent Left Speed Jul 13 07:00:07 volumio volumio[873]: info: Jul 13 07:00:07 volumio volumio[873]: ---------------------------- Client requests Volume 78 Jul 13 07:00:07 volumio volumio[873]: info: VolumeController::SetAlsaVolume78 Jul 13 07:00:07 volumio volumio[873]: info: CoreStateMachine::pushState Jul 13 07:00:07 volumio volumio[873]: info: CoreCommandRouter::volumioPushState Jul 13 07:00:07 volumio volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 07:00:07 volumio volumio[1135]: [155B blob data] Jul 13 07:00:07 volumio volumio[1135]: {"time":1720854007738,"response":"volume Success"}78 Jul 13 07:00:07 volumio volumio[873]: info: CoreCommandRouter::volumioGetQueue Jul 13 07:00:07 volumio volumio[873]: info: CoreStateMachine::getQueue Jul 13 07:00:07 volumio volumio[873]: info: CorePlayQueue::getQueue Jul 13 07:00:07 volumio volumio[873]: info: Jul 13 07:00:07 volumio volumio[873]: ---------------------------- MPD announces state update: mixer Jul 13 07:00:07 volumio volumio[873]: info: ControllerMpd::getState Jul 13 07:00:07 volumio volumio[873]: verbose: ControllerMpd::sendMpdCommand status Jul 13 07:00:07 volumio volumio[873]: info: sendMpdCommand status took 1 milliseconds Jul 13 07:00:07 volumio volumio[873]: verbose: ControllerMpd::parseState Jul 13 07:00:07 volumio volumio[873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 13 07:00:07 volumio volumio[873]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 13 07:00:07 volumio volumio[873]: verbose: ControllerMpd::parseTrackInfo Jul 13 07:00:07 volumio volumio[873]: info: ControllerMpd::pushState Jul 13 07:00:07 volumio volumio[873]: info: CoreCommandRouter::servicePushState Jul 13 07:00:07 volumio volumio[873]: In UPNP mode Jul 13 07:00:07 volumio volumio[873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":255489,"duration":262,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Goodnight & Goodbye","artist":"Mree","album":"Grow","uri":"http://aqqmusic.tc.qq.com/F000001WgEXt2eLvyf.flac?guid=ffffffff8365c0e60000018c33fff787&vkey=73C5B6DA8298ECCC1F176871F2E8DA806FB9EDA8A3BF860BA80596836A94FC9005B24C3807A54F628BE4823F56CE2AE746EA5FC5C584CE33&uin=1152921505121190912&src=F0000029fAW34Hvaao.flac&redirect=1&fromtag=111114","trackType":""} Jul 13 07:00:07 volumio volumio[873]: verbose: CURRENT POSITION 0 Jul 13 07:00:07 volumio volumio[873]: info: CoreStateMachine::syncState stateService play Jul 13 07:00:07 volumio volumio[873]: info: CoreStateMachine::syncState currentStatus play Jul 13 07:00:07 volumio volumio[873]: info: Received an update from plugin. extracting info from payload Jul 13 07:00:07 volumio volumio[873]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 13 07:00:07 volumio volumio[873]: info: CoreStateMachine::pushState Jul 13 07:00:07 volumio volumio[873]: info: CoreCommandRouter::volumioPushState Jul 13 07:00:07 volumio volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 07:00:07 volumio volumio[873]: info: CoreStateMachine::pushState Jul 13 07:00:07 volumio volumio[873]: info: CoreCommandRouter::volumioPushState Jul 13 07:00:07 volumio volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 07:00:07 volumio volumio[873]: info: ------------------------------ 11ms Jul 13 07:00:07 volumio volumio[873]: info: CoreCommandRouter::volumioGetQueue Jul 13 07:00:07 volumio volumio[873]: info: CoreStateMachine::getQueue Jul 13 07:00:07 volumio volumio[873]: info: CorePlayQueue::getQueue Jul 13 07:00:07 volumio volumio[873]: info: CoreCommandRouter::volumioGetQueue Jul 13 07:00:07 volumio volumio[873]: info: CoreStateMachine::getQueue Jul 13 07:00:07 volumio volumio[873]: info: CorePlayQueue::getQueue Jul 13 07:00:14 volumio volumio[873]: info: Jul 13 07:00:14 volumio volumio[873]: ---------------------------- MPD announces state update: player Jul 13 07:00:14 volumio volumio[873]: info: ControllerMpd::getState Jul 13 07:00:14 volumio volumio[873]: verbose: ControllerMpd::sendMpdCommand status Jul 13 07:00:14 volumio volumio[873]: info: sendMpdCommand status took 1 milliseconds Jul 13 07:00:14 volumio volumio[873]: verbose: ControllerMpd::parseState Jul 13 07:00:14 volumio volumio[873]: info: ControllerMpd::pushState Jul 13 07:00:14 volumio volumio[873]: info: CoreCommandRouter::servicePushState Jul 13 07:00:14 volumio volumio[873]: info: CoreStateMachine::pushState Jul 13 07:00:14 volumio volumio[873]: info: CoreCommandRouter::volumioPushState Jul 13 07:00:14 volumio volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 07:00:14 volumio volumio[873]: info: CorePlayQueue::getTrack 0 Jul 13 07:00:14 volumio volumio[873]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 13 07:00:14 volumio volumio[873]: verbose: CURRENT POSITION 0 Jul 13 07:00:14 volumio volumio[873]: info: CoreStateMachine::syncState stateService stop Jul 13 07:00:14 volumio volumio[873]: info: CoreStateMachine::syncState currentStatus play Jul 13 07:00:14 volumio volumio[873]: info: CoreCommandRouter::volumioPushState Jul 13 07:00:14 volumio volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 07:00:14 volumio volumio[873]: info: CoreStateMachine::stPlaybackTimer Jul 13 07:00:14 volumio volumio[873]: info: ------------------------------ 9ms Jul 13 07:00:14 volumio volumio[873]: info: CoreCommandRouter::volumioGetQueue Jul 13 07:00:14 volumio volumio[873]: info: CoreStateMachine::getQueue Jul 13 07:00:14 volumio volumio[873]: info: CorePlayQueue::getQueue Jul 13 07:00:15 volumio volumio[873]: info: Clearing queue after UPNP request Jul 13 07:00:16 volumio volumio[873]: info: CoreStateMachine::ClearQueue Jul 13 07:00:16 volumio volumio[873]: info: CoreStateMachine::stop Jul 13 07:00:16 volumio volumio[873]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 13 07:00:16 volumio volumio[873]: UNSET VOLATILE Jul 13 07:00:16 volumio volumio[873]: info: CorePlayQueue::clearPlayQueue Jul 13 07:00:16 volumio volumio[873]: info: CorePlayQueue::saveQueue Jul 13 07:00:16 volumio volumio[873]: info: CoreCommandRouter::volumioPushState Jul 13 07:00:16 volumio volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 07:00:16 volumio volumio[873]: info: CoreCommandRouter::volumioPushQueue Jul 13 07:00:16 volumio volumio[873]: info: Jul 13 07:00:16 volumio volumio[873]: ---------------------------- MPD announces system playlist update Jul 13 07:00:16 volumio volumio[873]: info: Ignoring MPD Status Update Jul 13 07:00:16 volumio volumio[873]: error: updateQueue error: null Jul 13 07:00:16 volumio volumio[873]: info: ------------------------------ 2ms Jul 13 07:00:16 volumio volumio[873]: info: Starting UPNP Playback Jul 13 07:00:16 volumio volumio[873]: info: Preparing playback through UPNP Jul 13 07:00:16 volumio volumio[873]: info: CoreCommandRouter::volumioGetState Jul 13 07:00:16 volumio volumio[873]: info: CorePlayQueue::getTrack 0 Jul 13 07:00:16 volumio volumio[873]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 13 07:00:16 volumio volumio[873]: info: Jul 13 07:00:16 volumio volumio[873]: ---------------------------- MPD announces system playlist update Jul 13 07:00:16 volumio volumio[873]: info: Ignoring MPD Status Update Jul 13 07:00:16 volumio volumio[873]: info: ------------------------------ 1ms Jul 13 07:00:16 volumio volumio[873]: info: Jul 13 07:00:16 volumio volumio[873]: ---------------------------- MPD announces system playlist update Jul 13 07:00:16 volumio volumio[873]: info: Ignoring MPD Status Update Jul 13 07:00:16 volumio volumio[873]: info: ------------------------------ 0ms Jul 13 07:00:16 volumio volumio[873]: info: Jul 13 07:00:16 volumio volumio[873]: ---------------------------- MPD announces system playlist update Jul 13 07:00:16 volumio volumio[873]: info: Ignoring MPD Status Update Jul 13 07:00:16 volumio volumio[873]: info: ------------------------------ 1ms Jul 13 07:00:16 volumio volumio[873]: info: Jul 13 07:00:16 volumio volumio[873]: ---------------------------- MPD announces system playlist update Jul 13 07:00:16 volumio volumio[873]: info: Ignoring MPD Status Update Jul 13 07:00:16 volumio volumio[873]: info: ------------------------------ 1ms Jul 13 07:00:16 volumio volumio[873]: info: Jul 13 07:00:16 volumio volumio[873]: ---------------------------- MPD announces system playlist update Jul 13 07:00:16 volumio volumio[873]: info: Ignoring MPD Status Update Jul 13 07:00:16 volumio volumio[873]: info: ------------------------------ 1ms Jul 13 07:00:16 volumio volumio[873]: info: Jul 13 07:00:16 volumio volumio[873]: ---------------------------- MPD announces system playlist update Jul 13 07:00:16 volumio volumio[873]: info: Ignoring MPD Status Update Jul 13 07:00:16 volumio volumio[873]: info: ------------------------------ 1ms Jul 13 07:00:17 volumio volumio[873]: info: Jul 13 07:00:17 volumio volumio[873]: ---------------------------- MPD announces state update: player Jul 13 07:00:17 volumio volumio[873]: info: ControllerMpd::getState Jul 13 07:00:17 volumio volumio[873]: verbose: ControllerMpd::sendMpdCommand status Jul 13 07:00:17 volumio volumio[873]: info: Jul 13 07:00:17 volumio volumio[873]: ---------------------------- MPD announces system playlist update Jul 13 07:00:17 volumio volumio[873]: info: Ignoring MPD Status Update Jul 13 07:00:17 volumio volumio[873]: info: Jul 13 07:00:17 volumio volumio[873]: ---------------------------- MPD announces state update: player Jul 13 07:00:17 volumio volumio[873]: info: ControllerMpd::getState Jul 13 07:00:17 volumio volumio[873]: verbose: ControllerMpd::sendMpdCommand status Jul 13 07:00:17 volumio volumio[873]: info: sendMpdCommand status took 2 milliseconds Jul 13 07:00:17 volumio volumio[873]: verbose: ControllerMpd::parseState Jul 13 07:00:17 volumio volumio[873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 13 07:00:17 volumio volumio[873]: info: ------------------------------ 2ms Jul 13 07:00:17 volumio volumio[873]: info: sendMpdCommand status took 2 milliseconds Jul 13 07:00:17 volumio volumio[873]: verbose: ControllerMpd::parseState Jul 13 07:00:17 volumio volumio[873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 13 07:00:17 volumio volumio[873]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 13 07:00:17 volumio volumio[873]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 13 07:00:17 volumio volumio[873]: verbose: ControllerMpd::parseTrackInfo Jul 13 07:00:17 volumio volumio[873]: verbose: ControllerMpd::parseTrackInfo Jul 13 07:00:17 volumio volumio[873]: info: ControllerMpd::pushState Jul 13 07:00:17 volumio volumio[873]: info: CoreCommandRouter::servicePushState Jul 13 07:00:17 volumio volumio[873]: In UPNP mode Jul 13 07:00:17 volumio volumio[873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":69,"duration":207,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"666 Kbps","isStreaming":false,"title":"Puff, the Magic Dragon","artist":"Peter, Paul & Mary","album":"The Best of Peter, Paul and Mary: Ten Years Together","uri":"http://aqqmusic.tc.qq.com/F0000012oddq42LawQ.flac?guid=ffffffff8365c0e60000018c33fff787&vkey=069F68A103774E0C8C3E7AA208A0E14E98B72EF8659DFF739CCFBED6223D0EE2D6518FA671E9B84CAC40BAF58F390501966E4342C444B11F&uin=1152921505121190912&redirect=1&fromtag=111114","trackType":""} Jul 13 07:00:17 volumio volumio[873]: verbose: CURRENT POSITION 0 Jul 13 07:00:17 volumio volumio[873]: info: CoreStateMachine::syncState stateService play Jul 13 07:00:17 volumio volumio[873]: info: CoreStateMachine::syncState currentStatus stop Jul 13 07:00:17 volumio volumio[873]: info: CoreStateMachine::pushState Jul 13 07:00:17 volumio volumio[873]: info: CoreCommandRouter::volumioPushState Jul 13 07:00:17 volumio volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 07:00:17 volumio volumio[873]: info: ControllerMpd::pushState Jul 13 07:00:17 volumio volumio[873]: info: CoreCommandRouter::servicePushState Jul 13 07:00:17 volumio volumio[873]: In UPNP mode Jul 13 07:00:17 volumio volumio[873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":116,"duration":207,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"666 Kbps","isStreaming":false,"title":"Puff, the Magic Dragon","artist":"Peter, Paul & Mary","album":"The Best of Peter, Paul and Mary: Ten Years Together","uri":"http://aqqmusic.tc.qq.com/F0000012oddq42LawQ.flac?guid=ffffffff8365c0e60000018c33fff787&vkey=069F68A103774E0C8C3E7AA208A0E14E98B72EF8659DFF739CCFBED6223D0EE2D6518FA671E9B84CAC40BAF58F390501966E4342C444B11F&uin=1152921505121190912&redirect=1&fromtag=111114","trackType":""} Jul 13 07:00:17 volumio volumio[873]: verbose: CURRENT POSITION 0 Jul 13 07:00:17 volumio volumio[873]: info: CoreStateMachine::syncState stateService play Jul 13 07:00:17 volumio volumio[873]: info: CoreStateMachine::syncState currentStatus play Jul 13 07:00:17 volumio volumio[873]: info: Received an update from plugin. extracting info from payload Jul 13 07:00:17 volumio volumio[873]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 13 07:00:17 volumio volumio[873]: info: CoreStateMachine::pushState Jul 13 07:00:17 volumio volumio[873]: info: CoreCommandRouter::volumioPushState Jul 13 07:00:17 volumio volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 07:00:17 volumio volumio[873]: info: CoreStateMachine::pushState Jul 13 07:00:17 volumio volumio[873]: info: CoreCommandRouter::volumioPushState Jul 13 07:00:17 volumio volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 07:00:17 volumio volumio[873]: info: ------------------------------ 20ms Jul 13 07:00:17 volumio volumio[873]: info: ------------------------------ 18ms Jul 13 07:00:17 volumio volumio[873]: info: CoreCommandRouter::volumioGetQueue Jul 13 07:00:17 volumio volumio[873]: info: CoreStateMachine::getQueue Jul 13 07:00:17 volumio volumio[873]: info: CorePlayQueue::getQueue Jul 13 07:00:17 volumio volumio[873]: info: CoreCommandRouter::volumioGetQueue Jul 13 07:00:17 volumio volumio[873]: info: CoreStateMachine::getQueue Jul 13 07:00:17 volumio volumio[873]: info: CorePlayQueue::getQueue Jul 13 07:00:54 volumio volumio[873]: info: CoreCommandRouter::volumioGetVisibleSources Jul 13 07:00:54 volumio volumio[873]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 13 07:00:54 volumio volumio[873]: info: CoreCommandRouter::volumioGetState Jul 13 07:00:54 volumio volumio[873]: info: CoreCommandRouter::volumioGetQueue Jul 13 07:00:54 volumio volumio[873]: info: CoreStateMachine::getQueue Jul 13 07:00:54 volumio volumio[873]: info: CorePlayQueue::getQueue Jul 13 07:00:54 volumio volumio[873]: info: Listing playlists Jul 13 07:00:54 volumio volumio[873]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 13 07:00:55 volumio volumio[873]: info: VolumeController::SetAlsaVolume80 Jul 13 07:00:55 volumio volumio[873]: info: CoreStateMachine::pushState Jul 13 07:00:55 volumio volumio[873]: info: CoreCommandRouter::volumioPushState Jul 13 07:00:55 volumio volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 07:00:55 volumio volumio[873]: info: CoreCommandRouter::volumioGetQueue Jul 13 07:00:55 volumio volumio[873]: info: CoreStateMachine::getQueue Jul 13 07:00:55 volumio volumio[873]: info: CorePlayQueue::getQueue Jul 13 07:00:55 volumio volumio[873]: info: Jul 13 07:00:55 volumio volumio[873]: ---------------------------- MPD announces state update: mixer Jul 13 07:00:55 volumio volumio[873]: info: ControllerMpd::getState Jul 13 07:00:55 volumio volumio[873]: verbose: ControllerMpd::sendMpdCommand status Jul 13 07:00:55 volumio volumio[873]: info: sendMpdCommand status took 1 milliseconds Jul 13 07:00:55 volumio volumio[873]: verbose: ControllerMpd::parseState Jul 13 07:00:55 volumio volumio[873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 13 07:00:55 volumio volumio[873]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 13 07:00:55 volumio volumio[873]: verbose: ControllerMpd::parseTrackInfo Jul 13 07:00:55 volumio volumio[873]: info: ControllerMpd::pushState Jul 13 07:00:55 volumio volumio[873]: info: CoreCommandRouter::servicePushState Jul 13 07:00:55 volumio volumio[873]: In UPNP mode Jul 13 07:00:55 volumio volumio[873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":39102,"duration":207,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"803 Kbps","isStreaming":false,"title":"Puff, the Magic Dragon","artist":"Peter, Paul & Mary","album":"The Best of Peter, Paul and Mary: Ten Years Together","uri":"http://aqqmusic.tc.qq.com/F0000012oddq42LawQ.flac?guid=ffffffff8365c0e60000018c33fff787&vkey=069F68A103774E0C8C3E7AA208A0E14E98B72EF8659DFF739CCFBED6223D0EE2D6518FA671E9B84CAC40BAF58F390501966E4342C444B11F&uin=1152921505121190912&redirect=1&fromtag=111114","trackType":""} Jul 13 07:00:55 volumio volumio[873]: verbose: CURRENT POSITION 0 Jul 13 07:00:55 volumio volumio[873]: info: CoreStateMachine::syncState stateService play Jul 13 07:00:55 volumio volumio[873]: info: CoreStateMachine::syncState currentStatus play Jul 13 07:00:55 volumio volumio[873]: info: Received an update from plugin. extracting info from payload Jul 13 07:00:55 volumio volumio[873]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 13 07:00:55 volumio volumio[873]: info: CoreStateMachine::pushState Jul 13 07:00:55 volumio volumio[873]: info: CoreCommandRouter::volumioPushState Jul 13 07:00:55 volumio volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 07:00:55 volumio volumio[873]: info: CoreStateMachine::pushState Jul 13 07:00:55 volumio volumio[873]: info: CoreCommandRouter::volumioPushState Jul 13 07:00:55 volumio volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 07:00:55 volumio volumio[873]: info: ------------------------------ 13ms Jul 13 07:00:55 volumio volumio[873]: info: CoreCommandRouter::volumioGetQueue Jul 13 07:00:55 volumio volumio[873]: info: CoreStateMachine::getQueue Jul 13 07:00:55 volumio volumio[873]: info: CorePlayQueue::getQueue Jul 13 07:00:55 volumio volumio[873]: info: CoreCommandRouter::volumioGetQueue Jul 13 07:00:55 volumio volumio[873]: info: CoreStateMachine::getQueue Jul 13 07:00:55 volumio volumio[873]: info: CorePlayQueue::getQueue Jul 13 07:00:55 volumio volumio[873]: info: VolumeController::SetAlsaVolume90 Jul 13 07:00:55 volumio volumio[873]: info: CoreStateMachine::pushState Jul 13 07:00:55 volumio volumio[873]: info: CoreCommandRouter::volumioPushState Jul 13 07:00:55 volumio volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 07:00:55 volumio volumio[873]: info: CoreCommandRouter::volumioGetQueue Jul 13 07:00:55 volumio volumio[873]: info: CoreStateMachine::getQueue Jul 13 07:00:55 volumio volumio[873]: info: CorePlayQueue::getQueue Jul 13 07:00:55 volumio volumio[873]: info: Jul 13 07:00:55 volumio volumio[873]: ---------------------------- MPD announces state update: mixer Jul 13 07:00:55 volumio volumio[873]: info: ControllerMpd::getState Jul 13 07:00:55 volumio volumio[873]: verbose: ControllerMpd::sendMpdCommand status Jul 13 07:00:55 volumio volumio[873]: info: sendMpdCommand status took 6 milliseconds Jul 13 07:00:55 volumio volumio[873]: verbose: ControllerMpd::parseState Jul 13 07:00:55 volumio volumio[873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 13 07:00:55 volumio volumio[873]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 13 07:00:55 volumio volumio[873]: verbose: ControllerMpd::parseTrackInfo Jul 13 07:00:55 volumio volumio[873]: info: ControllerMpd::pushState Jul 13 07:00:55 volumio volumio[873]: info: CoreCommandRouter::servicePushState Jul 13 07:00:55 volumio volumio[873]: In UPNP mode Jul 13 07:00:55 volumio volumio[873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":39218,"duration":207,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"766 Kbps","isStreaming":false,"title":"Puff, the Magic Dragon","artist":"Peter, Paul & Mary","album":"The Best of Peter, Paul and Mary: Ten Years Together","uri":"http://aqqmusic.tc.qq.com/F0000012oddq42LawQ.flac?guid=ffffffff8365c0e60000018c33fff787&vkey=069F68A103774E0C8C3E7AA208A0E14E98B72EF8659DFF739CCFBED6223D0EE2D6518FA671E9B84CAC40BAF58F390501966E4342C444B11F&uin=1152921505121190912&redirect=1&fromtag=111114","trackType":""} Jul 13 07:00:55 volumio volumio[873]: verbose: CURRENT POSITION 0 Jul 13 07:00:55 volumio volumio[873]: info: CoreStateMachine::syncState stateService play Jul 13 07:00:55 volumio volumio[873]: info: CoreStateMachine::syncState currentStatus play Jul 13 07:00:55 volumio volumio[873]: info: Received an update from plugin. extracting info from payload Jul 13 07:00:55 volumio volumio[873]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 13 07:00:55 volumio volumio[873]: info: CoreStateMachine::pushState Jul 13 07:00:55 volumio volumio[873]: info: CoreCommandRouter::volumioPushState Jul 13 07:00:55 volumio volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 07:00:55 volumio volumio[873]: info: CoreStateMachine::pushState Jul 13 07:00:55 volumio volumio[873]: info: CoreCommandRouter::volumioPushState Jul 13 07:00:55 volumio volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 07:00:55 volumio volumio[873]: info: ------------------------------ 19ms Jul 13 07:00:55 volumio volumio[873]: info: CoreCommandRouter::volumioGetQueue Jul 13 07:00:55 volumio volumio[873]: info: CoreStateMachine::getQueue Jul 13 07:00:55 volumio volumio[873]: info: CorePlayQueue::getQueue Jul 13 07:00:55 volumio volumio[873]: info: CoreCommandRouter::volumioGetQueue Jul 13 07:00:55 volumio volumio[873]: info: CoreStateMachine::getQueue Jul 13 07:00:55 volumio volumio[873]: info: CorePlayQueue::getQueue Jul 13 07:00:58 volumio volumio[873]: info: VolumeController::SetAlsaVolume95 Jul 13 07:00:58 volumio volumio[873]: info: CoreStateMachine::pushState Jul 13 07:00:58 volumio volumio[873]: info: CoreCommandRouter::volumioPushState Jul 13 07:00:58 volumio volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 07:00:58 volumio volumio[873]: info: CoreCommandRouter::volumioGetQueue Jul 13 07:00:58 volumio volumio[873]: info: CoreStateMachine::getQueue Jul 13 07:00:58 volumio volumio[873]: info: CorePlayQueue::getQueue Jul 13 07:00:58 volumio volumio[873]: info: Jul 13 07:00:58 volumio volumio[873]: ---------------------------- MPD announces state update: mixer Jul 13 07:00:58 volumio volumio[873]: info: ControllerMpd::getState Jul 13 07:00:58 volumio volumio[873]: verbose: ControllerMpd::sendMpdCommand status Jul 13 07:00:58 volumio volumio[873]: info: sendMpdCommand status took 1 milliseconds Jul 13 07:00:58 volumio volumio[873]: verbose: ControllerMpd::parseState Jul 13 07:00:58 volumio volumio[873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 13 07:00:58 volumio volumio[873]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 13 07:00:58 volumio volumio[873]: verbose: ControllerMpd::parseTrackInfo Jul 13 07:00:58 volumio volumio[873]: info: ControllerMpd::pushState Jul 13 07:00:58 volumio volumio[873]: info: CoreCommandRouter::servicePushState Jul 13 07:00:58 volumio volumio[873]: In UPNP mode Jul 13 07:00:58 volumio volumio[873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":41726,"duration":207,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"752 Kbps","isStreaming":false,"title":"Puff, the Magic Dragon","artist":"Peter, Paul & Mary","album":"The Best of Peter, Paul and Mary: Ten Years Together","uri":"http://aqqmusic.tc.qq.com/F0000012oddq42LawQ.flac?guid=ffffffff8365c0e60000018c33fff787&vkey=069F68A103774E0C8C3E7AA208A0E14E98B72EF8659DFF739CCFBED6223D0EE2D6518FA671E9B84CAC40BAF58F390501966E4342C444B11F&uin=1152921505121190912&redirect=1&fromtag=111114","trackType":""} Jul 13 07:00:58 volumio volumio[873]: verbose: CURRENT POSITION 0 Jul 13 07:00:58 volumio volumio[873]: info: CoreStateMachine::syncState stateService play Jul 13 07:00:58 volumio volumio[873]: info: CoreStateMachine::syncState currentStatus play Jul 13 07:00:58 volumio volumio[873]: info: Received an update from plugin. extracting info from payload Jul 13 07:00:58 volumio volumio[873]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 13 07:00:58 volumio volumio[873]: info: CoreStateMachine::pushState Jul 13 07:00:58 volumio volumio[873]: info: CoreCommandRouter::volumioPushState Jul 13 07:00:58 volumio volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 07:00:58 volumio volumio[873]: info: CoreStateMachine::pushState Jul 13 07:00:58 volumio volumio[873]: info: CoreCommandRouter::volumioPushState Jul 13 07:00:58 volumio volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 13 07:00:58 volumio volumio[873]: info: ------------------------------ 12ms Jul 13 07:00:58 volumio volumio[873]: info: CoreCommandRouter::volumioGetQueue Jul 13 07:00:58 volumio volumio[873]: info: CoreStateMachine::getQueue Jul 13 07:00:58 volumio volumio[873]: info: CorePlayQueue::getQueue Jul 13 07:00:58 volumio volumio[873]: info: CoreCommandRouter::volumioGetQueue Jul 13 07:00:58 volumio volumio[873]: info: CoreStateMachine::getQueue Jul 13 07:00:58 volumio volumio[873]: info: CorePlayQueue::getQueue Jul 13 07:01:29 volumio volumio[873]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 13 07:01:29 volumio volumio[873]: { Error: connect ETIMEDOUT 108.160.165.11:80 Jul 13 07:01:29 volumio volumio[873]: at Object._errnoException (util.js:1022:11) Jul 13 07:01:29 volumio volumio[873]: at _exceptionWithHostPort (util.js:1044:20) Jul 13 07:01:29 volumio volumio[873]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jul 13 07:01:29 volumio volumio[873]: code: 'ETIMEDOUT', Jul 13 07:01:29 volumio volumio[873]: errno: 'ETIMEDOUT', Jul 13 07:01:29 volumio volumio[873]: syscall: 'connect', Jul 13 07:01:29 volumio volumio[873]: address: '108.160.165.11', Jul 13 07:01:29 volumio volumio[873]: port: 80 } Jul 13 07:01:29 volumio volumio[873]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 13 07:01:30 volumio sudo[5228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-13 07:00 Jul 13 07:01:30 volumio sudo[5228]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cd11dc738d0d82822d0aa776d0729686b82e3758" VOLUMIO_FE_VERSION="77db3ca2a7f5a7023ece8c5b86e997d58abdace6" VOLUMIO_BE_VERSION="748352701ebc6ec2b59443fcac1ec9aea1f276df" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Jul 2 12:45:33 CEST 2021" VOLUMIO_VERSION="2.907" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="858e764292794952fe9c14f4c1868f5a"