-- Logs begin at Wed 2024-07-24 11:30:57 UTC, end at Wed 2024-07-24 12:22:26 UTC. -- Jul 24 12:21:10 volumio volumio[8977]: info: Jul 24 12:21:10 volumio volumio[8977]: ---------------------------- MPD announces state update: player Jul 24 12:21:10 volumio volumio[8977]: info: ControllerMpd::getState Jul 24 12:21:10 volumio volumio[8977]: verbose: ControllerMpd::sendMpdCommand status Jul 24 12:21:10 volumio volumio[8977]: info: sendMpdCommand status took 2 milliseconds Jul 24 12:21:10 volumio volumio[8977]: verbose: ControllerMpd::parseState Jul 24 12:21:10 volumio volumio[8977]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 24 12:21:10 volumio volumio[8977]: info: sendMpdCommand playlistinfo took 0 milliseconds Jul 24 12:21:10 volumio volumio[8977]: verbose: ControllerMpd::parseTrackInfo Jul 24 12:21:10 volumio volumio[8977]: info: ControllerMpd::pushState Jul 24 12:21:10 volumio volumio[8977]: info: CoreCommandRouter::servicePushState Jul 24 12:21:10 volumio volumio[8977]: info: CoreStateMachine::pushState Jul 24 12:21:10 volumio volumio[8977]: info: CoreCommandRouter::volumioPushState Jul 24 12:21:10 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 24 12:21:10 volumio volumio[8977]: info: CorePlayQueue::getTrack 0 Jul 24 12:21:10 volumio volumio[8977]: 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":"Havana","artist":"Camila Cabello","album":"Havana","uri":"http://sjy6.stream.qqmusic.qq.com/M500004DW9Kr2vk3FN.mp3?guid=ffffffffbe7698bc000001883e33e7c7&vkey=5B7A520B06CFEC18EA083E42308EF8324DA8B51CAB8085B9C0D30493EA8119C1B518C908687A7DE1B8182885A882599B6E5CF6B4357F71CD&uin=22213939&redirect=1&fromtag=111042","trackType":""} Jul 24 12:21:10 volumio volumio[8977]: verbose: CURRENT POSITION 0 Jul 24 12:21:10 volumio volumio[8977]: info: CoreStateMachine::syncState stateService stop Jul 24 12:21:10 volumio volumio[8977]: info: CoreStateMachine::syncState currentStatus play Jul 24 12:21:10 volumio volumio[8977]: info: CoreCommandRouter::volumioPushState Jul 24 12:21:10 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 24 12:21:10 volumio volumio[8977]: info: CoreStateMachine::stPlaybackTimer Jul 24 12:21:10 volumio volumio[8977]: info: ------------------------------ 16ms Jul 24 12:21:10 volumio volumio[8977]: info: CoreCommandRouter::volumioGetQueue Jul 24 12:21:10 volumio volumio[8977]: info: CoreStateMachine::getQueue Jul 24 12:21:10 volumio volumio[8977]: info: CorePlayQueue::getQueue Jul 24 12:21:10 volumio volumio[8977]: info: Clearing queue after UPNP request Jul 24 12:21:10 volumio volumio[8977]: info: CoreStateMachine::ClearQueue Jul 24 12:21:10 volumio volumio[8977]: info: CoreStateMachine::stop Jul 24 12:21:10 volumio volumio[8977]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 24 12:21:10 volumio volumio[8977]: verbose: UNSET VOLATILE Jul 24 12:21:10 volumio volumio[8977]: info: CorePlayQueue::clearPlayQueue Jul 24 12:21:10 volumio volumio[8977]: info: CorePlayQueue::saveQueue Jul 24 12:21:10 volumio volumio[8977]: info: CoreCommandRouter::volumioPushState Jul 24 12:21:10 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 24 12:21:10 volumio volumio[8977]: info: CoreCommandRouter::volumioPushQueue Jul 24 12:21:10 volumio volumio[8977]: info: Jul 24 12:21:10 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:21:10 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:21:10 volumio volumio[8977]: error: updateQueue error: null Jul 24 12:21:10 volumio volumio[8977]: info: ------------------------------ 6ms Jul 24 12:21:10 volumio volumio[8977]: info: Starting UPNP Playback Jul 24 12:21:10 volumio volumio[8977]: info: Preparing playback through UPNP Jul 24 12:21:10 volumio volumio[8977]: info: CoreCommandRouter::volumioGetState Jul 24 12:21:10 volumio volumio[8977]: info: CorePlayQueue::getTrack 0 Jul 24 12:21:10 volumio volumio[8977]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 24 12:21:11 volumio volumio[8977]: info: Jul 24 12:21:11 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:21:11 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:21:11 volumio volumio[8977]: info: ------------------------------ 3ms Jul 24 12:21:11 volumio volumio[8977]: info: Jul 24 12:21:11 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:21:11 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:21:11 volumio volumio[8977]: info: ------------------------------ 3ms Jul 24 12:21:11 volumio volumio[8977]: info: Jul 24 12:21:11 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:21:11 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:21:11 volumio volumio[8977]: info: ------------------------------ 3ms Jul 24 12:21:11 volumio volumio[8977]: info: Jul 24 12:21:11 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:21:11 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:21:11 volumio volumio[8977]: info: ------------------------------ 5ms Jul 24 12:21:11 volumio volumio[8977]: info: Jul 24 12:21:11 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:21:11 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:21:11 volumio volumio[8977]: info: ------------------------------ 1ms Jul 24 12:21:11 volumio volumio[8977]: info: Jul 24 12:21:11 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:21:11 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:21:11 volumio volumio[8977]: info: ------------------------------ 1ms Jul 24 12:21:11 volumio volumio[8977]: info: Jul 24 12:21:11 volumio volumio[8977]: ---------------------------- MPD announces state update: player Jul 24 12:21:11 volumio volumio[8977]: info: ControllerMpd::getState Jul 24 12:21:11 volumio volumio[8977]: verbose: ControllerMpd::sendMpdCommand status Jul 24 12:21:11 volumio volumio[8977]: info: sendMpdCommand status took 6 milliseconds Jul 24 12:21:11 volumio volumio[8977]: verbose: ControllerMpd::parseState Jul 24 12:21:11 volumio volumio[8977]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 24 12:21:11 volumio volumio[8977]: info: Jul 24 12:21:11 volumio volumio[8977]: ---------------------------- MPD announces state update: player Jul 24 12:21:11 volumio volumio[8977]: info: ControllerMpd::getState Jul 24 12:21:11 volumio volumio[8977]: verbose: ControllerMpd::sendMpdCommand status Jul 24 12:21:11 volumio volumio[8977]: info: Jul 24 12:21:11 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:21:11 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:21:11 volumio volumio[8977]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 24 12:21:11 volumio volumio[8977]: info: sendMpdCommand status took 6 milliseconds Jul 24 12:21:11 volumio volumio[8977]: verbose: ControllerMpd::parseTrackInfo Jul 24 12:21:11 volumio volumio[8977]: verbose: ControllerMpd::parseState Jul 24 12:21:11 volumio volumio[8977]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 24 12:21:11 volumio volumio[8977]: info: ControllerMpd::pushState Jul 24 12:21:11 volumio volumio[8977]: info: CoreCommandRouter::servicePushState Jul 24 12:21:11 volumio volumio[8977]: verbose: In UPNP mode Jul 24 12:21:11 volumio volumio[8977]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":176,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"远在北方孤独的鬼","artist":"花粥","album":"乍见之欢","uri":"http://sjy6.stream.qqmusic.qq.com/M500000blgqK3bc0DP.mp3?guid=ffffffffbe7698bc000001883e33e7c7&vkey=F42884DEAB239836FAC8DF2A9757384E1D12F8F7C62E20F2DD6E5606F69BD11AFD0617C766E78113F33D2AE5BB196CD38895FB073D612CD3&uin=22213939&redirect=1&fromtag=111042","trackType":""} Jul 24 12:21:11 volumio volumio[8977]: verbose: CURRENT POSITION 0 Jul 24 12:21:11 volumio volumio[8977]: info: CoreStateMachine::syncState stateService play Jul 24 12:21:11 volumio volumio[8977]: info: CoreStateMachine::syncState currentStatus stop Jul 24 12:21:11 volumio volumio[8977]: info: CoreStateMachine::pushState Jul 24 12:21:11 volumio volumio[8977]: info: CoreCommandRouter::volumioPushState Jul 24 12:21:11 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 24 12:21:11 volumio volumio[8977]: info: ------------------------------ 35ms Jul 24 12:21:11 volumio volumio[8977]: info: ------------------------------ 23ms Jul 24 12:21:11 volumio volumio[8977]: info: sendMpdCommand playlistinfo took 18 milliseconds Jul 24 12:21:11 volumio volumio[8977]: verbose: ControllerMpd::parseTrackInfo Jul 24 12:21:11 volumio volumio[8977]: info: ControllerMpd::pushState Jul 24 12:21:11 volumio volumio[8977]: info: CoreCommandRouter::servicePushState Jul 24 12:21:11 volumio volumio[8977]: verbose: In UPNP mode Jul 24 12:21:11 volumio volumio[8977]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":176,"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/M500000blgqK3bc0DP.mp3?guid=ffffffffbe7698bc000001883e33e7c7&vkey=F42884DEAB239836FAC8DF2A9757384E1D12F8F7C62E20F2DD6E5606F69BD11AFD0617C766E78113F33D2AE5BB196CD38895FB073D612CD3&uin=22213939&redirect=1&fromtag=111042","trackType":""} Jul 24 12:21:11 volumio volumio[8977]: verbose: CURRENT POSITION 0 Jul 24 12:21:11 volumio volumio[8977]: info: CoreStateMachine::syncState stateService play Jul 24 12:21:11 volumio volumio[8977]: info: CoreStateMachine::syncState currentStatus play Jul 24 12:21:11 volumio volumio[8977]: info: Received an update from plugin. extracting info from payload Jul 24 12:21:11 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 24 12:21:11 volumio volumio[8977]: info: CoreStateMachine::pushState Jul 24 12:21:11 volumio volumio[8977]: info: CoreCommandRouter::volumioPushState Jul 24 12:21:11 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 24 12:21:11 volumio volumio[8977]: info: CoreStateMachine::pushState Jul 24 12:21:11 volumio volumio[8977]: info: CoreCommandRouter::volumioPushState Jul 24 12:21:11 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 24 12:21:11 volumio volumio[8977]: info: ------------------------------ 56ms Jul 24 12:21:11 volumio volumio[8977]: info: CoreCommandRouter::volumioGetQueue Jul 24 12:21:11 volumio volumio[8977]: info: CoreStateMachine::getQueue Jul 24 12:21:11 volumio volumio[8977]: info: CorePlayQueue::getQueue Jul 24 12:21:11 volumio volumio[8977]: info: CoreCommandRouter::volumioGetQueue Jul 24 12:21:11 volumio volumio[8977]: info: CoreStateMachine::getQueue Jul 24 12:21:11 volumio volumio[8977]: info: CorePlayQueue::getQueue Jul 24 12:21:12 volumio volumio[8977]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Camila%20Cabello/Havana/622d2afb-ee38-4f2d-9723-2774ff928b56.jpg' Jul 24 12:21:28 volumio volumio[8977]: info: Jul 24 12:21:28 volumio volumio[8977]: ---------------------------- MPD announces state update: player Jul 24 12:21:28 volumio volumio[8977]: info: ControllerMpd::getState Jul 24 12:21:28 volumio volumio[8977]: verbose: ControllerMpd::sendMpdCommand status Jul 24 12:21:28 volumio volumio[8977]: info: sendMpdCommand status took 1 milliseconds Jul 24 12:21:28 volumio volumio[8977]: verbose: ControllerMpd::parseState Jul 24 12:21:28 volumio volumio[8977]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 24 12:21:28 volumio volumio[8977]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 24 12:21:28 volumio volumio[8977]: verbose: ControllerMpd::parseTrackInfo Jul 24 12:21:28 volumio volumio[8977]: info: ControllerMpd::pushState Jul 24 12:21:28 volumio volumio[8977]: info: CoreCommandRouter::servicePushState Jul 24 12:21:28 volumio volumio[8977]: info: CoreStateMachine::pushState Jul 24 12:21:28 volumio volumio[8977]: info: CoreCommandRouter::volumioPushState Jul 24 12:21:28 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 24 12:21:28 volumio volumio[8977]: info: CorePlayQueue::getTrack 0 Jul 24 12:21:28 volumio volumio[8977]: 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://sjy6.stream.qqmusic.qq.com/M500000blgqK3bc0DP.mp3?guid=ffffffffbe7698bc000001883e33e7c7&vkey=F42884DEAB239836FAC8DF2A9757384E1D12F8F7C62E20F2DD6E5606F69BD11AFD0617C766E78113F33D2AE5BB196CD38895FB073D612CD3&uin=22213939&redirect=1&fromtag=111042","trackType":""} Jul 24 12:21:28 volumio volumio[8977]: verbose: CURRENT POSITION 0 Jul 24 12:21:28 volumio volumio[8977]: info: CoreStateMachine::syncState stateService stop Jul 24 12:21:28 volumio volumio[8977]: info: CoreStateMachine::syncState currentStatus play Jul 24 12:21:28 volumio volumio[8977]: info: CoreCommandRouter::volumioPushState Jul 24 12:21:28 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 24 12:21:28 volumio volumio[8977]: info: CoreStateMachine::stPlaybackTimer Jul 24 12:21:28 volumio volumio[8977]: info: ------------------------------ 14ms Jul 24 12:21:28 volumio volumio[8977]: info: CoreCommandRouter::volumioGetQueue Jul 24 12:21:28 volumio volumio[8977]: info: CoreStateMachine::getQueue Jul 24 12:21:28 volumio volumio[8977]: info: CorePlayQueue::getQueue Jul 24 12:21:29 volumio volumio[8977]: info: Clearing queue after UPNP request Jul 24 12:21:29 volumio volumio[8977]: info: CoreStateMachine::ClearQueue Jul 24 12:21:29 volumio volumio[8977]: info: CoreStateMachine::stop Jul 24 12:21:29 volumio volumio[8977]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 24 12:21:29 volumio volumio[8977]: verbose: UNSET VOLATILE Jul 24 12:21:29 volumio volumio[8977]: info: CorePlayQueue::clearPlayQueue Jul 24 12:21:29 volumio volumio[8977]: info: CorePlayQueue::saveQueue Jul 24 12:21:29 volumio volumio[8977]: info: CoreCommandRouter::volumioPushState Jul 24 12:21:29 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 24 12:21:29 volumio volumio[8977]: info: CoreCommandRouter::volumioPushQueue Jul 24 12:21:29 volumio volumio[8977]: info: Jul 24 12:21:29 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:21:29 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:21:29 volumio volumio[8977]: error: updateQueue error: null Jul 24 12:21:29 volumio volumio[8977]: info: ------------------------------ 2ms Jul 24 12:21:29 volumio volumio[8977]: info: Starting UPNP Playback Jul 24 12:21:29 volumio volumio[8977]: info: Preparing playback through UPNP Jul 24 12:21:29 volumio volumio[8977]: info: CoreCommandRouter::volumioGetState Jul 24 12:21:29 volumio volumio[8977]: info: CorePlayQueue::getTrack 0 Jul 24 12:21:29 volumio volumio[8977]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 24 12:21:29 volumio volumio[8977]: info: Jul 24 12:21:29 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:21:29 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:21:29 volumio volumio[8977]: info: ------------------------------ 2ms Jul 24 12:21:29 volumio volumio[8977]: info: Jul 24 12:21:29 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:21:29 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:21:29 volumio volumio[8977]: info: ------------------------------ 1ms Jul 24 12:21:29 volumio volumio[8977]: info: Jul 24 12:21:29 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:21:29 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:21:29 volumio volumio[8977]: info: ------------------------------ 4ms Jul 24 12:21:29 volumio volumio[8977]: info: Jul 24 12:21:29 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:21:29 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:21:29 volumio volumio[8977]: info: ------------------------------ 1ms Jul 24 12:21:29 volumio volumio[8977]: info: Jul 24 12:21:29 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:21:29 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:21:29 volumio volumio[8977]: info: ------------------------------ 1ms Jul 24 12:21:29 volumio volumio[8977]: info: Jul 24 12:21:29 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:21:29 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:21:29 volumio volumio[8977]: info: ------------------------------ 2ms Jul 24 12:21:30 volumio volumio[8977]: info: Jul 24 12:21:30 volumio volumio[8977]: ---------------------------- MPD announces state update: player Jul 24 12:21:30 volumio volumio[8977]: info: ControllerMpd::getState Jul 24 12:21:30 volumio volumio[8977]: verbose: ControllerMpd::sendMpdCommand status Jul 24 12:21:30 volumio volumio[8977]: info: Jul 24 12:21:30 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:21:30 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:21:30 volumio volumio[8977]: info: sendMpdCommand status took 1 milliseconds Jul 24 12:21:30 volumio volumio[8977]: verbose: ControllerMpd::parseState Jul 24 12:21:30 volumio volumio[8977]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 24 12:21:30 volumio volumio[8977]: info: ------------------------------ 2ms Jul 24 12:21:30 volumio volumio[8977]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 24 12:21:30 volumio volumio[8977]: verbose: ControllerMpd::parseTrackInfo Jul 24 12:21:30 volumio volumio[8977]: info: ControllerMpd::pushState Jul 24 12:21:30 volumio volumio[8977]: info: CoreCommandRouter::servicePushState Jul 24 12:21:30 volumio volumio[8977]: verbose: In UPNP mode Jul 24 12:21:30 volumio volumio[8977]: verbose: STATE SERVICE {"status":"play","position":0,"seek":150,"duration":126,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"超重低音炮","artist":"全代扬","album":"全代杨精选集10","uri":"http://sjy6.stream.qqmusic.qq.com/M500001787WU4FZIBk.mp3?guid=ffffffffbe7698bc000001883e33e7c7&vkey=DA83E49D1ADD0F395109753965F884441B1B6F33850AA0C17EADA04900916CE8225C750FA0B353BBEB1A170C9B1FFB3D01195691C0990C88&uin=22213939&redirect=1&fromtag=111042","trackType":""} Jul 24 12:21:30 volumio volumio[8977]: verbose: CURRENT POSITION 0 Jul 24 12:21:30 volumio volumio[8977]: info: CoreStateMachine::syncState stateService play Jul 24 12:21:30 volumio volumio[8977]: info: CoreStateMachine::syncState currentStatus stop Jul 24 12:21:30 volumio volumio[8977]: info: CoreStateMachine::pushState Jul 24 12:21:30 volumio volumio[8977]: info: CoreCommandRouter::volumioPushState Jul 24 12:21:30 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 24 12:21:30 volumio volumio[8977]: info: ------------------------------ 8ms Jul 24 12:21:30 volumio volumio[8977]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%8A%B1%E7%B2%A5/%E4%B9%8D%E8%A7%81%E4%B9%8B%E6%AC%A2/bd32907b-6b35-4e39-a61d-b7cae01273a3.jpg' Jul 24 12:21:57 volumio volumio[1189]: 45 Jul 24 12:21:57 volumio volumio[1189]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 24 12:21:57 volumio volumio[1189]: Dload Upload Total Spent Left Speed Jul 24 12:21:57 volumio volumio[8977]: info: Jul 24 12:21:57 volumio volumio[8977]: ---------------------------- Client requests Volume 45 Jul 24 12:21:57 volumio volumio[8977]: info: VolumeController::SetAlsaVolume45 Jul 24 12:21:57 volumio volumio[8977]: info: CoreStateMachine::pushState Jul 24 12:21:57 volumio volumio[8977]: info: CoreCommandRouter::volumioPushState Jul 24 12:21:57 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 24 12:21:57 volumio volumio[1189]: [155B blob data] Jul 24 12:21:57 volumio volumio[1189]: {"time":1721823717290,"response":"volume Success"}45 Jul 24 12:22:12 volumio volumio[8977]: info: Jul 24 12:22:12 volumio volumio[8977]: ---------------------------- MPD announces state update: player Jul 24 12:22:12 volumio volumio[8977]: info: ControllerMpd::getState Jul 24 12:22:12 volumio volumio[8977]: verbose: ControllerMpd::sendMpdCommand status Jul 24 12:22:12 volumio volumio[8977]: info: sendMpdCommand status took 0 milliseconds Jul 24 12:22:12 volumio volumio[8977]: verbose: ControllerMpd::parseState Jul 24 12:22:12 volumio volumio[8977]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 24 12:22:12 volumio volumio[8977]: info: sendMpdCommand playlistinfo took 0 milliseconds Jul 24 12:22:12 volumio volumio[8977]: verbose: ControllerMpd::parseTrackInfo Jul 24 12:22:12 volumio volumio[8977]: info: ControllerMpd::pushState Jul 24 12:22:12 volumio volumio[8977]: info: CoreCommandRouter::servicePushState Jul 24 12:22:12 volumio volumio[8977]: info: CoreStateMachine::pushState Jul 24 12:22:12 volumio volumio[8977]: info: CoreCommandRouter::volumioPushState Jul 24 12:22:12 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 24 12:22:12 volumio volumio[8977]: info: CorePlayQueue::getTrack 0 Jul 24 12:22:12 volumio volumio[8977]: 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":"全代杨精选集10","uri":"http://sjy6.stream.qqmusic.qq.com/M500001787WU4FZIBk.mp3?guid=ffffffffbe7698bc000001883e33e7c7&vkey=DA83E49D1ADD0F395109753965F884441B1B6F33850AA0C17EADA04900916CE8225C750FA0B353BBEB1A170C9B1FFB3D01195691C0990C88&uin=22213939&redirect=1&fromtag=111042","trackType":""} Jul 24 12:22:12 volumio volumio[8977]: verbose: CURRENT POSITION 0 Jul 24 12:22:12 volumio volumio[8977]: info: CoreStateMachine::syncState stateService stop Jul 24 12:22:12 volumio volumio[8977]: info: CoreStateMachine::syncState currentStatus play Jul 24 12:22:12 volumio volumio[8977]: info: CoreCommandRouter::volumioPushState Jul 24 12:22:12 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 24 12:22:12 volumio volumio[8977]: info: CoreStateMachine::stPlaybackTimer Jul 24 12:22:12 volumio volumio[8977]: info: ------------------------------ 16ms Jul 24 12:22:12 volumio volumio[8977]: info: Clearing queue after UPNP request Jul 24 12:22:12 volumio volumio[8977]: info: CoreStateMachine::ClearQueue Jul 24 12:22:12 volumio volumio[8977]: info: CoreStateMachine::stop Jul 24 12:22:12 volumio volumio[8977]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 24 12:22:12 volumio volumio[8977]: verbose: UNSET VOLATILE Jul 24 12:22:12 volumio volumio[8977]: info: CorePlayQueue::clearPlayQueue Jul 24 12:22:12 volumio volumio[8977]: info: CorePlayQueue::saveQueue Jul 24 12:22:12 volumio volumio[8977]: info: CoreCommandRouter::volumioPushState Jul 24 12:22:12 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 24 12:22:12 volumio volumio[8977]: info: CoreCommandRouter::volumioPushQueue Jul 24 12:22:12 volumio volumio[8977]: info: Jul 24 12:22:13 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:22:13 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:22:13 volumio volumio[8977]: error: updateQueue error: null Jul 24 12:22:13 volumio volumio[8977]: info: ------------------------------ 2ms Jul 24 12:22:13 volumio volumio[8977]: info: Starting UPNP Playback Jul 24 12:22:13 volumio volumio[8977]: info: Preparing playback through UPNP Jul 24 12:22:13 volumio volumio[8977]: info: CoreCommandRouter::volumioGetState Jul 24 12:22:13 volumio volumio[8977]: info: CorePlayQueue::getTrack 0 Jul 24 12:22:13 volumio volumio[8977]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 24 12:22:13 volumio volumio[8977]: info: Jul 24 12:22:13 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:22:13 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:22:13 volumio volumio[8977]: info: Jul 24 12:22:13 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:22:13 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:22:13 volumio volumio[8977]: info: ------------------------------ 1ms Jul 24 12:22:13 volumio volumio[8977]: info: ------------------------------ 1ms Jul 24 12:22:13 volumio volumio[8977]: info: Jul 24 12:22:13 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:22:13 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:22:13 volumio volumio[8977]: info: ------------------------------ 1ms Jul 24 12:22:13 volumio volumio[8977]: info: Jul 24 12:22:13 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:22:13 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:22:13 volumio volumio[8977]: info: ------------------------------ 2ms Jul 24 12:22:13 volumio volumio[8977]: info: Jul 24 12:22:13 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:22:13 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:22:13 volumio volumio[8977]: info: ------------------------------ 1ms Jul 24 12:22:13 volumio volumio[8977]: info: Jul 24 12:22:13 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:22:13 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:22:13 volumio volumio[8977]: info: ------------------------------ 1ms Jul 24 12:22:14 volumio volumio[8977]: info: Jul 24 12:22:14 volumio volumio[8977]: ---------------------------- MPD announces state update: player Jul 24 12:22:14 volumio volumio[8977]: info: ControllerMpd::getState Jul 24 12:22:14 volumio volumio[8977]: verbose: ControllerMpd::sendMpdCommand status Jul 24 12:22:14 volumio volumio[8977]: info: Jul 24 12:22:14 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:22:14 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:22:14 volumio volumio[8977]: info: Jul 24 12:22:14 volumio volumio[8977]: ---------------------------- MPD announces state update: player Jul 24 12:22:14 volumio volumio[8977]: info: sendMpdCommand status took 4 milliseconds Jul 24 12:22:14 volumio volumio[8977]: info: ControllerMpd::getState Jul 24 12:22:14 volumio volumio[8977]: verbose: ControllerMpd::sendMpdCommand status Jul 24 12:22:14 volumio volumio[8977]: verbose: ControllerMpd::parseState Jul 24 12:22:14 volumio volumio[8977]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 24 12:22:14 volumio volumio[8977]: info: ------------------------------ 3ms Jul 24 12:22:14 volumio volumio[8977]: info: sendMpdCommand status took 7 milliseconds Jul 24 12:22:14 volumio volumio[8977]: verbose: ControllerMpd::parseState Jul 24 12:22:14 volumio volumio[8977]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 24 12:22:14 volumio volumio[8977]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 24 12:22:14 volumio volumio[8977]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 24 12:22:14 volumio volumio[8977]: verbose: ControllerMpd::parseTrackInfo Jul 24 12:22:14 volumio volumio[8977]: verbose: ControllerMpd::parseTrackInfo Jul 24 12:22:14 volumio volumio[8977]: info: ControllerMpd::pushState Jul 24 12:22:14 volumio volumio[8977]: info: CoreCommandRouter::servicePushState Jul 24 12:22:14 volumio volumio[8977]: verbose: In UPNP mode Jul 24 12:22:14 volumio volumio[8977]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":143,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"抒情旋律","artist":"金6","album":"迪玛希","uri":"http://192.168.2.160:49152/16f3e4658881a1c9809851be3c47551e.mp3","trackType":"mp3"} Jul 24 12:22:14 volumio volumio[8977]: verbose: CURRENT POSITION 0 Jul 24 12:22:14 volumio volumio[8977]: info: CoreStateMachine::syncState stateService play Jul 24 12:22:14 volumio volumio[8977]: info: CoreStateMachine::syncState currentStatus stop Jul 24 12:22:14 volumio volumio[8977]: info: CoreStateMachine::pushState Jul 24 12:22:14 volumio volumio[8977]: info: CoreCommandRouter::volumioPushState Jul 24 12:22:14 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 24 12:22:14 volumio volumio[8977]: info: ControllerMpd::pushState Jul 24 12:22:14 volumio volumio[8977]: info: CoreCommandRouter::servicePushState Jul 24 12:22:14 volumio volumio[8977]: verbose: In UPNP mode Jul 24 12:22:14 volumio volumio[8977]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":143,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"抒情旋律","artist":"金6","album":"迪玛希","uri":"http://192.168.2.160:49152/16f3e4658881a1c9809851be3c47551e.mp3","trackType":"mp3"} Jul 24 12:22:14 volumio volumio[8977]: verbose: CURRENT POSITION 0 Jul 24 12:22:14 volumio volumio[8977]: info: CoreStateMachine::syncState stateService play Jul 24 12:22:14 volumio volumio[8977]: info: CoreStateMachine::syncState currentStatus play Jul 24 12:22:14 volumio volumio[8977]: info: Received an update from plugin. extracting info from payload Jul 24 12:22:14 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 24 12:22:14 volumio volumio[8977]: info: CoreStateMachine::pushState Jul 24 12:22:14 volumio volumio[8977]: info: CoreCommandRouter::volumioPushState Jul 24 12:22:14 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 24 12:22:14 volumio volumio[8977]: info: CoreStateMachine::pushState Jul 24 12:22:14 volumio volumio[8977]: info: CoreCommandRouter::volumioPushState Jul 24 12:22:14 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 24 12:22:14 volumio volumio[8977]: info: ------------------------------ 47ms Jul 24 12:22:14 volumio volumio[8977]: info: ------------------------------ 42ms Jul 24 12:22:14 volumio volumio[8977]: info: CoreCommandRouter::volumioGetQueue Jul 24 12:22:14 volumio volumio[8977]: info: CoreStateMachine::getQueue Jul 24 12:22:14 volumio volumio[8977]: info: CorePlayQueue::getQueue Jul 24 12:22:14 volumio volumio[8977]: info: CoreCommandRouter::volumioGetQueue Jul 24 12:22:14 volumio volumio[8977]: info: CoreStateMachine::getQueue Jul 24 12:22:14 volumio volumio[8977]: info: CorePlayQueue::getQueue Jul 24 12:22:17 volumio volumio[8977]: info: Jul 24 12:22:17 volumio volumio[8977]: ---------------------------- MPD announces state update: player Jul 24 12:22:17 volumio volumio[8977]: info: ControllerMpd::getState Jul 24 12:22:17 volumio volumio[8977]: verbose: ControllerMpd::sendMpdCommand status Jul 24 12:22:17 volumio volumio[8977]: info: sendMpdCommand status took 1 milliseconds Jul 24 12:22:17 volumio volumio[8977]: verbose: ControllerMpd::parseState Jul 24 12:22:17 volumio volumio[8977]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 24 12:22:17 volumio volumio[8977]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 24 12:22:17 volumio volumio[8977]: verbose: ControllerMpd::parseTrackInfo Jul 24 12:22:17 volumio volumio[8977]: info: ControllerMpd::pushState Jul 24 12:22:17 volumio volumio[8977]: info: CoreCommandRouter::servicePushState Jul 24 12:22:17 volumio volumio[8977]: info: CoreStateMachine::pushState Jul 24 12:22:17 volumio volumio[8977]: info: CoreCommandRouter::volumioPushState Jul 24 12:22:17 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 24 12:22:17 volumio volumio[8977]: info: CorePlayQueue::getTrack 0 Jul 24 12:22:17 volumio volumio[8977]: 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":"金6","album":"迪玛希","uri":"http://192.168.2.160:49152/16f3e4658881a1c9809851be3c47551e.mp3","trackType":"mp3"} Jul 24 12:22:17 volumio volumio[8977]: verbose: CURRENT POSITION 0 Jul 24 12:22:17 volumio volumio[8977]: info: CoreStateMachine::syncState stateService stop Jul 24 12:22:17 volumio volumio[8977]: info: CoreStateMachine::syncState currentStatus play Jul 24 12:22:17 volumio volumio[8977]: info: CoreCommandRouter::volumioPushState Jul 24 12:22:17 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 24 12:22:17 volumio volumio[8977]: info: CoreStateMachine::stPlaybackTimer Jul 24 12:22:17 volumio volumio[8977]: info: ------------------------------ 15ms Jul 24 12:22:17 volumio volumio[8977]: info: CoreCommandRouter::volumioGetQueue Jul 24 12:22:17 volumio volumio[8977]: info: CoreStateMachine::getQueue Jul 24 12:22:17 volumio volumio[8977]: info: CorePlayQueue::getQueue Jul 24 12:22:17 volumio volumio[8977]: info: Clearing queue after UPNP request Jul 24 12:22:18 volumio volumio[8977]: info: CoreStateMachine::ClearQueue Jul 24 12:22:18 volumio volumio[8977]: info: CoreStateMachine::stop Jul 24 12:22:18 volumio volumio[8977]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 24 12:22:18 volumio volumio[8977]: verbose: UNSET VOLATILE Jul 24 12:22:18 volumio volumio[8977]: info: CorePlayQueue::clearPlayQueue Jul 24 12:22:18 volumio volumio[8977]: info: CorePlayQueue::saveQueue Jul 24 12:22:18 volumio volumio[8977]: info: CoreCommandRouter::volumioPushState Jul 24 12:22:18 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 24 12:22:18 volumio volumio[8977]: info: CoreCommandRouter::volumioPushQueue Jul 24 12:22:18 volumio volumio[8977]: info: Jul 24 12:22:18 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:22:18 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:22:18 volumio volumio[8977]: info: Starting UPNP Playback Jul 24 12:22:18 volumio volumio[8977]: info: Preparing playback through UPNP Jul 24 12:22:18 volumio volumio[8977]: info: CoreCommandRouter::volumioGetState Jul 24 12:22:18 volumio volumio[8977]: info: CorePlayQueue::getTrack 0 Jul 24 12:22:18 volumio volumio[8977]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 24 12:22:18 volumio volumio[8977]: error: updateQueue error: null Jul 24 12:22:18 volumio volumio[8977]: info: ------------------------------ 5ms Jul 24 12:22:18 volumio volumio[8977]: info: Jul 24 12:22:18 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:22:18 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:22:18 volumio volumio[8977]: info: ------------------------------ 2ms Jul 24 12:22:18 volumio volumio[8977]: info: Jul 24 12:22:18 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:22:18 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:22:18 volumio volumio[8977]: info: ------------------------------ 1ms Jul 24 12:22:18 volumio volumio[8977]: info: Jul 24 12:22:18 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:22:18 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:22:18 volumio volumio[8977]: info: ------------------------------ 1ms Jul 24 12:22:18 volumio volumio[8977]: info: Jul 24 12:22:18 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:22:18 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:22:18 volumio volumio[8977]: info: ------------------------------ 1ms Jul 24 12:22:18 volumio volumio[8977]: info: Jul 24 12:22:18 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:22:18 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:22:18 volumio volumio[8977]: info: ------------------------------ 1ms Jul 24 12:22:18 volumio volumio[8977]: info: Jul 24 12:22:18 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:22:18 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:22:18 volumio volumio[8977]: info: ------------------------------ 1ms Jul 24 12:22:19 volumio volumio[8977]: info: Jul 24 12:22:19 volumio volumio[8977]: ---------------------------- MPD announces state update: player Jul 24 12:22:19 volumio volumio[8977]: info: ControllerMpd::getState Jul 24 12:22:19 volumio volumio[8977]: verbose: ControllerMpd::sendMpdCommand status Jul 24 12:22:19 volumio volumio[8977]: info: Jul 24 12:22:19 volumio volumio[8977]: ---------------------------- MPD announces state update: player Jul 24 12:22:19 volumio volumio[8977]: info: sendMpdCommand status took 4 milliseconds Jul 24 12:22:19 volumio volumio[8977]: info: ControllerMpd::getState Jul 24 12:22:19 volumio volumio[8977]: verbose: ControllerMpd::sendMpdCommand status Jul 24 12:22:19 volumio volumio[8977]: verbose: ControllerMpd::parseState Jul 24 12:22:19 volumio volumio[8977]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 24 12:22:19 volumio volumio[8977]: info: Jul 24 12:22:19 volumio volumio[8977]: ---------------------------- MPD announces system playlist update Jul 24 12:22:19 volumio volumio[8977]: info: Ignoring MPD Status Update Jul 24 12:22:19 volumio volumio[8977]: info: sendMpdCommand status took 1 milliseconds Jul 24 12:22:19 volumio volumio[8977]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 24 12:22:19 volumio volumio[8977]: verbose: ControllerMpd::parseState Jul 24 12:22:19 volumio volumio[8977]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 24 12:22:19 volumio volumio[8977]: verbose: ControllerMpd::parseTrackInfo Jul 24 12:22:19 volumio volumio[8977]: info: ControllerMpd::pushState Jul 24 12:22:19 volumio volumio[8977]: info: CoreCommandRouter::servicePushState Jul 24 12:22:19 volumio volumio[8977]: verbose: In UPNP mode Jul 24 12:22:19 volumio volumio[8977]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":199,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Be my Satellite","artist":"Banaroo","album":"Fly Away","uri":"http://sjy6.stream.qqmusic.qq.com/M500002Q7pnB0S13SZ.mp3?guid=ffffffffbe7698bc000001883e33e7c7&vkey=B12E14A95471065089D6712DA4E303004045CEDBB7EB638A4ED9E31693D245ED5638CC42783348FE130E27EDB41274DD3EC729FA12806F7D&uin=22213939&redirect=1&fromtag=111042","trackType":""} Jul 24 12:22:19 volumio volumio[8977]: verbose: CURRENT POSITION 0 Jul 24 12:22:19 volumio volumio[8977]: info: CoreStateMachine::syncState stateService play Jul 24 12:22:19 volumio volumio[8977]: info: CoreStateMachine::syncState currentStatus stop Jul 24 12:22:19 volumio volumio[8977]: info: CoreStateMachine::pushState Jul 24 12:22:19 volumio volumio[8977]: info: CoreCommandRouter::volumioPushState Jul 24 12:22:19 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 24 12:22:19 volumio volumio[8977]: info: ------------------------------ 22ms Jul 24 12:22:19 volumio volumio[8977]: info: ------------------------------ 16ms Jul 24 12:22:19 volumio volumio[8977]: info: sendMpdCommand playlistinfo took 15 milliseconds Jul 24 12:22:19 volumio volumio[8977]: verbose: ControllerMpd::parseTrackInfo Jul 24 12:22:19 volumio volumio[8977]: info: ControllerMpd::pushState Jul 24 12:22:19 volumio volumio[8977]: info: CoreCommandRouter::servicePushState Jul 24 12:22:19 volumio volumio[8977]: verbose: In UPNP mode Jul 24 12:22:19 volumio volumio[8977]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":199,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Be my Satellite","artist":"Banaroo","album":"Fly Away","uri":"http://sjy6.stream.qqmusic.qq.com/M500002Q7pnB0S13SZ.mp3?guid=ffffffffbe7698bc000001883e33e7c7&vkey=B12E14A95471065089D6712DA4E303004045CEDBB7EB638A4ED9E31693D245ED5638CC42783348FE130E27EDB41274DD3EC729FA12806F7D&uin=22213939&redirect=1&fromtag=111042","trackType":""} Jul 24 12:22:19 volumio volumio[8977]: verbose: CURRENT POSITION 0 Jul 24 12:22:19 volumio volumio[8977]: info: CoreStateMachine::syncState stateService play Jul 24 12:22:19 volumio volumio[8977]: info: CoreStateMachine::syncState currentStatus play Jul 24 12:22:19 volumio volumio[8977]: info: Received an update from plugin. extracting info from payload Jul 24 12:22:19 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 24 12:22:19 volumio volumio[8977]: info: CoreStateMachine::pushState Jul 24 12:22:19 volumio volumio[8977]: info: CoreCommandRouter::volumioPushState Jul 24 12:22:19 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 24 12:22:19 volumio volumio[8977]: info: CoreStateMachine::pushState Jul 24 12:22:19 volumio volumio[8977]: info: CoreCommandRouter::volumioPushState Jul 24 12:22:19 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 24 12:22:19 volumio volumio[8977]: info: ------------------------------ 58ms Jul 24 12:22:19 volumio volumio[8977]: info: CoreCommandRouter::volumioGetQueue Jul 24 12:22:19 volumio volumio[8977]: info: CoreStateMachine::getQueue Jul 24 12:22:19 volumio volumio[8977]: info: CorePlayQueue::getQueue Jul 24 12:22:19 volumio volumio[8977]: info: CoreCommandRouter::volumioGetQueue Jul 24 12:22:19 volumio volumio[8977]: info: CoreStateMachine::getQueue Jul 24 12:22:19 volumio volumio[8977]: info: CorePlayQueue::getQueue Jul 24 12:22:24 volumio volumio[1189]: 35 Jul 24 12:22:24 volumio volumio[1189]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 24 12:22:24 volumio volumio[1189]: Dload Upload Total Spent Left Speed Jul 24 12:22:24 volumio volumio[8977]: info: Jul 24 12:22:24 volumio volumio[8977]: ---------------------------- Client requests Volume 35 Jul 24 12:22:24 volumio volumio[8977]: info: VolumeController::SetAlsaVolume35 Jul 24 12:22:24 volumio volumio[8977]: info: CoreStateMachine::pushState Jul 24 12:22:24 volumio volumio[8977]: info: CoreCommandRouter::volumioPushState Jul 24 12:22:24 volumio volumio[8977]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 24 12:22:24 volumio volumio[1189]: [155B blob data] Jul 24 12:22:24 volumio volumio[1189]: {"time":1721823744319,"response":"volume Success"}35 Jul 24 12:22:24 volumio volumio[8977]: info: CoreCommandRouter::volumioGetQueue Jul 24 12:22:24 volumio volumio[8977]: info: CoreStateMachine::getQueue Jul 24 12:22:24 volumio volumio[8977]: info: CorePlayQueue::getQueue Jul 24 12:22:25 volumio volumio[8977]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 24 12:22:25 volumio volumio[8977]: { Error: connect ETIMEDOUT 157.240.15.8:443 Jul 24 12:22:25 volumio volumio[8977]: at Object._errnoException (util.js:1022:11) Jul 24 12:22:25 volumio volumio[8977]: at _exceptionWithHostPort (util.js:1044:20) Jul 24 12:22:25 volumio volumio[8977]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jul 24 12:22:25 volumio volumio[8977]: code: 'ETIMEDOUT', Jul 24 12:22:25 volumio volumio[8977]: errno: 'ETIMEDOUT', Jul 24 12:22:25 volumio volumio[8977]: syscall: 'connect', Jul 24 12:22:25 volumio volumio[8977]: address: '157.240.15.8', Jul 24 12:22:25 volumio volumio[8977]: port: 443 } Jul 24 12:22:25 volumio volumio[8977]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 24 12:22:26 volumio sudo[10034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-24 12:21 Jul 24 12:22:26 volumio sudo[10034]: 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Oct 1 11:49:13 CEST 2021" VOLUMIO_VERSION="2.916" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="62511ec23417b6085328d5bda7373a0c"