-- Logs begin at Sun 2024-10-13 08:55:19 CST, end at Sun 2024-10-13 18:02:59 CST. -- Oct 13 18:01:08 volumio volumio[971]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8 Oct 13 18:01:08 volumio volumio[971]: info: CoreCommandRouter::volumioGetState Oct 13 18:01:08 volumio volumio[971]: info: CorePlayQueue::getTrack 0 Oct 13 18:01:10 volumio volumio[971]: info: CoreCommandRouter::volumioGetState Oct 13 18:01:10 volumio volumio[971]: info: CorePlayQueue::getTrack 0 Oct 13 18:01:12 volumio volumio[971]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 13 18:01:12 volumio volumio[971]: info: CoreCommandRouter::volumioGetState Oct 13 18:01:12 volumio volumio[971]: info: CorePlayQueue::getTrack 0 Oct 13 18:01:12 volumio volumio[971]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%B5%B5%E9%9B%B7/%E7%BD%B2%E5%89%8D%E8%A1%97%E5%B0%91%E5%B9%B4/718be908-1b13-4b6b-ba1f-b82050a3ad79.jpg' Oct 13 18:01:22 volumio volumio[971]: info: CoreCommandRouter::volumioNext Oct 13 18:01:22 volumio volumio[971]: info: CoreStateMachine::next Oct 13 18:01:22 volumio volumio[971]: info: CoreStateMachine::stop Oct 13 18:01:22 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 13 18:01:22 volumio volumio[971]: info: CoreStateMachine::stPlaybackTimer Oct 13 18:01:22 volumio volumio[971]: info: CoreStateMachine::updateTrackBlock Oct 13 18:01:22 volumio volumio[971]: info: CorePlayQueue::getTrackBlock Oct 13 18:01:22 volumio volumio[971]: info: CoreStateMachine::pushState Oct 13 18:01:22 volumio volumio[971]: info: CorePlayQueue::getTrack 0 Oct 13 18:01:22 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:01:22 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Oct 13 18:01:22 volumio volumio[971]: info: CoreStateMachine::serviceStop Oct 13 18:01:22 volumio volumio[971]: info: CorePlayQueue::getTrack 0 Oct 13 18:01:22 volumio volumio[971]: info: CoreCommandRouter::serviceStop Oct 13 18:01:22 volumio volumio[971]: info: ControllerMpd::stop Oct 13 18:01:22 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand stop Oct 13 18:01:22 volumio volumio[971]: info: Oct 13 18:01:22 volumio volumio[971]: ---------------------------- MPD announces state update: player Oct 13 18:01:22 volumio volumio[971]: info: sendMpdCommand stop took 88 milliseconds Oct 13 18:01:22 volumio volumio[971]: info: ControllerMpd::getState Oct 13 18:01:22 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:01:22 volumio volumio[971]: info: CoreStateMachine::play index undefined Oct 13 18:01:22 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 13 18:01:22 volumio volumio[971]: info: CorePlayQueue::getTrack 1 Oct 13 18:01:22 volumio volumio[971]: info: CoreStateMachine::startPlaybackTimer Oct 13 18:01:22 volumio volumio[971]: info: CorePlayQueue::getTrack 1 Oct 13 18:01:22 volumio volumio[971]: verbose: ControllerMpd::clearAddPlayTracks USB/08B5-4780/朴树 - 平凡之路 (1).flac Oct 13 18:01:22 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand stop Oct 13 18:01:22 volumio volumio[971]: info: CoreStateMachine::updateTrackBlock Oct 13 18:01:22 volumio volumio[971]: info: CorePlayQueue::getTrackBlock Oct 13 18:01:22 volumio volumio[971]: info: sendMpdCommand status took 18 milliseconds Oct 13 18:01:22 volumio volumio[971]: info: sendMpdCommand stop took 13 milliseconds Oct 13 18:01:22 volumio volumio[971]: verbose: ControllerMpd::parseState Oct 13 18:01:22 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:01:22 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand clear Oct 13 18:01:22 volumio volumio[971]: info: Oct 13 18:01:22 volumio volumio[971]: ---------------------------- MPD announces system playlist update Oct 13 18:01:22 volumio volumio[971]: info: Ignoring MPD Status Update Oct 13 18:01:22 volumio volumio[971]: info: sendMpdCommand playlistinfo took 9 milliseconds Oct 13 18:01:22 volumio volumio[971]: info: sendMpdCommand clear took 9 milliseconds Oct 13 18:01:22 volumio volumio[971]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:01:22 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand add "USB/08B5-4780/朴树 - 平凡之路 (1).flac" Oct 13 18:01:22 volumio volumio[971]: info: ControllerMpd::pushState Oct 13 18:01:22 volumio volumio[971]: info: CoreCommandRouter::servicePushState Oct 13 18:01:22 volumio volumio[971]: info: CoreStateMachine::pushState Oct 13 18:01:22 volumio volumio[971]: info: CorePlayQueue::getTrack 1 Oct 13 18:01:22 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:01:22 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Oct 13 18:01:22 volumio volumio[971]: info: CorePlayQueue::getTrack 1 Oct 13 18:01:22 volumio volumio[971]: 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":"USB/08B5-4780/刘晓超 - 偷了黄昏的酒.flac","trackType":"flac"} Oct 13 18:01:22 volumio volumio[971]: verbose: CURRENT POSITION 1 Oct 13 18:01:22 volumio volumio[971]: info: CoreStateMachine::syncState stateService stop Oct 13 18:01:22 volumio volumio[971]: info: CoreStateMachine::syncState currentStatus stop Oct 13 18:01:22 volumio volumio[971]: info: CoreStateMachine::pushState Oct 13 18:01:22 volumio volumio[971]: info: CorePlayQueue::getTrack 1 Oct 13 18:01:22 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Oct 13 18:01:22 volumio volumio[971]: info: No code Oct 13 18:01:22 volumio volumio[971]: info: CoreStateMachine::pushState Oct 13 18:01:22 volumio volumio[971]: info: CorePlayQueue::getTrack 1 Oct 13 18:01:22 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Oct 13 18:01:22 volumio volumio[971]: info: ------------------------------ 143ms Oct 13 18:01:22 volumio volumio[971]: info: touch_display: Setting screensaver timeout to 999999999999999 seconds. Oct 13 18:01:22 volumio volumio[971]: error: updateQueue error: null Oct 13 18:01:22 volumio volumio[971]: info: Oct 13 18:01:22 volumio volumio[971]: ---------------------------- MPD announces system playlist update Oct 13 18:01:22 volumio volumio[971]: info: Ignoring MPD Status Update Oct 13 18:01:22 volumio volumio[971]: info: ------------------------------ 128ms Oct 13 18:01:22 volumio volumio[971]: info: sendMpdCommand add "USB/08B5-4780/朴树 - 平凡之路 (1).flac" took 126 milliseconds Oct 13 18:01:22 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand play Oct 13 18:01:22 volumio volumio[971]: info: Oct 13 18:01:22 volumio volumio[971]: ---------------------------- MPD announces state update: player Oct 13 18:01:22 volumio volumio[971]: info: ------------------------------ 111ms Oct 13 18:01:22 volumio volumio[971]: info: sendMpdCommand play took 107 milliseconds Oct 13 18:01:22 volumio volumio[971]: info: ControllerMpd::getState Oct 13 18:01:22 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:01:22 volumio volumio[971]: info: Oct 13 18:01:22 volumio volumio[971]: ---------------------------- MPD announces state update: player Oct 13 18:01:22 volumio volumio[971]: info: ControllerMpd::getState Oct 13 18:01:22 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:01:22 volumio volumio[971]: info: sendMpdCommand status took 14 milliseconds Oct 13 18:01:22 volumio volumio[971]: verbose: ControllerMpd::parseState Oct 13 18:01:22 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:01:22 volumio volumio[971]: info: sendMpdCommand status took 58 milliseconds Oct 13 18:01:22 volumio volumio[971]: info: sendMpdCommand playlistinfo took 56 milliseconds Oct 13 18:01:22 volumio volumio[971]: verbose: ControllerMpd::parseState Oct 13 18:01:22 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:01:22 volumio volumio[971]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:01:22 volumio volumio[971]: info: ControllerMpd::pushState Oct 13 18:01:22 volumio volumio[971]: info: CoreCommandRouter::servicePushState Oct 13 18:01:22 volumio volumio[971]: info: CorePlayQueue::getTrack 1 Oct 13 18:01:22 volumio volumio[971]: verbose: STATE SERVICE {"status":"play","position":0,"seek":417,"duration":301,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3967 Kbps","isStreaming":false,"title":"平凡之路","artist":"朴树","album":"猎户星座","uri":"USB/08B5-4780/朴树 - 平凡之路 (1).flac","trackType":"flac"} Oct 13 18:01:22 volumio volumio[971]: verbose: CURRENT POSITION 1 Oct 13 18:01:22 volumio volumio[971]: info: CoreStateMachine::syncState stateService play Oct 13 18:01:22 volumio volumio[971]: info: CoreStateMachine::syncState currentStatus stop Oct 13 18:01:22 volumio volumio[971]: info: ------------------------------ 81ms Oct 13 18:01:22 volumio volumio[971]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9C%B4%E6%A0%91/%E7%8C%8E%E6%88%B7%E6%98%9F%E5%BA%A7/88437068-6f94-4273-8a75-6916acd8606d.jpg' Oct 13 18:01:22 volumio volumio[971]: info: sendMpdCommand playlistinfo took 10 milliseconds Oct 13 18:01:22 volumio volumio[971]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:01:22 volumio volumio[971]: info: ControllerMpd::pushState Oct 13 18:01:22 volumio volumio[971]: info: CoreCommandRouter::servicePushState Oct 13 18:01:22 volumio volumio[971]: info: CorePlayQueue::getTrack 1 Oct 13 18:01:22 volumio volumio[971]: verbose: STATE SERVICE {"status":"play","position":0,"seek":674,"duration":301,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4239 Kbps","isStreaming":false,"title":"平凡之路","artist":"朴树","album":"猎户星座","uri":"USB/08B5-4780/朴树 - 平凡之路 (1).flac","trackType":"flac"} Oct 13 18:01:22 volumio volumio[971]: verbose: CURRENT POSITION 1 Oct 13 18:01:22 volumio volumio[971]: info: CoreStateMachine::syncState stateService play Oct 13 18:01:22 volumio volumio[971]: info: CoreStateMachine::syncState currentStatus play Oct 13 18:01:22 volumio volumio[971]: info: Received an update from plugin. extracting info from payload Oct 13 18:01:22 volumio volumio[971]: info: CoreStateMachine::pushState Oct 13 18:01:22 volumio volumio[971]: info: CorePlayQueue::getTrack 1 Oct 13 18:01:22 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:01:22 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Oct 13 18:01:23 volumio volumio[971]: info: CoreStateMachine::pushState Oct 13 18:01:23 volumio volumio[971]: info: CorePlayQueue::getTrack 1 Oct 13 18:01:23 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Oct 13 18:01:23 volumio volumio[971]: info: ------------------------------ 145ms Oct 13 18:01:25 volumio volumio[971]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 13 18:01:25 volumio volumio[971]: info: CoreCommandRouter::volumioGetState Oct 13 18:01:25 volumio volumio[971]: info: CorePlayQueue::getTrack 1 Oct 13 18:01:25 volumio volumio[971]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9C%B4%E6%A0%91/%E7%8C%8E%E6%88%B7%E6%98%9F%E5%BA%A7/88437068-6f94-4273-8a75-6916acd8606d.jpg' Oct 13 18:02:44 volumio volumio[971]: info: CoreCommandRouter::volumioNext Oct 13 18:02:44 volumio volumio[971]: info: CoreStateMachine::next Oct 13 18:02:44 volumio volumio[971]: info: CoreStateMachine::stop Oct 13 18:02:44 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 13 18:02:44 volumio volumio[971]: info: CoreStateMachine::stPlaybackTimer Oct 13 18:02:44 volumio volumio[971]: info: CoreStateMachine::updateTrackBlock Oct 13 18:02:44 volumio volumio[971]: info: CorePlayQueue::getTrackBlock Oct 13 18:02:44 volumio volumio[971]: info: CoreStateMachine::pushState Oct 13 18:02:44 volumio volumio[971]: info: CorePlayQueue::getTrack 1 Oct 13 18:02:44 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:02:44 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Oct 13 18:02:44 volumio volumio[971]: info: CoreStateMachine::serviceStop Oct 13 18:02:44 volumio volumio[971]: info: CorePlayQueue::getTrack 1 Oct 13 18:02:44 volumio volumio[971]: info: CoreCommandRouter::serviceStop Oct 13 18:02:44 volumio volumio[971]: info: ControllerMpd::stop Oct 13 18:02:44 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand stop Oct 13 18:02:45 volumio volumio[971]: info: Oct 13 18:02:45 volumio volumio[971]: ---------------------------- MPD announces state update: player Oct 13 18:02:45 volumio volumio[971]: info: sendMpdCommand stop took 87 milliseconds Oct 13 18:02:45 volumio volumio[971]: info: ControllerMpd::getState Oct 13 18:02:45 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:02:45 volumio volumio[971]: info: CoreStateMachine::play index undefined Oct 13 18:02:45 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 13 18:02:45 volumio volumio[971]: info: CorePlayQueue::getTrack 2 Oct 13 18:02:45 volumio volumio[971]: info: CoreStateMachine::startPlaybackTimer Oct 13 18:02:45 volumio volumio[971]: info: CorePlayQueue::getTrack 2 Oct 13 18:02:45 volumio volumio[971]: verbose: ControllerMpd::clearAddPlayTracks USB/08B5-4780/何炫丽 - 烟雨唱扬州.flac Oct 13 18:02:45 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand stop Oct 13 18:02:45 volumio volumio[971]: info: CoreStateMachine::updateTrackBlock Oct 13 18:02:45 volumio volumio[971]: info: CorePlayQueue::getTrackBlock Oct 13 18:02:45 volumio volumio[971]: info: sendMpdCommand status took 17 milliseconds Oct 13 18:02:45 volumio volumio[971]: info: sendMpdCommand stop took 13 milliseconds Oct 13 18:02:45 volumio volumio[971]: verbose: ControllerMpd::parseState Oct 13 18:02:45 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:02:45 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand clear Oct 13 18:02:45 volumio volumio[971]: info: Oct 13 18:02:45 volumio volumio[971]: ---------------------------- MPD announces system playlist update Oct 13 18:02:45 volumio volumio[971]: info: Ignoring MPD Status Update Oct 13 18:02:45 volumio volumio[971]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 13 18:02:45 volumio volumio[971]: info: sendMpdCommand clear took 9 milliseconds Oct 13 18:02:45 volumio volumio[971]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:02:45 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand add "USB/08B5-4780/何炫丽 - 烟雨唱扬州.flac" Oct 13 18:02:45 volumio volumio[971]: info: ControllerMpd::pushState Oct 13 18:02:45 volumio volumio[971]: info: CoreCommandRouter::servicePushState Oct 13 18:02:45 volumio volumio[971]: info: CoreStateMachine::pushState Oct 13 18:02:45 volumio volumio[971]: info: CorePlayQueue::getTrack 2 Oct 13 18:02:45 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:02:45 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Oct 13 18:02:45 volumio volumio[971]: info: CorePlayQueue::getTrack 2 Oct 13 18:02:45 volumio volumio[971]: 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":"USB/08B5-4780/朴树 - 平凡之路 (1).flac","trackType":"flac"} Oct 13 18:02:45 volumio volumio[971]: verbose: CURRENT POSITION 2 Oct 13 18:02:45 volumio volumio[971]: info: CoreStateMachine::syncState stateService stop Oct 13 18:02:45 volumio volumio[971]: info: CoreStateMachine::syncState currentStatus stop Oct 13 18:02:45 volumio volumio[971]: info: CoreStateMachine::pushState Oct 13 18:02:45 volumio volumio[971]: info: CorePlayQueue::getTrack 2 Oct 13 18:02:45 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Oct 13 18:02:45 volumio volumio[971]: info: No code Oct 13 18:02:45 volumio volumio[971]: info: CoreStateMachine::pushState Oct 13 18:02:45 volumio volumio[971]: info: CorePlayQueue::getTrack 2 Oct 13 18:02:45 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Oct 13 18:02:45 volumio volumio[971]: info: ------------------------------ 127ms Oct 13 18:02:45 volumio volumio[971]: info: touch_display: Setting screensaver timeout to 999999999999999 seconds. Oct 13 18:02:45 volumio volumio[971]: error: updateQueue error: null Oct 13 18:02:45 volumio volumio[971]: info: Oct 13 18:02:45 volumio volumio[971]: ---------------------------- MPD announces system playlist update Oct 13 18:02:45 volumio volumio[971]: info: Ignoring MPD Status Update Oct 13 18:02:45 volumio volumio[971]: info: ------------------------------ 119ms Oct 13 18:02:45 volumio volumio[971]: info: sendMpdCommand add "USB/08B5-4780/何炫丽 - 烟雨唱扬州.flac" took 114 milliseconds Oct 13 18:02:45 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand play Oct 13 18:02:45 volumio volumio[971]: info: Oct 13 18:02:45 volumio volumio[971]: ---------------------------- MPD announces state update: player Oct 13 18:02:45 volumio volumio[971]: info: ------------------------------ 48ms Oct 13 18:02:45 volumio volumio[971]: info: sendMpdCommand play took 43 milliseconds Oct 13 18:02:45 volumio volumio[971]: info: ControllerMpd::getState Oct 13 18:02:45 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:02:45 volumio volumio[971]: info: Oct 13 18:02:45 volumio volumio[971]: ---------------------------- MPD announces state update: player Oct 13 18:02:45 volumio volumio[971]: info: sendMpdCommand status took 32 milliseconds Oct 13 18:02:45 volumio volumio[971]: info: ControllerMpd::getState Oct 13 18:02:45 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:02:45 volumio volumio[971]: verbose: ControllerMpd::parseState Oct 13 18:02:45 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:02:45 volumio volumio[971]: info: sendMpdCommand status took 41 milliseconds Oct 13 18:02:45 volumio volumio[971]: info: sendMpdCommand playlistinfo took 35 milliseconds Oct 13 18:02:45 volumio volumio[971]: verbose: ControllerMpd::parseState Oct 13 18:02:45 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:02:45 volumio volumio[971]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:02:45 volumio volumio[971]: info: ControllerMpd::pushState Oct 13 18:02:45 volumio volumio[971]: info: CoreCommandRouter::servicePushState Oct 13 18:02:45 volumio volumio[971]: info: CorePlayQueue::getTrack 2 Oct 13 18:02:45 volumio volumio[971]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":240,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"烟雨唱扬州","artist":"何炫丽","album":"烟雨唱扬州","uri":"USB/08B5-4780/何炫丽 - 烟雨唱扬州.flac","trackType":"flac"} Oct 13 18:02:45 volumio volumio[971]: verbose: CURRENT POSITION 2 Oct 13 18:02:45 volumio volumio[971]: info: CoreStateMachine::syncState stateService play Oct 13 18:02:45 volumio volumio[971]: info: CoreStateMachine::syncState currentStatus stop Oct 13 18:02:45 volumio volumio[971]: info: ------------------------------ 107ms Oct 13 18:02:45 volumio volumio[971]: info: sendMpdCommand playlistinfo took 19 milliseconds Oct 13 18:02:45 volumio volumio[971]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:02:45 volumio volumio[971]: info: ControllerMpd::pushState Oct 13 18:02:45 volumio volumio[971]: info: CoreCommandRouter::servicePushState Oct 13 18:02:45 volumio volumio[971]: info: CorePlayQueue::getTrack 2 Oct 13 18:02:45 volumio volumio[971]: verbose: STATE SERVICE {"status":"play","position":0,"seek":543,"duration":240,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2399 Kbps","isStreaming":false,"title":"烟雨唱扬州","artist":"何炫丽","album":"烟雨唱扬州","uri":"USB/08B5-4780/何炫丽 - 烟雨唱扬州.flac","trackType":"flac"} Oct 13 18:02:45 volumio volumio[971]: verbose: CURRENT POSITION 2 Oct 13 18:02:45 volumio volumio[971]: info: CoreStateMachine::syncState stateService play Oct 13 18:02:45 volumio volumio[971]: info: CoreStateMachine::syncState currentStatus play Oct 13 18:02:45 volumio volumio[971]: info: Received an update from plugin. extracting info from payload Oct 13 18:02:45 volumio volumio[971]: info: CoreStateMachine::pushState Oct 13 18:02:45 volumio volumio[971]: info: CorePlayQueue::getTrack 2 Oct 13 18:02:45 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:02:45 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Oct 13 18:02:45 volumio volumio[971]: info: CoreStateMachine::pushState Oct 13 18:02:45 volumio volumio[971]: info: CorePlayQueue::getTrack 2 Oct 13 18:02:45 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Oct 13 18:02:45 volumio volumio[971]: info: ------------------------------ 189ms Oct 13 18:02:47 volumio volumio[971]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 13 18:02:47 volumio volumio[971]: info: CoreCommandRouter::volumioGetState Oct 13 18:02:47 volumio volumio[971]: info: CorePlayQueue::getTrack 2 Oct 13 18:02:50 volumio volumio[971]: info: CoreCommandRouter::volumioNext Oct 13 18:02:50 volumio volumio[971]: info: CoreStateMachine::next Oct 13 18:02:50 volumio volumio[971]: info: CoreStateMachine::stop Oct 13 18:02:50 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 13 18:02:50 volumio volumio[971]: info: CoreStateMachine::stPlaybackTimer Oct 13 18:02:50 volumio volumio[971]: info: CoreStateMachine::updateTrackBlock Oct 13 18:02:50 volumio volumio[971]: info: CorePlayQueue::getTrackBlock Oct 13 18:02:50 volumio volumio[971]: info: CoreStateMachine::pushState Oct 13 18:02:50 volumio volumio[971]: info: CorePlayQueue::getTrack 2 Oct 13 18:02:50 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:02:50 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Oct 13 18:02:50 volumio volumio[971]: info: CoreStateMachine::serviceStop Oct 13 18:02:50 volumio volumio[971]: info: CorePlayQueue::getTrack 2 Oct 13 18:02:50 volumio volumio[971]: info: CoreCommandRouter::serviceStop Oct 13 18:02:50 volumio volumio[971]: info: ControllerMpd::stop Oct 13 18:02:50 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand stop Oct 13 18:02:50 volumio volumio[971]: info: Oct 13 18:02:50 volumio volumio[971]: ---------------------------- MPD announces state update: player Oct 13 18:02:50 volumio volumio[971]: info: sendMpdCommand stop took 30 milliseconds Oct 13 18:02:50 volumio volumio[971]: info: ControllerMpd::getState Oct 13 18:02:50 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:02:50 volumio volumio[971]: info: CoreStateMachine::play index undefined Oct 13 18:02:50 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 13 18:02:50 volumio volumio[971]: info: CorePlayQueue::getTrack 3 Oct 13 18:02:50 volumio volumio[971]: info: CoreStateMachine::startPlaybackTimer Oct 13 18:02:50 volumio volumio[971]: info: CorePlayQueue::getTrack 3 Oct 13 18:02:50 volumio volumio[971]: verbose: ControllerMpd::clearAddPlayTracks USB/08B5-4780/毛不易 - 一荤一素.flac Oct 13 18:02:50 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand stop Oct 13 18:02:50 volumio volumio[971]: info: CoreStateMachine::updateTrackBlock Oct 13 18:02:50 volumio volumio[971]: info: CorePlayQueue::getTrackBlock Oct 13 18:02:50 volumio volumio[971]: info: sendMpdCommand status took 9 milliseconds Oct 13 18:02:50 volumio volumio[971]: info: sendMpdCommand stop took 5 milliseconds Oct 13 18:02:50 volumio volumio[971]: verbose: ControllerMpd::parseState Oct 13 18:02:50 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:02:50 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand clear Oct 13 18:02:50 volumio volumio[971]: info: Oct 13 18:02:50 volumio volumio[971]: ---------------------------- MPD announces system playlist update Oct 13 18:02:50 volumio volumio[971]: info: Ignoring MPD Status Update Oct 13 18:02:50 volumio volumio[971]: info: sendMpdCommand playlistinfo took 55 milliseconds Oct 13 18:02:50 volumio volumio[971]: info: sendMpdCommand clear took 56 milliseconds Oct 13 18:02:50 volumio volumio[971]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:02:50 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand add "USB/08B5-4780/毛不易 - 一荤一素.flac" Oct 13 18:02:50 volumio volumio[971]: info: ControllerMpd::pushState Oct 13 18:02:50 volumio volumio[971]: info: CoreCommandRouter::servicePushState Oct 13 18:02:50 volumio volumio[971]: info: CoreStateMachine::pushState Oct 13 18:02:50 volumio volumio[971]: info: CorePlayQueue::getTrack 3 Oct 13 18:02:50 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:02:50 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Oct 13 18:02:50 volumio volumio[971]: info: CorePlayQueue::getTrack 3 Oct 13 18:02:50 volumio volumio[971]: 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":"USB/08B5-4780/何炫丽 - 烟雨唱扬州.flac","trackType":"flac"} Oct 13 18:02:50 volumio volumio[971]: verbose: CURRENT POSITION 3 Oct 13 18:02:50 volumio volumio[971]: info: CoreStateMachine::syncState stateService stop Oct 13 18:02:50 volumio volumio[971]: info: CoreStateMachine::syncState currentStatus stop Oct 13 18:02:50 volumio volumio[971]: info: CoreStateMachine::pushState Oct 13 18:02:50 volumio volumio[971]: info: CorePlayQueue::getTrack 3 Oct 13 18:02:50 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Oct 13 18:02:50 volumio volumio[971]: info: No code Oct 13 18:02:50 volumio volumio[971]: info: CoreStateMachine::pushState Oct 13 18:02:50 volumio volumio[971]: info: CorePlayQueue::getTrack 3 Oct 13 18:02:50 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Oct 13 18:02:50 volumio volumio[971]: info: ------------------------------ 155ms Oct 13 18:02:50 volumio volumio[971]: error: updateQueue error: null Oct 13 18:02:50 volumio volumio[971]: info: Oct 13 18:02:50 volumio volumio[971]: ---------------------------- MPD announces system playlist update Oct 13 18:02:50 volumio volumio[971]: info: Ignoring MPD Status Update Oct 13 18:02:50 volumio volumio[971]: info: ------------------------------ 104ms Oct 13 18:02:50 volumio volumio[971]: info: sendMpdCommand add "USB/08B5-4780/毛不易 - 一荤一素.flac" took 99 milliseconds Oct 13 18:02:50 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand play Oct 13 18:02:50 volumio volumio[971]: info: touch_display: Setting screensaver timeout to 999999999999999 seconds. Oct 13 18:02:50 volumio volumio[971]: info: Oct 13 18:02:50 volumio volumio[971]: ---------------------------- MPD announces state update: player Oct 13 18:02:50 volumio volumio[971]: info: ------------------------------ 87ms Oct 13 18:02:50 volumio volumio[971]: info: sendMpdCommand play took 83 milliseconds Oct 13 18:02:50 volumio volumio[971]: info: ControllerMpd::getState Oct 13 18:02:50 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:02:50 volumio volumio[971]: info: Oct 13 18:02:50 volumio volumio[971]: ---------------------------- MPD announces state update: player Oct 13 18:02:50 volumio volumio[971]: info: ControllerMpd::getState Oct 13 18:02:50 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand status Oct 13 18:02:50 volumio volumio[971]: info: sendMpdCommand status took 15 milliseconds Oct 13 18:02:50 volumio volumio[971]: verbose: ControllerMpd::parseState Oct 13 18:02:50 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:02:50 volumio volumio[971]: info: sendMpdCommand status took 10 milliseconds Oct 13 18:02:50 volumio volumio[971]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 13 18:02:50 volumio volumio[971]: verbose: ControllerMpd::parseState Oct 13 18:02:50 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 13 18:02:50 volumio volumio[971]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:02:50 volumio volumio[971]: info: ControllerMpd::pushState Oct 13 18:02:50 volumio volumio[971]: info: CoreCommandRouter::servicePushState Oct 13 18:02:50 volumio volumio[971]: info: CorePlayQueue::getTrack 3 Oct 13 18:02:50 volumio volumio[971]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":314,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一荤一素","artist":"毛不易","album":"歌手·当打之年 第2期","uri":"USB/08B5-4780/毛不易 - 一荤一素.flac","trackType":"flac"} Oct 13 18:02:50 volumio volumio[971]: verbose: CURRENT POSITION 3 Oct 13 18:02:50 volumio volumio[971]: info: CoreStateMachine::syncState stateService play Oct 13 18:02:50 volumio volumio[971]: info: CoreStateMachine::syncState currentStatus stop Oct 13 18:02:50 volumio volumio[971]: info: ------------------------------ 35ms Oct 13 18:02:50 volumio volumio[971]: info: sendMpdCommand playlistinfo took 11 milliseconds Oct 13 18:02:50 volumio volumio[971]: verbose: ControllerMpd::parseTrackInfo Oct 13 18:02:50 volumio volumio[971]: info: ControllerMpd::pushState Oct 13 18:02:50 volumio volumio[971]: info: CoreCommandRouter::servicePushState Oct 13 18:02:50 volumio volumio[971]: info: CorePlayQueue::getTrack 3 Oct 13 18:02:50 volumio volumio[971]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":314,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一荤一素","artist":"毛不易","album":"歌手·当打之年 第2期","uri":"USB/08B5-4780/毛不易 - 一荤一素.flac","trackType":"flac"} Oct 13 18:02:50 volumio volumio[971]: verbose: CURRENT POSITION 3 Oct 13 18:02:50 volumio volumio[971]: info: CoreStateMachine::syncState stateService play Oct 13 18:02:50 volumio volumio[971]: info: CoreStateMachine::syncState currentStatus play Oct 13 18:02:50 volumio volumio[971]: info: Received an update from plugin. extracting info from payload Oct 13 18:02:50 volumio volumio[971]: info: CoreStateMachine::pushState Oct 13 18:02:50 volumio volumio[971]: info: CorePlayQueue::getTrack 3 Oct 13 18:02:50 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 18:02:50 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Oct 13 18:02:50 volumio volumio[971]: info: CoreStateMachine::pushState Oct 13 18:02:50 volumio volumio[971]: info: CorePlayQueue::getTrack 3 Oct 13 18:02:50 volumio volumio[971]: info: CoreCommandRouter::volumioPushState Oct 13 18:02:50 volumio volumio[971]: info: ------------------------------ 139ms Oct 13 18:02:53 volumio volumio[971]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 13 18:02:53 volumio volumio[971]: info: CoreCommandRouter::volumioGetState Oct 13 18:02:53 volumio volumio[971]: info: CorePlayQueue::getTrack 3 Oct 13 18:02:58 volumio volumio[971]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 18:02:58 volumio volumio[971]: Error: connect ETIMEDOUT 108.160.169.46:443 Oct 13 18:02:58 volumio volumio[971]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Oct 13 18:02:58 volumio volumio[971]: errno: -110, Oct 13 18:02:58 volumio volumio[971]: code: 'ETIMEDOUT', Oct 13 18:02:58 volumio volumio[971]: syscall: 'connect', Oct 13 18:02:58 volumio volumio[971]: address: '108.160.169.46', Oct 13 18:02:58 volumio volumio[971]: port: 443 Oct 13 18:02:58 volumio volumio[971]: } Oct 13 18:02:58 volumio volumio[971]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 18:02:59 volumio sudo[5966]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-13 18:01 Oct 13 18:02:59 volumio sudo[5966]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"