-- Logs begin at Sat 2025-03-15 21:14:52 CST, end at Sat 2025-03-15 21:25:12 CST. -- Mar 15 21:24:01 volumio volumio[697]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 15 Mar 15 21:24:02 volumio volumio[697]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 16 Mar 15 21:24:02 volumio volumio[697]: info: CoreCommandRouter::volumioGetState Mar 15 21:24:02 volumio volumio[697]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%8A%A0%E8%97%A4%E7%99%BB%E7%B4%80%E5%AD%90/%E7%B4%85%E3%81%AE%E8%B1%9A%20%E3%82%B5%E3%82%A6%E3%83%B3%E3%83%89%E3%83%88%E3%83%A9%E3%83%83%E3%82%AF/49e25d1a-d88d-46de-8183-88d3ecd6210c.jpg' Mar 15 21:24:18 volumio volumio[697]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 15 Mar 15 21:24:20 volumio volumio[697]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 16 Mar 15 21:24:20 volumio volumio[697]: info: CoreCommandRouter::volumioGetState Mar 15 21:24:20 volumio volumio[697]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%8A%A0%E8%97%A4%E7%99%BB%E7%B4%80%E5%AD%90/%E7%B4%85%E3%81%AE%E8%B1%9A%20%E3%82%B5%E3%82%A6%E3%83%B3%E3%83%89%E3%83%88%E3%83%A9%E3%83%83%E3%82%AF/49e25d1a-d88d-46de-8183-88d3ecd6210c.jpg' Mar 15 21:24:21 volumio volumio[697]: info: Mar 15 21:24:21 volumio volumio[697]: ---------------------------- MPD announces state update: player Mar 15 21:24:21 volumio volumio[697]: info: ControllerMpd::getState Mar 15 21:24:21 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand status Mar 15 21:24:21 volumio volumio[697]: info: Mar 15 21:24:21 volumio volumio[697]: ---------------------------- MPD announces state update: player Mar 15 21:24:21 volumio volumio[697]: info: ControllerMpd::getState Mar 15 21:24:21 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand status Mar 15 21:24:21 volumio volumio[697]: info: Mar 15 21:24:21 volumio volumio[697]: ---------------------------- MPD announces state update: player Mar 15 21:24:21 volumio volumio[697]: info: ControllerMpd::getState Mar 15 21:24:21 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand status Mar 15 21:24:21 volumio volumio[697]: info: Mar 15 21:24:21 volumio volumio[697]: ---------------------------- MPD announces state update: player Mar 15 21:24:21 volumio volumio[697]: info: ControllerMpd::getState Mar 15 21:24:21 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand status Mar 15 21:24:21 volumio volumio[697]: info: sendMpdCommand status took 3 milliseconds Mar 15 21:24:21 volumio volumio[697]: info: sendMpdCommand status took 3 milliseconds Mar 15 21:24:21 volumio volumio[697]: info: sendMpdCommand status took 2 milliseconds Mar 15 21:24:21 volumio volumio[697]: verbose: ControllerMpd::parseState Mar 15 21:24:21 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 21:24:21 volumio volumio[697]: verbose: ControllerMpd::parseState Mar 15 21:24:21 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 21:24:21 volumio volumio[697]: verbose: ControllerMpd::parseState Mar 15 21:24:21 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 21:24:21 volumio volumio[697]: info: sendMpdCommand status took 3 milliseconds Mar 15 21:24:21 volumio volumio[697]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 15 21:24:21 volumio volumio[697]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 15 21:24:21 volumio volumio[697]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 15 21:24:21 volumio volumio[697]: verbose: ControllerMpd::parseState Mar 15 21:24:21 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 21:24:21 volumio volumio[697]: verbose: ControllerMpd::parseTrackInfo Mar 15 21:24:21 volumio volumio[697]: verbose: ControllerMpd::parseTrackInfo Mar 15 21:24:21 volumio volumio[697]: verbose: ControllerMpd::parseTrackInfo Mar 15 21:24:21 volumio volumio[697]: info: ControllerMpd::pushState Mar 15 21:24:21 volumio volumio[697]: info: CoreCommandRouter::servicePushState Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::pushState Mar 15 21:24:21 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:21 volumio volumio[697]: info: CorePlayQueue::getTrack 0 Mar 15 21:24:21 volumio volumio[697]: 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://m801.music.126.net/20250315214804/e8d8704c174cb9e7e015feb0bbcc2117/jdyyaac/525e/0409/0008/e4c6b28e143c84aff0377be7b5b36a9e.m4a?vuutv=xdavsnrnxFT3K97GNDCGQzzfwWePcA7zWzIM5YsORaKWg4SUa1f63rY0aRuEibGnDVFh1pzpx7RH6JWnCxYzSDfGZSMTa62lYErVqRNsC+Y=","trackType":""} Mar 15 21:24:21 volumio volumio[697]: verbose: CURRENT POSITION 0 Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::syncState stateService stop Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::syncState currentStatus play Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::play index undefined Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::pushState Mar 15 21:24:21 volumio volumio[697]: info: CorePlayQueue::getTrack 0 Mar 15 21:24:21 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 15 21:24:21 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:21 volumio volumio[697]: info: ControllerMpd::pushState Mar 15 21:24:21 volumio volumio[697]: info: CoreCommandRouter::servicePushState Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::pushState Mar 15 21:24:21 volumio volumio[697]: info: CorePlayQueue::getTrack 0 Mar 15 21:24:21 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:21 volumio volumio[697]: info: CorePlayQueue::getTrack 0 Mar 15 21:24:21 volumio volumio[697]: 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://m801.music.126.net/20250315214804/e8d8704c174cb9e7e015feb0bbcc2117/jdyyaac/525e/0409/0008/e4c6b28e143c84aff0377be7b5b36a9e.m4a?vuutv=xdavsnrnxFT3K97GNDCGQzzfwWePcA7zWzIM5YsORaKWg4SUa1f63rY0aRuEibGnDVFh1pzpx7RH6JWnCxYzSDfGZSMTa62lYErVqRNsC+Y=","trackType":""} Mar 15 21:24:21 volumio volumio[697]: verbose: CURRENT POSITION 0 Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::syncState stateService stop Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::syncState currentStatus stop Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::pushState Mar 15 21:24:21 volumio volumio[697]: info: CorePlayQueue::getTrack 0 Mar 15 21:24:21 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:21 volumio volumio[697]: info: No code Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::pushState Mar 15 21:24:21 volumio volumio[697]: info: CorePlayQueue::getTrack 0 Mar 15 21:24:21 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:21 volumio volumio[697]: info: ControllerMpd::pushState Mar 15 21:24:21 volumio volumio[697]: info: CoreCommandRouter::servicePushState Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::pushState Mar 15 21:24:21 volumio volumio[697]: info: CorePlayQueue::getTrack 0 Mar 15 21:24:21 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:21 volumio volumio[697]: info: CorePlayQueue::getTrack 0 Mar 15 21:24:21 volumio volumio[697]: 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://m801.music.126.net/20250315214804/e8d8704c174cb9e7e015feb0bbcc2117/jdyyaac/525e/0409/0008/e4c6b28e143c84aff0377be7b5b36a9e.m4a?vuutv=xdavsnrnxFT3K97GNDCGQzzfwWePcA7zWzIM5YsORaKWg4SUa1f63rY0aRuEibGnDVFh1pzpx7RH6JWnCxYzSDfGZSMTa62lYErVqRNsC+Y=","trackType":""} Mar 15 21:24:21 volumio volumio[697]: verbose: CURRENT POSITION 0 Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::syncState stateService stop Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::syncState currentStatus stop Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::pushState Mar 15 21:24:21 volumio volumio[697]: info: CorePlayQueue::getTrack 0 Mar 15 21:24:21 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:21 volumio volumio[697]: info: No code Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::pushState Mar 15 21:24:21 volumio volumio[697]: info: CorePlayQueue::getTrack 0 Mar 15 21:24:21 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:21 volumio volumio[697]: info: CorePlayQueue::getTrack 0 Mar 15 21:24:21 volumio volumio[697]: info: ------------------------------ 61ms Mar 15 21:24:21 volumio volumio[697]: info: ------------------------------ 60ms Mar 15 21:24:21 volumio volumio[697]: info: sendMpdCommand playlistinfo took 56 milliseconds Mar 15 21:24:21 volumio volumio[697]: verbose: ControllerMpd::parseTrackInfo Mar 15 21:24:21 volumio volumio[697]: info: ControllerMpd::pushState Mar 15 21:24:21 volumio volumio[697]: info: CoreCommandRouter::servicePushState Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::pushState Mar 15 21:24:21 volumio volumio[697]: info: CorePlayQueue::getTrack 0 Mar 15 21:24:21 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:21 volumio volumio[697]: info: CorePlayQueue::getTrack 0 Mar 15 21:24:21 volumio volumio[697]: 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://m801.music.126.net/20250315214804/e8d8704c174cb9e7e015feb0bbcc2117/jdyyaac/525e/0409/0008/e4c6b28e143c84aff0377be7b5b36a9e.m4a?vuutv=xdavsnrnxFT3K97GNDCGQzzfwWePcA7zWzIM5YsORaKWg4SUa1f63rY0aRuEibGnDVFh1pzpx7RH6JWnCxYzSDfGZSMTa62lYErVqRNsC+Y=","trackType":""} Mar 15 21:24:21 volumio volumio[697]: verbose: CURRENT POSITION 0 Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::syncState stateService stop Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::syncState currentStatus stop Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::pushState Mar 15 21:24:21 volumio volumio[697]: info: CorePlayQueue::getTrack 0 Mar 15 21:24:21 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:21 volumio volumio[697]: info: No code Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::pushState Mar 15 21:24:21 volumio volumio[697]: info: CorePlayQueue::getTrack 0 Mar 15 21:24:21 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:21 volumio volumio[697]: info: ------------------------------ 81ms Mar 15 21:24:21 volumio volumio[697]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::getQueue Mar 15 21:24:21 volumio volumio[697]: info: CorePlayQueue::getQueue Mar 15 21:24:21 volumio volumio[697]: info: Clearing queue after UPNP request Mar 15 21:24:21 volumio sudo[3514]: pam_unix(sudo:session): session closed for user root Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::ClearQueue Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::stop Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 15 21:24:21 volumio volumio[697]: info: CorePlayQueue::clearPlayQueue Mar 15 21:24:21 volumio volumio[697]: info: CorePlayQueue::saveQueue Mar 15 21:24:21 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:21 volumio volumio[697]: info: CoreCommandRouter::volumioPushQueue Mar 15 21:24:21 volumio volumio[697]: info: Mar 15 21:24:21 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:21 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:21 volumio volumio[697]: info: Mar 15 21:24:21 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:21 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:21 volumio volumio[697]: info: Mar 15 21:24:21 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:21 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:21 volumio volumio[697]: info: Mar 15 21:24:21 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:21 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:21 volumio volumio[697]: error: updateQueue error: null Mar 15 21:24:21 volumio volumio[697]: error: updateQueue error: null Mar 15 21:24:21 volumio volumio[697]: error: updateQueue error: null Mar 15 21:24:21 volumio volumio[697]: error: updateQueue error: null Mar 15 21:24:21 volumio volumio[697]: info: ------------------------------ 4ms Mar 15 21:24:21 volumio volumio[697]: info: ------------------------------ 3ms Mar 15 21:24:21 volumio volumio[697]: info: ------------------------------ 2ms Mar 15 21:24:21 volumio volumio[697]: info: ------------------------------ 2ms Mar 15 21:24:21 volumio volumio[697]: info: Starting UPNP Playback Mar 15 21:24:21 volumio volumio[697]: info: Preparing playback through UPNP Mar 15 21:24:21 volumio volumio[697]: info: CoreCommandRouter::volumioGetState Mar 15 21:24:21 volumio volumio[697]: info: CorePlayQueue::getTrack 0 Mar 15 21:24:21 volumio volumio[697]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:22 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:22 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:22 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:22 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 4ms Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 3ms Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 3ms Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 2ms Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:22 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:22 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:22 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:22 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 4ms Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 3ms Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 2ms Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 2ms Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:22 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:22 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:22 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 3ms Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 2ms Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:22 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:22 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 2ms Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 2ms Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:22 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:22 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:22 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 3ms Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 2ms Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 1ms Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:22 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:22 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:22 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 3ms Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 2ms Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 1ms Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:22 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:22 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 1ms Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 2ms Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:22 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:22 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces system playlist update Mar 15 21:24:22 volumio volumio[697]: info: Ignoring MPD Status Update Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 5ms Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 5ms Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 5ms Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces state update: player Mar 15 21:24:22 volumio volumio[697]: info: ControllerMpd::getState Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand status Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces state update: player Mar 15 21:24:22 volumio volumio[697]: info: ControllerMpd::getState Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand status Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces state update: player Mar 15 21:24:22 volumio volumio[697]: info: ControllerMpd::getState Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand status Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces state update: player Mar 15 21:24:22 volumio volumio[697]: info: ControllerMpd::getState Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand status Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces state update: player Mar 15 21:24:22 volumio volumio[697]: info: sendMpdCommand status took 10 milliseconds Mar 15 21:24:22 volumio volumio[697]: info: ControllerMpd::getState Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand status Mar 15 21:24:22 volumio volumio[697]: info: sendMpdCommand status took 9 milliseconds Mar 15 21:24:22 volumio volumio[697]: info: sendMpdCommand status took 8 milliseconds Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::parseState Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::parseState Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::parseState Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces state update: player Mar 15 21:24:22 volumio volumio[697]: info: ControllerMpd::getState Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand status Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces state update: player Mar 15 21:24:22 volumio volumio[697]: info: ControllerMpd::getState Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand status Mar 15 21:24:22 volumio volumio[697]: info: Mar 15 21:24:22 volumio volumio[697]: ---------------------------- MPD announces state update: player Mar 15 21:24:22 volumio volumio[697]: info: ControllerMpd::getState Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand status Mar 15 21:24:22 volumio volumio[697]: info: sendMpdCommand status took 8 milliseconds Mar 15 21:24:22 volumio volumio[697]: info: sendMpdCommand status took 6 milliseconds Mar 15 21:24:22 volumio volumio[697]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 15 21:24:22 volumio volumio[697]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 15 21:24:22 volumio volumio[697]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 15 21:24:22 volumio volumio[697]: info: sendMpdCommand status took 5 milliseconds Mar 15 21:24:22 volumio volumio[697]: info: sendMpdCommand status took 3 milliseconds Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::parseState Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::parseState Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::parseTrackInfo Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::parseTrackInfo Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::parseTrackInfo Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::parseState Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::parseState Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 21:24:22 volumio volumio[697]: info: ControllerMpd::pushState Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::servicePushState Mar 15 21:24:22 volumio volumio[697]: verbose: In UPNP mode Mar 15 21:24:22 volumio volumio[697]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":127,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"疾走する魂","artist":"佐藤直紀","album":"交响诗篇エウレカセブン O.S.T 2","uri":"http://m701.music.126.net/20250315214921/da9dc1df0dedc608455918e56ba1e463/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/36025045562/4762/d3ea/94f7/497505cc9794c86d96b2482caa64f823.m4a?vuutv=zDK/tLZksRqhKDFEUO60+BUUIcrAKOOkbd2SNNCZ0yArTBRT6mzMn4jg40hgHKQEYZkKstWuGSv4x7CsDEj4stbjJZ6F50BGmgixSbeW1XA=","trackType":""} Mar 15 21:24:22 volumio volumio[697]: verbose: CURRENT POSITION 0 Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::syncState stateService play Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::syncState currentStatus stop Mar 15 21:24:22 volumio volumio[697]: info: ControllerMpd::pushState Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::servicePushState Mar 15 21:24:22 volumio volumio[697]: verbose: In UPNP mode Mar 15 21:24:22 volumio volumio[697]: verbose: STATE SERVICE {"status":"play","position":0,"seek":79,"duration":127,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"疾走する魂","artist":"佐藤直紀","album":"交响诗篇エウレカセブン O.S.T 2","uri":"http://m701.music.126.net/20250315214921/da9dc1df0dedc608455918e56ba1e463/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/36025045562/4762/d3ea/94f7/497505cc9794c86d96b2482caa64f823.m4a?vuutv=zDK/tLZksRqhKDFEUO60+BUUIcrAKOOkbd2SNNCZ0yArTBRT6mzMn4jg40hgHKQEYZkKstWuGSv4x7CsDEj4stbjJZ6F50BGmgixSbeW1XA=","trackType":""} Mar 15 21:24:22 volumio volumio[697]: verbose: CURRENT POSITION 0 Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::syncState stateService play Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::syncState currentStatus play Mar 15 21:24:22 volumio volumio[697]: info: Received an update from plugin. extracting info from payload Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::pushState Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::pushState Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:22 volumio volumio[697]: info: ControllerMpd::pushState Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::servicePushState Mar 15 21:24:22 volumio volumio[697]: verbose: In UPNP mode Mar 15 21:24:22 volumio volumio[697]: verbose: STATE SERVICE {"status":"play","position":0,"seek":148,"duration":127,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"疾走する魂","artist":"佐藤直紀","album":"交响诗篇エウレカセブン O.S.T 2","uri":"http://m701.music.126.net/20250315214921/da9dc1df0dedc608455918e56ba1e463/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/36025045562/4762/d3ea/94f7/497505cc9794c86d96b2482caa64f823.m4a?vuutv=zDK/tLZksRqhKDFEUO60+BUUIcrAKOOkbd2SNNCZ0yArTBRT6mzMn4jg40hgHKQEYZkKstWuGSv4x7CsDEj4stbjJZ6F50BGmgixSbeW1XA=","trackType":""} Mar 15 21:24:22 volumio volumio[697]: verbose: CURRENT POSITION 0 Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::syncState stateService play Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::syncState currentStatus play Mar 15 21:24:22 volumio volumio[697]: info: Received an update from plugin. extracting info from payload Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::pushState Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::pushState Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 30ms Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 39ms Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 37ms Mar 15 21:24:22 volumio volumio[697]: info: sendMpdCommand status took 25 milliseconds Mar 15 21:24:22 volumio volumio[697]: info: sendMpdCommand playlistinfo took 23 milliseconds Mar 15 21:24:22 volumio volumio[697]: info: sendMpdCommand playlistinfo took 23 milliseconds Mar 15 21:24:22 volumio volumio[697]: info: sendMpdCommand playlistinfo took 22 milliseconds Mar 15 21:24:22 volumio volumio[697]: info: sendMpdCommand playlistinfo took 22 milliseconds Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::parseState Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::parseTrackInfo Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::parseTrackInfo Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::parseTrackInfo Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::parseTrackInfo Mar 15 21:24:22 volumio volumio[697]: info: ControllerMpd::pushState Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::servicePushState Mar 15 21:24:22 volumio volumio[697]: verbose: In UPNP mode Mar 15 21:24:22 volumio volumio[697]: verbose: STATE SERVICE {"status":"play","position":0,"seek":330,"duration":127,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"疾走する魂","artist":"佐藤直紀","album":"交响诗篇エウレカセブン O.S.T 2","uri":"http://m701.music.126.net/20250315214921/da9dc1df0dedc608455918e56ba1e463/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/36025045562/4762/d3ea/94f7/497505cc9794c86d96b2482caa64f823.m4a?vuutv=zDK/tLZksRqhKDFEUO60+BUUIcrAKOOkbd2SNNCZ0yArTBRT6mzMn4jg40hgHKQEYZkKstWuGSv4x7CsDEj4stbjJZ6F50BGmgixSbeW1XA=","trackType":""} Mar 15 21:24:22 volumio volumio[697]: verbose: CURRENT POSITION 0 Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::syncState stateService play Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::syncState currentStatus play Mar 15 21:24:22 volumio volumio[697]: info: Received an update from plugin. extracting info from payload Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::pushState Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::pushState Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:22 volumio volumio[697]: info: ControllerMpd::pushState Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::servicePushState Mar 15 21:24:22 volumio volumio[697]: verbose: In UPNP mode Mar 15 21:24:22 volumio volumio[697]: verbose: STATE SERVICE {"status":"play","position":0,"seek":432,"duration":127,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"疾走する魂","artist":"佐藤直紀","album":"交响诗篇エウレカセブン O.S.T 2","uri":"http://m701.music.126.net/20250315214921/da9dc1df0dedc608455918e56ba1e463/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/36025045562/4762/d3ea/94f7/497505cc9794c86d96b2482caa64f823.m4a?vuutv=zDK/tLZksRqhKDFEUO60+BUUIcrAKOOkbd2SNNCZ0yArTBRT6mzMn4jg40hgHKQEYZkKstWuGSv4x7CsDEj4stbjJZ6F50BGmgixSbeW1XA=","trackType":""} Mar 15 21:24:22 volumio volumio[697]: verbose: CURRENT POSITION 0 Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::syncState stateService play Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::syncState currentStatus play Mar 15 21:24:22 volumio volumio[697]: info: Received an update from plugin. extracting info from payload Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::pushState Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::pushState Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:22 volumio volumio[697]: info: ControllerMpd::pushState Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::servicePushState Mar 15 21:24:22 volumio volumio[697]: verbose: In UPNP mode Mar 15 21:24:22 volumio volumio[697]: verbose: STATE SERVICE {"status":"play","position":0,"seek":478,"duration":127,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"疾走する魂","artist":"佐藤直紀","album":"交响诗篇エウレカセブン O.S.T 2","uri":"http://m701.music.126.net/20250315214921/da9dc1df0dedc608455918e56ba1e463/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/36025045562/4762/d3ea/94f7/497505cc9794c86d96b2482caa64f823.m4a?vuutv=zDK/tLZksRqhKDFEUO60+BUUIcrAKOOkbd2SNNCZ0yArTBRT6mzMn4jg40hgHKQEYZkKstWuGSv4x7CsDEj4stbjJZ6F50BGmgixSbeW1XA=","trackType":""} Mar 15 21:24:22 volumio volumio[697]: verbose: CURRENT POSITION 0 Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::syncState stateService play Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::syncState currentStatus play Mar 15 21:24:22 volumio volumio[697]: info: Received an update from plugin. extracting info from payload Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::pushState Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::pushState Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:22 volumio volumio[697]: info: ControllerMpd::pushState Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::servicePushState Mar 15 21:24:22 volumio volumio[697]: verbose: In UPNP mode Mar 15 21:24:22 volumio volumio[697]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":127,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"疾走する魂","artist":"佐藤直紀","album":"交响诗篇エウレカセブン O.S.T 2","uri":"http://m701.music.126.net/20250315214921/da9dc1df0dedc608455918e56ba1e463/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/36025045562/4762/d3ea/94f7/497505cc9794c86d96b2482caa64f823.m4a?vuutv=zDK/tLZksRqhKDFEUO60+BUUIcrAKOOkbd2SNNCZ0yArTBRT6mzMn4jg40hgHKQEYZkKstWuGSv4x7CsDEj4stbjJZ6F50BGmgixSbeW1XA=","trackType":""} Mar 15 21:24:22 volumio volumio[697]: verbose: CURRENT POSITION 0 Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::syncState stateService play Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::syncState currentStatus play Mar 15 21:24:22 volumio volumio[697]: info: Received an update from plugin. extracting info from payload Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::pushState Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::pushState Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 69ms Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 63ms Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 61ms Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 61ms Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CorePlayQueue::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CorePlayQueue::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CorePlayQueue::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CorePlayQueue::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CorePlayQueue::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CorePlayQueue::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CorePlayQueue::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CorePlayQueue::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CorePlayQueue::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CorePlayQueue::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CorePlayQueue::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CorePlayQueue::getQueue Mar 15 21:24:22 volumio volumio[697]: info: sendMpdCommand playlistinfo took 74 milliseconds Mar 15 21:24:22 volumio volumio[697]: verbose: ControllerMpd::parseTrackInfo Mar 15 21:24:22 volumio volumio[697]: info: ControllerMpd::pushState Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::servicePushState Mar 15 21:24:22 volumio volumio[697]: verbose: In UPNP mode Mar 15 21:24:22 volumio volumio[697]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":127,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"疾走する魂","artist":"佐藤直紀","album":"交响诗篇エウレカセブン O.S.T 2","uri":"http://m701.music.126.net/20250315214921/da9dc1df0dedc608455918e56ba1e463/jdyyaac/obj/w5rDlsOJwrLDjj7CmsOj/36025045562/4762/d3ea/94f7/497505cc9794c86d96b2482caa64f823.m4a?vuutv=zDK/tLZksRqhKDFEUO60+BUUIcrAKOOkbd2SNNCZ0yArTBRT6mzMn4jg40hgHKQEYZkKstWuGSv4x7CsDEj4stbjJZ6F50BGmgixSbeW1XA=","trackType":""} Mar 15 21:24:22 volumio volumio[697]: verbose: CURRENT POSITION 0 Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::syncState stateService play Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::syncState currentStatus play Mar 15 21:24:22 volumio volumio[697]: info: Received an update from plugin. extracting info from payload Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::pushState Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::pushState Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioPushState Mar 15 21:24:22 volumio volumio[697]: info: ------------------------------ 112ms Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CorePlayQueue::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreCommandRouter::volumioGetQueue Mar 15 21:24:22 volumio volumio[697]: info: CoreStateMachine::getQueue Mar 15 21:24:22 volumio volumio[697]: info: CorePlayQueue::getQueue Mar 15 21:24:32 volumio volumio[697]: info: CoreCommandRouter::volumioGetState Mar 15 21:24:32 volumio sudo[3945]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Mar 15 21:24:32 volumio sudo[3945]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 15 21:24:34 volumio volumio[697]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 9 Mar 15 21:24:35 volumio volumio[697]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 10 Mar 15 21:24:35 volumio volumio[697]: info: CoreCommandRouter::volumioGetState Mar 15 21:24:50 volumio volumio[697]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 11 Mar 15 21:24:50 volumio volumio[697]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 12 Mar 15 21:24:50 volumio volumio[697]: info: CoreCommandRouter::volumioGetState Mar 15 21:25:06 volumio volumio[697]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 13 Mar 15 21:25:08 volumio volumio[697]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 14 Mar 15 21:25:08 volumio volumio[697]: info: CoreCommandRouter::volumioGetState Mar 15 21:25:12 volumio volumio[697]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 15 21:25:12 volumio volumio[697]: Error: connect ETIMEDOUT 65.49.26.97:443 Mar 15 21:25:12 volumio volumio[697]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Mar 15 21:25:12 volumio volumio[697]: errno: -110, Mar 15 21:25:12 volumio volumio[697]: code: 'ETIMEDOUT', Mar 15 21:25:12 volumio volumio[697]: syscall: 'connect', Mar 15 21:25:12 volumio volumio[697]: address: '65.49.26.97', Mar 15 21:25:12 volumio volumio[697]: port: 443 Mar 15 21:25:12 volumio volumio[697]: } Mar 15 21:25:12 volumio volumio[697]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 15 21:25:12 volumio sudo[4172]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-15 21:24 Mar 15 21:25:12 volumio sudo[4172]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:42:03 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="c434411fe8754b648dc7feb1d8f43761"