-- Logs begin at Mon 2025-12-15 19:30:56 CST, end at Mon 2025-12-15 19:50:55 CST. --
Dec 15 19:49:15 volumio-x86 volumio[977]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Dec 15 19:49:15 volumio-x86 volumio[977]: info: Retrying Login Due to Network Error
Dec 15 19:49:23 volumio-x86 volumio[977]: info:
Dec 15 19:49:23 volumio-x86 volumio[977]: ---------------------------- MPD announces state update: player
Dec 15 19:49:23 volumio-x86 volumio[977]: info: ControllerMpd::getState
Dec 15 19:49:23 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 19:49:23 volumio-x86 volumio[977]: info:
Dec 15 19:49:23 volumio-x86 volumio[977]: ---------------------------- MPD announces state update: player
Dec 15 19:49:23 volumio-x86 volumio[977]: info: ControllerMpd::getState
Dec 15 19:49:23 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 19:49:23 volumio-x86 volumio[977]: info: sendMpdCommand status took 2 milliseconds
Dec 15 19:49:23 volumio-x86 volumio[977]: info: sendMpdCommand status took 2 milliseconds
Dec 15 19:49:23 volumio-x86 volumio[977]: verbose: ControllerMpd::parseState
Dec 15 19:49:23 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 15 19:49:23 volumio-x86 volumio[977]: verbose: ControllerMpd::parseState
Dec 15 19:49:23 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 15 19:49:23 volumio-x86 volumio[977]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 15 19:49:23 volumio-x86 volumio[977]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 15 19:49:23 volumio-x86 volumio[977]: verbose: ControllerMpd::parseTrackInfo
Dec 15 19:49:23 volumio-x86 volumio[977]: verbose: ControllerMpd::parseTrackInfo
Dec 15 19:49:23 volumio-x86 volumio[977]: info: ControllerMpd::pushState
Dec 15 19:49:23 volumio-x86 volumio[977]: info: CoreCommandRouter::servicePushState
Dec 15 19:49:23 volumio-x86 volumio[977]: info: CoreStateMachine::pushState
Dec 15 19:49:23 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:49:23 volumio-x86 volumio[977]: info: CorePlayQueue::getTrack 1
Dec 15 19:49:23 volumio-x86 volumio[977]: 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://ws6.stream.qqmusic.qq.com/M80000440yww2IdN3G.mp3?guid=000000007e628642000001889efbcdf7&vkey=EF8DED5C6F790895CC354DE01D1D1F3C0116298E58708483612D532E20AE6172F9B33D1ADABEFFFDCECECFC89F59E5D5F094A701511C9914__v2ba83c09&uin=1152921505193197560&redirect=1&fromtag=111093","trackType":""}
Dec 15 19:49:23 volumio-x86 volumio[977]: verbose: CURRENT POSITION 1
Dec 15 19:49:23 volumio-x86 volumio[977]: info: CoreStateMachine::syncState stateService stop
Dec 15 19:49:23 volumio-x86 volumio[977]: info: CoreStateMachine::syncState currentStatus play
Dec 15 19:49:23 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:49:23 volumio-x86 volumio[977]: info: CoreStateMachine::stPlaybackTimer
Dec 15 19:49:23 volumio-x86 volumio[977]: info: ControllerMpd::pushState
Dec 15 19:49:23 volumio-x86 volumio[977]: info: CoreCommandRouter::servicePushState
Dec 15 19:49:23 volumio-x86 volumio[977]: info: CoreStateMachine::pushState
Dec 15 19:49:23 volumio-x86 volumio[977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 15 19:49:23 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:49:23 volumio-x86 volumio[977]: info: CorePlayQueue::getTrack 0
Dec 15 19:49:23 volumio-x86 volumio[977]: 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://ws6.stream.qqmusic.qq.com/M80000440yww2IdN3G.mp3?guid=000000007e628642000001889efbcdf7&vkey=EF8DED5C6F790895CC354DE01D1D1F3C0116298E58708483612D532E20AE6172F9B33D1ADABEFFFDCECECFC89F59E5D5F094A701511C9914__v2ba83c09&uin=1152921505193197560&redirect=1&fromtag=111093","trackType":""}
Dec 15 19:49:23 volumio-x86 volumio[977]: verbose: CURRENT POSITION 0
Dec 15 19:49:23 volumio-x86 volumio[977]: info: CoreStateMachine::syncState stateService stop
Dec 15 19:49:23 volumio-x86 volumio[977]: info: CoreStateMachine::syncState currentStatus stop
Dec 15 19:49:23 volumio-x86 volumio[977]: info: CoreStateMachine::pushState
Dec 15 19:49:23 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:49:23 volumio-x86 volumio[977]: info: No code
Dec 15 19:49:23 volumio-x86 volumio[977]: info: CoreStateMachine::pushState
Dec 15 19:49:23 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:49:23 volumio-x86 volumio[977]: info: ------------------------------ 46ms
Dec 15 19:49:23 volumio-x86 volumio[977]: info: ------------------------------ 45ms
Dec 15 19:49:23 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetQueue
Dec 15 19:49:23 volumio-x86 volumio[977]: info: CoreStateMachine::getQueue
Dec 15 19:49:23 volumio-x86 volumio[977]: info: CorePlayQueue::getQueue
Dec 15 19:49:24 volumio-x86 sudo[5306]: pam_unix(sudo:session): session closed for user root
Dec 15 19:49:25 volumio-x86 volumio[977]: info: Clearing queue after UPNP request
Dec 15 19:49:25 volumio-x86 volumio[977]: info: CoreStateMachine::ClearQueue
Dec 15 19:49:25 volumio-x86 volumio[977]: info: CoreStateMachine::stop
Dec 15 19:49:25 volumio-x86 volumio[977]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 15 19:49:25 volumio-x86 volumio[977]: info: CorePlayQueue::clearPlayQueue
Dec 15 19:49:25 volumio-x86 volumio[977]: info: CorePlayQueue::saveQueue
Dec 15 19:49:25 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:49:25 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushQueue
Dec 15 19:49:25 volumio-x86 volumio[977]: info:
Dec 15 19:49:25 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:49:25 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:49:25 volumio-x86 volumio[977]: info:
Dec 15 19:49:25 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:49:25 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:49:25 volumio-x86 volumio[977]: error: updateQueue error: null
Dec 15 19:49:25 volumio-x86 volumio[977]: error: updateQueue error: null
Dec 15 19:49:25 volumio-x86 volumio[977]: info: ------------------------------ 2ms
Dec 15 19:49:25 volumio-x86 volumio[977]: info: ------------------------------ 2ms
Dec 15 19:49:25 volumio-x86 volumio[977]: info: Starting UPNP Playback
Dec 15 19:49:25 volumio-x86 volumio[977]: info: Preparing playback through UPNP
Dec 15 19:49:25 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetState
Dec 15 19:49:25 volumio-x86 volumio[977]: info: CorePlayQueue::getTrack 0
Dec 15 19:49:25 volumio-x86 volumio[977]: info: CoreStateMachine::setConsumeUpdateService mpd
Dec 15 19:49:25 volumio-x86 volumio[977]: info: MyVolumio login type: Token
Dec 15 19:49:25 volumio-x86 volumio[977]: info:
Dec 15 19:49:25 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:49:25 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:49:25 volumio-x86 volumio[977]: info:
Dec 15 19:49:25 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:49:25 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:49:25 volumio-x86 volumio[977]: info: ------------------------------ 1ms
Dec 15 19:49:25 volumio-x86 volumio[977]: info: ------------------------------ 0ms
Dec 15 19:49:25 volumio-x86 volumio[977]: info:
Dec 15 19:49:25 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:49:25 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:49:25 volumio-x86 volumio[977]: info:
Dec 15 19:49:25 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:49:25 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:49:25 volumio-x86 volumio[977]: info: ------------------------------ 1ms
Dec 15 19:49:25 volumio-x86 volumio[977]: info: ------------------------------ 1ms
Dec 15 19:49:25 volumio-x86 volumio[977]: info:
Dec 15 19:49:25 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:49:25 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ------------------------------ 0ms
Dec 15 19:49:26 volumio-x86 volumio[977]: info:
Dec 15 19:49:26 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:49:26 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:49:26 volumio-x86 volumio[977]: info:
Dec 15 19:49:26 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:49:26 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ------------------------------ 1ms
Dec 15 19:49:26 volumio-x86 volumio[977]: info:
Dec 15 19:49:26 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:49:26 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ------------------------------ 2ms
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ------------------------------ 1ms
Dec 15 19:49:26 volumio-x86 volumio[977]: info:
Dec 15 19:49:26 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:49:26 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:49:26 volumio-x86 volumio[977]: info:
Dec 15 19:49:26 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:49:26 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ------------------------------ 2ms
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ------------------------------ 1ms
Dec 15 19:49:26 volumio-x86 volumio[977]: info:
Dec 15 19:49:26 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:49:26 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ------------------------------ 1ms
Dec 15 19:49:26 volumio-x86 volumio[977]: info:
Dec 15 19:49:26 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:49:26 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ------------------------------ 1ms
Dec 15 19:49:26 volumio-x86 volumio[977]: info:
Dec 15 19:49:26 volumio-x86 volumio[977]: ---------------------------- MPD announces state update: player
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ControllerMpd::getState
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 19:49:26 volumio-x86 volumio[977]: info:
Dec 15 19:49:26 volumio-x86 volumio[977]: ---------------------------- MPD announces state update: player
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ControllerMpd::getState
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 19:49:26 volumio-x86 volumio[977]: info:
Dec 15 19:49:26 volumio-x86 volumio[977]: ---------------------------- MPD announces state update: player
Dec 15 19:49:26 volumio-x86 volumio[977]: info: sendMpdCommand status took 15 milliseconds
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ControllerMpd::getState
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: ControllerMpd::parseState
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 15 19:49:26 volumio-x86 volumio[977]: info:
Dec 15 19:49:26 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:49:26 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:49:26 volumio-x86 volumio[977]: info:
Dec 15 19:49:26 volumio-x86 volumio[977]: ---------------------------- MPD announces state update: player
Dec 15 19:49:26 volumio-x86 volumio[977]: info: sendMpdCommand status took 14 milliseconds
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ControllerMpd::getState
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 19:49:26 volumio-x86 volumio[977]: info: sendMpdCommand status took 2 milliseconds
Dec 15 19:49:26 volumio-x86 volumio[977]: info: sendMpdCommand playlistinfo took 2 milliseconds
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: ControllerMpd::parseState
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: ControllerMpd::parseState
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: ControllerMpd::parseTrackInfo
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ControllerMpd::pushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::servicePushState
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: In UPNP mode
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"春江花月夜","artist":"段银莹","album":"国色天香","uri":"http://ws6.stream.qqmusic.qq.com/F00000440yww2IdN3G.flac?guid=000000007e628642000001889efbcdf7&vkey=5CBE304A2BD1CD59522ACA715B7D3FC56029F1385AAD19C082DEB004E69F51BF002D6FDC72AEE08EAA1C3119AF40057F28A51EBBB65295EE__v21e2a181d&uin=1152921505193197560&redirect=1&fromtag=111114","trackType":""}
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: CURRENT POSITION 0
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::syncState stateService play
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::syncState currentStatus stop
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ------------------------------ 24ms
Dec 15 19:49:26 volumio-x86 volumio[977]: info:
Dec 15 19:49:26 volumio-x86 volumio[977]: ---------------------------- MPD announces state update: player
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ControllerMpd::getState
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ------------------------------ 6ms
Dec 15 19:49:26 volumio-x86 volumio[977]: info: sendMpdCommand status took 6 milliseconds
Dec 15 19:49:26 volumio-x86 volumio[977]: info: sendMpdCommand playlistinfo took 5 milliseconds
Dec 15 19:49:26 volumio-x86 volumio[977]: info: sendMpdCommand playlistinfo took 4 milliseconds
Dec 15 19:49:26 volumio-x86 volumio[977]: info: sendMpdCommand status took 1 milliseconds
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: ControllerMpd::parseState
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: ControllerMpd::parseTrackInfo
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: ControllerMpd::parseTrackInfo
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: ControllerMpd::parseState
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ControllerMpd::pushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::servicePushState
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: In UPNP mode
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"春江花月夜","artist":"段银莹","album":"国色天香","uri":"http://ws6.stream.qqmusic.qq.com/F00000440yww2IdN3G.flac?guid=000000007e628642000001889efbcdf7&vkey=5CBE304A2BD1CD59522ACA715B7D3FC56029F1385AAD19C082DEB004E69F51BF002D6FDC72AEE08EAA1C3119AF40057F28A51EBBB65295EE__v21e2a181d&uin=1152921505193197560&redirect=1&fromtag=111114","trackType":""}
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: CURRENT POSITION 0
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::syncState stateService play
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::syncState currentStatus play
Dec 15 19:49:26 volumio-x86 volumio[977]: info: Received an update from plugin. extracting info from payload
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::pushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::pushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ControllerMpd::pushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::servicePushState
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: In UPNP mode
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"250 Kbps","isStreaming":false,"title":"春江花月夜","artist":"段银莹","album":"国色天香","uri":"http://ws6.stream.qqmusic.qq.com/F00000440yww2IdN3G.flac?guid=000000007e628642000001889efbcdf7&vkey=5CBE304A2BD1CD59522ACA715B7D3FC56029F1385AAD19C082DEB004E69F51BF002D6FDC72AEE08EAA1C3119AF40057F28A51EBBB65295EE__v21e2a181d&uin=1152921505193197560&redirect=1&fromtag=111114","trackType":""}
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: CURRENT POSITION 0
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::syncState stateService play
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::syncState currentStatus play
Dec 15 19:49:26 volumio-x86 volumio[977]: info: Received an update from plugin. extracting info from payload
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::pushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::pushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ------------------------------ 49ms
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ------------------------------ 36ms
Dec 15 19:49:26 volumio-x86 volumio[977]: info:
Dec 15 19:49:26 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:49:26 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:49:26 volumio-x86 volumio[977]: info:
Dec 15 19:49:26 volumio-x86 volumio[977]: ---------------------------- MPD announces state update: player
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ControllerMpd::getState
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 19:49:26 volumio-x86 volumio[977]: info: sendMpdCommand playlistinfo took 29 milliseconds
Dec 15 19:49:26 volumio-x86 volumio[977]: info: sendMpdCommand playlistinfo took 28 milliseconds
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ------------------------------ 2ms
Dec 15 19:49:26 volumio-x86 volumio[977]: info: sendMpdCommand status took 2 milliseconds
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: ControllerMpd::parseTrackInfo
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: ControllerMpd::parseTrackInfo
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: ControllerMpd::parseState
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ControllerMpd::pushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::servicePushState
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: In UPNP mode
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"255 Kbps","isStreaming":false,"title":"春江花月夜","artist":"段银莹","album":"国色天香","uri":"http://ws6.stream.qqmusic.qq.com/F00000440yww2IdN3G.flac?guid=000000007e628642000001889efbcdf7&vkey=5CBE304A2BD1CD59522ACA715B7D3FC56029F1385AAD19C082DEB004E69F51BF002D6FDC72AEE08EAA1C3119AF40057F28A51EBBB65295EE__v21e2a181d&uin=1152921505193197560&redirect=1&fromtag=111114","trackType":""}
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: CURRENT POSITION 0
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::syncState stateService play
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::syncState currentStatus play
Dec 15 19:49:26 volumio-x86 volumio[977]: info: Received an update from plugin. extracting info from payload
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::pushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::pushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ControllerMpd::pushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::servicePushState
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: In UPNP mode
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"255 Kbps","isStreaming":false,"title":"春江花月夜","artist":"段银莹","album":"国色天香","uri":"http://ws6.stream.qqmusic.qq.com/F00000440yww2IdN3G.flac?guid=000000007e628642000001889efbcdf7&vkey=5CBE304A2BD1CD59522ACA715B7D3FC56029F1385AAD19C082DEB004E69F51BF002D6FDC72AEE08EAA1C3119AF40057F28A51EBBB65295EE__v21e2a181d&uin=1152921505193197560&redirect=1&fromtag=111114","trackType":""}
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: CURRENT POSITION 0
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::syncState stateService play
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::syncState currentStatus play
Dec 15 19:49:26 volumio-x86 volumio[977]: info: Received an update from plugin. extracting info from payload
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::pushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::pushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ------------------------------ 67ms
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ------------------------------ 63ms
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::getQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CorePlayQueue::getQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::getQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CorePlayQueue::getQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::getQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CorePlayQueue::getQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::getQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CorePlayQueue::getQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::getQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CorePlayQueue::getQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::getQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CorePlayQueue::getQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::getQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CorePlayQueue::getQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::getQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CorePlayQueue::getQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: sendMpdCommand playlistinfo took 62 milliseconds
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: ControllerMpd::parseTrackInfo
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ControllerMpd::pushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::servicePushState
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: In UPNP mode
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"255 Kbps","isStreaming":false,"title":"春江花月夜","artist":"段银莹","album":"国色天香","uri":"http://ws6.stream.qqmusic.qq.com/F00000440yww2IdN3G.flac?guid=000000007e628642000001889efbcdf7&vkey=5CBE304A2BD1CD59522ACA715B7D3FC56029F1385AAD19C082DEB004E69F51BF002D6FDC72AEE08EAA1C3119AF40057F28A51EBBB65295EE__v21e2a181d&uin=1152921505193197560&redirect=1&fromtag=111114","trackType":""}
Dec 15 19:49:26 volumio-x86 volumio[977]: verbose: CURRENT POSITION 0
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::syncState stateService play
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::syncState currentStatus play
Dec 15 19:49:26 volumio-x86 volumio[977]: info: Received an update from plugin. extracting info from payload
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::pushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::pushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:49:26 volumio-x86 volumio[977]: info: ------------------------------ 77ms
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::getQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CorePlayQueue::getQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CoreStateMachine::getQueue
Dec 15 19:49:26 volumio-x86 volumio[977]: info: CorePlayQueue::getQueue
Dec 15 19:49:45 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetState
Dec 15 19:49:45 volumio-x86 sudo[5776]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py
Dec 15 19:49:45 volumio-x86 sudo[5776]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 19:49:46 volumio-x86 volumio[977]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 6
Dec 15 19:49:46 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetState
Dec 15 19:49:46 volumio-x86 volumio[977]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 7
Dec 15 19:49:46 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetState
Dec 15 19:49:46 volumio-x86 volumio[977]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%AE%B5%E9%93%B6%E8%8E%B9/%E5%9B%BD%E8%89%B2%E5%A4%A9%E9%A6%99/20afe66d-a55e-441c-a4c0-d8e787356d74.jpg'
Dec 15 19:49:55 volumio-x86 volumio[977]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Dec 15 19:49:55 volumio-x86 volumio[977]: info: Retrying Login Due to Network Error
Dec 15 19:50:04 volumio-x86 volumio[977]: info:
Dec 15 19:50:04 volumio-x86 volumio[977]: ---------------------------- MPD announces state update: player
Dec 15 19:50:04 volumio-x86 volumio[977]: info: ControllerMpd::getState
Dec 15 19:50:04 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 19:50:04 volumio-x86 volumio[977]: info:
Dec 15 19:50:04 volumio-x86 volumio[977]: ---------------------------- MPD announces state update: player
Dec 15 19:50:04 volumio-x86 volumio[977]: info: ControllerMpd::getState
Dec 15 19:50:04 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 19:50:04 volumio-x86 volumio[977]: info: sendMpdCommand status took 2 milliseconds
Dec 15 19:50:04 volumio-x86 volumio[977]: info: sendMpdCommand status took 1 milliseconds
Dec 15 19:50:04 volumio-x86 volumio[977]: verbose: ControllerMpd::parseState
Dec 15 19:50:04 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 15 19:50:04 volumio-x86 volumio[977]: verbose: ControllerMpd::parseState
Dec 15 19:50:04 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 15 19:50:04 volumio-x86 volumio[977]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 15 19:50:04 volumio-x86 volumio[977]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 15 19:50:04 volumio-x86 volumio[977]: verbose: ControllerMpd::parseTrackInfo
Dec 15 19:50:04 volumio-x86 volumio[977]: verbose: ControllerMpd::parseTrackInfo
Dec 15 19:50:04 volumio-x86 volumio[977]: info: ControllerMpd::pushState
Dec 15 19:50:04 volumio-x86 volumio[977]: info: CoreCommandRouter::servicePushState
Dec 15 19:50:04 volumio-x86 volumio[977]: info: CoreStateMachine::pushState
Dec 15 19:50:04 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:50:04 volumio-x86 volumio[977]: info: CorePlayQueue::getTrack 0
Dec 15 19:50:04 volumio-x86 volumio[977]: 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://ws6.stream.qqmusic.qq.com/F00000440yww2IdN3G.flac?guid=000000007e628642000001889efbcdf7&vkey=5CBE304A2BD1CD59522ACA715B7D3FC56029F1385AAD19C082DEB004E69F51BF002D6FDC72AEE08EAA1C3119AF40057F28A51EBBB65295EE__v21e2a181d&uin=1152921505193197560&redirect=1&fromtag=111114","trackType":""}
Dec 15 19:50:04 volumio-x86 volumio[977]: verbose: CURRENT POSITION 0
Dec 15 19:50:04 volumio-x86 volumio[977]: info: CoreStateMachine::syncState stateService stop
Dec 15 19:50:04 volumio-x86 volumio[977]: info: CoreStateMachine::syncState currentStatus play
Dec 15 19:50:04 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:50:04 volumio-x86 volumio[977]: info: CoreStateMachine::stPlaybackTimer
Dec 15 19:50:04 volumio-x86 volumio[977]: info: ControllerMpd::pushState
Dec 15 19:50:04 volumio-x86 volumio[977]: info: CoreCommandRouter::servicePushState
Dec 15 19:50:04 volumio-x86 volumio[977]: info: CoreStateMachine::pushState
Dec 15 19:50:04 volumio-x86 volumio[977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 15 19:50:04 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:50:04 volumio-x86 volumio[977]: info: CorePlayQueue::getTrack 0
Dec 15 19:50:04 volumio-x86 volumio[977]: 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://ws6.stream.qqmusic.qq.com/F00000440yww2IdN3G.flac?guid=000000007e628642000001889efbcdf7&vkey=5CBE304A2BD1CD59522ACA715B7D3FC56029F1385AAD19C082DEB004E69F51BF002D6FDC72AEE08EAA1C3119AF40057F28A51EBBB65295EE__v21e2a181d&uin=1152921505193197560&redirect=1&fromtag=111114","trackType":""}
Dec 15 19:50:04 volumio-x86 volumio[977]: verbose: CURRENT POSITION 0
Dec 15 19:50:04 volumio-x86 volumio[977]: info: CoreStateMachine::syncState stateService stop
Dec 15 19:50:04 volumio-x86 volumio[977]: info: CoreStateMachine::syncState currentStatus stop
Dec 15 19:50:04 volumio-x86 volumio[977]: info: CoreStateMachine::pushState
Dec 15 19:50:04 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:50:04 volumio-x86 volumio[977]: info: No code
Dec 15 19:50:04 volumio-x86 volumio[977]: info: CoreStateMachine::pushState
Dec 15 19:50:04 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:50:04 volumio-x86 volumio[977]: info: ------------------------------ 39ms
Dec 15 19:50:04 volumio-x86 volumio[977]: info: ------------------------------ 39ms
Dec 15 19:50:04 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetQueue
Dec 15 19:50:04 volumio-x86 volumio[977]: info: CoreStateMachine::getQueue
Dec 15 19:50:04 volumio-x86 volumio[977]: info: CorePlayQueue::getQueue
Dec 15 19:50:05 volumio-x86 volumio[977]: info: Clearing queue after UPNP request
Dec 15 19:50:05 volumio-x86 sudo[5776]: pam_unix(sudo:session): session closed for user root
Dec 15 19:50:05 volumio-x86 volumio[977]: info: CoreStateMachine::ClearQueue
Dec 15 19:50:05 volumio-x86 volumio[977]: info: CoreStateMachine::stop
Dec 15 19:50:05 volumio-x86 volumio[977]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 15 19:50:05 volumio-x86 volumio[977]: info: CorePlayQueue::clearPlayQueue
Dec 15 19:50:05 volumio-x86 volumio[977]: info: CorePlayQueue::saveQueue
Dec 15 19:50:05 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:50:05 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushQueue
Dec 15 19:50:05 volumio-x86 volumio[977]: info:
Dec 15 19:50:05 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:50:05 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:50:05 volumio-x86 volumio[977]: info:
Dec 15 19:50:05 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:50:05 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:50:05 volumio-x86 volumio[977]: error: updateQueue error: null
Dec 15 19:50:05 volumio-x86 volumio[977]: error: updateQueue error: null
Dec 15 19:50:05 volumio-x86 volumio[977]: info: ------------------------------ 1ms
Dec 15 19:50:05 volumio-x86 volumio[977]: info: ------------------------------ 2ms
Dec 15 19:50:05 volumio-x86 volumio[977]: info: Starting UPNP Playback
Dec 15 19:50:05 volumio-x86 volumio[977]: info: Preparing playback through UPNP
Dec 15 19:50:05 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetState
Dec 15 19:50:05 volumio-x86 volumio[977]: info: CorePlayQueue::getTrack 0
Dec 15 19:50:05 volumio-x86 volumio[977]: info: CoreStateMachine::setConsumeUpdateService mpd
Dec 15 19:50:05 volumio-x86 volumio[977]: info: MyVolumio login type: Token
Dec 15 19:50:05 volumio-x86 volumio[977]: info:
Dec 15 19:50:05 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:50:05 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:50:05 volumio-x86 volumio[977]: info:
Dec 15 19:50:05 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:50:05 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:50:05 volumio-x86 volumio[977]: info: ------------------------------ 2ms
Dec 15 19:50:05 volumio-x86 volumio[977]: info: ------------------------------ 1ms
Dec 15 19:50:05 volumio-x86 volumio[977]: info:
Dec 15 19:50:05 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:50:05 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:50:05 volumio-x86 volumio[977]: info:
Dec 15 19:50:05 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:50:05 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:50:05 volumio-x86 volumio[977]: info: ------------------------------ 2ms
Dec 15 19:50:05 volumio-x86 volumio[977]: info: ------------------------------ 1ms
Dec 15 19:50:05 volumio-x86 volumio[977]: info:
Dec 15 19:50:05 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:50:05 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:50:05 volumio-x86 volumio[977]: info: ------------------------------ 1ms
Dec 15 19:50:05 volumio-x86 volumio[977]: info:
Dec 15 19:50:05 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:50:05 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:50:05 volumio-x86 volumio[977]: info:
Dec 15 19:50:05 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:50:05 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:50:05 volumio-x86 volumio[977]: info: ------------------------------ 1ms
Dec 15 19:50:05 volumio-x86 volumio[977]: info:
Dec 15 19:50:05 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:50:05 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:50:05 volumio-x86 volumio[977]: info: ------------------------------ 1ms
Dec 15 19:50:05 volumio-x86 volumio[977]: info: ------------------------------ 1ms
Dec 15 19:50:05 volumio-x86 volumio[977]: info:
Dec 15 19:50:05 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:50:05 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:50:05 volumio-x86 volumio[977]: info:
Dec 15 19:50:05 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:50:05 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:50:05 volumio-x86 volumio[977]: info: ------------------------------ 2ms
Dec 15 19:50:05 volumio-x86 volumio[977]: info: ------------------------------ 1ms
Dec 15 19:50:05 volumio-x86 volumio[977]: info:
Dec 15 19:50:05 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:50:05 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:50:05 volumio-x86 volumio[977]: info:
Dec 15 19:50:05 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:50:05 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:50:05 volumio-x86 volumio[977]: info: ------------------------------ 1ms
Dec 15 19:50:05 volumio-x86 volumio[977]: info: ------------------------------ 1ms
Dec 15 19:50:06 volumio-x86 volumio[977]: info:
Dec 15 19:50:06 volumio-x86 volumio[977]: ---------------------------- MPD announces state update: player
Dec 15 19:50:06 volumio-x86 volumio[977]: info: ControllerMpd::getState
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 19:50:06 volumio-x86 volumio[977]: info:
Dec 15 19:50:06 volumio-x86 volumio[977]: ---------------------------- MPD announces state update: player
Dec 15 19:50:06 volumio-x86 volumio[977]: info: ControllerMpd::getState
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 19:50:06 volumio-x86 volumio[977]: info:
Dec 15 19:50:06 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:50:06 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:50:06 volumio-x86 volumio[977]: info:
Dec 15 19:50:06 volumio-x86 volumio[977]: ---------------------------- MPD announces state update: player
Dec 15 19:50:06 volumio-x86 volumio[977]: info: sendMpdCommand status took 17 milliseconds
Dec 15 19:50:06 volumio-x86 volumio[977]: info: ControllerMpd::getState
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 19:50:06 volumio-x86 volumio[977]: info: sendMpdCommand status took 16 milliseconds
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: ControllerMpd::parseState
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: ControllerMpd::parseState
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 15 19:50:06 volumio-x86 volumio[977]: info:
Dec 15 19:50:06 volumio-x86 volumio[977]: ---------------------------- MPD announces system playlist update
Dec 15 19:50:06 volumio-x86 volumio[977]: info: Ignoring MPD Status Update
Dec 15 19:50:06 volumio-x86 volumio[977]: info:
Dec 15 19:50:06 volumio-x86 volumio[977]: ---------------------------- MPD announces state update: player
Dec 15 19:50:06 volumio-x86 volumio[977]: info: ControllerMpd::getState
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 19:50:06 volumio-x86 volumio[977]: info: ------------------------------ 17ms
Dec 15 19:50:06 volumio-x86 volumio[977]: info: sendMpdCommand status took 16 milliseconds
Dec 15 19:50:06 volumio-x86 volumio[977]: info: sendMpdCommand playlistinfo took 15 milliseconds
Dec 15 19:50:06 volumio-x86 volumio[977]: info: sendMpdCommand playlistinfo took 15 milliseconds
Dec 15 19:50:06 volumio-x86 volumio[977]: info: ------------------------------ 14ms
Dec 15 19:50:06 volumio-x86 volumio[977]: info: sendMpdCommand status took 15 milliseconds
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: ControllerMpd::parseState
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: ControllerMpd::parseTrackInfo
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: ControllerMpd::parseTrackInfo
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: ControllerMpd::parseState
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 15 19:50:06 volumio-x86 volumio[977]: info: ControllerMpd::pushState
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreCommandRouter::servicePushState
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: In UPNP mode
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":275,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"不散","artist":"姚璎格","album":"不散","uri":"http://ws6.stream.qqmusic.qq.com/F000000yBEfn0l7W3v.flac?guid=000000007e628642000001889efbcdf7&vkey=27F931FE87705FC787CAF50786553ABA8CDADC008C57699F1AC300C7DB15B175F7EC8F64831A4BCE3C2DB3E833EA68A97D8797B33F7FFF98__v2ba83c09&uin=1152921505193197560&src=F000003Lov9H4dTk31.flac&redirect=1&fromtag=111114","trackType":""}
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: CURRENT POSITION 0
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreStateMachine::syncState stateService play
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreStateMachine::syncState currentStatus stop
Dec 15 19:50:06 volumio-x86 volumio[977]: info: ControllerMpd::pushState
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreCommandRouter::servicePushState
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: In UPNP mode
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":275,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1374 Kbps","isStreaming":false,"title":"不散","artist":"姚璎格","album":"不散","uri":"http://ws6.stream.qqmusic.qq.com/F000000yBEfn0l7W3v.flac?guid=000000007e628642000001889efbcdf7&vkey=27F931FE87705FC787CAF50786553ABA8CDADC008C57699F1AC300C7DB15B175F7EC8F64831A4BCE3C2DB3E833EA68A97D8797B33F7FFF98__v2ba83c09&uin=1152921505193197560&src=F000003Lov9H4dTk31.flac&redirect=1&fromtag=111114","trackType":""}
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: CURRENT POSITION 0
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreStateMachine::syncState stateService play
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreStateMachine::syncState currentStatus play
Dec 15 19:50:06 volumio-x86 volumio[977]: info: Received an update from plugin. extracting info from payload
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreStateMachine::pushState
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreStateMachine::pushState
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:50:06 volumio-x86 volumio[977]: info: ------------------------------ 46ms
Dec 15 19:50:06 volumio-x86 volumio[977]: info: ------------------------------ 53ms
Dec 15 19:50:06 volumio-x86 volumio[977]: info: sendMpdCommand playlistinfo took 22 milliseconds
Dec 15 19:50:06 volumio-x86 volumio[977]: info: sendMpdCommand playlistinfo took 22 milliseconds
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: ControllerMpd::parseTrackInfo
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: ControllerMpd::parseTrackInfo
Dec 15 19:50:06 volumio-x86 volumio[977]: info: ControllerMpd::pushState
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreCommandRouter::servicePushState
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: In UPNP mode
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: STATE SERVICE {"status":"play","position":0,"seek":596,"duration":275,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1374 Kbps","isStreaming":false,"title":"不散","artist":"姚璎格","album":"不散","uri":"http://ws6.stream.qqmusic.qq.com/F000000yBEfn0l7W3v.flac?guid=000000007e628642000001889efbcdf7&vkey=27F931FE87705FC787CAF50786553ABA8CDADC008C57699F1AC300C7DB15B175F7EC8F64831A4BCE3C2DB3E833EA68A97D8797B33F7FFF98__v2ba83c09&uin=1152921505193197560&src=F000003Lov9H4dTk31.flac&redirect=1&fromtag=111114","trackType":""}
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: CURRENT POSITION 0
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreStateMachine::syncState stateService play
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreStateMachine::syncState currentStatus play
Dec 15 19:50:06 volumio-x86 volumio[977]: info: Received an update from plugin. extracting info from payload
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreStateMachine::pushState
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreStateMachine::pushState
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:50:06 volumio-x86 volumio[977]: info: ControllerMpd::pushState
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreCommandRouter::servicePushState
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: In UPNP mode
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: STATE SERVICE {"status":"play","position":0,"seek":596,"duration":275,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1374 Kbps","isStreaming":false,"title":"不散","artist":"姚璎格","album":"不散","uri":"http://ws6.stream.qqmusic.qq.com/F000000yBEfn0l7W3v.flac?guid=000000007e628642000001889efbcdf7&vkey=27F931FE87705FC787CAF50786553ABA8CDADC008C57699F1AC300C7DB15B175F7EC8F64831A4BCE3C2DB3E833EA68A97D8797B33F7FFF98__v2ba83c09&uin=1152921505193197560&src=F000003Lov9H4dTk31.flac&redirect=1&fromtag=111114","trackType":""}
Dec 15 19:50:06 volumio-x86 volumio[977]: verbose: CURRENT POSITION 0
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreStateMachine::syncState stateService play
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreStateMachine::syncState currentStatus play
Dec 15 19:50:06 volumio-x86 volumio[977]: info: Received an update from plugin. extracting info from payload
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreStateMachine::pushState
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreStateMachine::pushState
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioPushState
Dec 15 19:50:06 volumio-x86 volumio[977]: info: ------------------------------ 94ms
Dec 15 19:50:06 volumio-x86 volumio[977]: info: ------------------------------ 93ms
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetQueue
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreStateMachine::getQueue
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CorePlayQueue::getQueue
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetQueue
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreStateMachine::getQueue
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CorePlayQueue::getQueue
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetQueue
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreStateMachine::getQueue
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CorePlayQueue::getQueue
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetQueue
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreStateMachine::getQueue
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CorePlayQueue::getQueue
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetQueue
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreStateMachine::getQueue
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CorePlayQueue::getQueue
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetQueue
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CoreStateMachine::getQueue
Dec 15 19:50:06 volumio-x86 volumio[977]: info: CorePlayQueue::getQueue
Dec 15 19:50:26 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetState
Dec 15 19:50:26 volumio-x86 sudo[5952]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py
Dec 15 19:50:26 volumio-x86 sudo[5952]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 19:50:27 volumio-x86 volumio[977]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 6
Dec 15 19:50:27 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetState
Dec 15 19:50:28 volumio-x86 volumio[977]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 7
Dec 15 19:50:28 volumio-x86 volumio[977]: info: CoreCommandRouter::volumioGetState
Dec 15 19:50:35 volumio-x86 volumio[977]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Dec 15 19:50:35 volumio-x86 volumio[977]: info: Retrying Login Due to Network Error
Dec 15 19:50:45 volumio-x86 volumio[977]: info: MyVolumio login type: Token
Dec 15 19:50:55 volumio-x86 volumio[977]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 15 19:50:55 volumio-x86 volumio[977]: Error: connect ETIMEDOUT 179.60.193.9:443
Dec 15 19:50:55 volumio-x86 volumio[977]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Dec 15 19:50:55 volumio-x86 volumio[977]: errno: -110,
Dec 15 19:50:55 volumio-x86 volumio[977]: code: 'ETIMEDOUT',
Dec 15 19:50:55 volumio-x86 volumio[977]: syscall: 'connect',
Dec 15 19:50:55 volumio-x86 volumio[977]: address: '179.60.193.9',
Dec 15 19:50:55 volumio-x86 volumio[977]: port: 443
Dec 15 19:50:55 volumio-x86 volumio[977]: }
Dec 15 19:50:55 volumio-x86 volumio[977]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 15 19:50:55 volumio-x86 sudo[6038]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-15 19:49
Dec 15 19:50:55 volumio-x86 sudo[6038]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET"
VOLUMIO_VERSION="3.779"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"